builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0031 starttime: 1461784686.66 results: success (0) buildid: 20160427094500 builduid: 93ea120917f447f8b90ce639b2d09e4c revision: de6bfcdfe5ce1f7113e085147d228e4b19de456c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 12:18:06.660459) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 12:18:06.661194) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 12:18:06.661698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 12:18:06.682662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 12:18:06.683066) ========= 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.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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-27 12:18:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 140M=0s 2016-04-27 12:18:06 (140 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126946 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 12:18:06.827967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 12:18:06.828337) ========= 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.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.026158 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 12:18:06.877735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 12:18:06.878094) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev de6bfcdfe5ce1f7113e085147d228e4b19de456c --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 de6bfcdfe5ce1f7113e085147d228e4b19de456c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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-27 12:18:06,955 truncating revision to first 12 chars 2016-04-27 12:18:06,955 Setting DEBUG logging. 2016-04-27 12:18:06,955 attempt 1/10 2016-04-27 12:18:06,955 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/de6bfcdfe5ce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 12:18:07,974 unpacking tar archive at: fx-team-de6bfcdfe5ce/testing/mozharness/ program finished with exit code 0 elapsedTime=1.266017 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 12:18:08.158427) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 12:18:08.158749) ========= script_repo_revision: de6bfcdfe5ce1f7113e085147d228e4b19de456c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 12:18:08.159184) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 12:18:08.159451) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 12:18:08.173285) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-04-27 12:18:08.173678) ========= /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.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 12:18:08 INFO - MultiFileLogger online at 20160427 12:18:08 in /builds/slave/test 12:18:08 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 12:18:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:18:08 INFO - {'append_to_log': False, 12:18:08 INFO - 'base_work_dir': '/builds/slave/test', 12:18:08 INFO - 'blob_upload_branch': 'Fx-Team', 12:18:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:18:08 INFO - 'branch': 'Fx-Team', 12:18:08 INFO - 'buildbot_json_path': 'buildprops.json', 12:18:08 INFO - 'config_files': ('talos/mac_config.py',), 12:18:08 INFO - 'default_actions': ('clobber', 12:18:08 INFO - 'read-buildbot-config', 12:18:08 INFO - 'download-and-extract', 12:18:08 INFO - 'populate-webroot', 12:18:08 INFO - 'create-virtualenv', 12:18:08 INFO - 'install', 12:18:08 INFO - 'run-tests'), 12:18:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:18:08 INFO - 'download_minidump_stackwalk': True, 12:18:08 INFO - 'download_symbols': 'ondemand', 12:18:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:18:08 INFO - 'tooltool.py': '/tools/tooltool.py', 12:18:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:18:08 INFO - '/tools/misc-python/virtualenv.py')}, 12:18:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:18:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:18:08 INFO - 'installer_path': 'installer.exe', 12:18:08 INFO - 'log_level': 'info', 12:18:08 INFO - 'log_name': 'talos', 12:18:08 INFO - 'log_to_console': True, 12:18:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:18:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:18:08 INFO - 'opt_config_files': (), 12:18:08 INFO - 'pip_index': False, 12:18:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:18:08 INFO - 'cmd': ('bash', 12:18:08 INFO - '-c', 12:18:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:18:08 INFO - 'enabled': True, 12:18:08 INFO - 'halt_on_failure': False, 12:18:08 INFO - 'name': 'check_screen_resolution'},), 12:18:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:18:08 INFO - 'cmd': ('bash', 12:18:08 INFO - '-c', 12:18:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:18:08 INFO - 'enabled': True, 12:18:08 INFO - 'halt_on_failure': False, 12:18:08 INFO - 'name': 'check_screen_resolution'},), 12:18:08 INFO - 'run_cmd_checks_enabled': True, 12:18:08 INFO - 'sps_profile': False, 12:18:08 INFO - 'sps_profile_interval': 0, 12:18:08 INFO - 'suite': 'dromaeojs-e10s', 12:18:08 INFO - 'system_bits': '32', 12:18:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:18:08 INFO - 'title': 't-yosemite-r7-0031', 12:18:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:18:08 INFO - 'use_talos_json': True, 12:18:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:18:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:18:08 INFO - 'work_dir': 'build'} 12:18:08 INFO - ##### 12:18:08 INFO - ##### Running clobber step. 12:18:08 INFO - ##### 12:18:08 INFO - Running pre-action listener: _resource_record_pre_action 12:18:08 INFO - Running main action method: clobber 12:18:08 INFO - rmtree: /builds/slave/test/build 12:18:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:18:10 INFO - Running post-action listener: _resource_record_post_action 12:18:10 INFO - ##### 12:18:10 INFO - ##### Running read-buildbot-config step. 12:18:10 INFO - ##### 12:18:10 INFO - Running pre-action listener: _resource_record_pre_action 12:18:10 INFO - Running main action method: read_buildbot_config 12:18:10 INFO - Using buildbot properties: 12:18:10 INFO - { 12:18:10 INFO - "project": "", 12:18:10 INFO - "product": "firefox", 12:18:10 INFO - "script_repo_revision": "production", 12:18:10 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 12:18:10 INFO - "repository": "", 12:18:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 12:18:10 INFO - "buildid": "20160427094500", 12:18:10 INFO - "pgo_build": "False", 12:18:10 INFO - "basedir": "/builds/slave/test", 12:18:10 INFO - "buildnumber": 649, 12:18:10 INFO - "slavename": "t-yosemite-r7-0031", 12:18:10 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:18:10 INFO - "platform": "yosemite_r7", 12:18:10 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 12:18:10 INFO - "branch": "fx-team", 12:18:10 INFO - "repo_path": "integration/fx-team", 12:18:10 INFO - "revision": "de6bfcdfe5ce1f7113e085147d228e4b19de456c", 12:18:10 INFO - "stage_platform": "macosx64", 12:18:10 INFO - "builduid": "93ea120917f447f8b90ce639b2d09e4c", 12:18:10 INFO - "slavebuilddir": "test" 12:18:10 INFO - } 12:18:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 12:18:10 INFO - Running post-action listener: _resource_record_post_action 12:18:10 INFO - ##### 12:18:10 INFO - ##### Running download-and-extract step. 12:18:10 INFO - ##### 12:18:10 INFO - Running pre-action listener: _resource_record_pre_action 12:18:10 INFO - Running main action method: download_and_extract 12:18:10 INFO - mkdir: /builds/slave/test/build/tests 12:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:10 INFO - https://queue.taskcluster.net/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:18:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 12:18:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 12:18:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 12:18:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 12:18:13 INFO - Downloaded 1199 bytes. 12:18:13 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 12:18:13 INFO - Using the following test package requirements: 12:18:13 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 12:18:13 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:18:13 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 12:18:13 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:18:13 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 12:18:13 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:18:13 INFO - u'jsshell-mac.zip'], 12:18:13 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:18:13 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 12:18:13 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 12:18:13 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:18:13 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 12:18:13 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:18:13 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 12:18:13 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:18:13 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 12:18:13 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:18:13 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 12:18:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:18: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')]} 12:18:13 INFO - https://queue.taskcluster.net/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:18:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:18:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:18:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:18:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:18:15 INFO - Downloaded 18117646 bytes. 12:18:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:18:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:18:18 INFO - Return code: 0 12:18:18 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:18:18 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')]} 12:18:18 INFO - https://queue.taskcluster.net/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:18:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:18:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:18:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:18:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:18:22 INFO - Downloaded 18117646 bytes. 12:18:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:18:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:18:26 INFO - Return code: 0 12:18:26 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')]} 12:18:26 INFO - https://queue.taskcluster.net/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:18:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 12:18:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 12:18:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 12:18:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:18:27 INFO - Downloaded 10840145 bytes. 12:18:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:18:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:18:27 INFO - Return code: 0 12:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:27 INFO - https://queue.taskcluster.net/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:18:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:18:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:18:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 12:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 12:18:30 INFO - Downloaded 110187735 bytes. 12:18:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:18:30 INFO - mkdir: /builds/slave/test/properties 12:18:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:18:30 INFO - Writing to file /builds/slave/test/properties/build_url 12:18:30 INFO - Contents: 12:18:30 INFO - build_url:https://queue.taskcluster.net/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:18:32 INFO - Running post-action listener: _resource_record_post_action 12:18:32 INFO - Running post-action listener: set_extra_try_arguments 12:18:32 INFO - ##### 12:18:32 INFO - ##### Running populate-webroot step. 12:18:32 INFO - ##### 12:18:32 INFO - Running pre-action listener: _resource_record_pre_action 12:18:32 INFO - Running main action method: populate_webroot 12:18:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:18:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:18:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:18:32 INFO - '--tppagecycles', 12:18:32 INFO - '7'], 12:18:32 INFO - 'tests': ['tsvgm']}}, 12:18:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:18:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:18:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:18:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:18:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:18:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:18:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:32 INFO - 'talos_options': ['--disable-e10s'], 12:18:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:32 INFO - 'talos_options': ['--disable-e10s'], 12:18:32 INFO - 'tests': ['damp', 'tps']}, 12:18:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:32 INFO - 'tests': ['damp', 'tps']}, 12:18:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:18:32 INFO - 'tests': ['dromaeo_dom']}, 12:18:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:18:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:18:32 INFO - 'tests': ['a11yr', 12:18:32 INFO - 'ts_paint', 12:18:32 INFO - 'tpaint', 12:18:32 INFO - 'sessionrestore', 12:18:32 INFO - 'sessionrestore_no_auto_restore', 12:18:32 INFO - 'tabpaint']}, 12:18:32 INFO - 'other-e10s': {'tests': ['a11yr', 12:18:32 INFO - 'ts_paint', 12:18:32 INFO - 'tpaint', 12:18:32 INFO - 'sessionrestore', 12:18:32 INFO - 'sessionrestore_no_auto_restore', 12:18:32 INFO - 'tabpaint']}, 12:18:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:18:32 INFO - 'ts_paint', 12:18:32 INFO - 'tpaint', 12:18:32 INFO - 'sessionrestore', 12:18:32 INFO - 'sessionrestore_no_auto_restore', 12:18:32 INFO - 'tabpaint']}, 12:18:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:18:32 INFO - 'ts_paint', 12:18:32 INFO - 'tpaint', 12:18:32 INFO - 'sessionrestore', 12:18:32 INFO - 'sessionrestore_no_auto_restore', 12:18:32 INFO - 'tabpaint']}, 12:18:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:18:32 INFO - 'tests': ['a11yr', 12:18:32 INFO - 'ts_paint', 12:18:32 INFO - 'tpaint', 12:18:32 INFO - 'sessionrestore', 12:18:32 INFO - 'sessionrestore_no_auto_restore', 12:18:32 INFO - 'tabpaint']}, 12:18:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:18:32 INFO - 'tests': ['a11yr', 12:18:32 INFO - 'ts_paint', 12:18:32 INFO - 'tpaint', 12:18:32 INFO - 'sessionrestore', 12:18:32 INFO - 'sessionrestore_no_auto_restore', 12:18:32 INFO - 'tabpaint']}, 12:18:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:18:32 INFO - 'tests': ['tsvgx', 12:18:32 INFO - 'tsvgr_opacity', 12:18:32 INFO - 'tart', 12:18:32 INFO - 'tscrollx', 12:18:32 INFO - 'cart']}, 12:18:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:18:32 INFO - 'tsvgr_opacity', 12:18:32 INFO - 'tart', 12:18:32 INFO - 'tscrollx', 12:18:32 INFO - 'cart']}, 12:18:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:32 INFO - 'talos_options': ['--disable-e10s'], 12:18:32 INFO - 'tests': ['tp5o']}, 12:18:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:32 INFO - 'tests': ['tp5o']}, 12:18:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:32 INFO - 'talos_options': ['--disable-e10s', 12:18:32 INFO - '--xperf_path', 12:18:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:32 INFO - 'tests': ['tp5n']}, 12:18:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:32 INFO - 'talos_options': ['--xperf_path', 12:18:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:32 INFO - 'tests': ['tp5n']}}, 12:18:32 INFO - 'talos.zip': {'path': '', 12:18:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:18:32 INFO - Running post-action listener: _resource_record_post_action 12:18:32 INFO - ##### 12:18:32 INFO - ##### Running create-virtualenv step. 12:18:32 INFO - ##### 12:18:32 INFO - Running pre-action listener: _resource_record_pre_action 12:18:32 INFO - Running main action method: create_virtualenv 12:18:32 INFO - Creating virtualenv /builds/slave/test/build/venv 12:18:32 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 12:18:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:18:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:18:32 INFO - Using real prefix '/tools/python27' 12:18:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:18:33 INFO - Installing distribute.............................................................................................................................................................................................done. 12:18:36 INFO - Installing pip.................done. 12:18:36 INFO - Return code: 0 12:18:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10530ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf41cd5a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051aae00>, '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 0x105013db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051a5b20>, '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.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 12:18: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', 'pip>=1.5'] in /builds/slave/test/build 12:18: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 pip>=1.5 12:18:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ApaaB0zkvx/Render', 12:18:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:36 INFO - 'HOME': '/Users/cltbld', 12:18:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:36 INFO - 'LOGNAME': 'cltbld', 12:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:36 INFO - 'MOZ_NO_REMOTE': '1', 12:18:36 INFO - 'NO_EM_RESTART': '1', 12:18:36 INFO - 'PAGER': '/bin/cat', 12:18:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:36 INFO - 'PWD': '/builds/slave/test', 12:18:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:36 INFO - 'SHELL': '/bin/bash', 12:18:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJhH0Wm4J5/Listeners', 12:18:36 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 12:18:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:36 INFO - 'USER': 'cltbld', 12:18:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:36 INFO - 'XPC_FLAGS': '0x0', 12:18:36 INFO - 'XPC_SERVICE_NAME': '0', 12:18:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:36 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 12:18:36 INFO - Cleaning up... 12:18:36 INFO - Return code: 0 12:18:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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', '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 0x10530ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf41cd5a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051aae00>, '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 0x105013db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051a5b20>, '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.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 12:18: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', 'psutil>=0.7.1'] in /builds/slave/test/build 12:18: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 psutil>=0.7.1 12:18:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ApaaB0zkvx/Render', 12:18:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:36 INFO - 'HOME': '/Users/cltbld', 12:18:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:36 INFO - 'LOGNAME': 'cltbld', 12:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:36 INFO - 'MOZ_NO_REMOTE': '1', 12:18:36 INFO - 'NO_EM_RESTART': '1', 12:18:36 INFO - 'PAGER': '/bin/cat', 12:18:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:36 INFO - 'PWD': '/builds/slave/test', 12:18:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:36 INFO - 'SHELL': '/bin/bash', 12:18:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJhH0Wm4J5/Listeners', 12:18:36 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 12:18:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:36 INFO - 'USER': 'cltbld', 12:18:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:36 INFO - 'XPC_FLAGS': '0x0', 12:18:36 INFO - 'XPC_SERVICE_NAME': '0', 12:18:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:36 INFO - Downloading/unpacking psutil>=0.7.1 12:18: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 12:18: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 12:18: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 12:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18: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 12:18: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 12:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:18:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:39 INFO - Installing collected packages: psutil 12:18:39 INFO - Running setup.py install for psutil 12:18:39 INFO - building 'psutil._psutil_osx' extension 12:18:39 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 12:18:40 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 12:18:40 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 12:18:40 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 12:18:40 INFO - building 'psutil._psutil_posix' extension 12:18:40 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 12:18:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:18:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:18:40 INFO - ^ 12:18:40 INFO - 1 warning generated. 12:18:40 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 12:18:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:41 INFO - Successfully installed psutil 12:18:41 INFO - Cleaning up... 12:18:41 INFO - Return code: 0 12:18:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:41 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 0x10530ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf41cd5a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051aae00>, '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 0x105013db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051a5b20>, '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.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 12:18:41 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 12:18:41 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 12:18:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ApaaB0zkvx/Render', 12:18:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:41 INFO - 'HOME': '/Users/cltbld', 12:18:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:41 INFO - 'LOGNAME': 'cltbld', 12:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:41 INFO - 'MOZ_NO_REMOTE': '1', 12:18:41 INFO - 'NO_EM_RESTART': '1', 12:18:41 INFO - 'PAGER': '/bin/cat', 12:18:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:41 INFO - 'PWD': '/builds/slave/test', 12:18:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:41 INFO - 'SHELL': '/bin/bash', 12:18:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJhH0Wm4J5/Listeners', 12:18:41 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 12:18:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:41 INFO - 'USER': 'cltbld', 12:18:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:41 INFO - 'XPC_FLAGS': '0x0', 12:18:41 INFO - 'XPC_SERVICE_NAME': '0', 12:18:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:18:43 INFO - Installing collected packages: mozsystemmonitor 12:18:43 INFO - Running setup.py install for mozsystemmonitor 12:18:44 INFO - Successfully installed mozsystemmonitor 12:18:44 INFO - Cleaning up... 12:18:44 INFO - Return code: 0 12:18:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:18:44 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')]} 12:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:44 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')]} 12:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:44 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 0x10530ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf41cd5a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051aae00>, '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 0x105013db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051a5b20>, '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.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 12:18:44 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 12:18:44 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 12:18:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ApaaB0zkvx/Render', 12:18:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:44 INFO - 'HOME': '/Users/cltbld', 12:18:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:44 INFO - 'LOGNAME': 'cltbld', 12:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:44 INFO - 'MOZ_NO_REMOTE': '1', 12:18:44 INFO - 'NO_EM_RESTART': '1', 12:18:44 INFO - 'PAGER': '/bin/cat', 12:18:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:44 INFO - 'PWD': '/builds/slave/test', 12:18:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:44 INFO - 'SHELL': '/bin/bash', 12:18:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJhH0Wm4J5/Listeners', 12:18:44 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 12:18:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:44 INFO - 'USER': 'cltbld', 12:18:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:44 INFO - 'XPC_FLAGS': '0x0', 12:18:44 INFO - 'XPC_SERVICE_NAME': '0', 12:18:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:44 INFO - Downloading/unpacking blobuploader==1.2.4 12:18:44 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 12:18:44 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 12:18:44 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 12:18:44 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 12:18:44 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 12:18:44 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 12:18:46 INFO - Downloading blobuploader-1.2.4.tar.gz 12:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:18:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:18:46 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 12:18:46 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 12:18:46 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 12:18:46 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 12:18:46 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 12:18:46 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 12:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:18:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:48 INFO - Downloading docopt-0.6.1.tar.gz 12:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:18:48 INFO - Installing collected packages: blobuploader, requests, docopt 12:18:48 INFO - Running setup.py install for blobuploader 12:18:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:18:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:18:48 INFO - Running setup.py install for requests 12:18:48 INFO - Running setup.py install for docopt 12:18:48 INFO - Successfully installed blobuploader requests docopt 12:18:48 INFO - Cleaning up... 12:18:49 INFO - Return code: 0 12:18:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:49 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')]} 12:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:49 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')]} 12:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:49 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 0x10530ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf41cd5a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051aae00>, '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 0x105013db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051a5b20>, '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.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 12:18:49 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 12:18:49 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 12:18:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ApaaB0zkvx/Render', 12:18:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:49 INFO - 'HOME': '/Users/cltbld', 12:18:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:49 INFO - 'LOGNAME': 'cltbld', 12:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:49 INFO - 'MOZ_NO_REMOTE': '1', 12:18:49 INFO - 'NO_EM_RESTART': '1', 12:18:49 INFO - 'PAGER': '/bin/cat', 12:18:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:49 INFO - 'PWD': '/builds/slave/test', 12:18:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:49 INFO - 'SHELL': '/bin/bash', 12:18:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJhH0Wm4J5/Listeners', 12:18:49 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 12:18:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:49 INFO - 'USER': 'cltbld', 12:18:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:49 INFO - 'XPC_FLAGS': '0x0', 12:18:49 INFO - 'XPC_SERVICE_NAME': '0', 12:18:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:18:49 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Y5FpBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:18:49 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-AGHzbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:18:49 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-cK0gly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:18:49 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-FUIDid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:18:49 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-i7kVVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:18:49 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-6ct3JK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:18:49 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-OVRMsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:18:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-mnXcxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:18:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-UyRYv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:18:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-csV3_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:18:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-PvOyhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:18:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-gDhrtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:18:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-2vXl44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:18:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-AI9UqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-pP5O_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:18:50 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-2kByIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:18:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-NDGscI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:18:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:18:51 INFO - Running setup.py install for manifestparser 12:18:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:18:51 INFO - Running setup.py install for mozcrash 12:18:51 INFO - Running setup.py install for mozdebug 12:18:51 INFO - Running setup.py install for mozdevice 12:18:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:18:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:18:51 INFO - Running setup.py install for mozfile 12:18:51 INFO - Running setup.py install for mozhttpd 12:18:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:18:52 INFO - Running setup.py install for mozinfo 12:18:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:18:52 INFO - Running setup.py install for mozInstall 12:18:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:18:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:18:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:18:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:18:52 INFO - Running setup.py install for mozleak 12:18:52 INFO - Running setup.py install for mozlog 12:18:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:18:52 INFO - Running setup.py install for moznetwork 12:18:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:18:52 INFO - Running setup.py install for mozprocess 12:18:52 INFO - Running setup.py install for mozprofile 12:18:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:18:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:18:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:18:53 INFO - Running setup.py install for mozrunner 12:18:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:18:53 INFO - Running setup.py install for mozscreenshot 12:18:53 INFO - Running setup.py install for moztest 12:18:53 INFO - Running setup.py install for mozversion 12:18:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:18:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:18:53 INFO - Cleaning up... 12:18:53 INFO - Return code: 0 12:18:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:53 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 0x10530ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf41cd5a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051aae00>, '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 0x105013db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051a5b20>, '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.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 12:18:53 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 12:18:53 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 12:18:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ApaaB0zkvx/Render', 12:18:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:53 INFO - 'HOME': '/Users/cltbld', 12:18:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:53 INFO - 'LOGNAME': 'cltbld', 12:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:53 INFO - 'MOZ_NO_REMOTE': '1', 12:18:53 INFO - 'NO_EM_RESTART': '1', 12:18:53 INFO - 'PAGER': '/bin/cat', 12:18:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:53 INFO - 'PWD': '/builds/slave/test', 12:18:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:53 INFO - 'SHELL': '/bin/bash', 12:18:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJhH0Wm4J5/Listeners', 12:18:53 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 12:18:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:53 INFO - 'USER': 'cltbld', 12:18:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:53 INFO - 'XPC_FLAGS': '0x0', 12:18:53 INFO - 'XPC_SERVICE_NAME': '0', 12:18:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:18:53 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-AzsjG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:18:54 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)) 12:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:18:54 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-n5m4In-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:18:54 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)) 12:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:18:54 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-5V8y71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:18:54 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)) 12:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:18:54 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-P0bmbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:18:54 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)) 12:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:18:54 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-LH4j9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:18:54 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)) 12:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:18:54 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-5tR8gJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:18:54 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)) 12:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:18:54 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-hEmVEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:18:54 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)) 12:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:18:54 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-u999HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:18:54 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)) 12:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:18:54 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-ddTrOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:18:54 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)) 12:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:18:54 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-NgM3in-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:18:55 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)) 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:18:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-LSn89J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:18:55 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)) 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:18:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-e0En9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:18:55 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)) 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:18:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-rXQXIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:18:55 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)) 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:18:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-NKYqpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:18:55 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)) 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-so_pvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:55 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)) 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:18:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Gs4wt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:18:55 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)) 12:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:18:55 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-tMnIpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:18:55 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)) 12:18:55 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)) 12:18:55 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)) 12:18:55 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)) 12:18:55 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)) 12:18:55 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)) 12:18:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:18:55 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 12:18:55 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 12:18:55 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 12:18:55 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 12:18:55 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 12:18:55 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 12:18:58 INFO - Downloading blessings-1.6.tar.gz 12:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:18:58 INFO - Installing collected packages: blessings 12:18:58 INFO - Running setup.py install for blessings 12:18:58 INFO - Successfully installed blessings 12:18:58 INFO - Cleaning up... 12:18:58 INFO - Return code: 0 12:18:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:58 INFO - Reading from file tmpfile_stdout 12:18:58 INFO - Current package versions: 12:18:58 INFO - blessings == 1.6 12:18:58 INFO - blobuploader == 1.2.4 12:18:58 INFO - docopt == 0.6.1 12:18:58 INFO - manifestparser == 1.1 12:18:58 INFO - mozInstall == 1.12 12:18:58 INFO - mozcrash == 0.17 12:18:58 INFO - mozdebug == 0.1 12:18:58 INFO - mozdevice == 0.48 12:18:58 INFO - mozfile == 1.2 12:18:58 INFO - mozhttpd == 0.7 12:18:58 INFO - mozinfo == 0.9 12:18:58 INFO - mozleak == 0.1 12:18:58 INFO - mozlog == 3.1 12:18:58 INFO - moznetwork == 0.27 12:18:58 INFO - mozprocess == 0.22 12:18:58 INFO - mozprofile == 0.28 12:18:58 INFO - mozrunner == 6.11 12:18:58 INFO - mozscreenshot == 0.1 12:18:58 INFO - mozsystemmonitor == 0.0 12:18:58 INFO - moztest == 0.7 12:18:58 INFO - mozversion == 1.4 12:18:58 INFO - psutil == 3.1.1 12:18:58 INFO - requests == 1.2.3 12:18:58 INFO - wsgiref == 0.1.2 12:18:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:58 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 0x10530ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf41cd5a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051aae00>, '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 0x105013db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051a5b20>, '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.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 12:18:58 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 12:18:58 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 12:18:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ApaaB0zkvx/Render', 12:18:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:58 INFO - 'HOME': '/Users/cltbld', 12:18:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:58 INFO - 'LOGNAME': 'cltbld', 12:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:58 INFO - 'MOZ_NO_REMOTE': '1', 12:18:58 INFO - 'NO_EM_RESTART': '1', 12:18:58 INFO - 'PAGER': '/bin/cat', 12:18:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:58 INFO - 'PWD': '/builds/slave/test', 12:18:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:58 INFO - 'SHELL': '/bin/bash', 12:18:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJhH0Wm4J5/Listeners', 12:18:58 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 12:18:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:58 INFO - 'USER': 'cltbld', 12:18:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:58 INFO - 'XPC_FLAGS': '0x0', 12:18:58 INFO - 'XPC_SERVICE_NAME': '0', 12:18:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:59 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)) 12:18:59 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)) 12:18:59 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)) 12:18:59 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)) 12:18:59 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)) 12:18:59 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)) 12:18:59 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)) 12:18:59 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)) 12:18:59 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)) 12:18:59 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)) 12:18:59 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)) 12:18:59 INFO - Cleaning up... 12:18:59 INFO - Return code: 0 12:18:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:59 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 0x10530ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf41cd5a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051aae00>, '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 0x105013db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051a5b20>, '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.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 12:18:59 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 12:18:59 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 12:18:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ApaaB0zkvx/Render', 12:18:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:59 INFO - 'HOME': '/Users/cltbld', 12:18:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:59 INFO - 'LOGNAME': 'cltbld', 12:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:59 INFO - 'MOZ_NO_REMOTE': '1', 12:18:59 INFO - 'NO_EM_RESTART': '1', 12:18:59 INFO - 'PAGER': '/bin/cat', 12:18:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:59 INFO - 'PWD': '/builds/slave/test', 12:18:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:59 INFO - 'SHELL': '/bin/bash', 12:18:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJhH0Wm4J5/Listeners', 12:18:59 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 12:18:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:59 INFO - 'USER': 'cltbld', 12:18:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:59 INFO - 'XPC_FLAGS': '0x0', 12:18:59 INFO - 'XPC_SERVICE_NAME': '0', 12:18:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:59 INFO - Downloading/unpacking jsonschema 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:19:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:19:01 INFO - Downloading/unpacking functools32 (from jsonschema) 12:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:02 INFO - Downloading functools32-3.2.3-2.tar.gz 12:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:19:02 INFO - warning: no files found matching '*.txt' 12:19:02 INFO - no previously-included directories found matching 'build' 12:19:02 INFO - no previously-included directories found matching 'dist' 12:19:02 INFO - no previously-included directories found matching '.git*' 12:19:02 INFO - Installing collected packages: jsonschema, functools32 12:19:02 INFO - Running setup.py install for functools32 12:19:02 INFO - warning: no files found matching '*.txt' 12:19:02 INFO - no previously-included directories found matching 'build' 12:19:02 INFO - no previously-included directories found matching 'dist' 12:19:02 INFO - no previously-included directories found matching '.git*' 12:19:02 INFO - Successfully installed jsonschema functools32 12:19:02 INFO - Cleaning up... 12:19:02 INFO - Return code: 0 12:19:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:02 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 0x10530ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf41cd5a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051aae00>, '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 0x105013db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051a5b20>, '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.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 12:19:02 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 12:19:02 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 12:19:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ApaaB0zkvx/Render', 12:19:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:02 INFO - 'HOME': '/Users/cltbld', 12:19:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:02 INFO - 'LOGNAME': 'cltbld', 12:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:02 INFO - 'MOZ_NO_REMOTE': '1', 12:19:02 INFO - 'NO_EM_RESTART': '1', 12:19:02 INFO - 'PAGER': '/bin/cat', 12:19:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:02 INFO - 'PWD': '/builds/slave/test', 12:19:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:02 INFO - 'SHELL': '/bin/bash', 12:19:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJhH0Wm4J5/Listeners', 12:19:02 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 12:19:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:02 INFO - 'USER': 'cltbld', 12:19:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:02 INFO - 'XPC_FLAGS': '0x0', 12:19:02 INFO - 'XPC_SERVICE_NAME': '0', 12:19:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:02 INFO - Downloading/unpacking flake8 12:19:02 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 12:19:02 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 12:19:02 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 12:19:02 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 12:19:02 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 12:19:02 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 12:19:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:19:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:19:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:19:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:19:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:19:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:19:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:19:06 INFO - no previously-included directories found matching 'docs/_build' 12:19:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:19:06 INFO - Running setup.py install for pep8 12:19:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:19:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:19:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:19:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:19:06 INFO - no previously-included directories found matching 'docs/_build' 12:19:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:19:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:19:06 INFO - Cleaning up... 12:19:06 INFO - Return code: 0 12:19:06 INFO - Running post-action listener: _resource_record_post_action 12:19:06 INFO - Running post-action listener: _start_resource_monitoring 12:19:06 INFO - Starting resource monitoring. 12:19:06 INFO - ##### 12:19:06 INFO - ##### Running install step. 12:19:06 INFO - ##### 12:19:06 INFO - Running pre-action listener: _resource_record_pre_action 12:19:06 INFO - Running main action method: install 12:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:07 INFO - Reading from file tmpfile_stdout 12:19:07 INFO - Detecting whether we're running mozinstall >=1.0... 12:19:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:19:07 INFO - Reading from file tmpfile_stdout 12:19:07 INFO - Output received: 12:19:07 INFO - Usage: mozinstall [options] installer 12:19:07 INFO - Options: 12:19:07 INFO - -h, --help show this help message and exit 12:19:07 INFO - -d DEST, --destination=DEST 12:19:07 INFO - Directory to install application into. [default: 12:19:07 INFO - "/builds/slave/test"] 12:19:07 INFO - --app=APP Application being installed. [default: firefox] 12:19:07 INFO - mkdir: /builds/slave/test/build/application 12:19:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:19:41 INFO - Reading from file tmpfile_stdout 12:19:41 INFO - Output received: 12:19:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:19:41 INFO - Running post-action listener: _resource_record_post_action 12:19:41 INFO - ##### 12:19:41 INFO - ##### Running run-tests step. 12:19:41 INFO - ##### 12:19:41 INFO - Running pre-action listener: _resource_record_pre_action 12:19:41 INFO - Running main action method: run_tests 12:19:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:19:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:19:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:19:41 INFO - 2016-04-27 12:19:41.024 screenresolution[1643:7554] starting screenresolution argv=screenresolution get 12:19:41 INFO - 2016-04-27 12:19:41.027 screenresolution[1643:7554] Display 0: 1600x1200x32@60 12:19:41 INFO - 2016-04-27 12:19:41.033 screenresolution[1644:7556] starting screenresolution argv=screenresolution list 12:19:41 INFO - Available Modes on Display 0 12:19:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:19:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:19:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:19:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:19:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:19:41 INFO - Intel Iris: 12:19:41 INFO - Chipset Model: Intel Iris 12:19:41 INFO - Type: GPU 12:19:41 INFO - Bus: Built-In 12:19:41 INFO - VRAM (Dynamic, Max): 1536 MB 12:19:41 INFO - Vendor: Intel (0x8086) 12:19:41 INFO - Device ID: 0x0a2e 12:19:41 INFO - Revision ID: 0x0009 12:19:41 INFO - Displays: 12:19:41 INFO - Display: 12:19:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:19:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:19:41 INFO - Display Serial Number: 1600x1200 60 12:19:41 INFO - Main Display: Yes 12:19:41 INFO - Mirror: Off 12:19:41 INFO - Online: Yes 12:19:41 INFO - Rotation: Supported 12:19:41 INFO - Return code: 0 12:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:19:41 INFO - Python 2.7.3 12:19:41 INFO - Return code: 0 12:19:41 INFO - grabbing minidump binary from tooltool 12:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:41 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 0x1051aae00>, '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 0x105013db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051a5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:19:41 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 12:19:41 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 12:19:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:19:41 INFO - Return code: 0 12:19:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:19:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:19:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:19:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:19:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:19:42 INFO - Return code: 0 12:19:42 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/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--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 12:19:42 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/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0031 --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 12:19:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ApaaB0zkvx/Render', 12:19:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:42 INFO - 'HOME': '/Users/cltbld', 12:19:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:42 INFO - 'LOGNAME': 'cltbld', 12:19:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:19:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:42 INFO - 'MOZ_NO_REMOTE': '1', 12:19:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:19:42 INFO - 'NO_EM_RESTART': '1', 12:19:42 INFO - 'PAGER': '/bin/cat', 12:19:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:42 INFO - 'PWD': '/builds/slave/test', 12:19:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:19:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:42 INFO - 'SHELL': '/bin/bash', 12:19:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QJhH0Wm4J5/Listeners', 12:19:42 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 12:19:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:42 INFO - 'USER': 'cltbld', 12:19:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:42 INFO - 'XPC_FLAGS': '0x0', 12:19:42 INFO - 'XPC_SERVICE_NAME': '0', 12:19:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:42 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/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--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 12:19:42 INFO - mozversion application_buildid: 20160427094500 12:19:42 INFO - mozversion application_changeset: de6bfcdfe5ce1f7113e085147d228e4b19de456c 12:19:42 INFO - mozversion application_display_name: Nightly 12:19:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:19:42 INFO - mozversion application_name: Firefox 12:19:42 INFO - mozversion application_remotingname: firefox 12:19:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:19:42 INFO - mozversion application_vendor: Mozilla 12:19:42 INFO - mozversion application_version: 49.0a1 12:19:42 INFO - mozversion platform_buildid: 20160427094500 12:19:42 INFO - mozversion platform_changeset: de6bfcdfe5ce1f7113e085147d228e4b19de456c 12:19:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:19:42 INFO - mozversion platform_version: 49.0a1 12:19:42 INFO - using testdate: 1461784782 12:19:42 INFO - actual date: 1461784782 12:19:42 INFO - starting webserver on 'localhost:49271' 12:19:42 INFO - SUITE-START | Running 2 tests 12:19:42 INFO - TEST-START | dromaeo_css 12:19:42 INFO - operating with platform_type : mac_ 12:19:42 INFO - Initialising browser for dromaeo_css test... 12:19:42 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpwrCOxC/profile http://localhost:49271/getInfo.html) 12:19:45 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 12:19:45 INFO - PROCESS | 1662 | colorDepth:24 12:19:45 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 12:19:45 INFO - PROCESS | 1662 | __metrics 12:19:45 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:19:46 INFO - TEST-INFO | 1662: exit 0 12:19:46 INFO - Browser initialized. 12:19:46 INFO - Running cycle 1/1 for dromaeo_css test... 12:19:46 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpwrCOxC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:19:58 INFO - PROCESS | 1665 | RSS: Main: 249942016 12:19:58 INFO - PROCESS | 1665 | 12:20:48 INFO - PROCESS | 1665 | 1461784848283 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] 12:22:58 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 12:22:59 INFO - PROCESS | 1665 | RSS: Main: 262238208 12:22:59 INFO - PROCESS | 1665 | 12:26:01 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 12:26:02 INFO - PROCESS | 1665 | RSS: Main: 273793024 12:26:02 INFO - PROCESS | 1665 | 12:29:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 12:29:04 INFO - PROCESS | 1665 | RSS: Main: 275677184 12:29:04 INFO - PROCESS | 1665 | 12:32:06 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 12:32:07 INFO - PROCESS | 1665 | RSS: Main: 277389312 12:32:07 INFO - PROCESS | 1665 | 12:35:10 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 12:35:10 INFO - PROCESS | 1665 | RSS: Main: 280281088 12:35:10 INFO - PROCESS | 1665 | 12:38:12 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 12:38:13 INFO - PROCESS | 1665 | RSS: Main: 281391104 12:38:13 INFO - PROCESS | 1665 | 12:38:13 INFO - PROCESS | 1665 | __start_tp_report 12:38:13 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 12:38:13 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 12:38:13 INFO - PROCESS | 1665 | |i|pagename|runs| 12:38:13 INFO - PROCESS | 1665 | |0;dojo.html;3466.7919924804514;3474.3919814032547;3516.8593256269733;3519.0850378901496;3557.430811070229;5801.1008293714485;5803.709814509273;5805.883882322356;5809.622374545662;5832.766689332432;5651.7739290428335;5749.770009199627;5753.338366087901;5848.619839710426;5870.354261031293;5205.193195054763;5291.550218231455;5292.206169074631;5325.707086110262;5354.973225133869;125.28293061831305;5216.895662086756;5251.921221181667;5286.894262114755;5291.365036195662;5268.236105764681;5277.788888444457;5320.600954928396;5336.17289320154;5370.275012873251;4284.871453856389;5327.920081198785;5341.572674186055;5350.518453339179;5370.865728356823;5177.119889618736;5187.221916712523;5307.522322990911;5308.92036619451;5338.919916201221;5620.297462817148;5712.885742285131;5742.454466825645;5758.309002919635;5760.049591817345;6323.146375239376;6323.683815809191;6339;6349.904751428732;6363.713632886531;6192.256929168529;6254.280757712876;6327;6344.841378965517;6359.777407790705;5106.05537975472;5763.106718458645;5884.146798714162;5946.43508866657;5982.312034116046;6161.106639537242;6349.777757778455;6349.968250158812;6366.7771627993725;6374.139491168726;5224.346956630421;6267.310595834455;6267.65527895961;6288.402601752918;6305.842353941188;4641.74470404131;6293.465055470337;6317.778877739257;6323.747050118036;6372.904406433907;6167.784127555514;6226.346233645402;6232.504198992209;6258.15514905491;6281.497480201573;6216.7824126155365;6318.052292156213;6323.9683801580695;6327.145835312266;6333.904991425133;4938.456769755324;5010.574101201439;5018.749062546858;5028.069807085701;5032.949670503248;4420.3590479380955;4449.354843547668;4501.77491125449;4517.186906356822;4528.0943811237885;5780.306363236438;5889.911651325234;5911.852203694856;5931.73307201177;5953.553483488669;6249.189679761518;6262.373762623793;6266.122742816009;6276.968615156987;6319.936800631935;5829.47534721877;5863.794767183128;5930.9406905931255;5941.138534912414;5989.760409583655;5411.810586629528;5442.047641662773;5450.209719590637;5488.04860500447;5527.53015993645;6450.709718062699;6471.805845824632;6487.805365839033;6491.091247225487;6506.739730410731;6200.286966998672;6210.813675589739;6281.59169653971;6302.905456418066;6306.337834527492;6438.90341644885;6449.96775016122;6467.482601391784;6480.611163330215;6483.384078512534;5878.3239927408895;5934.584579079423;6314.1160237565855;6325.525585581007;6327.303996560467;5047.914698339874;5289.338832645919;6163.013917773134;6219.844503887258;6270.216222972129;6182.381761823782;6195.380461953949;6234.501239900887;6291.905621415774;6317.241930968313;5104.948950510596;6201.379862013762;6250.062490626442;6259.34276900937;6265.74937002533;6010.639361638316;6021.036634138517;6061.424164704346;6099.430845494592;6167.599106058092;6137.907931381123;6182.1345011699295;6192.195014648067;6219.471344935731;6229.345918678474;6019.187409699634;6077.5745697802495;6124.479419249235;6134.846628834315;6149.139120523041 12:38:13 INFO - PROCESS | 1665 | |1;ext.html;500.81469856153205;535.2052202479317;565.5532129617601;576.7635269539485;631.5989346764806;28848.13455596333;37250.06874828131;37313;37354.8132259339;37406.81296593517;40442.797786011106;40972.385414218814;41239.79380103095;41242.17515649685;41298.58701412985;7799.376049916007;9583.137517623412;9587.712368628918;9594.952025239863;9596.18432433244;7982.3614110871285;9430.811383772321;9534.856977145313;9558.235341172724;9558.61765529378;9429.575669094873;9533.42799432033;9579.377340472882;9590.712278631618;9641.276904232176;9483.525823708787;9490.90509094907;9577.904220957771;9580.281478889076;9597.616095356178;9373.437593744397;9483.33616646835;9504.097110774464;9505.714828555154;9536.2371010319;38266;38496.422553661716;38762.03094922649;38915.805420972996;38995.41506877399;2840.5597132444504;3053.92365190872;3105.1460848266684;3294.275259442919;3402.897913062612;20205.19179232829;26704.332391690168;26930.192094237205;27526.587101193498;27704.307392315153;2632.7104018557943;2648.5762278035613;2658.9335266618295;2732.699403065661;2810.690824009357;290335;358686.2065689681;362475;368816.9999999973;370611;32920.341593168;33737.83131084378;34747.65252347495;34881.77913773006;34971.4754278686;34615.65384346175;34944.82527587346;34983;35010.82494587511;35464.64535354613;14702.55892323232;14893.031952923026;14913.92543037278;14929.701405972037;14936.32786524609;12623.053271004712;12640.6839829005;12731.554395596295;12734.490620375267;12747.68130796719;7861.489003214772;7907.406944479187;7911.208879112043;7983.321417679563;8093.109757926623;3420.6237313895454;3420.9315813684084;3446.5347178130633;3461.394256005189;3463.7229021678204;982.1455333859445;988.5798535622475;1052.947052947053;1061.3525749292926;1091.2850549352693;29322;29463.410731785243;29641.851790740908;29979.40041199164;30226.54660180099;1046.5081411736471;1137.2380505061628;1162.0297051961707;1218.1777300322424;1218.2994778002508;14035.438582456587;14194.574162775134;15230.93383463169;15254;15328.923355383375;500012;500214;503537;507058;508413;57997.71001144967;58302.627302952445;58548.41451585515;58687;58811.411885880596;1263.172621932654;1413.4699487692114;1458.555140682081;1460;1470.6102882736084;26751.598726019514;28348.433031338845;28805.279868002628;28980.7101928978;29449.85275073611;50363.74818125886;50442;50598.74700626473;50797.98404031972;50832.74583627058;380695;380935;381559;382536;383561;22579.661305080765;25913.870430647727;26240;26295.605565916143;27157.59263611087;36788;44029.55970440255;45002.54997450115;45015.54984450244;46012.53987460083;37167.442488362154;37225.255494890494;37408;37989.430158548195;38239.23521529498;36538.59612289135;36845.63154368422;37009.62990370062;37094.629053710196;37726.62273377231;28076.578851317656;33071.00786976395;34141.658583413846;36072.27855442824;36944.63055369412;29533.556996645497;30116.24709382283;31182.844085779427;31355.686443135277;31363.05910822679;19534.925579093288;23055.423614409774;23511;23664.52670946606;24143.637845431982 12:38:13 INFO - PROCESS | 1665 | |2;jquery.html;340.6100015482273;394.34538665814756;394.7986526871295;401.7468994533443;405.56807000544416;16357.836421635795;18594.907025464872;19712.31006914758;20013;20163.697544536826;15481.380744770224;19571.804281957175;20149.395518134443;20180.59638807223;20328.08523616437;5047.167217409123;5927.792527261547;5952.345242023395;6089.1170780236835;6092.329843717188;5707.857303567403;5842.620229685078;5846.50304724099;5907.113932910055;5936.109583562478;5854.034084376073;5887.969605319052;5909.172715819767;7028.71885124597;7572.129205141397;6312.926802443596;7438.033055702778;7442.404607631403;7501.5874126923;7545.7358992435275;7136.215016348197;7333.1933487316355;7354.448416368794;7359.484836061478;7392.334689877936;20601.969901504865;25336.11323603665;25341.23976280696;26894.327641808915;27116.864415677795;2250.44864008319;2398.9040438382444;2471.295680731001;2471.3450935502105;2726.8636568171514;11979.161458697894;14253.572392828231;14378.28108594566;15545.222738863125;15809.130497822614;1719.423992962359;1805.7652505174374;1844.0687452836366;1868.2340240501464;1893.611809579033;117589.82410175874;123629;125869.74130258671;126483.73516264811;127897.36051319684;20615.587688246153;20743.125365539086;20952.371428857157;21169.25907593227;21226.681599776017;33885.661143388745;34102.65897340995;34612.82693586516;34709.47935780965;34715.437805298825;9866.457344846101;10966.451677416257;10982.780344393228;11119.16606254518;11213.159013074051;9167.724968250963;9181.173694367539;9226.308026897876;9292.07079292079;9317.860232096524;9427.90572094284;9662.130408263149;9724.805503889882;9745.902540974499;9765.804683906283;3252.756043296762;3254.511823226535;3778.9244215115546;3849.345611246095;3896.5908579598736;881.8633111867671;922.4050487435701;944.8960614332418;986.4032260482448;990.2375171118342;14724.411023558938;16551.420700275674;17099.401520946707;18820.247190112517;19162.904185478983;852.8123812761182;921.5576523268735;950.6245033211843;1001.3441196016621;1002.8495725641212;10390.740231494274;10461.006204410722;10496.790064198825;10522.210834187466;10538.57845686164;473959;618870;629782;631797;633693;119855.40072299582;122030;124437.37781311036;126728;129664;855.7261676263536;1030.8711411073616;1047.0314958663207;1048.632978457549;1051.7002654243504;15309.38762449534;17556.912215438842;17901.731474027638;17908;17996;49717;51292.46122616327;52040;52181.21728174004;52678.47321526735;70511.64744176246;73239.26760732324;73320.53358932899;74973;75351;7815.25755053269;7820.882686759817;7836.912604741068;7902.525848449111;7966.322862556747;8774.153931482706;9986;11934.820977685515;12015.459304331502;12024.819627705416;8372.539510326991;9901.950490247502;10025;10259.948700256451;10418.218633602359;8533.35999800005;9350.95324523373;10071.949640251752;10218.489075546044;10258.794824103625;10419.322744021918;10507;10536.315139515908;10649.574017039542;10967.890321097006;7655.923440765521;7727.536347818924;7792.922070779219;7844.6077696113825;7927.365810735243;6088.452039316306;9417.587361895496;10292.279540432099;10382.937033574963;10392.428416436866 12:38:13 INFO - PROCESS | 1665 | |3;mootools.html;1609.0989046134166;1613.2337139858569;1886.594382207825;1951.71700103485;1968.9606207875834;7811.765647030584;8374.623141958611;8385;8739.868901966476;8744.562771861405;8449.746507604781;8457.492550446977;8513.446625969307;8598.699045533407;8603;2353.5410594933996;2396.6405039244164;2398.400399900025;2398.7721166489155;2401.939951501209;2020.4342784020498;2099.5695882344157;2275.782456385834;2419.1412048722714;2425.223928342931;1990.4227773945538;2410.349205714456;2411.445367565461;2419.21375552946;2422.4307287787356;2346.9061237550477;2384.7257565380028;2392.2703575409582;2394.628832530952;2415.5893498105365;2027.6654352031896;2359.796503783066;2361.775631315022;2379.1078345620394;2385.689860318165;8151.388645851584;8364.247217750431;8483.957580212122;8528.232459078712;8540.274076703425;3863.1887303666263;5181.611379146579;5316.707581083039;5344.225087362311;5395.622306438551;3383.915402114967;3470.514128022079;3505.474178873164;3543.362194804934;3555.982220088909;1014.122783792022;1031.886492485826;1041.666666666667;1054.3305001324138;1059.8516207730925;11254.887451125547;11378.203525753117;11413.771724565546;11414.086873050135;11435.199536032482;4731.621470282438;4748.738819364969;4771.6898401603785;4784.904301913943;4899.902001960012;9631.036896310314;9649.276304277208;9767.267454940766;9825;9854;5262.210668399771;5265.078611243017;5325.813596524181;5334.786608535693;5350.3312085989255;4362.76004819738;4723.716577005391;4856;4894.510548945077;4902.215645496774;3193.536937144101;3428.7428442866885;3445.500402441632;3905.2189562087697;3962.9603703963166;1246.5851258821303;1361.659585103724;1363.4341748174595;1373.25844044217;1376.7865980772997;734.963251837406;869.1959937058195;919.1543779722671;933.5938866593053;940.2337095267335;5682.147677848356;5775.16260142277;5790.073588225863;5924.733386997509;6109.236345456818;431.35727765629616;449.0569803412872;452.90941811637805;459.0589291951486;474.0211463328216;3815.1502041343633;3932.528096628366;3946.2699400610977;3957.724754626029;3990.3016972029777;10173.491325433699;10522.053015228666;10658.573657053632;10679.252452328263;10688.51901664427;10342.534585943651;10440.582376704846;10518.894811051945;10533.999270069331;10612.416317102634;6852.6231057292325;7984.960075199587;8102.351811855037;8112.959435202786;8199.95900020496;5587.860303492445;5731.02572562657;5825.155352473783;5834.679092649945;5877.147813567094;9801.656942006995;9904.50477476109;9941.502924853872;9967.750806229902;9984.750381240527;9650.372725772802;9870.506474676382;9952.25358098131;10058.547365368722;10065.396076235449;6134.38656134383;7092.574445533284;7327.377172940147;7355.5586664800285;7408.148062972827;8038.758837234892;8068.87896681562;8085.474444161111;8162.142974987541;8172.591370431336;7123.964380178066;7227.313405226495;7263.709451622088;7343.3390994810725;7389.889151662837;6937.89593156093;7109.28907109285;7170.605616691132;7177.318154775288;7260.709571617076;6777.288384719731;6890.827729306808;6917.515773895779;6925.099737034153;6929.549579277331;4597.149527337319;4814.759262036814;4831.154547954024;4956.454789973028;5049.2426136079885;4799.784009719501;4868.756562171948;4869.391326084239;4876.731779752147;5025.84922452327 12:38:13 INFO - PROCESS | 1665 | |4;prototype.html;263.84565029457764;319.49838753157536;323.24683487474175;325.5117324013978;329.17541558396215;5519.586031047673;5602.775888964442;5632.3804381518;5635.8591035224035;5654.208410822488;5481.834675303253;5541.639793413426;5550.833474995757;5569.470900264469;5616.66300021999;4002.919941601166;4144.564820693829;4224.8521301754445;4278.122984788111;4285.871423857289;4133.2353514599745;4240.194363071022;4265.104328091104;4286.978565107186;4290.806913688876;4229.767362795045;4245.893852653678;4256.489221293449;4269.935950960738;4270.743755374672;3989.3218152914073;4261.914761704764;4271.188474189925;4283;4305.203537345601;3715.442683597455;3732.42147467143;3739.8593429004145;3740.6907582346234;3754.511913451234;4777.402824646919;4915.852524424273;4961.677490963076;5032.924506132411;5229.751206980996;4405.907194082817;4632.2819962905805;4752.5485078917445;4855.174620314555;4934.827281045146;5098.974505127488;5822.854428639275;5847;5857.355690874;5870.26621672291;3494.405950988338;3673.9529234168135;3892.1631849152286;4106.7125301228925;4132.070284186064;5411.621186516945;5542.39033706292;5572.885422915433;5667.291588551431;5690.459406356431;4153.418521407006;4156.667466602665;4190.20386126635;4195.1819395217635;4195.4336164618;3753.4557489163917;3931.8427262909163;4053.4527838741983;4266.509351424564;4277.401163837066;4390.814480090357;4735.692180008357;4800.687955282895;4864.197407427806;4922.532359425849;5428.619996600279;5884.352721200665;5921.5558833086825;5945.583809133405;5987.9101813472835;1478.9556313310618;1556.564162034632;1559.384043302889;1559.6023014131324;1562.4609509719128;805.6374631415769;858.9570521473902;973.8101070291367;1039.5166247694858;1052.4737631184407;5802.564807639359;5864.296284445809;5881.411858814085;5883.7058147092475;5891.49922256613;6416.663335065739;6517.315681853432;6523.902141467882;6550.508711846535;6553.967230163914;5591.664500130005;5596.496315331639;5812.273465816773;5847.380569350251;5892.528597712173;3343.6656334366367;3421.4867769834227;3422.5892892853017;3429.9142521436665;3436.60479044908;6053.303870055;6484.027395890655;6675.9762605356145;6742.258351581322;6762.932370676329;5766.481016708516;6330.366963303725;6445.452136568444;6511.186101737283;6632.568883022588;6059.848503787441;6739.191297044288;6748.628825414649;6762.357576030269;6778.576498935279;6396.520260980352;6409.35906409374;6458.54790164684;6475.190601174853;6506.446952008943;5100.515451032146;6097.603655762361;6308.526860485574;6344.238691357066;6402.917228632725;5236.895262094813;5638.182463542681;6050.7595942832495;6420.414239611381;6500.869982600416;3767.6420740029653;3982.3230050892;4023.6177563131455;4057.350823868167;4073.77979001439;4654.671795508128;4849.660523763444;5316.521513063843;6249.375062493896;6259.6870156492905;4898.706077635354;5509.724513774376;5612.326520817528;5859.355470898113;5927.288725352985;5124.20730701761;5661.207430959586;5773.393793651606;5938.317093534126;6018.458338749533;4950.960298337245;5565.276514053147;5625.578081643975;5858.297004359504;5884.6469211847425;5155.607985843876;5945.256842894638;5986.461218490357;6000.819975400745;6013.278406591237;5103.897922041612;5361.865953351197;5656.886862262814;5813.09896965971;5843.474087332161 12:38:13 INFO - PROCESS | 1665 | |5;yui.html;583.6323116436647;643.8937575300075;661.7022339947024;688.4629988608883;696.5750891955903;14696.632584185401;14967.101973881547;15015.624609384771;15162.090274583532;15203.619909502268;13934.233617151052;13964;13971.860281397183;13996.580102596912;14048;608.8417011576978;799.5122974985254;869.3045563549135;888.8222355528904;902.9638814447447;892.8526793079134;895.494045864088;897.2642433204775;898.5641963647626;905.266733945503;954.9283803714715;959.0553304994575;961.1541843177994;963.7157038673608;964.1563631822156;919.641339877445;920.2224120618067;923.0354279777648;957.0620791624212;958.6213445688984;687.5496549759915;690.102866273847;708.5961002228731;713.4791602130474;714.1679942866606;14552.981291309612;14580.781288280685;14605.78091328631;15055.774163387558;15081.622959425993;12798;12910.87089129106;12963.611091667264;13056.804147937788;13198.53805116826;8892.822143557158;10084;10257.333273337284;10395.16838652906;10521.736956576147;3211.197200699825;3380.746444016684;3473.3400653875683;3492.947605785915;3502.492138639883;87960.56019719924;88540;89040.55479722624;89463.65804512937;91966.70083247905;8499.66001359951;9153.862692059625;9553.132563187788;9629.32594718363;9846.015398460097;18347.266109355744;22885.427864303525;23083.961221745063;23110.53778924412;23113.306600802003;7336.889946650805;7415.777526674208;7467;7543.057117860268;7834.843303134019;3520.8239588020497;3994.201159768;3998.7400818946676;4025.1144748155943;4046.089629833264;3461.0655123116617;3466.1507930557177;3467.046562195366;3544.2557063017057;3558.2349794794245;528.5612941258746;623.510544222783;623.5510432488601;638.7828138432955;646.1728986896779;515.1397166731567;546.5982502860394;579.5461875486897;588.4674369695432;622.1010639625788;6245.812625621239;7978.960105199437;8052.59737013147;8143.267105960492;8161.959190204011;486.6131425516723;577.2466930655451;582.6620560075146;597.8879284530769;600.9098635204755;3825.885223443301;3842.481265029185;3861.362875125573;3905.297046531595;3908.4528166056775;95898;99002.5049874746;99889.5016574752;100852.99147008582;105292;86245.13754862496;86394;86570;86981.56509217413;87135;75450;77308;77315.61342193253;77533;78935.60532197417;7407;7581.5595036942805;8221.83556328882;8262.628181731716;8442.071372148936;43219;43499.347509788015;44781.55218447774;45673.54326456693;46149.30776038295;45029.774851125534;66469;67365.66317168383;67789.66105169442;68852.31147688659;10269.948650256702;10270.6405275815;10513.474326283807;10703.464826758787;10860.663883919573;11905.583304584297;12041;12190.57332993341;12263.69340766488;12404.379781010733;11343;11518.82721759191;11671.066314694634;11829.645110646694;11891.643250702493;11263.943680281875;11465.369404682822;11616.477258523219;11679.261753335828;12543.749125017632;10605.363678179334;10994.34033957965;11125.109991200847;11182.496787644413;11610.24533405326;9432.434053956784;9538.251270719245;9547.809043819223;9691.370060946016;9931.404115753077;9424.293178011814;9428.811423771624;9793.608255669693;9838.917719051042;9885.55515001841 12:38:13 INFO - PROCESS | 1665 | __end_tp_report 12:38:13 INFO - PROCESS | 1665 | __start_cc_report 12:38:13 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,414 12:38:13 INFO - PROCESS | 1665 | __end_cc_report 12:38:13 INFO - PROCESS | 1665 | __startTimestamp1461785893247__endTimestamp 12:38:13 INFO - PROCESS | 1665 | 12:38:13 INFO - PROCESS | 1665 | ------- Summary: start ------- 12:38:13 INFO - PROCESS | 1665 | Number of tests: 6 12:38:13 INFO - PROCESS | 1665 | 12:38:13 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5762.48 Median:6010.64 stddev:790.67 (13.2%) stddev-sans-first:772.31 12:38:13 INFO - PROCESS | 1665 | Values: 3466.8 3474.4 3516.9 3519.1 3557.4 5801.1 5803.7 5805.9 5809.6 5832.8 5651.8 5749.8 5753.3 5848.6 5870.4 5205.2 5291.6 5292.2 5325.7 5355.0 125.3 5216.9 5251.9 5286.9 5291.4 5268.2 5277.8 5320.6 5336.2 5370.3 4284.9 5327.9 5341.6 5350.5 5370.9 5177.1 5187.2 5307.5 5308.9 5338.9 5620.3 5712.9 5742.5 5758.3 5760.0 6323.1 6323.7 6339.0 6349.9 6363.7 6192.3 6254.3 6327.0 6344.8 6359.8 5106.1 5763.1 5884.1 5946.4 5982.3 6161.1 6349.8 6350.0 6366.8 6374.1 5224.3 6267.3 6267.7 6288.4 6305.8 4641.7 6293.5 6317.8 6323.7 6372.9 6167.8 6226.3 6232.5 6258.2 6281.5 6216.8 6318.1 6324.0 6327.1 6333.9 4938.5 5010.6 5018.7 5028.1 5032.9 4420.4 4449.4 4501.8 4517.2 4528.1 5780.3 5889.9 5911.9 5931.7 5953.6 6249.2 6262.4 6266.1 6277.0 6319.9 5829.5 5863.8 5930.9 5941.1 5989.8 5411.8 5442.0 5450.2 5488.0 5527.5 6450.7 6471.8 6487.8 6491.1 6506.7 6200.3 6210.8 6281.6 6302.9 6306.3 6438.9 6450.0 6467.5 6480.6 6483.4 5878.3 5934.6 6314.1 6325.5 6327.3 5047.9 5289.3 6163.0 6219.8 6270.2 6182.4 6195.4 6234.5 6291.9 6317.2 5104.9 6201.4 6250.1 6259.3 6265.7 6010.6 6021.0 6061.4 6099.4 6167.6 6137.9 6182.1 6192.2 6219.5 6229.3 6019.2 6077.6 6124.5 6134.8 6149.1 12:38:13 INFO - PROCESS | 1665 | 12:38:13 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:54311.17 Median:199506.80 stddev:111031.68 (55.7%) stddev-sans-first:111269.65 12:38:13 INFO - PROCESS | 1665 | Values: 500.8 535.2 565.6 576.8 631.6 28848.1 37250.1 37313.0 37354.8 37406.8 40442.8 40972.4 41239.8 41242.2 41298.6 7799.4 9583.1 9587.7 9595.0 9596.2 7982.4 9430.8 9534.9 9558.2 9558.6 9429.6 9533.4 9579.4 9590.7 9641.3 9483.5 9490.9 9577.9 9580.3 9597.6 9373.4 9483.3 9504.1 9505.7 9536.2 38266.0 38496.4 38762.0 38915.8 38995.4 2840.6 3053.9 3105.1 3294.3 3402.9 20205.2 26704.3 26930.2 27526.6 27704.3 2632.7 2648.6 2658.9 2732.7 2810.7 290335.0 358686.2 362475.0 368817.0 370611.0 32920.3 33737.8 34747.7 34881.8 34971.5 34615.7 34944.8 34983.0 35010.8 35464.6 14702.6 14893.0 14913.9 14929.7 14936.3 12623.1 12640.7 12731.6 12734.5 12747.7 7861.5 7907.4 7911.2 7983.3 8093.1 3420.6 3420.9 3446.5 3461.4 3463.7 982.1 988.6 1052.9 1061.4 1091.3 29322.0 29463.4 29641.9 29979.4 30226.5 1046.5 1137.2 1162.0 1218.2 1218.3 14035.4 14194.6 15230.9 15254.0 15328.9 500012.0 500214.0 503537.0 507058.0 508413.0 57997.7 58302.6 58548.4 58687.0 58811.4 1263.2 1413.5 1458.6 1460.0 1470.6 26751.6 28348.4 28805.3 28980.7 29449.9 50363.7 50442.0 50598.7 50798.0 50832.7 380695.0 380935.0 381559.0 382536.0 383561.0 22579.7 25913.9 26240.0 26295.6 27157.6 36788.0 44029.6 45002.5 45015.5 46012.5 37167.4 37225.3 37408.0 37989.4 38239.2 36538.6 36845.6 37009.6 37094.6 37726.6 28076.6 33071.0 34141.7 36072.3 36944.6 29533.6 30116.2 31182.8 31355.7 31363.1 19534.9 23055.4 23511.0 23664.5 24143.6 12:38:13 INFO - PROCESS | 1665 | 12:38:13 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:35809.15 Median:17221.63 stddev:100135.38 (581.5%) stddev-sans-first:100380.87 12:38:13 INFO - PROCESS | 1665 | Values: 340.6 394.3 394.8 401.7 405.6 16357.8 18594.9 19712.3 20013.0 20163.7 15481.4 19571.8 20149.4 20180.6 20328.1 5047.2 5927.8 5952.3 6089.1 6092.3 5707.9 5842.6 5846.5 5907.1 5936.1 5854.0 5888.0 5909.2 7028.7 7572.1 6312.9 7438.0 7442.4 7501.6 7545.7 7136.2 7333.2 7354.4 7359.5 7392.3 20602.0 25336.1 25341.2 26894.3 27116.9 2250.4 2398.9 2471.3 2471.3 2726.9 11979.2 14253.6 14378.3 15545.2 15809.1 1719.4 1805.8 1844.1 1868.2 1893.6 117589.8 123629.0 125869.7 126483.7 127897.4 20615.6 20743.1 20952.4 21169.3 21226.7 33885.7 34102.7 34612.8 34709.5 34715.4 9866.5 10966.5 10982.8 11119.2 11213.2 9167.7 9181.2 9226.3 9292.1 9317.9 9427.9 9662.1 9724.8 9745.9 9765.8 3252.8 3254.5 3778.9 3849.3 3896.6 881.9 922.4 944.9 986.4 990.2 14724.4 16551.4 17099.4 18820.2 19162.9 852.8 921.6 950.6 1001.3 1002.8 10390.7 10461.0 10496.8 10522.2 10538.6 473959.0 618870.0 629782.0 631797.0 633693.0 119855.4 122030.0 124437.4 126728.0 129664.0 855.7 1030.9 1047.0 1048.6 1051.7 15309.4 17556.9 17901.7 17908.0 17996.0 49717.0 51292.5 52040.0 52181.2 52678.5 70511.6 73239.3 73320.5 74973.0 75351.0 7815.3 7820.9 7836.9 7902.5 7966.3 8774.2 9986.0 11934.8 12015.5 12024.8 8372.5 9902.0 10025.0 10259.9 10418.2 8533.4 9351.0 10071.9 10218.5 10258.8 10419.3 10507.0 10536.3 10649.6 10967.9 7655.9 7727.5 7792.9 7844.6 7927.4 6088.5 9417.6 10292.3 10382.9 10392.4 12:38:13 INFO - PROCESS | 1665 | 12:38:13 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5585.37 Median:4873.06 stddev:3135.86 (64.4%) stddev-sans-first:3130.42 12:38:13 INFO - PROCESS | 1665 | Values: 1609.1 1613.2 1886.6 1951.7 1969.0 7811.8 8374.6 8385.0 8739.9 8744.6 8449.7 8457.5 8513.4 8598.7 8603.0 2353.5 2396.6 2398.4 2398.8 2401.9 2020.4 2099.6 2275.8 2419.1 2425.2 1990.4 2410.3 2411.4 2419.2 2422.4 2346.9 2384.7 2392.3 2394.6 2415.6 2027.7 2359.8 2361.8 2379.1 2385.7 8151.4 8364.2 8484.0 8528.2 8540.3 3863.2 5181.6 5316.7 5344.2 5395.6 3383.9 3470.5 3505.5 3543.4 3556.0 1014.1 1031.9 1041.7 1054.3 1059.9 11254.9 11378.2 11413.8 11414.1 11435.2 4731.6 4748.7 4771.7 4784.9 4899.9 9631.0 9649.3 9767.3 9825.0 9854.0 5262.2 5265.1 5325.8 5334.8 5350.3 4362.8 4723.7 4856.0 4894.5 4902.2 3193.5 3428.7 3445.5 3905.2 3963.0 1246.6 1361.7 1363.4 1373.3 1376.8 735.0 869.2 919.2 933.6 940.2 5682.1 5775.2 5790.1 5924.7 6109.2 431.4 449.1 452.9 459.1 474.0 3815.2 3932.5 3946.3 3957.7 3990.3 10173.5 10522.1 10658.6 10679.3 10688.5 10342.5 10440.6 10518.9 10534.0 10612.4 6852.6 7985.0 8102.4 8113.0 8200.0 5587.9 5731.0 5825.2 5834.7 5877.1 9801.7 9904.5 9941.5 9967.8 9984.8 9650.4 9870.5 9952.3 10058.5 10065.4 6134.4 7092.6 7327.4 7355.6 7408.1 8038.8 8068.9 8085.5 8162.1 8172.6 7124.0 7227.3 7263.7 7343.3 7389.9 6937.9 7109.3 7170.6 7177.3 7260.7 6777.3 6890.8 6917.5 6925.1 6929.5 4597.1 4814.8 4831.2 4956.5 5049.2 4799.8 4868.8 4869.4 4876.7 5025.8 12:38:13 INFO - PROCESS | 1665 | 12:38:13 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4872.84 Median:5455.23 stddev:1508.99 (27.7%) stddev-sans-first:1473.03 12:38:13 INFO - PROCESS | 1665 | Values: 263.8 319.5 323.2 325.5 329.2 5519.6 5602.8 5632.4 5635.9 5654.2 5481.8 5541.6 5550.8 5569.5 5616.7 4002.9 4144.6 4224.9 4278.1 4285.9 4133.2 4240.2 4265.1 4287.0 4290.8 4229.8 4245.9 4256.5 4269.9 4270.7 3989.3 4261.9 4271.2 4283.0 4305.2 3715.4 3732.4 3739.9 3740.7 3754.5 4777.4 4915.9 4961.7 5032.9 5229.8 4405.9 4632.3 4752.5 4855.2 4934.8 5099.0 5822.9 5847.0 5857.4 5870.3 3494.4 3674.0 3892.2 4106.7 4132.1 5411.6 5542.4 5572.9 5667.3 5690.5 4153.4 4156.7 4190.2 4195.2 4195.4 3753.5 3931.8 4053.5 4266.5 4277.4 4390.8 4735.7 4800.7 4864.2 4922.5 5428.6 5884.4 5921.6 5945.6 5987.9 1479.0 1556.6 1559.4 1559.6 1562.5 805.6 859.0 973.8 1039.5 1052.5 5802.6 5864.3 5881.4 5883.7 5891.5 6416.7 6517.3 6523.9 6550.5 6554.0 5591.7 5596.5 5812.3 5847.4 5892.5 3343.7 3421.5 3422.6 3429.9 3436.6 6053.3 6484.0 6676.0 6742.3 6762.9 5766.5 6330.4 6445.5 6511.2 6632.6 6059.8 6739.2 6748.6 6762.4 6778.6 6396.5 6409.4 6458.5 6475.2 6506.4 5100.5 6097.6 6308.5 6344.2 6402.9 5236.9 5638.2 6050.8 6420.4 6500.9 3767.6 3982.3 4023.6 4057.4 4073.8 4654.7 4849.7 5316.5 6249.4 6259.7 4898.7 5509.7 5612.3 5859.4 5927.3 5124.2 5661.2 5773.4 5938.3 6018.5 4951.0 5565.3 5625.6 5858.3 5884.6 5155.6 5945.3 5986.5 6000.8 6013.3 5103.9 5361.9 5656.9 5813.1 5843.5 12:38:13 INFO - PROCESS | 1665 | 12:38:13 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:18906.59 Median:593.18 stddev:27609.96 (4654.6%) stddev-sans-first:27653.13 12:38:13 INFO - PROCESS | 1665 | Values: 583.6 643.9 661.7 688.5 696.6 14696.6 14967.1 15015.6 15162.1 15203.6 13934.2 13964.0 13971.9 13996.6 14048.0 608.8 799.5 869.3 888.8 903.0 892.9 895.5 897.3 898.6 905.3 954.9 959.1 961.2 963.7 964.2 919.6 920.2 923.0 957.1 958.6 687.5 690.1 708.6 713.5 714.2 14553.0 14580.8 14605.8 15055.8 15081.6 12798.0 12910.9 12963.6 13056.8 13198.5 8892.8 10084.0 10257.3 10395.2 10521.7 3211.2 3380.7 3473.3 3492.9 3502.5 87960.6 88540.0 89040.6 89463.7 91966.7 8499.7 9153.9 9553.1 9629.3 9846.0 18347.3 22885.4 23084.0 23110.5 23113.3 7336.9 7415.8 7467.0 7543.1 7834.8 3520.8 3994.2 3998.7 4025.1 4046.1 3461.1 3466.2 3467.0 3544.3 3558.2 528.6 623.5 623.6 638.8 646.2 515.1 546.6 579.5 588.5 622.1 6245.8 7979.0 8052.6 8143.3 8162.0 486.6 577.2 582.7 597.9 600.9 3825.9 3842.5 3861.4 3905.3 3908.5 95898.0 99002.5 99889.5 100853.0 105292.0 86245.1 86394.0 86570.0 86981.6 87135.0 75450.0 77308.0 77315.6 77533.0 78935.6 7407.0 7581.6 8221.8 8262.6 8442.1 43219.0 43499.3 44781.6 45673.5 46149.3 45029.8 66469.0 67365.7 67789.7 68852.3 10269.9 10270.6 10513.5 10703.5 10860.7 11905.6 12041.0 12190.6 12263.7 12404.4 11343.0 11518.8 11671.1 11829.6 11891.6 11263.9 11465.4 11616.5 11679.3 12543.7 10605.4 10994.3 11125.1 11182.5 11610.2 9432.4 9538.3 9547.8 9691.4 9931.4 9424.3 9428.8 9793.6 9838.9 9885.6 12:38:13 INFO - PROCESS | 1665 | -------- Summary: end -------- 12:38:13 INFO - PROCESS | 1665 | 12:38:13 INFO - TEST-INFO | 1665: exit 0 12:38:13 INFO - TEST-OK | dromaeo_css | took 1111112ms 12:38:13 INFO - TEST-START | kraken 12:38:13 INFO - operating with platform_type : mac_ 12:38:13 INFO - Initialising browser for kraken test... 12:38:13 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmp_QLKHo/profile http://localhost:49271/getInfo.html) 12:38:16 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 12:38:16 INFO - PROCESS | 1678 | colorDepth:24 12:38:16 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 12:38:16 INFO - PROCESS | 1678 | __metrics 12:38:16 ERROR - PROCESS | 1678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:38:17 INFO - TEST-INFO | 1678: exit 0 12:38:17 INFO - Browser initialized. 12:38:17 INFO - Running cycle 1/1 for kraken test... 12:38:17 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmp_QLKHo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:38:29 INFO - PROCESS | 1681 | RSS: Main: 249995264 12:38:29 INFO - PROCESS | 1681 | 12:38:31 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 12:38:32 INFO - PROCESS | 1681 | RSS: Main: 262029312 12:38:32 INFO - PROCESS | 1681 | 12:38:35 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 12:38:36 INFO - PROCESS | 1681 | RSS: Main: 270974976 12:38:36 INFO - PROCESS | 1681 | 12:38:39 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 12:38:40 INFO - PROCESS | 1681 | RSS: Main: 274739200 12:38:40 INFO - PROCESS | 1681 | 12:38:42 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 12:38:43 INFO - PROCESS | 1681 | RSS: Main: 275206144 12:38:43 INFO - PROCESS | 1681 | 12:38:45 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:38:45 INFO - PROCESS | 1681 | RSS: Main: 276975616 12:38:45 INFO - PROCESS | 1681 | 12:38:48 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 12:38:49 INFO - PROCESS | 1681 | RSS: Main: 276852736 12:38:49 INFO - PROCESS | 1681 | 12:38:52 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 12:38:52 INFO - PROCESS | 1681 | RSS: Main: 276971520 12:38:52 INFO - PROCESS | 1681 | 12:38:55 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 12:38:56 INFO - PROCESS | 1681 | RSS: Main: 277164032 12:38:56 INFO - PROCESS | 1681 | 12:38:57 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:38:58 INFO - PROCESS | 1681 | RSS: Main: 276889600 12:38:58 INFO - PROCESS | 1681 | 12:39:00 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:39:01 INFO - PROCESS | 1681 | RSS: Main: 276992000 12:39:01 INFO - PROCESS | 1681 | 12:39:03 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:39:04 INFO - PROCESS | 1681 | RSS: Main: 277426176 12:39:04 INFO - PROCESS | 1681 | 12:39:07 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:39:07 INFO - PROCESS | 1681 | RSS: Main: 277323776 12:39:07 INFO - PROCESS | 1681 | 12:39:11 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:39:11 INFO - PROCESS | 1681 | RSS: Main: 277364736 12:39:11 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 12:39:13 INFO - PROCESS | 1681 | RSS: Main: 278937600 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | __start_tp_report 12:39:13 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 12:39:13 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 12:39:13 INFO - PROCESS | 1681 | |i|pagename|runs| 12:39:13 INFO - PROCESS | 1681 | |0;ai-astar;116;111;116;115;115;128;117;114;116;116 12:39:13 INFO - PROCESS | 1681 | |1;audio-beat-detection;154;124;164;170;139;135;172;153;189;151 12:39:13 INFO - PROCESS | 1681 | |2;audio-dft;197;199;205;234;197;192;177;263;283;203 12:39:13 INFO - PROCESS | 1681 | |3;audio-fft;68;78;76;143;57;70;84;119;165;66 12:39:13 INFO - PROCESS | 1681 | |4;audio-oscillator;79;83;126;76;77;79;117;80;79;119 12:39:13 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;90;88;90;88;92;87;91;88;90;128 12:39:13 INFO - PROCESS | 1681 | |6;imaging-darkroom;95;98;155;125;97;97;97;97;95;96 12:39:13 INFO - PROCESS | 1681 | |7;imaging-desaturate;125;145;125;98;93;97;95;96;92;94 12:39:13 INFO - PROCESS | 1681 | |8;json-parse-financial;57;63;66;60;61;65;82;102;98;92 12:39:13 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;62;67;79;62;72;88;110;100;100;82 12:39:13 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;96;100;105;85;81;84;86;83;86;82 12:39:13 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;160;175;160;135;170;158;147;160;198;170 12:39:13 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;195;205;199;226;254;201;201;203;196;202 12:39:13 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;70;69;72;69;77;74;71;71;70;70 12:39:13 INFO - PROCESS | 1681 | __end_tp_report 12:39:13 INFO - PROCESS | 1681 | __start_cc_report 12:39:13 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1078 12:39:13 INFO - PROCESS | 1681 | __end_cc_report 12:39:13 INFO - PROCESS | 1681 | __startTimestamp1461785953757__endTimestamp 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | ------- Summary: start ------- 12:39:13 INFO - PROCESS | 1681 | Number of tests: 14 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:116.40 Median:116.00 stddev:4.40 (3.8%) stddev-sans-first:4.67 12:39:13 INFO - PROCESS | 1681 | Values: 116.0 111.0 116.0 115.0 115.0 128.0 117.0 114.0 116.0 116.0 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:159.00 stddev:19.40 (12.2%) stddev-sans-first:20.58 12:39:13 INFO - PROCESS | 1681 | Values: 154.0 124.0 164.0 170.0 139.0 135.0 172.0 153.0 189.0 151.0 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:215.00 Median:204.00 stddev:34.01 (16.7%) stddev-sans-first:35.44 12:39:13 INFO - PROCESS | 1681 | Values: 197.0 199.0 205.0 234.0 197.0 192.0 177.0 263.0 283.0 203.0 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:92.60 Median:69.00 stddev:36.72 (53.2%) stddev-sans-first:37.85 12:39:13 INFO - PROCESS | 1681 | Values: 68.0 78.0 76.0 143.0 57.0 70.0 84.0 119.0 165.0 66.0 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:79.00 stddev:20.33 (25.7%) stddev-sans-first:21.06 12:39:13 INFO - PROCESS | 1681 | Values: 79.0 83.0 126.0 76.0 77.0 79.0 117.0 80.0 79.0 119.0 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:93.20 Median:90.00 stddev:12.33 (13.7%) stddev-sans-first:13.02 12:39:13 INFO - PROCESS | 1681 | Values: 90.0 88.0 90.0 88.0 92.0 87.0 91.0 88.0 90.0 128.0 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:105.20 Median:97.00 stddev:19.68 (20.3%) stddev-sans-first:20.52 12:39:13 INFO - PROCESS | 1681 | Values: 95.0 98.0 155.0 125.0 97.0 97.0 97.0 97.0 95.0 96.0 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:106.00 Median:94.50 stddev:18.61 (19.7%) stddev-sans-first:18.43 12:39:13 INFO - PROCESS | 1681 | Values: 125.0 145.0 125.0 98.0 93.0 97.0 95.0 96.0 92.0 94.0 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:74.60 Median:65.50 stddev:17.21 (26.3%) stddev-sans-first:17.03 12:39:13 INFO - PROCESS | 1681 | Values: 57.0 63.0 66.0 60.0 61.0 65.0 82.0 102.0 98.0 92.0 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:82.20 Median:69.50 stddev:17.00 (24.5%) stddev-sans-first:16.39 12:39:13 INFO - PROCESS | 1681 | Values: 62.0 67.0 79.0 62.0 72.0 88.0 110.0 100.0 100.0 82.0 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:84.50 stddev:8.39 (9.9%) stddev-sans-first:8.49 12:39:13 INFO - PROCESS | 1681 | Values: 96.0 100.0 105.0 85.0 81.0 84.0 86.0 83.0 86.0 82.0 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:163.30 Median:165.00 stddev:16.86 (10.2%) stddev-sans-first:17.84 12:39:13 INFO - PROCESS | 1681 | Values: 160.0 175.0 160.0 135.0 170.0 158.0 147.0 160.0 198.0 170.0 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:208.20 Median:202.50 stddev:18.26 (9.0%) stddev-sans-first:18.73 12:39:13 INFO - PROCESS | 1681 | Values: 195.0 205.0 199.0 226.0 254.0 201.0 201.0 203.0 196.0 202.0 12:39:13 INFO - PROCESS | 1681 | 12:39:13 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.00 stddev:2.50 (3.5%) stddev-sans-first:2.60 12:39:13 INFO - PROCESS | 1681 | Values: 70.0 69.0 72.0 69.0 77.0 74.0 71.0 71.0 70.0 70.0 12:39:13 INFO - PROCESS | 1681 | -------- Summary: end -------- 12:39:13 INFO - PROCESS | 1681 | 12:39:14 INFO - TEST-INFO | 1681: exit 0 12:39:14 INFO - TEST-OK | kraken | took 60727ms 12:39:14 INFO - SUITE-END | took 1171s 12:39:14 INFO - Completed test suite (00:19:32) 12:39:14 INFO - javascript benchmark 12:39:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3466.7919924804514, 3474.3919814032547, 3516.8593256269733, 3519.0850378901496, 3557.430811070229, 5801.1008293714485, 5803.709814509273, 5805.883882322356, 5809.622374545662, 5832.766689332432, 5651.7739290428335, 5749.770009199627, 5753.338366087901, 5848.619839710426, 5870.354261031293, 5205.193195054763, 5291.550218231455, 5292.206169074631, 5325.707086110262, 5354.973225133869, 125.28293061831305, 5216.895662086756, 5251.921221181667, 5286.894262114755, 5291.365036195662, 5268.236105764681, 5277.788888444457, 5320.600954928396, 5336.17289320154, 5370.275012873251, 4284.871453856389, 5327.920081198785, 5341.572674186055, 5350.518453339179, 5370.865728356823, 5177.119889618736, 5187.221916712523, 5307.522322990911, 5308.92036619451, 5338.919916201221, 5620.297462817148, 5712.885742285131, 5742.454466825645, 5758.309002919635, 5760.049591817345, 6323.146375239376, 6323.683815809191, 6339.0, 6349.904751428732, 6363.713632886531, 6192.256929168529, 6254.280757712876, 6327.0, 6344.841378965517, 6359.777407790705, 5106.05537975472, 5763.106718458645, 5884.146798714162, 5946.43508866657, 5982.312034116046, 6161.106639537242, 6349.777757778455, 6349.968250158812, 6366.7771627993725, 6374.139491168726, 5224.346956630421, 6267.310595834455, 6267.65527895961, 6288.402601752918, 6305.842353941188, 4641.74470404131, 6293.465055470337, 6317.778877739257, 6323.747050118036, 6372.904406433907, 6167.784127555514, 6226.346233645402, 6232.504198992209, 6258.15514905491, 6281.497480201573, 6216.7824126155365, 6318.052292156213, 6323.9683801580695, 6327.145835312266, 6333.904991425133, 4938.456769755324, 5010.574101201439, 5018.749062546858, 5028.069807085701, 5032.949670503248, 4420.3590479380955, 4449.354843547668, 4501.77491125449, 4517.186906356822, 4528.0943811237885, 5780.306363236438, 5889.911651325234, 5911.852203694856, 5931.73307201177, 5953.553483488669, 6249.189679761518, 6262.373762623793, 6266.122742816009, 6276.968615156987, 6319.936800631935, 5829.47534721877, 5863.794767183128, 5930.9406905931255, 5941.138534912414, 5989.760409583655, 5411.810586629528, 5442.047641662773, 5450.209719590637, 5488.04860500447, 5527.53015993645, 6450.709718062699, 6471.805845824632, 6487.805365839033, 6491.091247225487, 6506.739730410731, 6200.286966998672, 6210.813675589739, 6281.59169653971, 6302.905456418066, 6306.337834527492, 6438.90341644885, 6449.96775016122, 6467.482601391784, 6480.611163330215, 6483.384078512534, 5878.3239927408895, 5934.584579079423, 6314.1160237565855, 6325.525585581007, 6327.303996560467, 5047.914698339874, 5289.338832645919, 6163.013917773134, 6219.844503887258, 6270.216222972129, 6182.381761823782, 6195.380461953949, 6234.501239900887, 6291.905621415774, 6317.241930968313, 5104.948950510596, 6201.379862013762, 6250.062490626442, 6259.34276900937, 6265.74937002533, 6010.639361638316, 6021.036634138517, 6061.424164704346, 6099.430845494592, 6167.599106058092, 6137.907931381123, 6182.1345011699295, 6192.195014648067, 6219.471344935731, 6229.345918678474, 6019.187409699634, 6077.5745697802495, 6124.479419249235, 6134.846628834315, 6149.139120523041], "value": 5716.941293688742, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.81469856153205, 535.2052202479317, 565.5532129617601, 576.7635269539485, 631.5989346764806, 28848.13455596333, 37250.06874828131, 37313.0, 37354.8132259339, 37406.81296593517, 40442.797786011106, 40972.385414218814, 41239.79380103095, 41242.17515649685, 41298.58701412985, 7799.376049916007, 9583.137517623412, 9587.712368628918, 9594.952025239863, 9596.18432433244, 7982.3614110871285, 9430.811383772321, 9534.856977145313, 9558.235341172724, 9558.61765529378, 9429.575669094873, 9533.42799432033, 9579.377340472882, 9590.712278631618, 9641.276904232176, 9483.525823708787, 9490.90509094907, 9577.904220957771, 9580.281478889076, 9597.616095356178, 9373.437593744397, 9483.33616646835, 9504.097110774464, 9505.714828555154, 9536.2371010319, 38266.0, 38496.422553661716, 38762.03094922649, 38915.805420972996, 38995.41506877399, 2840.5597132444504, 3053.92365190872, 3105.1460848266684, 3294.275259442919, 3402.897913062612, 20205.19179232829, 26704.332391690168, 26930.192094237205, 27526.587101193498, 27704.307392315153, 2632.7104018557943, 2648.5762278035613, 2658.9335266618295, 2732.699403065661, 2810.690824009357, 290335.0, 358686.2065689681, 362475.0, 368816.9999999973, 370611.0, 32920.341593168, 33737.83131084378, 34747.65252347495, 34881.77913773006, 34971.4754278686, 34615.65384346175, 34944.82527587346, 34983.0, 35010.82494587511, 35464.64535354613, 14702.55892323232, 14893.031952923026, 14913.92543037278, 14929.701405972037, 14936.32786524609, 12623.053271004712, 12640.6839829005, 12731.554395596295, 12734.490620375267, 12747.68130796719, 7861.489003214772, 7907.406944479187, 7911.208879112043, 7983.321417679563, 8093.109757926623, 3420.6237313895454, 3420.9315813684084, 3446.5347178130633, 3461.394256005189, 3463.7229021678204, 982.1455333859445, 988.5798535622475, 1052.947052947053, 1061.3525749292926, 1091.2850549352693, 29322.0, 29463.410731785243, 29641.851790740908, 29979.40041199164, 30226.54660180099, 1046.5081411736471, 1137.2380505061628, 1162.0297051961707, 1218.1777300322424, 1218.2994778002508, 14035.438582456587, 14194.574162775134, 15230.93383463169, 15254.0, 15328.923355383375, 500012.0, 500214.0, 503537.0, 507058.0, 508413.0, 57997.71001144967, 58302.627302952445, 58548.41451585515, 58687.0, 58811.411885880596, 1263.172621932654, 1413.4699487692114, 1458.555140682081, 1460.0, 1470.6102882736084, 26751.598726019514, 28348.433031338845, 28805.279868002628, 28980.7101928978, 29449.85275073611, 50363.74818125886, 50442.0, 50598.74700626473, 50797.98404031972, 50832.74583627058, 380695.0, 380935.0, 381559.0, 382536.0, 383561.0, 22579.661305080765, 25913.870430647727, 26240.0, 26295.605565916143, 27157.59263611087, 36788.0, 44029.55970440255, 45002.54997450115, 45015.54984450244, 46012.53987460083, 37167.442488362154, 37225.255494890494, 37408.0, 37989.430158548195, 38239.23521529498, 36538.59612289135, 36845.63154368422, 37009.62990370062, 37094.629053710196, 37726.62273377231, 28076.578851317656, 33071.00786976395, 34141.658583413846, 36072.27855442824, 36944.63055369412, 29533.556996645497, 30116.24709382283, 31182.844085779427, 31355.686443135277, 31363.05910822679, 19534.925579093288, 23055.423614409774, 23511.0, 23664.52670946606, 24143.637845431982], "value": 17434.53106567221, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.6100015482273, 394.34538665814756, 394.7986526871295, 401.7468994533443, 405.56807000544416, 16357.836421635795, 18594.907025464872, 19712.31006914758, 20013.0, 20163.697544536826, 15481.380744770224, 19571.804281957175, 20149.395518134443, 20180.59638807223, 20328.08523616437, 5047.167217409123, 5927.792527261547, 5952.345242023395, 6089.1170780236835, 6092.329843717188, 5707.857303567403, 5842.620229685078, 5846.50304724099, 5907.113932910055, 5936.109583562478, 5854.034084376073, 5887.969605319052, 5909.172715819767, 7028.71885124597, 7572.129205141397, 6312.926802443596, 7438.033055702778, 7442.404607631403, 7501.5874126923, 7545.7358992435275, 7136.215016348197, 7333.1933487316355, 7354.448416368794, 7359.484836061478, 7392.334689877936, 20601.969901504865, 25336.11323603665, 25341.23976280696, 26894.327641808915, 27116.864415677795, 2250.44864008319, 2398.9040438382444, 2471.295680731001, 2471.3450935502105, 2726.8636568171514, 11979.161458697894, 14253.572392828231, 14378.28108594566, 15545.222738863125, 15809.130497822614, 1719.423992962359, 1805.7652505174374, 1844.0687452836366, 1868.2340240501464, 1893.611809579033, 117589.82410175874, 123629.0, 125869.74130258671, 126483.73516264811, 127897.36051319684, 20615.587688246153, 20743.125365539086, 20952.371428857157, 21169.25907593227, 21226.681599776017, 33885.661143388745, 34102.65897340995, 34612.82693586516, 34709.47935780965, 34715.437805298825, 9866.457344846101, 10966.451677416257, 10982.780344393228, 11119.16606254518, 11213.159013074051, 9167.724968250963, 9181.173694367539, 9226.308026897876, 9292.07079292079, 9317.860232096524, 9427.90572094284, 9662.130408263149, 9724.805503889882, 9745.902540974499, 9765.804683906283, 3252.756043296762, 3254.511823226535, 3778.9244215115546, 3849.345611246095, 3896.5908579598736, 881.8633111867671, 922.4050487435701, 944.8960614332418, 986.4032260482448, 990.2375171118342, 14724.411023558938, 16551.420700275674, 17099.401520946707, 18820.247190112517, 19162.904185478983, 852.8123812761182, 921.5576523268735, 950.6245033211843, 1001.3441196016621, 1002.8495725641212, 10390.740231494274, 10461.006204410722, 10496.790064198825, 10522.210834187466, 10538.57845686164, 473959.0, 618870.0, 629782.0, 631797.0, 633693.0, 119855.40072299582, 122030.0, 124437.37781311036, 126728.0, 129664.0, 855.7261676263536, 1030.8711411073616, 1047.0314958663207, 1048.632978457549, 1051.7002654243504, 15309.38762449534, 17556.912215438842, 17901.731474027638, 17908.0, 17996.0, 49717.0, 51292.46122616327, 52040.0, 52181.21728174004, 52678.47321526735, 70511.64744176246, 73239.26760732324, 73320.53358932899, 74973.0, 75351.0, 7815.25755053269, 7820.882686759817, 7836.912604741068, 7902.525848449111, 7966.322862556747, 8774.153931482706, 9986.0, 11934.820977685515, 12015.459304331502, 12024.819627705416, 8372.539510326991, 9901.950490247502, 10025.0, 10259.948700256451, 10418.218633602359, 8533.35999800005, 9350.95324523373, 10071.949640251752, 10218.489075546044, 10258.794824103625, 10419.322744021918, 10507.0, 10536.315139515908, 10649.574017039542, 10967.890321097006, 7655.923440765521, 7727.536347818924, 7792.922070779219, 7844.6077696113825, 7927.365810735243, 6088.452039316306, 9417.587361895496, 10292.279540432099, 10382.937033574963, 10392.428416436866], "value": 10405.851003047364, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1609.0989046134166, 1613.2337139858569, 1886.594382207825, 1951.71700103485, 1968.9606207875834, 7811.765647030584, 8374.623141958611, 8385.0, 8739.868901966476, 8744.562771861405, 8449.746507604781, 8457.492550446977, 8513.446625969307, 8598.699045533407, 8603.0, 2353.5410594933996, 2396.6405039244164, 2398.400399900025, 2398.7721166489155, 2401.939951501209, 2020.4342784020498, 2099.5695882344157, 2275.782456385834, 2419.1412048722714, 2425.223928342931, 1990.4227773945538, 2410.349205714456, 2411.445367565461, 2419.21375552946, 2422.4307287787356, 2346.9061237550477, 2384.7257565380028, 2392.2703575409582, 2394.628832530952, 2415.5893498105365, 2027.6654352031896, 2359.796503783066, 2361.775631315022, 2379.1078345620394, 2385.689860318165, 8151.388645851584, 8364.247217750431, 8483.957580212122, 8528.232459078712, 8540.274076703425, 3863.1887303666263, 5181.611379146579, 5316.707581083039, 5344.225087362311, 5395.622306438551, 3383.915402114967, 3470.514128022079, 3505.474178873164, 3543.362194804934, 3555.982220088909, 1014.122783792022, 1031.886492485826, 1041.666666666667, 1054.3305001324138, 1059.8516207730925, 11254.887451125547, 11378.203525753117, 11413.771724565546, 11414.086873050135, 11435.199536032482, 4731.621470282438, 4748.738819364969, 4771.6898401603785, 4784.904301913943, 4899.902001960012, 9631.036896310314, 9649.276304277208, 9767.267454940766, 9825.0, 9854.0, 5262.210668399771, 5265.078611243017, 5325.813596524181, 5334.786608535693, 5350.3312085989255, 4362.76004819738, 4723.716577005391, 4856.0, 4894.510548945077, 4902.215645496774, 3193.536937144101, 3428.7428442866885, 3445.500402441632, 3905.2189562087697, 3962.9603703963166, 1246.5851258821303, 1361.659585103724, 1363.4341748174595, 1373.25844044217, 1376.7865980772997, 734.963251837406, 869.1959937058195, 919.1543779722671, 933.5938866593053, 940.2337095267335, 5682.147677848356, 5775.16260142277, 5790.073588225863, 5924.733386997509, 6109.236345456818, 431.35727765629616, 449.0569803412872, 452.90941811637805, 459.0589291951486, 474.0211463328216, 3815.1502041343633, 3932.528096628366, 3946.2699400610977, 3957.724754626029, 3990.3016972029777, 10173.491325433699, 10522.053015228666, 10658.573657053632, 10679.252452328263, 10688.51901664427, 10342.534585943651, 10440.582376704846, 10518.894811051945, 10533.999270069331, 10612.416317102634, 6852.6231057292325, 7984.960075199587, 8102.351811855037, 8112.959435202786, 8199.95900020496, 5587.860303492445, 5731.02572562657, 5825.155352473783, 5834.679092649945, 5877.147813567094, 9801.656942006995, 9904.50477476109, 9941.502924853872, 9967.750806229902, 9984.750381240527, 9650.372725772802, 9870.506474676382, 9952.25358098131, 10058.547365368722, 10065.396076235449, 6134.38656134383, 7092.574445533284, 7327.377172940147, 7355.5586664800285, 7408.148062972827, 8038.758837234892, 8068.87896681562, 8085.474444161111, 8162.142974987541, 8172.591370431336, 7123.964380178066, 7227.313405226495, 7263.709451622088, 7343.3390994810725, 7389.889151662837, 6937.89593156093, 7109.28907109285, 7170.605616691132, 7177.318154775288, 7260.709571617076, 6777.288384719731, 6890.827729306808, 6917.515773895779, 6925.099737034153, 6929.549579277331, 4597.149527337319, 4814.759262036814, 4831.154547954024, 4956.454789973028, 5049.2426136079885, 4799.784009719501, 4868.756562171948, 4869.391326084239, 4876.731779752147, 5025.84922452327], "value": 4434.958274431747, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [263.84565029457764, 319.49838753157536, 323.24683487474175, 325.5117324013978, 329.17541558396215, 5519.586031047673, 5602.775888964442, 5632.3804381518, 5635.8591035224035, 5654.208410822488, 5481.834675303253, 5541.639793413426, 5550.833474995757, 5569.470900264469, 5616.66300021999, 4002.919941601166, 4144.564820693829, 4224.8521301754445, 4278.122984788111, 4285.871423857289, 4133.2353514599745, 4240.194363071022, 4265.104328091104, 4286.978565107186, 4290.806913688876, 4229.767362795045, 4245.893852653678, 4256.489221293449, 4269.935950960738, 4270.743755374672, 3989.3218152914073, 4261.914761704764, 4271.188474189925, 4283.0, 4305.203537345601, 3715.442683597455, 3732.42147467143, 3739.8593429004145, 3740.6907582346234, 3754.511913451234, 4777.402824646919, 4915.852524424273, 4961.677490963076, 5032.924506132411, 5229.751206980996, 4405.907194082817, 4632.2819962905805, 4752.5485078917445, 4855.174620314555, 4934.827281045146, 5098.974505127488, 5822.854428639275, 5847.0, 5857.355690874, 5870.26621672291, 3494.405950988338, 3673.9529234168135, 3892.1631849152286, 4106.7125301228925, 4132.070284186064, 5411.621186516945, 5542.39033706292, 5572.885422915433, 5667.291588551431, 5690.459406356431, 4153.418521407006, 4156.667466602665, 4190.20386126635, 4195.1819395217635, 4195.4336164618, 3753.4557489163917, 3931.8427262909163, 4053.4527838741983, 4266.509351424564, 4277.401163837066, 4390.814480090357, 4735.692180008357, 4800.687955282895, 4864.197407427806, 4922.532359425849, 5428.619996600279, 5884.352721200665, 5921.5558833086825, 5945.583809133405, 5987.9101813472835, 1478.9556313310618, 1556.564162034632, 1559.384043302889, 1559.6023014131324, 1562.4609509719128, 805.6374631415769, 858.9570521473902, 973.8101070291367, 1039.5166247694858, 1052.4737631184407, 5802.564807639359, 5864.296284445809, 5881.411858814085, 5883.7058147092475, 5891.49922256613, 6416.663335065739, 6517.315681853432, 6523.902141467882, 6550.508711846535, 6553.967230163914, 5591.664500130005, 5596.496315331639, 5812.273465816773, 5847.380569350251, 5892.528597712173, 3343.6656334366367, 3421.4867769834227, 3422.5892892853017, 3429.9142521436665, 3436.60479044908, 6053.303870055, 6484.027395890655, 6675.9762605356145, 6742.258351581322, 6762.932370676329, 5766.481016708516, 6330.366963303725, 6445.452136568444, 6511.186101737283, 6632.568883022588, 6059.848503787441, 6739.191297044288, 6748.628825414649, 6762.357576030269, 6778.576498935279, 6396.520260980352, 6409.35906409374, 6458.54790164684, 6475.190601174853, 6506.446952008943, 5100.515451032146, 6097.603655762361, 6308.526860485574, 6344.238691357066, 6402.917228632725, 5236.895262094813, 5638.182463542681, 6050.7595942832495, 6420.414239611381, 6500.869982600416, 3767.6420740029653, 3982.3230050892, 4023.6177563131455, 4057.350823868167, 4073.77979001439, 4654.671795508128, 4849.660523763444, 5316.521513063843, 6249.375062493896, 6259.6870156492905, 4898.706077635354, 5509.724513774376, 5612.326520817528, 5859.355470898113, 5927.288725352985, 5124.20730701761, 5661.207430959586, 5773.393793651606, 5938.317093534126, 6018.458338749533, 4950.960298337245, 5565.276514053147, 5625.578081643975, 5858.297004359504, 5884.6469211847425, 5155.607985843876, 5945.256842894638, 5986.461218490357, 6000.819975400745, 6013.278406591237, 5103.897922041612, 5361.865953351197, 5656.886862262814, 5813.09896965971, 5843.474087332161], "value": 4392.121582159063, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.6323116436647, 643.8937575300075, 661.7022339947024, 688.4629988608883, 696.5750891955903, 14696.632584185401, 14967.101973881547, 15015.624609384771, 15162.090274583532, 15203.619909502268, 13934.233617151052, 13964.0, 13971.860281397183, 13996.580102596912, 14048.0, 608.8417011576978, 799.5122974985254, 869.3045563549135, 888.8222355528904, 902.9638814447447, 892.8526793079134, 895.494045864088, 897.2642433204775, 898.5641963647626, 905.266733945503, 954.9283803714715, 959.0553304994575, 961.1541843177994, 963.7157038673608, 964.1563631822156, 919.641339877445, 920.2224120618067, 923.0354279777648, 957.0620791624212, 958.6213445688984, 687.5496549759915, 690.102866273847, 708.5961002228731, 713.4791602130474, 714.1679942866606, 14552.981291309612, 14580.781288280685, 14605.78091328631, 15055.774163387558, 15081.622959425993, 12798.0, 12910.87089129106, 12963.611091667264, 13056.804147937788, 13198.53805116826, 8892.822143557158, 10084.0, 10257.333273337284, 10395.16838652906, 10521.736956576147, 3211.197200699825, 3380.746444016684, 3473.3400653875683, 3492.947605785915, 3502.492138639883, 87960.56019719924, 88540.0, 89040.55479722624, 89463.65804512937, 91966.70083247905, 8499.66001359951, 9153.862692059625, 9553.132563187788, 9629.32594718363, 9846.015398460097, 18347.266109355744, 22885.427864303525, 23083.961221745063, 23110.53778924412, 23113.306600802003, 7336.889946650805, 7415.777526674208, 7467.0, 7543.057117860268, 7834.843303134019, 3520.8239588020497, 3994.201159768, 3998.7400818946676, 4025.1144748155943, 4046.089629833264, 3461.0655123116617, 3466.1507930557177, 3467.046562195366, 3544.2557063017057, 3558.2349794794245, 528.5612941258746, 623.510544222783, 623.5510432488601, 638.7828138432955, 646.1728986896779, 515.1397166731567, 546.5982502860394, 579.5461875486897, 588.4674369695432, 622.1010639625788, 6245.812625621239, 7978.960105199437, 8052.59737013147, 8143.267105960492, 8161.959190204011, 486.6131425516723, 577.2466930655451, 582.6620560075146, 597.8879284530769, 600.9098635204755, 3825.885223443301, 3842.481265029185, 3861.362875125573, 3905.297046531595, 3908.4528166056775, 95898.0, 99002.5049874746, 99889.5016574752, 100852.99147008582, 105292.0, 86245.13754862496, 86394.0, 86570.0, 86981.56509217413, 87135.0, 75450.0, 77308.0, 77315.61342193253, 77533.0, 78935.60532197417, 7407.0, 7581.5595036942805, 8221.83556328882, 8262.628181731716, 8442.071372148936, 43219.0, 43499.347509788015, 44781.55218447774, 45673.54326456693, 46149.30776038295, 45029.774851125534, 66469.0, 67365.66317168383, 67789.66105169442, 68852.31147688659, 10269.948650256702, 10270.6405275815, 10513.474326283807, 10703.464826758787, 10860.663883919573, 11905.583304584297, 12041.0, 12190.57332993341, 12263.69340766488, 12404.379781010733, 11343.0, 11518.82721759191, 11671.066314694634, 11829.645110646694, 11891.643250702493, 11263.943680281875, 11465.369404682822, 11616.477258523219, 11679.261753335828, 12543.749125017632, 10605.363678179334, 10994.34033957965, 11125.109991200847, 11182.496787644413, 11610.24533405326, 9432.434053956784, 9538.251270719245, 9547.809043819223, 9691.370060946016, 9931.404115753077, 9424.293178011814, 9428.811423771624, 9793.608255669693, 9838.917719051042, 9885.55515001841], "value": 6862.01458781063, "unit": "score"}], "name": "dromaeo_css", "value": 7194.234749838533, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 116.0, 115.0, 115.0, 128.0, 117.0, 114.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 164.0, 170.0, 139.0, 135.0, 172.0, 153.0, 189.0, 151.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 199.0, 205.0, 234.0, 197.0, 192.0, 177.0, 263.0, 283.0, 203.0], "value": 215.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 78.0, 76.0, 143.0, 57.0, 70.0, 84.0, 119.0, 165.0, 66.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 126.0, 76.0, 77.0, 79.0, 117.0, 80.0, 79.0, 119.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 90.0, 88.0, 92.0, 87.0, 91.0, 88.0, 90.0, 128.0], "value": 93.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 155.0, 125.0, 97.0, 97.0, 97.0, 97.0, 95.0, 96.0], "value": 105.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 145.0, 125.0, 98.0, 93.0, 97.0, 95.0, 96.0, 92.0, 94.0], "value": 106.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 66.0, 60.0, 61.0, 65.0, 82.0, 102.0, 98.0, 92.0], "value": 74.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 67.0, 79.0, 62.0, 72.0, 88.0, 110.0, 100.0, 100.0, 82.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 100.0, 105.0, 85.0, 81.0, 84.0, 86.0, 83.0, 86.0, 82.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 175.0, 160.0, 135.0, 170.0, 158.0, 147.0, 160.0, 198.0, 170.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 205.0, 199.0, 226.0, 254.0, 201.0, 201.0, 203.0, 196.0, 202.0], "value": 208.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 72.0, 69.0, 77.0, 74.0, 71.0, 71.0, 70.0, 70.0], "value": 71.3, "unit": "score"}], "name": "kraken", "value": 1663.4, "alertThreshold": 2.0}]} 12:39:14 INFO - Return code: 0 12:39:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:39:15 ERROR - # TBPL SUCCESS # 12:39:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:39:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:39:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:39:15 INFO - 2016-04-27 12:39:15.063 screenresolution[1686:10601] starting screenresolution argv=screenresolution get 12:39:15 INFO - 2016-04-27 12:39:15.066 screenresolution[1686:10601] Display 0: 1600x1200x32@60 12:39:15 INFO - 2016-04-27 12:39:15.072 screenresolution[1687:10605] starting screenresolution argv=screenresolution list 12:39:15 INFO - Available Modes on Display 0 12:39:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:39:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:39:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:39:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:39:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:39:15 INFO - Intel Iris: 12:39:15 INFO - Chipset Model: Intel Iris 12:39:15 INFO - Type: GPU 12:39:15 INFO - Bus: Built-In 12:39:15 INFO - VRAM (Dynamic, Max): 1536 MB 12:39:15 INFO - Vendor: Intel (0x8086) 12:39:15 INFO - Device ID: 0x0a2e 12:39:15 INFO - Revision ID: 0x0009 12:39:15 INFO - Displays: 12:39:15 INFO - Display: 12:39:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:39:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:39:15 INFO - Display Serial Number: 1600x1200 60 12:39:15 INFO - Main Display: Yes 12:39:15 INFO - Mirror: Off 12:39:15 INFO - Online: Yes 12:39:15 INFO - Rotation: Supported 12:39:15 INFO - Return code: 0 12:39:15 INFO - Running post-action listener: _resource_record_post_action 12:39:15 INFO - Running post-run listener: _resource_record_post_run 12:39:16 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 38086144; Write bytes: 697375232; Read time: 398; Write time: 1892 12:39:16 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395504128; Write bytes: 388867584; Read time: 29691; Write time: 698 12:39:16 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 36267520; Write bytes: 299160576; Read time: 377; Write time: 1169 12:39:16 INFO - Running post-run listener: _upload_blobber_files 12:39:16 INFO - Blob upload gear active. 12:39:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:39:16 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 12:39:16 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'] 12:39:16 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 12:39:16 INFO - (blobuploader) - INFO - Open directory for files ... 12:39:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:39:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:39:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:18 INFO - (blobuploader) - INFO - Done attempting. 12:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:39:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:18 INFO - (blobuploader) - INFO - Done attempting. 12:39:18 INFO - (blobuploader) - INFO - Iteration through files over. 12:39:18 INFO - Return code: 0 12:39:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:39:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:39:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67486e877810d72682f6dc9f78bf9124246a5c155eb88591bf9139c7515d13d705c347a291fa66ae6f3ad4435ea76d3bc6d3f550d75dd9f0d4a3323fd73455ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/363430b39b911571c762965a28e2a65b8be6f0afa5e35b2367b6fd4631b9394e0dc7b78d10ffee9f09efb0b4fa11222272f181b39539c1a859a1037a0c8a0d53"} 12:39:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:39:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:39:18 INFO - Contents: 12:39:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67486e877810d72682f6dc9f78bf9124246a5c155eb88591bf9139c7515d13d705c347a291fa66ae6f3ad4435ea76d3bc6d3f550d75dd9f0d4a3323fd73455ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/363430b39b911571c762965a28e2a65b8be6f0afa5e35b2367b6fd4631b9394e0dc7b78d10ffee9f09efb0b4fa11222272f181b39539c1a859a1037a0c8a0d53"} 12:39:18 INFO - Running post-run listener: copy_logs_to_upload_dir 12:39:18 INFO - Copying logs to upload dir... 12:39:18 INFO - mkdir: /builds/slave/test/build/upload/logs 12:39:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.819866 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-04-27 12:39:19.031911) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 12:39:19.035389) ========= 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.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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/67486e877810d72682f6dc9f78bf9124246a5c155eb88591bf9139c7515d13d705c347a291fa66ae6f3ad4435ea76d3bc6d3f550d75dd9f0d4a3323fd73455ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/363430b39b911571c762965a28e2a65b8be6f0afa5e35b2367b6fd4631b9394e0dc7b78d10ffee9f09efb0b4fa11222272f181b39539c1a859a1037a0c8a0d53"} build_url:https://queue.taskcluster.net/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010768 build_url: 'https://queue.taskcluster.net/v1/task/eL6BK3EITLKJxh0Ix5881w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67486e877810d72682f6dc9f78bf9124246a5c155eb88591bf9139c7515d13d705c347a291fa66ae6f3ad4435ea76d3bc6d3f550d75dd9f0d4a3323fd73455ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/363430b39b911571c762965a28e2a65b8be6f0afa5e35b2367b6fd4631b9394e0dc7b78d10ffee9f09efb0b4fa11222272f181b39539c1a859a1037a0c8a0d53"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 12:39:19.066479) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 12:39:19.067157) ========= 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.ApaaB0zkvx/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.QJhH0Wm4J5/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.005136 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 12:39:19.117335) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 12:39:19.117726) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 12:39:19.118172) ========= ========= Total master_lag: 0.16 =========