builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0264 starttime: 1463161409.92 results: success (0) buildid: 20160513090035 builduid: 5ba24935d4164d6f9036414264444526 revision: a225f011dec1e24bb17e9c3ab0df54ac95875d34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:29.918922) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:29.919539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:29.920047) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:29.940012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:29.940328) ========= 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.sKlZC4G3m4/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.5GN4WXD1ak/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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-05-13 10:43:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.5M=0.001s 2016-05-13 10:43:30 (12.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.486024 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:30.476981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:30.477428) ========= 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.sKlZC4G3m4/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.5GN4WXD1ak/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.019786 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:30.527376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-05-13 10:43:30.527836) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a225f011dec1e24bb17e9c3ab0df54ac95875d34 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a225f011dec1e24bb17e9c3ab0df54ac95875d34 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sKlZC4G3m4/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.5GN4WXD1ak/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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-05-13 10:43:30,446 truncating revision to first 12 chars 2016-05-13 10:43:30,446 Setting DEBUG logging. 2016-05-13 10:43:30,446 attempt 1/10 2016-05-13 10:43:30,446 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a225f011dec1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 10:43:34,073 unpacking tar archive at: mozilla-beta-a225f011dec1/testing/mozharness/ program finished with exit code 0 elapsedTime=3.883821 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-05-13 10:43:34.436984) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:34.437332) ========= script_repo_revision: a225f011dec1e24bb17e9c3ab0df54ac95875d34 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:34.437751) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:34.438155) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 10:43:34.451990) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2016-05-13 10:43:34.452655) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sKlZC4G3m4/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.5GN4WXD1ak/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:43:34 INFO - MultiFileLogger online at 20160513 10:43:34 in /builds/slave/test 10:43:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:43:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:43:34 INFO - {'append_to_log': False, 10:43:34 INFO - 'base_work_dir': '/builds/slave/test', 10:43:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:43:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:43:34 INFO - 'branch': 'Mozilla-Beta', 10:43:34 INFO - 'buildbot_json_path': 'buildprops.json', 10:43:34 INFO - 'config_files': ('talos/mac_config.py',), 10:43:34 INFO - 'default_actions': ('clobber', 10:43:34 INFO - 'read-buildbot-config', 10:43:34 INFO - 'download-and-extract', 10:43:34 INFO - 'populate-webroot', 10:43:34 INFO - 'create-virtualenv', 10:43:34 INFO - 'install', 10:43:34 INFO - 'run-tests'), 10:43:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:43:34 INFO - 'download_minidump_stackwalk': True, 10:43:34 INFO - 'download_symbols': 'ondemand', 10:43:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:43:34 INFO - 'tooltool.py': '/tools/tooltool.py', 10:43:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:43:34 INFO - '/tools/misc-python/virtualenv.py')}, 10:43:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:43:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:43:34 INFO - 'installer_path': 'installer.exe', 10:43:34 INFO - 'log_level': 'info', 10:43:34 INFO - 'log_name': 'talos', 10:43:34 INFO - 'log_to_console': True, 10:43:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:43:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:43:34 INFO - 'opt_config_files': (), 10:43:34 INFO - 'pip_index': False, 10:43:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:43:34 INFO - 'cmd': ('bash', 10:43:34 INFO - '-c', 10:43:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:43:34 INFO - 'enabled': True, 10:43:34 INFO - 'halt_on_failure': False, 10:43:34 INFO - 'name': 'check_screen_resolution'},), 10:43:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:43:34 INFO - 'cmd': ('bash', 10:43:34 INFO - '-c', 10:43:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:43:34 INFO - 'enabled': True, 10:43:34 INFO - 'halt_on_failure': False, 10:43:34 INFO - 'name': 'check_screen_resolution'},), 10:43:34 INFO - 'run_cmd_checks_enabled': True, 10:43:34 INFO - 'sps_profile': False, 10:43:34 INFO - 'sps_profile_interval': 0, 10:43:34 INFO - 'suite': 'dromaeojs-e10s', 10:43:34 INFO - 'system_bits': '32', 10:43:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:43:34 INFO - 'title': 't-yosemite-r7-0264', 10:43:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:43:34 INFO - 'use_talos_json': True, 10:43:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:43:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:43:34 INFO - 'work_dir': 'build'} 10:43:34 INFO - ##### 10:43:34 INFO - ##### Running clobber step. 10:43:34 INFO - ##### 10:43:34 INFO - Running pre-action listener: _resource_record_pre_action 10:43:34 INFO - Running main action method: clobber 10:43:34 INFO - rmtree: /builds/slave/test/build 10:43:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:43:35 INFO - Running post-action listener: _resource_record_post_action 10:43:35 INFO - ##### 10:43:35 INFO - ##### Running read-buildbot-config step. 10:43:35 INFO - ##### 10:43:35 INFO - Running pre-action listener: _resource_record_pre_action 10:43:35 INFO - Running main action method: read_buildbot_config 10:43:35 INFO - Using buildbot properties: 10:43:35 INFO - { 10:43:35 INFO - "project": "", 10:43:35 INFO - "product": "firefox", 10:43:35 INFO - "script_repo_revision": "production", 10:43:35 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:43:35 INFO - "repository": "", 10:43:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:43:35 INFO - "buildid": "20160513090035", 10:43:35 INFO - "pgo_build": "False", 10:43:35 INFO - "basedir": "/builds/slave/test", 10:43:35 INFO - "buildnumber": 5, 10:43:35 INFO - "slavename": "t-yosemite-r7-0264", 10:43:35 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 10:43:35 INFO - "platform": "yosemite_r7", 10:43:35 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:43:35 INFO - "branch": "mozilla-beta", 10:43:35 INFO - "repo_path": "releases/mozilla-beta", 10:43:35 INFO - "revision": "a225f011dec1e24bb17e9c3ab0df54ac95875d34", 10:43:35 INFO - "stage_platform": "macosx64", 10:43:35 INFO - "builduid": "5ba24935d4164d6f9036414264444526", 10:43:35 INFO - "slavebuilddir": "test" 10:43:35 INFO - } 10:43:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 10:43:35 INFO - Running post-action listener: _resource_record_post_action 10:43:35 INFO - ##### 10:43:35 INFO - ##### Running download-and-extract step. 10:43:35 INFO - ##### 10:43:35 INFO - Running pre-action listener: _resource_record_pre_action 10:43:35 INFO - Running main action method: download_and_extract 10:43:35 INFO - mkdir: /builds/slave/test/build/tests 10:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:35 INFO - https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:43:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:43:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:43:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:43:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 10:44:00 INFO - Downloaded 1241 bytes. 10:44:00 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:44:00 INFO - Using the following test package requirements: 10:44:00 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:44:00 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:44:00 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 10:44:00 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:44:00 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 10:44:00 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:44:00 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:44:00 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 10:44:00 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:44:00 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:44:00 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 10:44:00 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:44:00 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 10:44:00 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:44:00 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 10:44:00 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:44:00 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:44:00 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 10:44:00 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 10:44:00 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')]} 10:44:00 INFO - https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:44:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:44:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:44:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:44:18 INFO - Downloaded 17747433 bytes. 10:44:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:44:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:44:21 INFO - Return code: 0 10:44:21 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:21 INFO - https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:44:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:44:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:44:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:44:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:44:22 INFO - Downloaded 17747433 bytes. 10:44:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:44:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:44:25 INFO - Return code: 0 10:44:25 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')]} 10:44:25 INFO - https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:44:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:44:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:44:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 10:44:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 10:44:26 INFO - Downloaded 10845194 bytes. 10:44:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:44:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:44:27 INFO - Return code: 0 10:44: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')]} 10:44:27 INFO - https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 10:44:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:44:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:44:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 10:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 10:44:36 INFO - Downloaded 88270297 bytes. 10:44:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:44:36 INFO - mkdir: /builds/slave/test/properties 10:44:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:44:36 INFO - Writing to file /builds/slave/test/properties/build_url 10:44:36 INFO - Contents: 10:44:36 INFO - build_url:https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:44:39 INFO - Running post-action listener: _resource_record_post_action 10:44:39 INFO - Running post-action listener: set_extra_try_arguments 10:44:39 INFO - ##### 10:44:39 INFO - ##### Running populate-webroot step. 10:44:39 INFO - ##### 10:44:39 INFO - Running pre-action listener: _resource_record_pre_action 10:44:39 INFO - Running main action method: populate_webroot 10:44:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:44:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:44:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:44:39 INFO - '--tppagecycles', 10:44:39 INFO - '7'], 10:44:39 INFO - 'tests': ['tsvgm']}}, 10:44:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:44:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:44:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:44:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:44:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:44:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:44:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:44:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:39 INFO - 'talos_options': ['--e10s'], 10:44:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:44:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:39 INFO - 'tests': ['damp', 'tps']}, 10:44:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:39 INFO - 'talos_options': ['--e10s'], 10:44:39 INFO - 'tests': ['damp', 'tps']}, 10:44:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:44:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:44:39 INFO - 'other': {'tests': ['a11yr', 10:44:39 INFO - 'ts_paint', 10:44:39 INFO - 'tpaint', 10:44:39 INFO - 'sessionrestore', 10:44:39 INFO - 'sessionrestore_no_auto_restore', 10:44:39 INFO - 'tabpaint']}, 10:44:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:44:39 INFO - 'tests': ['a11yr', 10:44:39 INFO - 'ts_paint', 10:44:39 INFO - 'tpaint', 10:44:39 INFO - 'sessionrestore', 10:44:39 INFO - 'sessionrestore_no_auto_restore', 10:44:39 INFO - 'tabpaint']}, 10:44:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:44:39 INFO - 'tests': ['a11yr', 10:44:39 INFO - 'ts_paint', 10:44:39 INFO - 'tpaint', 10:44:39 INFO - 'sessionrestore', 10:44:39 INFO - 'sessionrestore_no_auto_restore', 10:44:39 INFO - 'tabpaint']}, 10:44:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:44:39 INFO - 'tests': ['a11yr', 10:44:39 INFO - 'ts_paint', 10:44:39 INFO - 'tpaint', 10:44:39 INFO - 'sessionrestore', 10:44:39 INFO - 'sessionrestore_no_auto_restore', 10:44:39 INFO - 'tabpaint']}, 10:44:39 INFO - 'other_l64': {'tests': ['a11yr', 10:44:39 INFO - 'ts_paint', 10:44:39 INFO - 'tpaint', 10:44:39 INFO - 'sessionrestore', 10:44:39 INFO - 'sessionrestore_no_auto_restore', 10:44:39 INFO - 'tabpaint']}, 10:44:39 INFO - 'other_nol64': {'tests': ['a11yr', 10:44:39 INFO - 'ts_paint', 10:44:39 INFO - 'tpaint', 10:44:39 INFO - 'sessionrestore', 10:44:39 INFO - 'sessionrestore_no_auto_restore', 10:44:39 INFO - 'tabpaint']}, 10:44:39 INFO - 'svgr': {'tests': ['tsvgx', 10:44:39 INFO - 'tsvgr_opacity', 10:44:39 INFO - 'tart', 10:44:39 INFO - 'tscrollx', 10:44:39 INFO - 'cart']}, 10:44:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:44:39 INFO - 'tests': ['tsvgx', 10:44:39 INFO - 'tsvgr_opacity', 10:44:39 INFO - 'tart', 10:44:39 INFO - 'tscrollx', 10:44:39 INFO - 'cart']}, 10:44:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:39 INFO - 'tests': ['tp5o']}, 10:44:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:39 INFO - 'talos_options': ['--e10s'], 10:44:39 INFO - 'tests': ['tp5o']}, 10:44:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:39 INFO - 'talos_options': ['--xperf_path', 10:44:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:44:39 INFO - 'tests': ['tp5n']}, 10:44:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:39 INFO - 'talos_options': ['--e10s', 10:44:39 INFO - '--xperf_path', 10:44:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:44:39 INFO - 'tests': ['tp5n']}}, 10:44:39 INFO - 'talos.zip': {'path': '', 10:44:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:44:39 INFO - Running post-action listener: _resource_record_post_action 10:44:39 INFO - ##### 10:44:39 INFO - ##### Running create-virtualenv step. 10:44:39 INFO - ##### 10:44:39 INFO - Running pre-action listener: _resource_record_pre_action 10:44:39 INFO - Running main action method: create_virtualenv 10:44:39 INFO - Creating virtualenv /builds/slave/test/build/venv 10:44:39 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 10:44:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:44:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:44:39 INFO - Using real prefix '/tools/python27' 10:44:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:44:40 INFO - Installing distribute.............................................................................................................................................................................................done. 10:44:43 INFO - Installing pip.................done. 10:44:43 INFO - Return code: 0 10:44:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:44:43 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')]} 10:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:43 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')]} 10:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:43 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 0x10d294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d29b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff549cd6530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d138d30>, '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 0x10cf9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d12fb20>, '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.sKlZC4G3m4/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.5GN4WXD1ak/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:44:43 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 10:44:43 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 10:44:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKlZC4G3m4/Render', 10:44:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:43 INFO - 'HOME': '/Users/cltbld', 10:44:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:43 INFO - 'LOGNAME': 'cltbld', 10:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:43 INFO - 'MOZ_NO_REMOTE': '1', 10:44:43 INFO - 'NO_EM_RESTART': '1', 10:44:43 INFO - 'PAGER': '/bin/cat', 10:44:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:43 INFO - 'PWD': '/builds/slave/test', 10:44:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:43 INFO - 'SHELL': '/bin/bash', 10:44:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5GN4WXD1ak/Listeners', 10:44:43 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:44:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:43 INFO - 'USER': 'cltbld', 10:44:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:43 INFO - 'XPC_FLAGS': '0x0', 10:44:43 INFO - 'XPC_SERVICE_NAME': '0', 10:44:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:43 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 10:44:43 INFO - Cleaning up... 10:44:43 INFO - Return code: 0 10:44:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:44:43 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')]} 10:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:43 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')]} 10:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:43 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 0x10d294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d29b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff549cd6530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d138d30>, '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 0x10cf9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d12fb20>, '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.sKlZC4G3m4/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.5GN4WXD1ak/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:44:43 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 10:44:43 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 10:44:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKlZC4G3m4/Render', 10:44:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:43 INFO - 'HOME': '/Users/cltbld', 10:44:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:43 INFO - 'LOGNAME': 'cltbld', 10:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:43 INFO - 'MOZ_NO_REMOTE': '1', 10:44:43 INFO - 'NO_EM_RESTART': '1', 10:44:43 INFO - 'PAGER': '/bin/cat', 10:44:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:43 INFO - 'PWD': '/builds/slave/test', 10:44:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:43 INFO - 'SHELL': '/bin/bash', 10:44:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5GN4WXD1ak/Listeners', 10:44:43 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:44:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:43 INFO - 'USER': 'cltbld', 10:44:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:43 INFO - 'XPC_FLAGS': '0x0', 10:44:43 INFO - 'XPC_SERVICE_NAME': '0', 10:44:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:43 INFO - Downloading/unpacking psutil>=0.7.1 10:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:44:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:44:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:44:46 INFO - Installing collected packages: psutil 10:44:46 INFO - Running setup.py install for psutil 10:44:46 INFO - building 'psutil._psutil_osx' extension 10:44:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:44:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:44:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:44:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:44:46 INFO - building 'psutil._psutil_posix' extension 10:44:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:44:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:44:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:44:46 INFO - ^ 10:44:46 INFO - 1 warning generated. 10:44:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:44:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:44:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:44:47 INFO - Successfully installed psutil 10:44:47 INFO - Cleaning up... 10:44:47 INFO - Return code: 0 10:44:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d29b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff549cd6530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d138d30>, '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 0x10cf9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d12fb20>, '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.sKlZC4G3m4/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.5GN4WXD1ak/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:44:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKlZC4G3m4/Render', 10:44:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:47 INFO - 'HOME': '/Users/cltbld', 10:44:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:47 INFO - 'LOGNAME': 'cltbld', 10:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:47 INFO - 'MOZ_NO_REMOTE': '1', 10:44:47 INFO - 'NO_EM_RESTART': '1', 10:44:47 INFO - 'PAGER': '/bin/cat', 10:44:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:47 INFO - 'PWD': '/builds/slave/test', 10:44:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:47 INFO - 'SHELL': '/bin/bash', 10:44:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5GN4WXD1ak/Listeners', 10:44:47 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:44:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:47 INFO - 'USER': 'cltbld', 10:44:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:47 INFO - 'XPC_FLAGS': '0x0', 10:44:47 INFO - 'XPC_SERVICE_NAME': '0', 10:44:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:44: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 10:44: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 10:44: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 10:44: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 10:44: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 10:44: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 10:44:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:44:49 INFO - Installing collected packages: mozsystemmonitor 10:44:49 INFO - Running setup.py install for mozsystemmonitor 10:44:50 INFO - Successfully installed mozsystemmonitor 10:44:50 INFO - Cleaning up... 10:44:50 INFO - Return code: 0 10:44:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d29b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff549cd6530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d138d30>, '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 0x10cf9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d12fb20>, '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.sKlZC4G3m4/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.5GN4WXD1ak/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:44:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:44:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:44:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKlZC4G3m4/Render', 10:44:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:50 INFO - 'HOME': '/Users/cltbld', 10:44:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:50 INFO - 'LOGNAME': 'cltbld', 10:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:50 INFO - 'MOZ_NO_REMOTE': '1', 10:44:50 INFO - 'NO_EM_RESTART': '1', 10:44:50 INFO - 'PAGER': '/bin/cat', 10:44:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:50 INFO - 'PWD': '/builds/slave/test', 10:44:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:50 INFO - 'SHELL': '/bin/bash', 10:44:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5GN4WXD1ak/Listeners', 10:44:50 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:44:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:50 INFO - 'USER': 'cltbld', 10:44:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:50 INFO - 'XPC_FLAGS': '0x0', 10:44:50 INFO - 'XPC_SERVICE_NAME': '0', 10:44:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:50 INFO - Downloading/unpacking blobuploader==1.2.4 10:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:52 INFO - Downloading blobuploader-1.2.4.tar.gz 10:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:44:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:44:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:53 INFO - Downloading docopt-0.6.1.tar.gz 10:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:44:54 INFO - Installing collected packages: blobuploader, requests, docopt 10:44:54 INFO - Running setup.py install for blobuploader 10:44:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:44:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:44:54 INFO - Running setup.py install for requests 10:44:54 INFO - Running setup.py install for docopt 10:44:54 INFO - Successfully installed blobuploader requests docopt 10:44:54 INFO - Cleaning up... 10:44:54 INFO - Return code: 0 10:44:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d29b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff549cd6530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d138d30>, '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 0x10cf9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d12fb20>, '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.sKlZC4G3m4/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.5GN4WXD1ak/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:44:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKlZC4G3m4/Render', 10:44:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:54 INFO - 'HOME': '/Users/cltbld', 10:44:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:54 INFO - 'LOGNAME': 'cltbld', 10:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:54 INFO - 'MOZ_NO_REMOTE': '1', 10:44:54 INFO - 'NO_EM_RESTART': '1', 10:44:54 INFO - 'PAGER': '/bin/cat', 10:44:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:54 INFO - 'PWD': '/builds/slave/test', 10:44:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:54 INFO - 'SHELL': '/bin/bash', 10:44:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5GN4WXD1ak/Listeners', 10:44:54 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:44:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:54 INFO - 'USER': 'cltbld', 10:44:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:54 INFO - 'XPC_FLAGS': '0x0', 10:44:54 INFO - 'XPC_SERVICE_NAME': '0', 10:44:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:44:55 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-8dhPUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:44:55 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-dIf5kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:44:55 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-4PSxsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:44:55 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-L2N1Xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:44:55 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-tc8con-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:44:55 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-542FTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:44:55 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-XLPIpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:44:55 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-QimfiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:44:56 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-P8SfKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:44:56 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-DMLjOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:44:56 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-2hs2g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:44:56 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-1SvGJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:44:56 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-o5mXUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:44:56 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-iHH0WC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:56 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-U50yNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:44:56 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-TP0l9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:44:56 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-1J2I0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:44:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:44:56 INFO - Running setup.py install for manifestparser 10:44:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:44:57 INFO - Running setup.py install for mozcrash 10:44:57 INFO - Running setup.py install for mozdebug 10:44:57 INFO - Running setup.py install for mozdevice 10:44:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:44:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:44:57 INFO - Running setup.py install for mozfile 10:44:57 INFO - Running setup.py install for mozhttpd 10:44:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:44:57 INFO - Running setup.py install for mozinfo 10:44:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:44:58 INFO - Running setup.py install for mozInstall 10:44:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:44:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:44:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:44:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:44:58 INFO - Running setup.py install for mozleak 10:44:58 INFO - Running setup.py install for mozlog 10:44:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:44:58 INFO - Running setup.py install for moznetwork 10:44:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:44:58 INFO - Running setup.py install for mozprocess 10:44:58 INFO - Running setup.py install for mozprofile 10:44:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:44:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:44:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:44:58 INFO - Running setup.py install for mozrunner 10:44:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:44:59 INFO - Running setup.py install for mozscreenshot 10:44:59 INFO - Running setup.py install for moztest 10:44:59 INFO - Running setup.py install for mozversion 10:44:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:44:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:44:59 INFO - Cleaning up... 10:44:59 INFO - Return code: 0 10:44:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:44: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')]} 10:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44: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')]} 10:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d29b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff549cd6530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d138d30>, '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 0x10cf9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d12fb20>, '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.sKlZC4G3m4/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.5GN4WXD1ak/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:44:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKlZC4G3m4/Render', 10:44:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:59 INFO - 'HOME': '/Users/cltbld', 10:44:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:59 INFO - 'LOGNAME': 'cltbld', 10:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:59 INFO - 'MOZ_NO_REMOTE': '1', 10:44:59 INFO - 'NO_EM_RESTART': '1', 10:44:59 INFO - 'PAGER': '/bin/cat', 10:44:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:59 INFO - 'PWD': '/builds/slave/test', 10:44:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:59 INFO - 'SHELL': '/bin/bash', 10:44:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5GN4WXD1ak/Listeners', 10:44:59 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:44:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:59 INFO - 'USER': 'cltbld', 10:44:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:59 INFO - 'XPC_FLAGS': '0x0', 10:44:59 INFO - 'XPC_SERVICE_NAME': '0', 10:44:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:44:59 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-DSVVuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:44:59 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-6WKnQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:45:00 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)) 10:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:45:00 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-bIak_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:45:00 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-8PQuQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:45:00 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-OJT1M1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:45:00 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-uDEZxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:45:00 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-_njM2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:45:00 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Z3249d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:45:00 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-vNZ2ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:45:00 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-po6blU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:45:00 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-yAuG4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:45:01 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)) 10:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:45:01 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-kfAaps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:45:01 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)) 10:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:45:01 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-6WttmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:45:01 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-fjLDkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:01 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-KoHTdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:45:01 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-6y6dWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:45:01 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-twxqVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:45:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:45: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 10:45: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 10:45: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 10:45: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 10:45: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 10:45: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 10:45:04 INFO - Downloading blessings-1.6.tar.gz 10:45:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:45:04 INFO - Installing collected packages: blessings 10:45:04 INFO - Running setup.py install for blessings 10:45:04 INFO - Successfully installed blessings 10:45:04 INFO - Cleaning up... 10:45:04 INFO - Return code: 0 10:45:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:45:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:45:04 INFO - Reading from file tmpfile_stdout 10:45:04 INFO - Current package versions: 10:45:04 INFO - blessings == 1.6 10:45:04 INFO - blobuploader == 1.2.4 10:45:04 INFO - docopt == 0.6.1 10:45:04 INFO - manifestparser == 1.1 10:45:04 INFO - mozInstall == 1.12 10:45:04 INFO - mozcrash == 0.17 10:45:04 INFO - mozdebug == 0.1 10:45:04 INFO - mozdevice == 0.48 10:45:04 INFO - mozfile == 1.2 10:45:04 INFO - mozhttpd == 0.7 10:45:04 INFO - mozinfo == 0.9 10:45:04 INFO - mozleak == 0.1 10:45:04 INFO - mozlog == 3.1 10:45:04 INFO - moznetwork == 0.27 10:45:04 INFO - mozprocess == 0.22 10:45:04 INFO - mozprofile == 0.28 10:45:04 INFO - mozrunner == 6.11 10:45:04 INFO - mozscreenshot == 0.1 10:45:04 INFO - mozsystemmonitor == 0.0 10:45:04 INFO - moztest == 0.7 10:45:04 INFO - mozversion == 1.4 10:45:04 INFO - psutil == 3.1.1 10:45:04 INFO - requests == 1.2.3 10:45:04 INFO - wsgiref == 0.1.2 10:45:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d29b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff549cd6530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d138d30>, '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 0x10cf9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d12fb20>, '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.sKlZC4G3m4/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.5GN4WXD1ak/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:45:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKlZC4G3m4/Render', 10:45:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:04 INFO - 'HOME': '/Users/cltbld', 10:45:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:04 INFO - 'LOGNAME': 'cltbld', 10:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:04 INFO - 'MOZ_NO_REMOTE': '1', 10:45:04 INFO - 'NO_EM_RESTART': '1', 10:45:04 INFO - 'PAGER': '/bin/cat', 10:45:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:04 INFO - 'PWD': '/builds/slave/test', 10:45:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:04 INFO - 'SHELL': '/bin/bash', 10:45:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5GN4WXD1ak/Listeners', 10:45:04 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:45:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:04 INFO - 'USER': 'cltbld', 10:45:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:04 INFO - 'XPC_FLAGS': '0x0', 10:45:04 INFO - 'XPC_SERVICE_NAME': '0', 10:45:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:05 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)) 10:45:05 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)) 10:45:05 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)) 10:45:05 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)) 10:45:05 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)) 10:45:05 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)) 10:45:05 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)) 10:45:05 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)) 10:45:05 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)) 10:45:05 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)) 10:45:05 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)) 10:45:05 INFO - Cleaning up... 10:45:05 INFO - Return code: 0 10:45:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d29b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff549cd6530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d138d30>, '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 0x10cf9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d12fb20>, '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.sKlZC4G3m4/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.5GN4WXD1ak/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:45:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKlZC4G3m4/Render', 10:45:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:05 INFO - 'HOME': '/Users/cltbld', 10:45:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:05 INFO - 'LOGNAME': 'cltbld', 10:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:05 INFO - 'MOZ_NO_REMOTE': '1', 10:45:05 INFO - 'NO_EM_RESTART': '1', 10:45:05 INFO - 'PAGER': '/bin/cat', 10:45:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:05 INFO - 'PWD': '/builds/slave/test', 10:45:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:05 INFO - 'SHELL': '/bin/bash', 10:45:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5GN4WXD1ak/Listeners', 10:45:05 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:45:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:05 INFO - 'USER': 'cltbld', 10:45:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:05 INFO - 'XPC_FLAGS': '0x0', 10:45:05 INFO - 'XPC_SERVICE_NAME': '0', 10:45:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:05 INFO - Downloading/unpacking jsonschema 10:45: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 10:45: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 10:45: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 10:45: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 10:45: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 10:45: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 10:45:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:45:07 INFO - Downloading/unpacking functools32 (from jsonschema) 10:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:08 INFO - Downloading functools32-3.2.3-2.tar.gz 10:45:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:45:08 INFO - warning: no files found matching '*.txt' 10:45:08 INFO - no previously-included directories found matching 'build' 10:45:08 INFO - no previously-included directories found matching 'dist' 10:45:08 INFO - no previously-included directories found matching '.git*' 10:45:08 INFO - Installing collected packages: jsonschema, functools32 10:45:08 INFO - Running setup.py install for functools32 10:45:08 INFO - warning: no files found matching '*.txt' 10:45:08 INFO - no previously-included directories found matching 'build' 10:45:08 INFO - no previously-included directories found matching 'dist' 10:45:08 INFO - no previously-included directories found matching '.git*' 10:45:08 INFO - Successfully installed jsonschema functools32 10:45:08 INFO - Cleaning up... 10:45:08 INFO - Return code: 0 10:45:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d29b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff549cd6530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d138d30>, '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 0x10cf9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d12fb20>, '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.sKlZC4G3m4/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.5GN4WXD1ak/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:45:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKlZC4G3m4/Render', 10:45:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:08 INFO - 'HOME': '/Users/cltbld', 10:45:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:08 INFO - 'LOGNAME': 'cltbld', 10:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:08 INFO - 'MOZ_NO_REMOTE': '1', 10:45:08 INFO - 'NO_EM_RESTART': '1', 10:45:08 INFO - 'PAGER': '/bin/cat', 10:45:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:08 INFO - 'PWD': '/builds/slave/test', 10:45:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:08 INFO - 'SHELL': '/bin/bash', 10:45:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5GN4WXD1ak/Listeners', 10:45:08 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:45:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:08 INFO - 'USER': 'cltbld', 10:45:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:08 INFO - 'XPC_FLAGS': '0x0', 10:45:08 INFO - 'XPC_SERVICE_NAME': '0', 10:45:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:08 INFO - Downloading/unpacking flake8 10:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:45:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:45:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:45:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:45:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:45:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:45:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:45:12 INFO - no previously-included directories found matching 'docs/_build' 10:45:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:45:12 INFO - Running setup.py install for pep8 10:45:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:45:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:45:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:45:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:45:12 INFO - no previously-included directories found matching 'docs/_build' 10:45:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:45:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:45:12 INFO - Cleaning up... 10:45:12 INFO - Return code: 0 10:45:12 INFO - Running post-action listener: _resource_record_post_action 10:45:12 INFO - Running post-action listener: _start_resource_monitoring 10:45:12 INFO - Starting resource monitoring. 10:45:12 INFO - ##### 10:45:12 INFO - ##### Running install step. 10:45:12 INFO - ##### 10:45:12 INFO - Running pre-action listener: _resource_record_pre_action 10:45:12 INFO - Running main action method: install 10:45:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:45:13 INFO - Reading from file tmpfile_stdout 10:45:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:45:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:45:13 INFO - Reading from file tmpfile_stdout 10:45:13 INFO - Output received: 10:45:13 INFO - Usage: mozinstall [options] installer 10:45:13 INFO - Options: 10:45:13 INFO - -h, --help show this help message and exit 10:45:13 INFO - -d DEST, --destination=DEST 10:45:13 INFO - Directory to install application into. [default: 10:45:13 INFO - "/builds/slave/test"] 10:45:13 INFO - --app=APP Application being installed. [default: firefox] 10:45:13 INFO - mkdir: /builds/slave/test/build/application 10:45:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:45:35 INFO - Reading from file tmpfile_stdout 10:45:35 INFO - Output received: 10:45:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:45:35 INFO - Running post-action listener: _resource_record_post_action 10:45:35 INFO - ##### 10:45:35 INFO - ##### Running run-tests step. 10:45:35 INFO - ##### 10:45:35 INFO - Running pre-action listener: _resource_record_pre_action 10:45:35 INFO - Running main action method: run_tests 10:45:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:45:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:45:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:45:35 INFO - 2016-05-13 10:45:35.512 screenresolution[2218:27913] starting screenresolution argv=screenresolution get 10:45:35 INFO - 2016-05-13 10:45:35.514 screenresolution[2218:27913] Display 0: 1600x1200x32@60 10:45:35 INFO - 2016-05-13 10:45:35.521 screenresolution[2219:27915] starting screenresolution argv=screenresolution list 10:45:35 INFO - Available Modes on Display 0 10:45:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:45:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:45:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:45:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:45:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:45:35 INFO - Intel Iris: 10:45:35 INFO - Chipset Model: Intel Iris 10:45:35 INFO - Type: GPU 10:45:35 INFO - Bus: Built-In 10:45:35 INFO - VRAM (Dynamic, Max): 1536 MB 10:45:35 INFO - Vendor: Intel (0x8086) 10:45:35 INFO - Device ID: 0x0a2e 10:45:35 INFO - Revision ID: 0x0009 10:45:35 INFO - Displays: 10:45:35 INFO - Display: 10:45:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:45:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:45:35 INFO - Display Serial Number: 1600x1200 60 10:45:35 INFO - Main Display: Yes 10:45:35 INFO - Mirror: Off 10:45:35 INFO - Online: Yes 10:45:35 INFO - Rotation: Supported 10:45:35 INFO - Return code: 0 10:45:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:45:35 INFO - Python 2.7.3 10:45:35 INFO - Return code: 0 10:45:35 INFO - grabbing minidump binary from tooltool 10:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:35 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 0x10d138d30>, '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 0x10cf9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d12fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:45:35 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 10:45:35 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 10:45:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:45:35 INFO - Return code: 0 10:45:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:45:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:45:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:45:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:45:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:45:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:45:37 INFO - Return code: 0 10:45:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--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 10:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0264 --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 10:45:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKlZC4G3m4/Render', 10:45:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:37 INFO - 'HOME': '/Users/cltbld', 10:45:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:37 INFO - 'LOGNAME': 'cltbld', 10:45:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:45:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:37 INFO - 'MOZ_NO_REMOTE': '1', 10:45:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:45:37 INFO - 'NO_EM_RESTART': '1', 10:45:37 INFO - 'PAGER': '/bin/cat', 10:45:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:37 INFO - 'PWD': '/builds/slave/test', 10:45:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:45:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:37 INFO - 'SHELL': '/bin/bash', 10:45:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5GN4WXD1ak/Listeners', 10:45:37 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:45:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:37 INFO - 'USER': 'cltbld', 10:45:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:37 INFO - 'XPC_FLAGS': '0x0', 10:45:37 INFO - 'XPC_SERVICE_NAME': '0', 10:45:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--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 10:45:37 INFO - mozversion application_buildid: 20160513090035 10:45:37 INFO - mozversion application_changeset: a225f011dec1e24bb17e9c3ab0df54ac95875d34 10:45:37 INFO - mozversion application_display_name: Firefox 10:45:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:45:37 INFO - mozversion application_name: Firefox 10:45:37 INFO - mozversion application_remotingname: firefox 10:45:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:45:37 INFO - mozversion application_vendor: Mozilla 10:45:37 INFO - mozversion application_version: 47.0 10:45:37 INFO - mozversion platform_buildid: 20160513090035 10:45:37 INFO - mozversion platform_changeset: a225f011dec1e24bb17e9c3ab0df54ac95875d34 10:45:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:45:37 INFO - mozversion platform_version: 47.0 10:45:37 INFO - using testdate: 1463161537 10:45:37 INFO - actual date: 1463161537 10:45:37 INFO - starting webserver on 'localhost:57296' 10:45:37 INFO - SUITE-START | Running 2 tests 10:45:37 INFO - TEST-START | dromaeo_css 10:45:37 INFO - operating with platform_type : mac_ 10:45:37 INFO - Initialising browser for dromaeo_css test... 10:45:37 INFO - TEST-INFO | started process 2237 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpqVpiyo/profile http://localhost:57296/getInfo.html) 10:45:40 INFO - PROCESS | 2237 | __metrics Screen width/height:1600/1200 10:45:40 INFO - PROCESS | 2237 | colorDepth:24 10:45:40 INFO - PROCESS | 2237 | Browser inner width/height: 1024/689 10:45:40 INFO - PROCESS | 2237 | __metrics 10:45:40 ERROR - PROCESS | 2237 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 10:45:40 INFO - TEST-INFO | 2237: exit 0 10:45:40 INFO - Browser initialized. 10:45:40 INFO - Running cycle 1/1 for dromaeo_css test... 10:45:40 INFO - TEST-INFO | started process 2241 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpqVpiyo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:45:52 INFO - PROCESS | 2241 | RSS: Main: 167841792 10:45:52 INFO - PROCESS | 2241 | 10:46:42 INFO - PROCESS | 2241 | 1463161602192 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] 10:48:52 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:57296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57296/tests/dromaeo/cssquery-ext.html) 10:48:54 INFO - PROCESS | 2241 | RSS: Main: 177922048 10:48:54 INFO - PROCESS | 2241 | 10:51:56 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:57296/tests/dromaeo/cssquery-ext.html (next: http://localhost:57296/tests/dromaeo/cssquery-jquery.html) 10:51:56 INFO - PROCESS | 2241 | RSS: Main: 189341696 10:51:56 INFO - PROCESS | 2241 | 10:54:58 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:57296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57296/tests/dromaeo/cssquery-mootools.html) 10:54:59 INFO - PROCESS | 2241 | RSS: Main: 191197184 10:54:59 INFO - PROCESS | 2241 | 10:58:00 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:57296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57296/tests/dromaeo/cssquery-prototype.html) 10:58:01 INFO - PROCESS | 2241 | RSS: Main: 195174400 10:58:01 INFO - PROCESS | 2241 | 11:01:03 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:57296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57296/tests/dromaeo/cssquery-yui.html) 11:01:04 INFO - PROCESS | 2241 | RSS: Main: 193974272 11:01:04 INFO - PROCESS | 2241 | 11:04:06 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:57296/tests/dromaeo/cssquery-yui.html (next: http://localhost:57296/tests/dromaeo/cssquery-dojo.html) 11:04:06 INFO - PROCESS | 2241 | RSS: Main: 199471104 11:04:06 INFO - PROCESS | 2241 | 11:04:06 INFO - PROCESS | 2241 | __start_tp_report 11:04:06 INFO - PROCESS | 2241 | _x_x_mozilla_page_load 11:04:06 INFO - PROCESS | 2241 | _x_x_mozilla_page_load_details 11:04:06 INFO - PROCESS | 2241 | |i|pagename|runs| 11:04:06 INFO - PROCESS | 2241 | |0;dojo.html;3223.4842425211955;3600.855965761369;3672.5776535698387;3674.7978861162624;3719.126005388735;5182.948170518293;5651.689157096358;5986.970065149668;6016.669083200422;6038.305594856582;5970.373110823366;6022.909656355158;6035.51715862731;6040.365761595024;6042.274927008754;5320.441353657859;5418.322709661293;5418.674879507223;5487.396386397493;5576.693281869496;5351;5432.891342173174;5449.3188351456065;5524.861878453051;5527.944720552783;5452.59105567082;5482.23248745176;5482.588805839578;5484.149956756709;5508.283923089993;5008.5993120550265;5271.813841885583;5281.973590132063;5434.157705555645;5464.098423760075;5262.2632831403635;5308.495692909206;5336.252924590561;5383.353997520323;5415.729213539307;5243.767714587069;5814.186013958007;5868.97065514674;5898.469137777621;5934.1098835174635;6198.938010619881;6291.7797877074545;6364.045393191012;6371.522135839784;6380.330065343119;6371.681415929185;6405.19935008124;6441.355864413568;6448.967755161241;6468.256150542654;6136.417040381157;6180.196574445294;6186.969065154645;6216;6217.160683307786;6400.871982560416;6450.967745161244;6516.57642253252;6568.474522038226;6579.769708060195;6267.561270711007;6268.310485846553;6306.936930630635;6311.368863113744;6325.778597749057;6352.047192921006;6354.3963323484195;6359.268684101295;6363.045543168561;6368.681565921778;5237.6333656643665;6139.631622102688;6289.622622642656;6303.936960630427;6365.904511432333;6320.747170113236;6321.905171422432;6328.050792381087;6336.239651241881;6344.714487848058;4951.851444456672;5073.010762901273;5090.414602320707;5102.285680004802;5106.080905437057;4397.922508985319;4493.640508759291;4512.887177820515;4570.268756998864;4613.2388155953895;4669.949261416222;5668.376478587352;6040.275166979991;6090.695465226721;6136.386361363828;6407.583507072025;6442.259140198843;6453.999630057348;6460.289368169498;6461.224653041665;6002.069679199731;6059.969700151559;6093;6129.114290130661;6169.9383006170265;5618.943810561924;5620.606557540933;5624.128260119688;5633.605647604629;5641.464060914206;5493.560515158858;5804.854878628068;6665.200175978914;6693.564918280394;6695.263521012685;6229.750809967732;6285.59143655661;6366.490680745622;6373.075903993988;6380.298167201697;6578.901316480353;6633.568818026813;6641.3690699385415;6664.0670306158145;6670.533062685566;6263.906041409291;6264.091706702594;6343.429091381798;6346.428821406095;6348.492120630431;6338.605506788499;6353.459955903615;6375.872482550416;6388;6399.64801935898;6244.219472565929;6269.279032911091;6278.15244941927;6281.434670879643;6288.339724328879;6180.949238629533;6212.9068063978175;6271.96864015677;6272.749090036347;6273.1844860167885;6085.117657939662;6146.924288249628;6203.937960620336;6206.379362063757;6208.782692605737;4922.384701912261;6118.357572454828;6229;6249.843753906189;6259.436650701276;6113.141862489121;6146.985747351637;6163.722632481459;6191.071339299141;6233.0338797486465 11:04:06 INFO - PROCESS | 2241 | |1;ext.html;465.94641616214125;490.66144360391326;528.9368369577148;533.8185017094189;605.1588292273738;38620.806895965514;39482.0129496762;39500.60499395005;39514.60485395149;39540.406893896616;41037.58962410375;41201.17597648045;41422.792886035524;41596.79201603995;41670.958226044364;9503;9577.856332155023;9601.663941762039;9690.903090969106;9753.073458021476;8061.596920153998;9761.951190244039;9777.46223957682;9894.950525247365;9934;9785.36395134314;9790.755231119243;9792.510374481282;9877.753056173617;9971.800563988716;9721.90278097217;9837.557309921034;9928.354656947275;9939.65211217604;9945.850812237823;8433.873491897626;9672.90327096727;9793.951030244874;9820.754481138028;9871.60513579456;31162.376752464825;39568.6150984717;39680;39993.80018599446;40275.39586906199;3051.2829485070993;3395.7792743471596;3429.348423799495;3435.7251419886347;3448.4654878493875;24714.752852471425;27576.448471030468;27806.582901256497;28772.424551509062;29082.98209562676;2808.5225511663066;2828.264651190705;2846.288427893027;2867.9426411471654;2867.996201329539;287992.2401551978;312983;349365.99999999744;349680;351089;62591.374086259464;62969.685151574864;65717;67211.32788672148;67409.66295168492;75415.86876196861;76509.61745191239;76822.6158869202;76827;76857;18052;18447.631047378978;18451.630967380577;18676.90661546711;18717.15772790228;13732.038757286895;13940.651483712989;14244.501442449671;14272;14300.785488217685;22294.665580016313;22631.66052509214;22912.31263062111;22936.655950160763;23504.882475587856;7514.98547696065;8721.433106848035;8952.283817294601;8955.910440895637;9013.377592033366;958.2238386906489;1082.5115466233929;1186.9347185904685;1189.6609466302061;1220.993895030537;30425.087247382613;30589.235269118006;30619.69380306213;30896.38207235843;31246.375072498424;1099.5326986030905;1136.3749937534324;1145.6563031090639;1167.772284404533;1243.9626811195678;15369.001014933994;15730.102152571662;15779.763303550455;15886.44397446107;16179.595510112342;502952;509173;509879;510443;516449;60750;61455.38544614586;61738.69130654318;61828;62001.37998620046;1492.7089217602681;1530.232581368521;1541.768734689783;1547.9148646824308;1598.9600259993592;25303.493930121662;30071.548926765678;30495;30622.77508899708;30735.84632076915;41526.58473415348;48251.27623085586;48589.02821943612;49279;49345.753271233414;383793;388581;388712;389987;390985.0450747728;30884.382312354075;32004.35991280208;46363.072738545714;47290;48368.51631483781;44453.777731111135;44778;45144.32283515816;45447.86380340386;46142.30786538137;36927.63072369242;37003.44494832634;37426.25147497089;37565.62434375731;38089.857304280915;32483.350332992733;38091;38884;40131.59868401279;40573.39139912963;38754.6124538751;39113.80443097766;39221.6077839218;39527;39789;33510.832445837616;34308.82845585856;34390.31219375548;34608.88520033209;34785.82607086949;25943.61084583695;26261.212163635122;26341.868290658425;26570.202893913214;26716.281668221043 11:04:06 INFO - PROCESS | 2241 | |2;jquery.html;359.5110649516657;370.30937301931885;375.3843696338006;381.999162195049;383.09016086793866;20769.584608307843;21547.784522154794;21898;22074.66887996681;22551.872406379676;21739.021744021516;21955;22621.886890565565;22672.09311627533;22872;5885.941140588604;5895.675737834428;6012.3687012863675;6109;6127.662978536178;5838.2702162229725;5945.197398351233;5977.193078934353;6002.369751176129;6018.3078945921125;5051.570616497584;5589.692566908819;5792.160136780164;5911.46796788289;5956.255468066492;5875.735591898375;5910.704464776744;5917.378675239124;5945.910811337833;5964.463198312151;5018.949810501921;5207.4792520748;5233.712145831978;5235.319408476874;5237.266782650432;26470.07354742594;26951.865240673866;27138.728612713818;27243.45513089747;27479.86260068687;2208.7901649343285;2564.5383830910428;2630.5659566171557;2983.5673827294922;2991.820490770539;15647.452339168189;15786.842131578653;15850.048997060214;15895.284712187979;16169.514914552583;1721.2340508473735;1787.4458917735544;1790.6060666653316;1816.954576135594;1870.3453791173117;95850;102681;104516.47741761242;106007;106637.93362066358;10864.945675271572;11189.49647265875;11237.60668376603;11276.379799110964;11347.035501982258;13622.523211687741;13812.240326782123;14072.577822665336;14116.364763585663;14175.85824141766;9108.588168833709;9133.45199288045;9185.402948808307;9190.218831399407;9279.953600232091;9427.434353938786;9485.905140948502;9495;9502.287328450393;9560.952195239119;6497.220333560003;6544.541882068304;6690.19717633887;6707.798766037026;6720.495962802809;1723.8448539631493;1883.0867029490687;1896.7818700849302;1897.9715304270446;1928.807119288088;940.9576569054273;991.8809742830762;1030.3508789462592;1032.1794173631981;1057.471264367816;20363.80722915647;20611.896940515202;21568.245111421023;22077.558448830932;23014.194503192644;975.8487434447673;990.6978371596588;1045.3518818332682;1076.0799516413354;1079.865016872891;11716.472758725879;11831.053515718722;11911.3448760319;12040.578579749841;12067.336296503601;661343;662405;668571;671274;688001;102124;109817;112293;124385;124567.37716311542;1006.1799633298838;1011.6358111080006;1016.044917777287;1032.4373216596973;1035.0322448510667;19344.90327548353;19379.4186174415;20125.39623811288;20235.59528809445;20473.795262047784;54325.72837135789;57181.714091429276;57292.71353643205;57580.84838303294;59802.401975981425;81109.18890811253;82320.58839705763;83200.75198871901;83980.58009709913;84745;8300.128486509071;8301.626426810688;8406.075331713384;8623.396362254582;8773.649054037767;13023.544175953795;13554;13929.164250145024;14056.156630602196;14352.712945741236;11462.94268528652;11503.769924601294;11767.352795596324;12051;12091.153619246568;8925;10495.527701253615;10554.73343198821;11497.54009839597;12210.145289829981;10151.340162889388;10657.680269591925;11751.882481175078;12085.81871271914;12159.939200303941;7736.806579835549;8173;8403.075661677089;8523.616437260214;8753.212210901049;11012.724681883017;12182.695432614255;12185.390879884653;12237.388130593612;12441.626751197478 11:04:06 INFO - PROCESS | 2241 | |3;mootools.html;1641.7947756530436;1653.9828005776444;1957.8629495935281;2012.8691635043722;2031.3499680102373;7907.16974717655;8316.960379952507;9279.164875161243;9537.95231023844;9542.093501117391;9264.722058338244;9280.535973201348;9313.906860931389;9412.247020238381;9424.90575094249;2580.948381032378;2580.9870950645222;2589.2491177558486;2602.1282870238397;2606.6741657292837;2572.1126211457017;2583.276682528895;2589.184406911826;2605.374710069579;2635.8007106766377;2586.327554835747;2599.0383558083536;2625.3830349867767;2634.4204275059456;2642.960355594668;2582.6384306197147;2596.7792737617233;2597.9480410391875;2611.4777044591065;2634.7233540478164;2578.329634295078;2595.922122336333;2602.830815996973;2612.3207965928996;2631.0396705202656;9107.635694572275;9279.489628070454;9383;9404.24766018717;9411.576479058458;5545.112781954868;5550.222968784374;5884.470397664188;5899.233099697055;5970.582059255854;3703.333399988001;3835.9041023974346;3929.0766669832565;3929.2730844793805;3939.212157568498;928.953552322388;1089.7057794395469;1095.1622009162998;1139.7378602921374;1144.9084073274119;12460.688482787913;12726.554570590077;12824.615261542169;12836.908862746677;12837;5180.145276029413;5202.817901373433;5271.262023316739;5272;5294.682319060868;8780.604872780741;10522.053015228666;10557.313774604627;10575;10789.62236321725;4975.800967961313;5738.8278351649515;5781.624194427349;5805.796797112081;6003.219581454383;4031.5766844481495;5151.896962060738;5242.344706911636;5245.632805703564;5374.086405311106;3385.5768028996376;4106.445629839993;4153.1070819773895;4156.2726522858375;4176.979115104405;1344.0927374022692;1363.6999860030778;1370.164199838098;1377.5867239828212;1389.4997800791707;1429.4496618801836;1439.5897169306697;1468.0384348251912;1481.5481278210034;1487.137460273039;8692.261157801659;8774.990876049209;8797.38418310712;8803.69187078462;8833.984091829394;537.3551737914519;542.7204989430446;544.3685325022955;550.0484162398992;551.0741953518047;6354;6399.264084630234;6412.422881940648;6442;6459.967700161469;11293.322400655987;11349.943250283695;11594.434751308634;11626.76746465066;11697.707557310965;9451.33840631163;10629.46852657364;10972.945135274273;11335.886641133648;11559.248648837798;8612.526311052952;8704;8774.298056155492;8820.382573219813;8850.380473366931;7309.561426314438;8082.757517274491;8486.787830304293;8558.657653694032;8592.527410992205;9957.302988790716;9999.450030248407;10121.392716437038;10180.13468855126;10264.948675256575;8787.692430764893;10003.2997690161;10649.627263045757;10657.41384223844;10664.786704266027;7175.928240717526;7699.923000769921;7858.489198202098;7939.364850812037;8056.7180148694515;8692.869606955774;8722.171393717586;8743.03826579063;8772.780680482783;8844.867326990228;7588.696452142073;7761.146273909752;7860.84278314442;7871.763847084597;7906.5651389174145;6869.725210991704;7191.352778249982;7708.267714567107;7742.806429839299;7774.30031297186;8243.093259741303;8296.087430382773;8361.122082181284;8372.28835548985;8379.287760540423;7216.7474138404905;7254.5647261164495;7389.298016688406;7412.073490813648;7501.662425190771;7473.402127829652;7514.211007844097;7524.774256772305;7530.209328020698;7553.811154720956 11:04:06 INFO - PROCESS | 2241 | |4;prototype.html;340.2803071503769;345.24736075355713;346.42493460854985;347.8104433083969;351.8047483646576;6999.755008574701;7029.191642961061;7047.260037696045;7064.788056358305;7065.7880263592115;5810.389909059551;6943.861122777542;6992.96503517483;7024.367806897391;7031.4374850012;5000.774965126559;5091.134507133796;5175.223716442526;5189.844304670866;5268.657537260085;5128.666636668605;5160.380754309488;5165.276861239429;5180.792768289264;5213.817516386927;5102.846914592568;5120.23196520523;5130.307408499861;5148.5881129509735;5162.380514338266;5136.743162841862;5154.433012368637;5164.122099243138;5167.896642067157;5170.095233334151;3464.6015708193377;3630.455431685242;4483.887902802423;4507.918099656092;4509.30105833593;6606.240282367541;6779.084823548807;6798.864022719567;6828.863422731567;6866.176058872918;4968.205087186033;5971.193888824996;6065.363136870609;6082.300535438437;6096.116063170815;6037.78867739627;7507.399408047398;7513.962430187814;7522.172561018284;7523.924760752378;4980.779708971289;4996;5014.373203349582;5020.246962955549;5036.118679231156;7585.658645360972;7941.761747147595;7941.880871786928;7984.720534781255;8018.278354948025;5102.897942041139;5106;5106.310648062538;5117.616178786606;5134.794608215704;5211.817586384458;5222.399424066205;5232.73836308183;5244.082285600005;5245.475452454724;6020.729067191987;6059.242594675666;6076.848078798065;6076.939230607726;6081.7871374502565;6062.363451837582;7529.757589997589;7545.8117146028135;7551.320381165611;7561.09266887966;1665.4753752567901;1789.5526118470382;1818.163644723442;1820.2809890093604;1820.381070436058;1043.2853495355705;1083.4528563075596;1088.1349327284827;1099.9780004400027;1103.4372470040178;6308.432241098231;7032.331928466788;7128.394086502602;7131.0373099631925;7153.856922861513;7574.204708505637;7794;7797.805054873674;7816.06207255133;7851.764447066483;7023.473239507058;7233.348998590152;7244.637768111574;7267.127944646676;7267.563946163247;4108.732932359387;4149.875503734833;4156.106437116035;4160.958390416117;4173.457450531411;8129.959350203211;8223.42436029484;8235;8241.79395515117;8246.670133194724;7805.141434442206;8063.717769878026;8079.1516890725625;8117.904082948727;8155.184481551797;8191.672333106728;8234.258916697527;8235.21765432283;8257.95871020629;8262.752117436366;7897.723579674684;7900.723474678359;7927.286544210818;7928.960355198187;7938.880916786368;6783.694733736895;7705.730299439493;7718.961405192938;7724.034495688039;7732.149463559116;6644.33556644351;8208.179182081743;8210.958945205235;8212.712555060783;8246.917530824854;4906.018796240694;4935.679180853376;4947.727874966911;4954.4797796232315;4964.230544265644;6571.78421991933;6907.6891539881835;7811;7843.254890785366;7856.84286314282;7292.744753933587;7507.88738168917;7515.361194298327;7572.138209513298;7578.772636820904;7453.031105956191;7524.247575242432;7556.962215189109;7557.2820582044615;7584.54492730438;6048.788292409745;7321.377682897013;7375.594342311224;7390;7401.370883474965;7521.849563008818;7547.886781698388;7577.052868391451;7579.279968402993;7579.658915348712;7221.260242616165;7285.235050319852;7312.085989251344;7396.371308438843;7400.962995185205 11:04:06 INFO - PROCESS | 2241 | |5;yui.html;709.9183593886704;749.093596747935;758.5941521286111;768.3968085053231;778.1557010643452;15851.128187949658;16085;16104.516864494055;16105.194740262983;16136.83863161368;14904.776428353556;14908.627284317898;14912.25438728062;14932.850671493281;14937.804975601954;773.0607312115778;914.4970266353512;941.6892425499586;953.6328513522275;971.2958105373618;930.5533343994887;957.8515330123842;968.9951550242274;969.0745338202036;970.6311601591385;982.8918818929913;998.9001099890025;1000.6747806962729;1021.3310281765456;1023.3194925374617;974.1524873360152;989.7624570103195;993.602558976408;996.875390576178;1011.246621267157;725.2457444258018;740.315208432198;740.9592472414015;747.495440577608;758.8861670749377;15502.689946201126;15560.766588501181;15623.687526249525;15764.448244311508;15863.841361586352;10971.506282217319;13391.732165356736;13466.483585070528;13518.594442166652;13677.179369237878;10171.54228059739;10206.183505319557;10315.226358023103;10421.895781042169;10699.304545204537;3580.7135429165864;3628.365036118695;3629.6007439181667;3635.6546128118052;3744.588095309514;80572.59713701395;81070.78393824097;81567.77648335339;82032;82238;9688.224942004763;9857.211423086135;9936.950315248378;10000.049687218974;10135.391876487434;21613.67579486309;22230.88884555567;22392.216272430713;22968.19611313596;23154.7684523156;7600.8479830403085;7733.7679869604;7862;7969.561674107864;8042.839143217103;4189.664826813848;4193.97903010483;4202.411662367271;4204;4449.221386257392;3716.572594151653;3724.8137593120778;3730.515033045687;3769.4911186989953;3779.4708740776314;661.4873473058323;671.4896678524259;673.7473447457204;694.1669996004714;700.4956431369405;551.9862003449946;607.4988134788817;608.5435923057706;611.9816405507842;612.461034289831;7184.281571842774;7606.353459955855;8510.446820956618;8533.146685331418;8666.046734859161;500.41451501743046;512.3032675561234;571.7798647520734;573.4208449465985;616.7286393986632;2974.583558301796;3825.6748176405317;3923.509561304837;4070.5252579525036;4210.32634778434;96281.5557766634;96746;99057;99351.50324248477;100253.99746002593;85491.57254213688;85694.14305856987;86181;86500.26999459976;88152;73228;73248;73814;76958.61520692361;78415;8742.912570874465;8909.821803563762;8914.465132092095;8942.73171804847;9025.503597302211;38498.80750596229;52262.47737522576;52904.20643690425;53503;54555.72722136364;46343.53656463392;64748;69846.65076674584;72698;72900.63549682217;8713.910761154855;11248.437578121226;11326.490307935997;11380.43097845121;11415.714607134889;12153.69615759613;12199.817002744789;12224.144309898222;12507.93746031264;13086.934565327112;9514.38156519824;9743.074407931235;11477.426128693365;11744.765104697688;12319.75360492803;11584.536618535165;11639.47622356979;11762.3530705812;11838.171328006956;11952.163348565517;11371.658850234506;11792.820717928138;11845.881541184823;11900.702482438008;11988.64034078979;9836.901630983599;9889.456079915673;9979.251556133175;9996.60013599477;10066.345687530287;9599;9787.412755234423;9851.45816980073;9947.950260248652;9992.350497217658 11:04:06 INFO - PROCESS | 2241 | __end_tp_report 11:04:06 INFO - PROCESS | 2241 | __start_cc_report 11:04:06 INFO - PROCESS | 2241 | _x_x_mozilla_cycle_collect,357 11:04:06 INFO - PROCESS | 2241 | __end_cc_report 11:04:06 INFO - PROCESS | 2241 | __startTimestamp1463162646712__endTimestamp 11:04:06 INFO - PROCESS | 2241 | 11:04:06 INFO - PROCESS | 2241 | ------- Summary: start ------- 11:04:06 INFO - PROCESS | 2241 | Number of tests: 6 11:04:06 INFO - PROCESS | 2241 | 11:04:06 INFO - PROCESS | 2241 | [#0] dojo.html Cycles:165 Average:5904.05 Median:6180.20 stddev:657.95 (10.6%) stddev-sans-first:625.46 11:04:06 INFO - PROCESS | 2241 | Values: 3223.5 3600.9 3672.6 3674.8 3719.1 5182.9 5651.7 5987.0 6016.7 6038.3 5970.4 6022.9 6035.5 6040.4 6042.3 5320.4 5418.3 5418.7 5487.4 5576.7 5351.0 5432.9 5449.3 5524.9 5527.9 5452.6 5482.2 5482.6 5484.1 5508.3 5008.6 5271.8 5282.0 5434.2 5464.1 5262.3 5308.5 5336.3 5383.4 5415.7 5243.8 5814.2 5869.0 5898.5 5934.1 6198.9 6291.8 6364.0 6371.5 6380.3 6371.7 6405.2 6441.4 6449.0 6468.3 6136.4 6180.2 6187.0 6216.0 6217.2 6400.9 6451.0 6516.6 6568.5 6579.8 6267.6 6268.3 6306.9 6311.4 6325.8 6352.0 6354.4 6359.3 6363.0 6368.7 5237.6 6139.6 6289.6 6303.9 6365.9 6320.7 6321.9 6328.1 6336.2 6344.7 4951.9 5073.0 5090.4 5102.3 5106.1 4397.9 4493.6 4512.9 4570.3 4613.2 4669.9 5668.4 6040.3 6090.7 6136.4 6407.6 6442.3 6454.0 6460.3 6461.2 6002.1 6060.0 6093.0 6129.1 6169.9 5618.9 5620.6 5624.1 5633.6 5641.5 5493.6 5804.9 6665.2 6693.6 6695.3 6229.8 6285.6 6366.5 6373.1 6380.3 6578.9 6633.6 6641.4 6664.1 6670.5 6263.9 6264.1 6343.4 6346.4 6348.5 6338.6 6353.5 6375.9 6388.0 6399.6 6244.2 6269.3 6278.2 6281.4 6288.3 6180.9 6212.9 6272.0 6272.7 6273.2 6085.1 6146.9 6203.9 6206.4 6208.8 4922.4 6118.4 6229.0 6249.8 6259.4 6113.1 6147.0 6163.7 6191.1 6233.0 11:04:06 INFO - PROCESS | 2241 | 11:04:06 INFO - PROCESS | 2241 | [#1] ext.html Cycles:180 Average:57944.39 Median:390486.02 stddev:110228.17 (28.2%) stddev-sans-first:110452.91 11:04:06 INFO - PROCESS | 2241 | Values: 465.9 490.7 528.9 533.8 605.2 38620.8 39482.0 39500.6 39514.6 39540.4 41037.6 41201.2 41422.8 41596.8 41671.0 9503.0 9577.9 9601.7 9690.9 9753.1 8061.6 9762.0 9777.5 9895.0 9934.0 9785.4 9790.8 9792.5 9877.8 9971.8 9721.9 9837.6 9928.4 9939.7 9945.9 8433.9 9672.9 9794.0 9820.8 9871.6 31162.4 39568.6 39680.0 39993.8 40275.4 3051.3 3395.8 3429.3 3435.7 3448.5 24714.8 27576.4 27806.6 28772.4 29083.0 2808.5 2828.3 2846.3 2867.9 2868.0 287992.2 312983.0 349366.0 349680.0 351089.0 62591.4 62969.7 65717.0 67211.3 67409.7 75415.9 76509.6 76822.6 76827.0 76857.0 18052.0 18447.6 18451.6 18676.9 18717.2 13732.0 13940.7 14244.5 14272.0 14300.8 22294.7 22631.7 22912.3 22936.7 23504.9 7515.0 8721.4 8952.3 8955.9 9013.4 958.2 1082.5 1186.9 1189.7 1221.0 30425.1 30589.2 30619.7 30896.4 31246.4 1099.5 1136.4 1145.7 1167.8 1244.0 15369.0 15730.1 15779.8 15886.4 16179.6 502952.0 509173.0 509879.0 510443.0 516449.0 60750.0 61455.4 61738.7 61828.0 62001.4 1492.7 1530.2 1541.8 1547.9 1599.0 25303.5 30071.5 30495.0 30622.8 30735.8 41526.6 48251.3 48589.0 49279.0 49345.8 383793.0 388581.0 388712.0 389987.0 390985.0 30884.4 32004.4 46363.1 47290.0 48368.5 44453.8 44778.0 45144.3 45447.9 46142.3 36927.6 37003.4 37426.3 37565.6 38089.9 32483.4 38091.0 38884.0 40131.6 40573.4 38754.6 39113.8 39221.6 39527.0 39789.0 33510.8 34308.8 34390.3 34608.9 34785.8 25943.6 26261.2 26341.9 26570.2 26716.3 11:04:06 INFO - PROCESS | 2241 | 11:04:06 INFO - PROCESS | 2241 | [#2] jquery.html Cycles:180 Average:37062.43 Median:22586.88 stddev:110681.58 (490.0%) stddev-sans-first:110957.76 11:04:06 INFO - PROCESS | 2241 | Values: 359.5 370.3 375.4 382.0 383.1 20769.6 21547.8 21898.0 22074.7 22551.9 21739.0 21955.0 22621.9 22672.1 22872.0 5885.9 5895.7 6012.4 6109.0 6127.7 5838.3 5945.2 5977.2 6002.4 6018.3 5051.6 5589.7 5792.2 5911.5 5956.3 5875.7 5910.7 5917.4 5945.9 5964.5 5018.9 5207.5 5233.7 5235.3 5237.3 26470.1 26951.9 27138.7 27243.5 27479.9 2208.8 2564.5 2630.6 2983.6 2991.8 15647.5 15786.8 15850.0 15895.3 16169.5 1721.2 1787.4 1790.6 1817.0 1870.3 95850.0 102681.0 104516.5 106007.0 106637.9 10864.9 11189.5 11237.6 11276.4 11347.0 13622.5 13812.2 14072.6 14116.4 14175.9 9108.6 9133.5 9185.4 9190.2 9280.0 9427.4 9485.9 9495.0 9502.3 9561.0 6497.2 6544.5 6690.2 6707.8 6720.5 1723.8 1883.1 1896.8 1898.0 1928.8 941.0 991.9 1030.4 1032.2 1057.5 20363.8 20611.9 21568.2 22077.6 23014.2 975.8 990.7 1045.4 1076.1 1079.9 11716.5 11831.1 11911.3 12040.6 12067.3 661343.0 662405.0 668571.0 671274.0 688001.0 102124.0 109817.0 112293.0 124385.0 124567.4 1006.2 1011.6 1016.0 1032.4 1035.0 19344.9 19379.4 20125.4 20235.6 20473.8 54325.7 57181.7 57292.7 57580.8 59802.4 81109.2 82320.6 83200.8 83980.6 84745.0 8300.1 8301.6 8406.1 8623.4 8773.6 13023.5 13554.0 13929.2 14056.2 14352.7 11462.9 11503.8 11767.4 12051.0 12091.2 8925.0 10495.5 10554.7 11497.5 12210.1 10151.3 10657.7 11751.9 12085.8 12159.9 7736.8 8173.0 8403.1 8523.6 8753.2 11012.7 12182.7 12185.4 12237.4 12441.6 11:04:06 INFO - PROCESS | 2241 | 11:04:06 INFO - PROCESS | 2241 | [#3] mootools.html Cycles:180 Average:6364.03 Median:2958.40 stddev:3371.66 (114.0%) stddev-sans-first:3362.43 11:04:06 INFO - PROCESS | 2241 | Values: 1641.8 1654.0 1957.9 2012.9 2031.3 7907.2 8317.0 9279.2 9538.0 9542.1 9264.7 9280.5 9313.9 9412.2 9424.9 2580.9 2581.0 2589.2 2602.1 2606.7 2572.1 2583.3 2589.2 2605.4 2635.8 2586.3 2599.0 2625.4 2634.4 2643.0 2582.6 2596.8 2597.9 2611.5 2634.7 2578.3 2595.9 2602.8 2612.3 2631.0 9107.6 9279.5 9383.0 9404.2 9411.6 5545.1 5550.2 5884.5 5899.2 5970.6 3703.3 3835.9 3929.1 3929.3 3939.2 929.0 1089.7 1095.2 1139.7 1144.9 12460.7 12726.6 12824.6 12836.9 12837.0 5180.1 5202.8 5271.3 5272.0 5294.7 8780.6 10522.1 10557.3 10575.0 10789.6 4975.8 5738.8 5781.6 5805.8 6003.2 4031.6 5151.9 5242.3 5245.6 5374.1 3385.6 4106.4 4153.1 4156.3 4177.0 1344.1 1363.7 1370.2 1377.6 1389.5 1429.4 1439.6 1468.0 1481.5 1487.1 8692.3 8775.0 8797.4 8803.7 8834.0 537.4 542.7 544.4 550.0 551.1 6354.0 6399.3 6412.4 6442.0 6460.0 11293.3 11349.9 11594.4 11626.8 11697.7 9451.3 10629.5 10972.9 11335.9 11559.2 8612.5 8704.0 8774.3 8820.4 8850.4 7309.6 8082.8 8486.8 8558.7 8592.5 9957.3 9999.5 10121.4 10180.1 10264.9 8787.7 10003.3 10649.6 10657.4 10664.8 7175.9 7699.9 7858.5 7939.4 8056.7 8692.9 8722.2 8743.0 8772.8 8844.9 7588.7 7761.1 7860.8 7871.8 7906.6 6869.7 7191.4 7708.3 7742.8 7774.3 8243.1 8296.1 8361.1 8372.3 8379.3 7216.7 7254.6 7389.3 7412.1 7501.7 7473.4 7514.2 7524.8 7530.2 7553.8 11:04:06 INFO - PROCESS | 2241 | 11:04:06 INFO - PROCESS | 2241 | [#4] prototype.html Cycles:180 Average:6150.63 Median:6996.36 stddev:1971.97 (28.2%) stddev-sans-first:1928.67 11:04:06 INFO - PROCESS | 2241 | Values: 340.3 345.2 346.4 347.8 351.8 6999.8 7029.2 7047.3 7064.8 7065.8 5810.4 6943.9 6993.0 7024.4 7031.4 5000.8 5091.1 5175.2 5189.8 5268.7 5128.7 5160.4 5165.3 5180.8 5213.8 5102.8 5120.2 5130.3 5148.6 5162.4 5136.7 5154.4 5164.1 5167.9 5170.1 3464.6 3630.5 4483.9 4507.9 4509.3 6606.2 6779.1 6798.9 6828.9 6866.2 4968.2 5971.2 6065.4 6082.3 6096.1 6037.8 7507.4 7514.0 7522.2 7523.9 4980.8 4996.0 5014.4 5020.2 5036.1 7585.7 7941.8 7941.9 7984.7 8018.3 5102.9 5106.0 5106.3 5117.6 5134.8 5211.8 5222.4 5232.7 5244.1 5245.5 6020.7 6059.2 6076.8 6076.9 6081.8 6062.4 7529.8 7545.8 7551.3 7561.1 1665.5 1789.6 1818.2 1820.3 1820.4 1043.3 1083.5 1088.1 1100.0 1103.4 6308.4 7032.3 7128.4 7131.0 7153.9 7574.2 7794.0 7797.8 7816.1 7851.8 7023.5 7233.3 7244.6 7267.1 7267.6 4108.7 4149.9 4156.1 4161.0 4173.5 8130.0 8223.4 8235.0 8241.8 8246.7 7805.1 8063.7 8079.2 8117.9 8155.2 8191.7 8234.3 8235.2 8258.0 8262.8 7897.7 7900.7 7927.3 7929.0 7938.9 6783.7 7705.7 7719.0 7724.0 7732.1 6644.3 8208.2 8211.0 8212.7 8246.9 4906.0 4935.7 4947.7 4954.5 4964.2 6571.8 6907.7 7811.0 7843.3 7856.8 7292.7 7507.9 7515.4 7572.1 7578.8 7453.0 7524.2 7557.0 7557.3 7584.5 6048.8 7321.4 7375.6 7390.0 7401.4 7521.8 7547.9 7577.1 7579.3 7579.7 7221.3 7285.2 7312.1 7396.4 7401.0 11:04:06 INFO - PROCESS | 2241 | 11:04:06 INFO - PROCESS | 2241 | [#5] yui.html Cycles:180 Average:19012.36 Median:590.46 stddev:27000.33 (4572.8%) stddev-sans-first:27041.09 11:04:06 INFO - PROCESS | 2241 | Values: 709.9 749.1 758.6 768.4 778.2 15851.1 16085.0 16104.5 16105.2 16136.8 14904.8 14908.6 14912.3 14932.9 14937.8 773.1 914.5 941.7 953.6 971.3 930.6 957.9 969.0 969.1 970.6 982.9 998.9 1000.7 1021.3 1023.3 974.2 989.8 993.6 996.9 1011.2 725.2 740.3 741.0 747.5 758.9 15502.7 15560.8 15623.7 15764.4 15863.8 10971.5 13391.7 13466.5 13518.6 13677.2 10171.5 10206.2 10315.2 10421.9 10699.3 3580.7 3628.4 3629.6 3635.7 3744.6 80572.6 81070.8 81567.8 82032.0 82238.0 9688.2 9857.2 9937.0 10000.0 10135.4 21613.7 22230.9 22392.2 22968.2 23154.8 7600.8 7733.8 7862.0 7969.6 8042.8 4189.7 4194.0 4202.4 4204.0 4449.2 3716.6 3724.8 3730.5 3769.5 3779.5 661.5 671.5 673.7 694.2 700.5 552.0 607.5 608.5 612.0 612.5 7184.3 7606.4 8510.4 8533.1 8666.0 500.4 512.3 571.8 573.4 616.7 2974.6 3825.7 3923.5 4070.5 4210.3 96281.6 96746.0 99057.0 99351.5 100254.0 85491.6 85694.1 86181.0 86500.3 88152.0 73228.0 73248.0 73814.0 76958.6 78415.0 8742.9 8909.8 8914.5 8942.7 9025.5 38498.8 52262.5 52904.2 53503.0 54555.7 46343.5 64748.0 69846.7 72698.0 72900.6 8713.9 11248.4 11326.5 11380.4 11415.7 12153.7 12199.8 12224.1 12507.9 13086.9 9514.4 9743.1 11477.4 11744.8 12319.8 11584.5 11639.5 11762.4 11838.2 11952.2 11371.7 11792.8 11845.9 11900.7 11988.6 9836.9 9889.5 9979.3 9996.6 10066.3 9599.0 9787.4 9851.5 9948.0 9992.4 11:04:06 INFO - PROCESS | 2241 | -------- Summary: end -------- 11:04:06 INFO - PROCESS | 2241 | 11:04:07 INFO - TEST-INFO | 2241: exit 0 11:04:07 INFO - TEST-OK | dromaeo_css | took 1109940ms 11:04:07 INFO - TEST-START | kraken 11:04:07 INFO - operating with platform_type : mac_ 11:04:07 INFO - Initialising browser for kraken test... 11:04:07 INFO - TEST-INFO | started process 2247 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp0uuZyL/profile http://localhost:57296/getInfo.html) 11:04:09 INFO - PROCESS | 2247 | __metrics Screen width/height:1600/1200 11:04:09 INFO - PROCESS | 2247 | colorDepth:24 11:04:09 INFO - PROCESS | 2247 | Browser inner width/height: 1024/689 11:04:09 INFO - PROCESS | 2247 | __metrics 11:04:09 ERROR - PROCESS | 2247 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 11:04:10 INFO - TEST-INFO | 2247: exit 0 11:04:10 INFO - Browser initialized. 11:04:10 INFO - Running cycle 1/1 for kraken test... 11:04:10 INFO - TEST-INFO | started process 2251 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp0uuZyL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:04:22 INFO - PROCESS | 2251 | RSS: Main: 168099840 11:04:22 INFO - PROCESS | 2251 | 11:04:24 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57296/tests/kraken/driver.html?testName=audio-beat-detection) 11:04:25 INFO - PROCESS | 2251 | RSS: Main: 179683328 11:04:25 INFO - PROCESS | 2251 | 11:04:27 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57296/tests/kraken/driver.html?testName=audio-dft) 11:04:28 INFO - PROCESS | 2251 | RSS: Main: 188715008 11:04:28 INFO - PROCESS | 2251 | 11:04:31 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57296/tests/kraken/driver.html?testName=audio-fft) 11:04:32 INFO - PROCESS | 2251 | RSS: Main: 192638976 11:04:32 INFO - PROCESS | 2251 | 11:04:34 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57296/tests/kraken/driver.html?testName=audio-oscillator) 11:04:34 INFO - PROCESS | 2251 | RSS: Main: 194088960 11:04:34 INFO - PROCESS | 2251 | 11:04:36 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:04:37 INFO - PROCESS | 2251 | RSS: Main: 194605056 11:04:37 INFO - PROCESS | 2251 | 11:04:40 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57296/tests/kraken/driver.html?testName=imaging-darkroom) 11:04:40 INFO - PROCESS | 2251 | RSS: Main: 194408448 11:04:40 INFO - PROCESS | 2251 | 11:04:43 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57296/tests/kraken/driver.html?testName=imaging-desaturate) 11:04:44 INFO - PROCESS | 2251 | RSS: Main: 194220032 11:04:44 INFO - PROCESS | 2251 | 11:04:47 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57296/tests/kraken/driver.html?testName=json-parse-financial) 11:04:47 INFO - PROCESS | 2251 | RSS: Main: 194433024 11:04:47 INFO - PROCESS | 2251 | 11:04:49 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:04:49 INFO - PROCESS | 2251 | RSS: Main: 194252800 11:04:49 INFO - PROCESS | 2251 | 11:04:51 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:04:52 INFO - PROCESS | 2251 | RSS: Main: 194101248 11:04:52 INFO - PROCESS | 2251 | 11:04:54 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:04:55 INFO - PROCESS | 2251 | RSS: Main: 194314240 11:04:55 INFO - PROCESS | 2251 | 11:04:57 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:04:58 INFO - PROCESS | 2251 | RSS: Main: 194469888 11:04:58 INFO - PROCESS | 2251 | 11:05:00 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:05:01 INFO - PROCESS | 2251 | RSS: Main: 194555904 11:05:01 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57296/tests/kraken/driver.html?testName=ai-astar) 11:05:03 INFO - PROCESS | 2251 | RSS: Main: 196030464 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | __start_tp_report 11:05:03 INFO - PROCESS | 2251 | _x_x_mozilla_page_load 11:05:03 INFO - PROCESS | 2251 | _x_x_mozilla_page_load_details 11:05:03 INFO - PROCESS | 2251 | |i|pagename|runs| 11:05:03 INFO - PROCESS | 2251 | |0;ai-astar;115;110;114;115;115;127;111;113;112;114 11:05:03 INFO - PROCESS | 2251 | |1;audio-beat-detection;155;135;195;187;153;171;132;153;149;121 11:05:03 INFO - PROCESS | 2251 | |2;audio-dft;193;197;200;200;194;194;198;199;196;195 11:05:03 INFO - PROCESS | 2251 | |3;audio-fft;63;65;79;109;56;56;56;60;123;56 11:05:03 INFO - PROCESS | 2251 | |4;audio-oscillator;83;79;123;81;82;85;122;81;79;118 11:05:03 INFO - PROCESS | 2251 | |5;imaging-gaussian-blur;89;86;88;87;89;85;90;86;103;130 11:05:03 INFO - PROCESS | 2251 | |6;imaging-darkroom;95;98;118;95;93;101;114;148;151;152 11:05:03 INFO - PROCESS | 2251 | |7;imaging-desaturate;91;106;91;91;97;89;92;99;91;93 11:05:03 INFO - PROCESS | 2251 | |8;json-parse-financial;56;60;60;57;59;57;59;59;60;56 11:05:03 INFO - PROCESS | 2251 | |9;json-stringify-tinderbox;65;70;65;80;70;71;64;65;66;66 11:05:03 INFO - PROCESS | 2251 | |10;stanford-crypto-aes;82;81;94;108;111;69;99;108;107;90 11:05:03 INFO - PROCESS | 2251 | |11;stanford-crypto-ccm;128;133;139;116;120;119;134;145;118;117 11:05:03 INFO - PROCESS | 2251 | |12;stanford-crypto-pbkdf2;126;135;136;135;140;126;136;133;152;173 11:05:03 INFO - PROCESS | 2251 | |13;stanford-crypto-sha256-iterative;64;63;64;65;68;65;66;70;67;67 11:05:03 INFO - PROCESS | 2251 | __end_tp_report 11:05:03 INFO - PROCESS | 2251 | __start_cc_report 11:05:03 INFO - PROCESS | 2251 | _x_x_mozilla_cycle_collect,912 11:05:03 INFO - PROCESS | 2251 | __end_cc_report 11:05:03 INFO - PROCESS | 2251 | __startTimestamp1463162703250__endTimestamp 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | ------- Summary: start ------- 11:05:03 INFO - PROCESS | 2251 | Number of tests: 14 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.50 stddev:4.70 (4.1%) stddev-sans-first:4.98 11:05:03 INFO - PROCESS | 2251 | Values: 115.0 110.0 114.0 115.0 115.0 127.0 111.0 113.0 112.0 114.0 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:154.00 stddev:23.59 (15.3%) stddev-sans-first:25.02 11:05:03 INFO - PROCESS | 2251 | Values: 155.0 135.0 195.0 187.0 153.0 171.0 132.0 153.0 149.0 121.0 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | [#2] audio-dft Cycles:10 Average:196.60 Median:197.50 stddev:2.59 (1.3%) stddev-sans-first:2.40 11:05:03 INFO - PROCESS | 2251 | Values: 193.0 197.0 200.0 200.0 194.0 194.0 198.0 199.0 196.0 195.0 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | [#3] audio-fft Cycles:10 Average:72.30 Median:58.00 stddev:24.30 (41.9%) stddev-sans-first:25.54 11:05:03 INFO - PROCESS | 2251 | Values: 63.0 65.0 79.0 109.0 56.0 56.0 56.0 60.0 123.0 56.0 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:81.00 stddev:19.24 (23.7%) stddev-sans-first:20.04 11:05:03 INFO - PROCESS | 2251 | Values: 83.0 79.0 123.0 81.0 82.0 85.0 122.0 81.0 79.0 118.0 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | [#5] imaging-gaussian-blur Cycles:10 Average:93.30 Median:87.50 stddev:13.87 (15.9%) stddev-sans-first:14.63 11:05:03 INFO - PROCESS | 2251 | Values: 89.0 86.0 88.0 87.0 89.0 85.0 90.0 86.0 103.0 130.0 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | [#6] imaging-darkroom Cycles:10 Average:116.50 Median:122.50 stddev:24.74 (20.2%) stddev-sans-first:24.99 11:05:03 INFO - PROCESS | 2251 | Values: 95.0 98.0 118.0 95.0 93.0 101.0 114.0 148.0 151.0 152.0 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:91.50 stddev:5.21 (5.7%) stddev-sans-first:5.41 11:05:03 INFO - PROCESS | 2251 | Values: 91.0 106.0 91.0 91.0 97.0 89.0 92.0 99.0 91.0 93.0 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:59.00 stddev:1.64 (2.8%) stddev-sans-first:1.51 11:05:03 INFO - PROCESS | 2251 | Values: 56.0 60.0 60.0 57.0 59.0 57.0 59.0 59.0 60.0 56.0 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:4.85 (7.1%) stddev-sans-first:5.00 11:05:03 INFO - PROCESS | 2251 | Values: 65.0 70.0 65.0 80.0 70.0 71.0 64.0 65.0 66.0 66.0 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | [#10] stanford-crypto-aes Cycles:10 Average:94.90 Median:81.50 stddev:14.22 (17.5%) stddev-sans-first:14.30 11:05:03 INFO - PROCESS | 2251 | Values: 82.0 81.0 94.0 108.0 111.0 69.0 99.0 108.0 107.0 90.0 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:130.50 stddev:10.38 (8.0%) stddev-sans-first:11.00 11:05:03 INFO - PROCESS | 2251 | Values: 128.0 133.0 139.0 116.0 120.0 119.0 134.0 145.0 118.0 117.0 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.20 Median:136.00 stddev:13.94 (10.3%) stddev-sans-first:13.95 11:05:03 INFO - PROCESS | 2251 | Values: 126.0 135.0 136.0 135.0 140.0 126.0 136.0 133.0 152.0 173.0 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - PROCESS | 2251 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.50 stddev:2.13 (3.2%) stddev-sans-first:2.15 11:05:03 INFO - PROCESS | 2251 | Values: 64.0 63.0 64.0 65.0 68.0 65.0 66.0 70.0 67.0 67.0 11:05:03 INFO - PROCESS | 2251 | -------- Summary: end -------- 11:05:03 INFO - PROCESS | 2251 | 11:05:03 INFO - TEST-INFO | 2251: exit 0 11:05:03 INFO - TEST-OK | kraken | took 56763ms 11:05:03 INFO - SUITE-END | took 1166s 11:05:04 INFO - Completed test suite (00:19:27) 11:05:04 INFO - javascript benchmark 11:05:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3223.4842425211955, 3600.855965761369, 3672.5776535698387, 3674.7978861162624, 3719.126005388735, 5182.948170518293, 5651.689157096358, 5986.970065149668, 6016.669083200422, 6038.305594856582, 5970.373110823366, 6022.909656355158, 6035.51715862731, 6040.365761595024, 6042.274927008754, 5320.441353657859, 5418.322709661293, 5418.674879507223, 5487.396386397493, 5576.693281869496, 5351.0, 5432.891342173174, 5449.3188351456065, 5524.861878453051, 5527.944720552783, 5452.59105567082, 5482.23248745176, 5482.588805839578, 5484.149956756709, 5508.283923089993, 5008.5993120550265, 5271.813841885583, 5281.973590132063, 5434.157705555645, 5464.098423760075, 5262.2632831403635, 5308.495692909206, 5336.252924590561, 5383.353997520323, 5415.729213539307, 5243.767714587069, 5814.186013958007, 5868.97065514674, 5898.469137777621, 5934.1098835174635, 6198.938010619881, 6291.7797877074545, 6364.045393191012, 6371.522135839784, 6380.330065343119, 6371.681415929185, 6405.19935008124, 6441.355864413568, 6448.967755161241, 6468.256150542654, 6136.417040381157, 6180.196574445294, 6186.969065154645, 6216.0, 6217.160683307786, 6400.871982560416, 6450.967745161244, 6516.57642253252, 6568.474522038226, 6579.769708060195, 6267.561270711007, 6268.310485846553, 6306.936930630635, 6311.368863113744, 6325.778597749057, 6352.047192921006, 6354.3963323484195, 6359.268684101295, 6363.045543168561, 6368.681565921778, 5237.6333656643665, 6139.631622102688, 6289.622622642656, 6303.936960630427, 6365.904511432333, 6320.747170113236, 6321.905171422432, 6328.050792381087, 6336.239651241881, 6344.714487848058, 4951.851444456672, 5073.010762901273, 5090.414602320707, 5102.285680004802, 5106.080905437057, 4397.922508985319, 4493.640508759291, 4512.887177820515, 4570.268756998864, 4613.2388155953895, 4669.949261416222, 5668.376478587352, 6040.275166979991, 6090.695465226721, 6136.386361363828, 6407.583507072025, 6442.259140198843, 6453.999630057348, 6460.289368169498, 6461.224653041665, 6002.069679199731, 6059.969700151559, 6093.0, 6129.114290130661, 6169.9383006170265, 5618.943810561924, 5620.606557540933, 5624.128260119688, 5633.605647604629, 5641.464060914206, 5493.560515158858, 5804.854878628068, 6665.200175978914, 6693.564918280394, 6695.263521012685, 6229.750809967732, 6285.59143655661, 6366.490680745622, 6373.075903993988, 6380.298167201697, 6578.901316480353, 6633.568818026813, 6641.3690699385415, 6664.0670306158145, 6670.533062685566, 6263.906041409291, 6264.091706702594, 6343.429091381798, 6346.428821406095, 6348.492120630431, 6338.605506788499, 6353.459955903615, 6375.872482550416, 6388.0, 6399.64801935898, 6244.219472565929, 6269.279032911091, 6278.15244941927, 6281.434670879643, 6288.339724328879, 6180.949238629533, 6212.9068063978175, 6271.96864015677, 6272.749090036347, 6273.1844860167885, 6085.117657939662, 6146.924288249628, 6203.937960620336, 6206.379362063757, 6208.782692605737, 4922.384701912261, 6118.357572454828, 6229.0, 6249.843753906189, 6259.436650701276, 6113.141862489121, 6146.985747351637, 6163.722632481459, 6191.071339299141, 6233.0338797486465], "unit": "score", "name": "dojo.html", "value": 5864.968731160825}, {"lowerIsBetter": false, "replicates": [465.94641616214125, 490.66144360391326, 528.9368369577148, 533.8185017094189, 605.1588292273738, 38620.806895965514, 39482.0129496762, 39500.60499395005, 39514.60485395149, 39540.406893896616, 41037.58962410375, 41201.17597648045, 41422.792886035524, 41596.79201603995, 41670.958226044364, 9503.0, 9577.856332155023, 9601.663941762039, 9690.903090969106, 9753.073458021476, 8061.596920153998, 9761.951190244039, 9777.46223957682, 9894.950525247365, 9934.0, 9785.36395134314, 9790.755231119243, 9792.510374481282, 9877.753056173617, 9971.800563988716, 9721.90278097217, 9837.557309921034, 9928.354656947275, 9939.65211217604, 9945.850812237823, 8433.873491897626, 9672.90327096727, 9793.951030244874, 9820.754481138028, 9871.60513579456, 31162.376752464825, 39568.6150984717, 39680.0, 39993.80018599446, 40275.39586906199, 3051.2829485070993, 3395.7792743471596, 3429.348423799495, 3435.7251419886347, 3448.4654878493875, 24714.752852471425, 27576.448471030468, 27806.582901256497, 28772.424551509062, 29082.98209562676, 2808.5225511663066, 2828.264651190705, 2846.288427893027, 2867.9426411471654, 2867.996201329539, 287992.2401551978, 312983.0, 349365.99999999744, 349680.0, 351089.0, 62591.374086259464, 62969.685151574864, 65717.0, 67211.32788672148, 67409.66295168492, 75415.86876196861, 76509.61745191239, 76822.6158869202, 76827.0, 76857.0, 18052.0, 18447.631047378978, 18451.630967380577, 18676.90661546711, 18717.15772790228, 13732.038757286895, 13940.651483712989, 14244.501442449671, 14272.0, 14300.785488217685, 22294.665580016313, 22631.66052509214, 22912.31263062111, 22936.655950160763, 23504.882475587856, 7514.98547696065, 8721.433106848035, 8952.283817294601, 8955.910440895637, 9013.377592033366, 958.2238386906489, 1082.5115466233929, 1186.9347185904685, 1189.6609466302061, 1220.993895030537, 30425.087247382613, 30589.235269118006, 30619.69380306213, 30896.38207235843, 31246.375072498424, 1099.5326986030905, 1136.3749937534324, 1145.6563031090639, 1167.772284404533, 1243.9626811195678, 15369.001014933994, 15730.102152571662, 15779.763303550455, 15886.44397446107, 16179.595510112342, 502952.0, 509173.0, 509879.0, 510443.0, 516449.0, 60750.0, 61455.38544614586, 61738.69130654318, 61828.0, 62001.37998620046, 1492.7089217602681, 1530.232581368521, 1541.768734689783, 1547.9148646824308, 1598.9600259993592, 25303.493930121662, 30071.548926765678, 30495.0, 30622.77508899708, 30735.84632076915, 41526.58473415348, 48251.27623085586, 48589.02821943612, 49279.0, 49345.753271233414, 383793.0, 388581.0, 388712.0, 389987.0, 390985.0450747728, 30884.382312354075, 32004.35991280208, 46363.072738545714, 47290.0, 48368.51631483781, 44453.777731111135, 44778.0, 45144.32283515816, 45447.86380340386, 46142.30786538137, 36927.63072369242, 37003.44494832634, 37426.25147497089, 37565.62434375731, 38089.857304280915, 32483.350332992733, 38091.0, 38884.0, 40131.59868401279, 40573.39139912963, 38754.6124538751, 39113.80443097766, 39221.6077839218, 39527.0, 39789.0, 33510.832445837616, 34308.82845585856, 34390.31219375548, 34608.88520033209, 34785.82607086949, 25943.61084583695, 26261.212163635122, 26341.868290658425, 26570.202893913214, 26716.281668221043], "unit": "score", "name": "ext.html", "value": 20185.873192057556}, {"lowerIsBetter": false, "replicates": [359.5110649516657, 370.30937301931885, 375.3843696338006, 381.999162195049, 383.09016086793866, 20769.584608307843, 21547.784522154794, 21898.0, 22074.66887996681, 22551.872406379676, 21739.021744021516, 21955.0, 22621.886890565565, 22672.09311627533, 22872.0, 5885.941140588604, 5895.675737834428, 6012.3687012863675, 6109.0, 6127.662978536178, 5838.2702162229725, 5945.197398351233, 5977.193078934353, 6002.369751176129, 6018.3078945921125, 5051.570616497584, 5589.692566908819, 5792.160136780164, 5911.46796788289, 5956.255468066492, 5875.735591898375, 5910.704464776744, 5917.378675239124, 5945.910811337833, 5964.463198312151, 5018.949810501921, 5207.4792520748, 5233.712145831978, 5235.319408476874, 5237.266782650432, 26470.07354742594, 26951.865240673866, 27138.728612713818, 27243.45513089747, 27479.86260068687, 2208.7901649343285, 2564.5383830910428, 2630.5659566171557, 2983.5673827294922, 2991.820490770539, 15647.452339168189, 15786.842131578653, 15850.048997060214, 15895.284712187979, 16169.514914552583, 1721.2340508473735, 1787.4458917735544, 1790.6060666653316, 1816.954576135594, 1870.3453791173117, 95850.0, 102681.0, 104516.47741761242, 106007.0, 106637.93362066358, 10864.945675271572, 11189.49647265875, 11237.60668376603, 11276.379799110964, 11347.035501982258, 13622.523211687741, 13812.240326782123, 14072.577822665336, 14116.364763585663, 14175.85824141766, 9108.588168833709, 9133.45199288045, 9185.402948808307, 9190.218831399407, 9279.953600232091, 9427.434353938786, 9485.905140948502, 9495.0, 9502.287328450393, 9560.952195239119, 6497.220333560003, 6544.541882068304, 6690.19717633887, 6707.798766037026, 6720.495962802809, 1723.8448539631493, 1883.0867029490687, 1896.7818700849302, 1897.9715304270446, 1928.807119288088, 940.9576569054273, 991.8809742830762, 1030.3508789462592, 1032.1794173631981, 1057.471264367816, 20363.80722915647, 20611.896940515202, 21568.245111421023, 22077.558448830932, 23014.194503192644, 975.8487434447673, 990.6978371596588, 1045.3518818332682, 1076.0799516413354, 1079.865016872891, 11716.472758725879, 11831.053515718722, 11911.3448760319, 12040.578579749841, 12067.336296503601, 661343.0, 662405.0, 668571.0, 671274.0, 688001.0, 102124.0, 109817.0, 112293.0, 124385.0, 124567.37716311542, 1006.1799633298838, 1011.6358111080006, 1016.044917777287, 1032.4373216596973, 1035.0322448510667, 19344.90327548353, 19379.4186174415, 20125.39623811288, 20235.59528809445, 20473.795262047784, 54325.72837135789, 57181.714091429276, 57292.71353643205, 57580.84838303294, 59802.401975981425, 81109.18890811253, 82320.58839705763, 83200.75198871901, 83980.58009709913, 84745.0, 8300.128486509071, 8301.626426810688, 8406.075331713384, 8623.396362254582, 8773.649054037767, 13023.544175953795, 13554.0, 13929.164250145024, 14056.156630602196, 14352.712945741236, 11462.94268528652, 11503.769924601294, 11767.352795596324, 12051.0, 12091.153619246568, 8925.0, 10495.527701253615, 10554.73343198821, 11497.54009839597, 12210.145289829981, 10151.340162889388, 10657.680269591925, 11751.882481175078, 12085.81871271914, 12159.939200303941, 7736.806579835549, 8173.0, 8403.075661677089, 8523.616437260214, 8753.212210901049, 11012.724681883017, 12182.695432614255, 12185.390879884653, 12237.388130593612, 12441.626751197478], "unit": "score", "name": "jquery.html", "value": 10086.538988580967}, {"lowerIsBetter": false, "replicates": [1641.7947756530436, 1653.9828005776444, 1957.8629495935281, 2012.8691635043722, 2031.3499680102373, 7907.16974717655, 8316.960379952507, 9279.164875161243, 9537.95231023844, 9542.093501117391, 9264.722058338244, 9280.535973201348, 9313.906860931389, 9412.247020238381, 9424.90575094249, 2580.948381032378, 2580.9870950645222, 2589.2491177558486, 2602.1282870238397, 2606.6741657292837, 2572.1126211457017, 2583.276682528895, 2589.184406911826, 2605.374710069579, 2635.8007106766377, 2586.327554835747, 2599.0383558083536, 2625.3830349867767, 2634.4204275059456, 2642.960355594668, 2582.6384306197147, 2596.7792737617233, 2597.9480410391875, 2611.4777044591065, 2634.7233540478164, 2578.329634295078, 2595.922122336333, 2602.830815996973, 2612.3207965928996, 2631.0396705202656, 9107.635694572275, 9279.489628070454, 9383.0, 9404.24766018717, 9411.576479058458, 5545.112781954868, 5550.222968784374, 5884.470397664188, 5899.233099697055, 5970.582059255854, 3703.333399988001, 3835.9041023974346, 3929.0766669832565, 3929.2730844793805, 3939.212157568498, 928.953552322388, 1089.7057794395469, 1095.1622009162998, 1139.7378602921374, 1144.9084073274119, 12460.688482787913, 12726.554570590077, 12824.615261542169, 12836.908862746677, 12837.0, 5180.145276029413, 5202.817901373433, 5271.262023316739, 5272.0, 5294.682319060868, 8780.604872780741, 10522.053015228666, 10557.313774604627, 10575.0, 10789.62236321725, 4975.800967961313, 5738.8278351649515, 5781.624194427349, 5805.796797112081, 6003.219581454383, 4031.5766844481495, 5151.896962060738, 5242.344706911636, 5245.632805703564, 5374.086405311106, 3385.5768028996376, 4106.445629839993, 4153.1070819773895, 4156.2726522858375, 4176.979115104405, 1344.0927374022692, 1363.6999860030778, 1370.164199838098, 1377.5867239828212, 1389.4997800791707, 1429.4496618801836, 1439.5897169306697, 1468.0384348251912, 1481.5481278210034, 1487.137460273039, 8692.261157801659, 8774.990876049209, 8797.38418310712, 8803.69187078462, 8833.984091829394, 537.3551737914519, 542.7204989430446, 544.3685325022955, 550.0484162398992, 551.0741953518047, 6354.0, 6399.264084630234, 6412.422881940648, 6442.0, 6459.967700161469, 11293.322400655987, 11349.943250283695, 11594.434751308634, 11626.76746465066, 11697.707557310965, 9451.33840631163, 10629.46852657364, 10972.945135274273, 11335.886641133648, 11559.248648837798, 8612.526311052952, 8704.0, 8774.298056155492, 8820.382573219813, 8850.380473366931, 7309.561426314438, 8082.757517274491, 8486.787830304293, 8558.657653694032, 8592.527410992205, 9957.302988790716, 9999.450030248407, 10121.392716437038, 10180.13468855126, 10264.948675256575, 8787.692430764893, 10003.2997690161, 10649.627263045757, 10657.41384223844, 10664.786704266027, 7175.928240717526, 7699.923000769921, 7858.489198202098, 7939.364850812037, 8056.7180148694515, 8692.869606955774, 8722.171393717586, 8743.03826579063, 8772.780680482783, 8844.867326990228, 7588.696452142073, 7761.146273909752, 7860.84278314442, 7871.763847084597, 7906.5651389174145, 6869.725210991704, 7191.352778249982, 7708.267714567107, 7742.806429839299, 7774.30031297186, 8243.093259741303, 8296.087430382773, 8361.122082181284, 8372.28835548985, 8379.287760540423, 7216.7474138404905, 7254.5647261164495, 7389.298016688406, 7412.073490813648, 7501.662425190771, 7473.402127829652, 7514.211007844097, 7524.774256772305, 7530.209328020698, 7553.811154720956], "unit": "score", "name": "mootools.html", "value": 5115.008230527502}, {"lowerIsBetter": false, "replicates": [340.2803071503769, 345.24736075355713, 346.42493460854985, 347.8104433083969, 351.8047483646576, 6999.755008574701, 7029.191642961061, 7047.260037696045, 7064.788056358305, 7065.7880263592115, 5810.389909059551, 6943.861122777542, 6992.96503517483, 7024.367806897391, 7031.4374850012, 5000.774965126559, 5091.134507133796, 5175.223716442526, 5189.844304670866, 5268.657537260085, 5128.666636668605, 5160.380754309488, 5165.276861239429, 5180.792768289264, 5213.817516386927, 5102.846914592568, 5120.23196520523, 5130.307408499861, 5148.5881129509735, 5162.380514338266, 5136.743162841862, 5154.433012368637, 5164.122099243138, 5167.896642067157, 5170.095233334151, 3464.6015708193377, 3630.455431685242, 4483.887902802423, 4507.918099656092, 4509.30105833593, 6606.240282367541, 6779.084823548807, 6798.864022719567, 6828.863422731567, 6866.176058872918, 4968.205087186033, 5971.193888824996, 6065.363136870609, 6082.300535438437, 6096.116063170815, 6037.78867739627, 7507.399408047398, 7513.962430187814, 7522.172561018284, 7523.924760752378, 4980.779708971289, 4996.0, 5014.373203349582, 5020.246962955549, 5036.118679231156, 7585.658645360972, 7941.761747147595, 7941.880871786928, 7984.720534781255, 8018.278354948025, 5102.897942041139, 5106.0, 5106.310648062538, 5117.616178786606, 5134.794608215704, 5211.817586384458, 5222.399424066205, 5232.73836308183, 5244.082285600005, 5245.475452454724, 6020.729067191987, 6059.242594675666, 6076.848078798065, 6076.939230607726, 6081.7871374502565, 6062.363451837582, 7529.757589997589, 7545.8117146028135, 7551.320381165611, 7561.09266887966, 1665.4753752567901, 1789.5526118470382, 1818.163644723442, 1820.2809890093604, 1820.381070436058, 1043.2853495355705, 1083.4528563075596, 1088.1349327284827, 1099.9780004400027, 1103.4372470040178, 6308.432241098231, 7032.331928466788, 7128.394086502602, 7131.0373099631925, 7153.856922861513, 7574.204708505637, 7794.0, 7797.805054873674, 7816.06207255133, 7851.764447066483, 7023.473239507058, 7233.348998590152, 7244.637768111574, 7267.127944646676, 7267.563946163247, 4108.732932359387, 4149.875503734833, 4156.106437116035, 4160.958390416117, 4173.457450531411, 8129.959350203211, 8223.42436029484, 8235.0, 8241.79395515117, 8246.670133194724, 7805.141434442206, 8063.717769878026, 8079.1516890725625, 8117.904082948727, 8155.184481551797, 8191.672333106728, 8234.258916697527, 8235.21765432283, 8257.95871020629, 8262.752117436366, 7897.723579674684, 7900.723474678359, 7927.286544210818, 7928.960355198187, 7938.880916786368, 6783.694733736895, 7705.730299439493, 7718.961405192938, 7724.034495688039, 7732.149463559116, 6644.33556644351, 8208.179182081743, 8210.958945205235, 8212.712555060783, 8246.917530824854, 4906.018796240694, 4935.679180853376, 4947.727874966911, 4954.4797796232315, 4964.230544265644, 6571.78421991933, 6907.6891539881835, 7811.0, 7843.254890785366, 7856.84286314282, 7292.744753933587, 7507.88738168917, 7515.361194298327, 7572.138209513298, 7578.772636820904, 7453.031105956191, 7524.247575242432, 7556.962215189109, 7557.2820582044615, 7584.54492730438, 6048.788292409745, 7321.377682897013, 7375.594342311224, 7390.0, 7401.370883474965, 7521.849563008818, 7547.886781698388, 7577.052868391451, 7579.279968402993, 7579.658915348712, 7221.260242616165, 7285.235050319852, 7312.085989251344, 7396.371308438843, 7400.962995185205], "unit": "score", "name": "prototype.html", "value": 5487.464634456434}, {"lowerIsBetter": false, "replicates": [709.9183593886704, 749.093596747935, 758.5941521286111, 768.3968085053231, 778.1557010643452, 15851.128187949658, 16085.0, 16104.516864494055, 16105.194740262983, 16136.83863161368, 14904.776428353556, 14908.627284317898, 14912.25438728062, 14932.850671493281, 14937.804975601954, 773.0607312115778, 914.4970266353512, 941.6892425499586, 953.6328513522275, 971.2958105373618, 930.5533343994887, 957.8515330123842, 968.9951550242274, 969.0745338202036, 970.6311601591385, 982.8918818929913, 998.9001099890025, 1000.6747806962729, 1021.3310281765456, 1023.3194925374617, 974.1524873360152, 989.7624570103195, 993.602558976408, 996.875390576178, 1011.246621267157, 725.2457444258018, 740.315208432198, 740.9592472414015, 747.495440577608, 758.8861670749377, 15502.689946201126, 15560.766588501181, 15623.687526249525, 15764.448244311508, 15863.841361586352, 10971.506282217319, 13391.732165356736, 13466.483585070528, 13518.594442166652, 13677.179369237878, 10171.54228059739, 10206.183505319557, 10315.226358023103, 10421.895781042169, 10699.304545204537, 3580.7135429165864, 3628.365036118695, 3629.6007439181667, 3635.6546128118052, 3744.588095309514, 80572.59713701395, 81070.78393824097, 81567.77648335339, 82032.0, 82238.0, 9688.224942004763, 9857.211423086135, 9936.950315248378, 10000.049687218974, 10135.391876487434, 21613.67579486309, 22230.88884555567, 22392.216272430713, 22968.19611313596, 23154.7684523156, 7600.8479830403085, 7733.7679869604, 7862.0, 7969.561674107864, 8042.839143217103, 4189.664826813848, 4193.97903010483, 4202.411662367271, 4204.0, 4449.221386257392, 3716.572594151653, 3724.8137593120778, 3730.515033045687, 3769.4911186989953, 3779.4708740776314, 661.4873473058323, 671.4896678524259, 673.7473447457204, 694.1669996004714, 700.4956431369405, 551.9862003449946, 607.4988134788817, 608.5435923057706, 611.9816405507842, 612.461034289831, 7184.281571842774, 7606.353459955855, 8510.446820956618, 8533.146685331418, 8666.046734859161, 500.41451501743046, 512.3032675561234, 571.7798647520734, 573.4208449465985, 616.7286393986632, 2974.583558301796, 3825.6748176405317, 3923.509561304837, 4070.5252579525036, 4210.32634778434, 96281.5557766634, 96746.0, 99057.0, 99351.50324248477, 100253.99746002593, 85491.57254213688, 85694.14305856987, 86181.0, 86500.26999459976, 88152.0, 73228.0, 73248.0, 73814.0, 76958.61520692361, 78415.0, 8742.912570874465, 8909.821803563762, 8914.465132092095, 8942.73171804847, 9025.503597302211, 38498.80750596229, 52262.47737522576, 52904.20643690425, 53503.0, 54555.72722136364, 46343.53656463392, 64748.0, 69846.65076674584, 72698.0, 72900.63549682217, 8713.910761154855, 11248.437578121226, 11326.490307935997, 11380.43097845121, 11415.714607134889, 12153.69615759613, 12199.817002744789, 12224.144309898222, 12507.93746031264, 13086.934565327112, 9514.38156519824, 9743.074407931235, 11477.426128693365, 11744.765104697688, 12319.75360492803, 11584.536618535165, 11639.47622356979, 11762.3530705812, 11838.171328006956, 11952.163348565517, 11371.658850234506, 11792.820717928138, 11845.881541184823, 11900.702482438008, 11988.64034078979, 9836.901630983599, 9889.456079915673, 9979.251556133175, 9996.60013599477, 10066.345687530287, 9599.0, 9787.412755234423, 9851.45816980073, 9947.950260248652, 9992.350497217658], "unit": "score", "name": "yui.html", "value": 7137.616006660093}], "name": "dromaeo_css", "value": 7879.099328853068}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 114.0, 115.0, 115.0, 127.0, 111.0, 113.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.6}, {"lowerIsBetter": true, "replicates": [155.0, 135.0, 195.0, 187.0, 153.0, 171.0, 132.0, 153.0, 149.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 155.1}, {"lowerIsBetter": true, "replicates": [193.0, 197.0, 200.0, 200.0, 194.0, 194.0, 198.0, 199.0, 196.0, 195.0], "unit": "score", "name": "audio-dft", "value": 196.6}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 79.0, 109.0, 56.0, 56.0, 56.0, 60.0, 123.0, 56.0], "unit": "score", "name": "audio-fft", "value": 72.3}, {"lowerIsBetter": true, "replicates": [83.0, 79.0, 123.0, 81.0, 82.0, 85.0, 122.0, 81.0, 79.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 93.3}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 88.0, 87.0, 89.0, 85.0, 90.0, 86.0, 103.0, 130.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.3}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 118.0, 95.0, 93.0, 101.0, 114.0, 148.0, 151.0, 152.0], "unit": "score", "name": "imaging-darkroom", "value": 116.5}, {"lowerIsBetter": true, "replicates": [91.0, 106.0, 91.0, 91.0, 97.0, 89.0, 92.0, 99.0, 91.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 94.0}, {"lowerIsBetter": true, "replicates": [56.0, 60.0, 60.0, 57.0, 59.0, 57.0, 59.0, 59.0, 60.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [65.0, 70.0, 65.0, 80.0, 70.0, 71.0, 64.0, 65.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 94.0, 108.0, 111.0, 69.0, 99.0, 108.0, 107.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 94.9}, {"lowerIsBetter": true, "replicates": [128.0, 133.0, 139.0, 116.0, 120.0, 119.0, 134.0, 145.0, 118.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.9}, {"lowerIsBetter": true, "replicates": [126.0, 135.0, 136.0, 135.0, 140.0, 126.0, 136.0, 133.0, 152.0, 173.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.2}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 64.0, 65.0, 68.0, 65.0, 66.0, 70.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1489.1000000000001}]} 11:05:04 INFO - Return code: 0 11:05:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:05:04 ERROR - # TBPL SUCCESS # 11:05:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:05:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:05:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:05:04 INFO - 2016-05-13 11:05:04.570 screenresolution[2256:30908] starting screenresolution argv=screenresolution get 11:05:04 INFO - 2016-05-13 11:05:04.573 screenresolution[2256:30908] Display 0: 1600x1200x32@60 11:05:04 INFO - 2016-05-13 11:05:04.579 screenresolution[2257:30911] starting screenresolution argv=screenresolution list 11:05:04 INFO - Available Modes on Display 0 11:05:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:05:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:05:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:05:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:05:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:05:04 INFO - Intel Iris: 11:05:04 INFO - Chipset Model: Intel Iris 11:05:04 INFO - Type: GPU 11:05:04 INFO - Bus: Built-In 11:05:04 INFO - VRAM (Dynamic, Max): 1536 MB 11:05:04 INFO - Vendor: Intel (0x8086) 11:05:04 INFO - Device ID: 0x0a2e 11:05:04 INFO - Revision ID: 0x0009 11:05:04 INFO - Displays: 11:05:04 INFO - Display: 11:05:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:05:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:05:04 INFO - Display Serial Number: 1600x1200 60 11:05:04 INFO - Main Display: Yes 11:05:04 INFO - Mirror: Off 11:05:04 INFO - Online: Yes 11:05:04 INFO - Rotation: Supported 11:05:04 INFO - Return code: 0 11:05:04 INFO - Running post-action listener: _resource_record_post_action 11:05:04 INFO - Running post-run listener: _resource_record_post_run 11:05:05 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 311296; Write bytes: 509729792; Read time: 2; Write time: 1578 11:05:05 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 198298112; Write bytes: 196141056; Read time: 18093; Write time: 410 11:05:05 INFO - run-tests - Wall time: 1169s; CPU: 53.0%; Read bytes: 311296; Write bytes: 303631360; Read time: 2; Write time: 1132 11:05:05 INFO - Running post-run listener: _upload_blobber_files 11:05:05 INFO - Blob upload gear active. 11:05:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:05:05 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 11:05:05 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:05:05 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:05:06 INFO - (blobuploader) - INFO - Open directory for files ... 11:05:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:05:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:05:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:06 INFO - (blobuploader) - INFO - Done attempting. 11:05:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:05:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:05:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:08 INFO - (blobuploader) - INFO - Done attempting. 11:05:08 INFO - (blobuploader) - INFO - Iteration through files over. 11:05:08 INFO - Return code: 0 11:05:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:05:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:05:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03f82d42183190899ad13109f82c901e7804e325351788acd66f5d4d6200af164c9e5549f608c5a250a9ab8b01f2964c9bf94128fdfdd8d95c758ce15f17504d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/749d4f6e735eb97eb66e2d7726c6dc7dda1fc962f05514e181751e5022b5c8e4faa0e1affb224b9ffa8d3273ac0e8d5c44bf27ca60f8ae96745c7e63c8df8e35"} 11:05:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:05:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:05:08 INFO - Contents: 11:05:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03f82d42183190899ad13109f82c901e7804e325351788acd66f5d4d6200af164c9e5549f608c5a250a9ab8b01f2964c9bf94128fdfdd8d95c758ce15f17504d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/749d4f6e735eb97eb66e2d7726c6dc7dda1fc962f05514e181751e5022b5c8e4faa0e1affb224b9ffa8d3273ac0e8d5c44bf27ca60f8ae96745c7e63c8df8e35"} 11:05:08 INFO - Running post-run listener: copy_logs_to_upload_dir 11:05:08 INFO - Copying logs to upload dir... 11:05:08 INFO - mkdir: /builds/slave/test/build/upload/logs 11:05:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1293.928252 ========= master_lag: 22.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2016-05-13 11:05:30.551530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-05-13 11:05:30.557494) ========= 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.sKlZC4G3m4/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.5GN4WXD1ak/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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/Mozilla-Beta/sha512/03f82d42183190899ad13109f82c901e7804e325351788acd66f5d4d6200af164c9e5549f608c5a250a9ab8b01f2964c9bf94128fdfdd8d95c758ce15f17504d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/749d4f6e735eb97eb66e2d7726c6dc7dda1fc962f05514e181751e5022b5c8e4faa0e1affb224b9ffa8d3273ac0e8d5c44bf27ca60f8ae96745c7e63c8df8e35"} build_url:https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011589 build_url: 'https://queue.taskcluster.net/v1/task/I5iunLLfQBWZkDY_4fJdlg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03f82d42183190899ad13109f82c901e7804e325351788acd66f5d4d6200af164c9e5549f608c5a250a9ab8b01f2964c9bf94128fdfdd8d95c758ce15f17504d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/749d4f6e735eb97eb66e2d7726c6dc7dda1fc962f05514e181751e5022b5c8e4faa0e1affb224b9ffa8d3273ac0e8d5c44bf27ca60f8ae96745c7e63c8df8e35"}' ========= master_lag: 1.31 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-05-13 11:05:31.880231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-05-13 11:05:31.880568) ========= 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.sKlZC4G3m4/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.5GN4WXD1ak/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.005140 ========= master_lag: 5.34 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-05-13 11:05:37.225843) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 11:05:37.230216) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 11:05:38.072771) ========= ========= Total master_lag: 28.93 =========