builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0256 starttime: 1466768072.56 results: success (0) buildid: 20160624023758 builduid: c93e4c60148e44dd80e347d7cffee231 revision: cc7b9052413aea1efe4f89e13b941ca2f5cc2915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 04:34:32.561701) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 04:34:32.562249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 21 secs) (at 2016-06-24 04:34:32.562589) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 21 secs) (at 2016-06-24 04:34:54.235519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 14 secs) (at 2016-06-24 04:34:54.235827) ========= 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.XUBCZG0MPI/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.0cQNU2PPd9/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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-06-24 04:34:54-- 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% 145M=0s 2016-06-24 04:34:55 (145 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.609463 ========= master_lag: 14.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 14 secs) (at 2016-06-24 04:35:09.095237) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-06-24 04:35:09.095558) ========= 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.XUBCZG0MPI/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.0cQNU2PPd9/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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.020318 ========= master_lag: 3.76 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-06-24 04:35:12.875148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 04:35:12.875523) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cc7b9052413aea1efe4f89e13b941ca2f5cc2915 --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 cc7b9052413aea1efe4f89e13b941ca2f5cc2915 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XUBCZG0MPI/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.0cQNU2PPd9/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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-06-24 04:35:13,027 truncating revision to first 12 chars 2016-06-24 04:35:13,027 Setting DEBUG logging. 2016-06-24 04:35:13,028 attempt 1/10 2016-06-24 04:35:13,028 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cc7b9052413a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 04:35:13,811 unpacking tar archive at: mozilla-beta-cc7b9052413a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.132270 ========= master_lag: 0.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 04:35:14.212860) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 04:35:14.213235) ========= script_repo_revision: cc7b9052413aea1efe4f89e13b941ca2f5cc2915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 04:35:14.213676) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 8 secs) (at 2016-06-24 04:35:14.216175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 8 secs) (at 2016-06-24 04:35:22.630905) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-24 04:35:22.631279) ========= /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.XUBCZG0MPI/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.0cQNU2PPd9/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 04:35:24 INFO - MultiFileLogger online at 20160624 04:35:24 in /builds/slave/test 04:35:24 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 04:35:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:35:24 INFO - {'append_to_log': False, 04:35:24 INFO - 'base_work_dir': '/builds/slave/test', 04:35:24 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:35:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:35:24 INFO - 'branch': 'Mozilla-Beta', 04:35:24 INFO - 'buildbot_json_path': 'buildprops.json', 04:35:24 INFO - 'config_files': ('talos/mac_config.py',), 04:35:24 INFO - 'default_actions': ('clobber', 04:35:24 INFO - 'read-buildbot-config', 04:35:24 INFO - 'download-and-extract', 04:35:24 INFO - 'populate-webroot', 04:35:24 INFO - 'create-virtualenv', 04:35:24 INFO - 'install', 04:35:24 INFO - 'run-tests'), 04:35:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:35:24 INFO - 'download_minidump_stackwalk': True, 04:35:24 INFO - 'download_symbols': 'ondemand', 04:35:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:35:24 INFO - 'tooltool.py': '/tools/tooltool.py', 04:35:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:35:24 INFO - '/tools/misc-python/virtualenv.py')}, 04:35:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:35:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:35:24 INFO - 'installer_path': 'installer.exe', 04:35:24 INFO - 'log_level': 'info', 04:35:24 INFO - 'log_name': 'talos', 04:35:24 INFO - 'log_to_console': True, 04:35:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:35:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:35:24 INFO - 'opt_config_files': (), 04:35:24 INFO - 'pip_index': False, 04:35:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:35:24 INFO - 'cmd': ('bash', 04:35:24 INFO - '-c', 04:35:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:35:24 INFO - 'enabled': True, 04:35:24 INFO - 'halt_on_failure': False, 04:35:24 INFO - 'name': 'check_screen_resolution'},), 04:35:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:35:24 INFO - 'cmd': ('bash', 04:35:24 INFO - '-c', 04:35:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:35:24 INFO - 'enabled': True, 04:35:24 INFO - 'halt_on_failure': False, 04:35:24 INFO - 'name': 'check_screen_resolution'},), 04:35:24 INFO - 'run_cmd_checks_enabled': True, 04:35:24 INFO - 'sps_profile': False, 04:35:24 INFO - 'sps_profile_interval': 0, 04:35:24 INFO - 'suite': 'dromaeojs-e10s', 04:35:24 INFO - 'system_bits': '32', 04:35:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:35:24 INFO - 'title': 't-yosemite-r7-0256', 04:35:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:35:24 INFO - 'use_talos_json': True, 04:35:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:35:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:35:24 INFO - 'work_dir': 'build'} 04:35:24 INFO - ##### 04:35:24 INFO - ##### Running clobber step. 04:35:24 INFO - ##### 04:35:24 INFO - Running pre-action listener: _resource_record_pre_action 04:35:24 INFO - Running main action method: clobber 04:35:24 INFO - rmtree: /builds/slave/test/build 04:35:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:35:25 INFO - Running post-action listener: _resource_record_post_action 04:35:25 INFO - ##### 04:35:25 INFO - ##### Running read-buildbot-config step. 04:35:25 INFO - ##### 04:35:25 INFO - Running pre-action listener: _resource_record_pre_action 04:35:25 INFO - Running main action method: read_buildbot_config 04:35:25 INFO - Using buildbot properties: 04:35:25 INFO - { 04:35:25 INFO - "project": "", 04:35:25 INFO - "product": "firefox", 04:35:25 INFO - "script_repo_revision": "production", 04:35:25 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:35:25 INFO - "repository": "", 04:35:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:35:25 INFO - "buildid": "20160624023758", 04:35:25 INFO - "pgo_build": "False", 04:35:25 INFO - "basedir": "/builds/slave/test", 04:35:25 INFO - "buildnumber": 5, 04:35:25 INFO - "slavename": "t-yosemite-r7-0256", 04:35:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:35:25 INFO - "platform": "yosemite_r7", 04:35:25 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:35:25 INFO - "branch": "mozilla-beta", 04:35:25 INFO - "repo_path": "releases/mozilla-beta", 04:35:25 INFO - "revision": "cc7b9052413aea1efe4f89e13b941ca2f5cc2915", 04:35:25 INFO - "stage_platform": "macosx64", 04:35:25 INFO - "builduid": "c93e4c60148e44dd80e347d7cffee231", 04:35:25 INFO - "slavebuilddir": "test" 04:35:25 INFO - } 04:35:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 04:35:25 INFO - Running post-action listener: _resource_record_post_action 04:35:25 INFO - ##### 04:35:25 INFO - ##### Running download-and-extract step. 04:35:25 INFO - ##### 04:35:25 INFO - Running pre-action listener: _resource_record_pre_action 04:35:25 INFO - Running main action method: download_and_extract 04:35:25 INFO - mkdir: /builds/slave/test/build/tests 04:35: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')]} 04:35:25 INFO - https://queue.taskcluster.net/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:35:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:35:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:35:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 04:35:26 INFO - Downloaded 1165 bytes. 04:35:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:35:26 INFO - Using the following test package requirements: 04:35:26 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:35:26 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:35:26 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 04:35:26 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:35:26 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 04:35:26 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:35:26 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:35:26 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 04:35:26 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:35:26 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:35:26 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 04:35:26 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:35:26 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 04:35:26 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:35:26 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 04:35:26 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:35:26 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 04:35:26 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 04:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:26 INFO - https://queue.taskcluster.net/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:35:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:35:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:35:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:35:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:35:27 INFO - Downloaded 18344060 bytes. 04:35:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:35:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:35:30 INFO - Return code: 0 04:35:30 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:35:30 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')]} 04:35:30 INFO - https://queue.taskcluster.net/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:35:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:35:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:35:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:35:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:35:31 INFO - Downloaded 18344060 bytes. 04:35:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:35:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:35:35 INFO - Return code: 0 04:35: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')]} 04:35:35 INFO - https://queue.taskcluster.net/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:35:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:35:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:35:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 04:35:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 04:35:36 INFO - Downloaded 10840145 bytes. 04:35:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:35:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:35:36 INFO - Return code: 0 04:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:36 INFO - https://queue.taskcluster.net/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 04:35:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:35:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:35:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 04:35:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 04:35:42 INFO - Downloaded 86224629 bytes. 04:35:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:35:42 INFO - mkdir: /builds/slave/test/properties 04:35:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:35:42 INFO - Writing to file /builds/slave/test/properties/build_url 04:35:42 INFO - Contents: 04:35:42 INFO - build_url:https://queue.taskcluster.net/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:35:43 INFO - Running post-action listener: _resource_record_post_action 04:35:43 INFO - Running post-action listener: set_extra_try_arguments 04:35:43 INFO - ##### 04:35:43 INFO - ##### Running populate-webroot step. 04:35:43 INFO - ##### 04:35:43 INFO - Running pre-action listener: _resource_record_pre_action 04:35:43 INFO - Running main action method: populate_webroot 04:35:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:35:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:35:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:35:43 INFO - '--tppagecycles', 04:35:43 INFO - '7'], 04:35:43 INFO - 'tests': ['tsvgm']}}, 04:35:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:35:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:35:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:35:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:35:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:35:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:35:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:43 INFO - 'talos_options': ['--disable-e10s'], 04:35:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:35:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:35:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:43 INFO - 'talos_options': ['--disable-e10s'], 04:35:43 INFO - 'tests': ['damp', 'tps']}, 04:35:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:43 INFO - 'tests': ['damp', 'tps']}, 04:35:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:35:43 INFO - 'tests': ['dromaeo_dom']}, 04:35:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:35:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:35:43 INFO - 'tests': ['a11yr', 04:35:43 INFO - 'ts_paint', 04:35:43 INFO - 'tpaint', 04:35:43 INFO - 'sessionrestore', 04:35:43 INFO - 'sessionrestore_no_auto_restore', 04:35:43 INFO - 'tabpaint']}, 04:35:43 INFO - 'other-e10s': {'tests': ['a11yr', 04:35:43 INFO - 'ts_paint', 04:35:43 INFO - 'tpaint', 04:35:43 INFO - 'sessionrestore', 04:35:43 INFO - 'sessionrestore_no_auto_restore', 04:35:43 INFO - 'tabpaint']}, 04:35:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:35:43 INFO - 'ts_paint', 04:35:43 INFO - 'tpaint', 04:35:43 INFO - 'sessionrestore', 04:35:43 INFO - 'sessionrestore_no_auto_restore', 04:35:43 INFO - 'tabpaint']}, 04:35:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:35:43 INFO - 'ts_paint', 04:35:43 INFO - 'tpaint', 04:35:43 INFO - 'sessionrestore', 04:35:43 INFO - 'sessionrestore_no_auto_restore', 04:35:43 INFO - 'tabpaint']}, 04:35:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:35:43 INFO - 'tests': ['a11yr', 04:35:43 INFO - 'ts_paint', 04:35:43 INFO - 'tpaint', 04:35:43 INFO - 'sessionrestore', 04:35:43 INFO - 'sessionrestore_no_auto_restore', 04:35:43 INFO - 'tabpaint']}, 04:35:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:35:43 INFO - 'tests': ['a11yr', 04:35:43 INFO - 'ts_paint', 04:35:43 INFO - 'tpaint', 04:35:43 INFO - 'sessionrestore', 04:35:43 INFO - 'sessionrestore_no_auto_restore', 04:35:43 INFO - 'tabpaint']}, 04:35:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:35:43 INFO - 'tests': ['tsvgx', 04:35:43 INFO - 'tsvgr_opacity', 04:35:43 INFO - 'tart', 04:35:43 INFO - 'tscrollx', 04:35:43 INFO - 'cart']}, 04:35:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:35:43 INFO - 'tsvgr_opacity', 04:35:43 INFO - 'tart', 04:35:43 INFO - 'tscrollx', 04:35:43 INFO - 'cart']}, 04:35:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:43 INFO - 'talos_options': ['--disable-e10s'], 04:35:43 INFO - 'tests': ['tp5o']}, 04:35:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:43 INFO - 'tests': ['tp5o']}, 04:35:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:43 INFO - 'talos_options': ['--disable-e10s', 04:35:43 INFO - '--xperf_path', 04:35:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:35:43 INFO - 'tests': ['tp5n']}, 04:35:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:35:43 INFO - 'talos_options': ['--xperf_path', 04:35:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:35:43 INFO - 'tests': ['tp5n']}}, 04:35:43 INFO - 'talos.zip': {'path': '', 04:35:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:35:43 INFO - Running post-action listener: _resource_record_post_action 04:35:43 INFO - ##### 04:35:43 INFO - ##### Running create-virtualenv step. 04:35:43 INFO - ##### 04:35:43 INFO - Running pre-action listener: _resource_record_pre_action 04:35:43 INFO - Running main action method: create_virtualenv 04:35:43 INFO - Creating virtualenv /builds/slave/test/build/venv 04:35:43 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 04:35:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:35:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:35:43 INFO - Using real prefix '/tools/python27' 04:35:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:35:44 INFO - Installing distribute.............................................................................................................................................................................................done. 04:35:46 INFO - Installing pip.................done. 04:35:46 INFO - Return code: 0 04:35:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:46 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 0x10be50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be60420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d8c74b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcefe00>, '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 0x10bb58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bceab20>, '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.XUBCZG0MPI/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.0cQNU2PPd9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 04:35:46 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 04:35:46 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 04:35:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XUBCZG0MPI/Render', 04:35:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:46 INFO - 'HOME': '/Users/cltbld', 04:35:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:46 INFO - 'LOGNAME': 'cltbld', 04:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:46 INFO - 'MOZ_NO_REMOTE': '1', 04:35:46 INFO - 'NO_EM_RESTART': '1', 04:35:46 INFO - 'PAGER': '/bin/cat', 04:35:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:46 INFO - 'PWD': '/builds/slave/test', 04:35:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:46 INFO - 'SHELL': '/bin/bash', 04:35:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0cQNU2PPd9/Listeners', 04:35:46 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 04:35:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:46 INFO - 'USER': 'cltbld', 04:35:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:46 INFO - 'XPC_FLAGS': '0x0', 04:35:46 INFO - 'XPC_SERVICE_NAME': '0', 04:35:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:47 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 04:35:47 INFO - Cleaning up... 04:35:47 INFO - Return code: 0 04:35:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:35: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')]} 04:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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')]} 04:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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', '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 0x10be50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be60420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d8c74b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcefe00>, '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 0x10bb58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bceab20>, '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.XUBCZG0MPI/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.0cQNU2PPd9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 04:35: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', 'psutil>=0.7.1'] in /builds/slave/test/build 04:35: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 psutil>=0.7.1 04:35:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XUBCZG0MPI/Render', 04:35:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:47 INFO - 'HOME': '/Users/cltbld', 04:35:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:47 INFO - 'LOGNAME': 'cltbld', 04:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:47 INFO - 'MOZ_NO_REMOTE': '1', 04:35:47 INFO - 'NO_EM_RESTART': '1', 04:35:47 INFO - 'PAGER': '/bin/cat', 04:35:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:47 INFO - 'PWD': '/builds/slave/test', 04:35:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:47 INFO - 'SHELL': '/bin/bash', 04:35:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0cQNU2PPd9/Listeners', 04:35:47 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 04:35:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:47 INFO - 'USER': 'cltbld', 04:35:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:47 INFO - 'XPC_FLAGS': '0x0', 04:35:47 INFO - 'XPC_SERVICE_NAME': '0', 04:35:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:47 INFO - Downloading/unpacking psutil>=0.7.1 04:35: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 04:35: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 04:35: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 04:35: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 04:35: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 04:35: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 04:35:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:35:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:50 INFO - Installing collected packages: psutil 04:35:50 INFO - Running setup.py install for psutil 04:35:50 INFO - building 'psutil._psutil_osx' extension 04:35:50 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 04:35:50 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 04:35:50 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 04:35:50 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 04:35:50 INFO - building 'psutil._psutil_posix' extension 04:35:50 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 04:35:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:35:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:35:50 INFO - ^ 04:35:50 INFO - 1 warning generated. 04:35:50 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 04:35:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:50 INFO - Successfully installed psutil 04:35:50 INFO - Cleaning up... 04:35:50 INFO - Return code: 0 04:35:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:35: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')]} 04:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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')]} 04:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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', '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 0x10be50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be60420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d8c74b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcefe00>, '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 0x10bb58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bceab20>, '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.XUBCZG0MPI/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.0cQNU2PPd9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 04:35: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:35: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 mozsystemmonitor==0.0.0 04:35:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XUBCZG0MPI/Render', 04:35:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:50 INFO - 'HOME': '/Users/cltbld', 04:35:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:50 INFO - 'LOGNAME': 'cltbld', 04:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:50 INFO - 'MOZ_NO_REMOTE': '1', 04:35:50 INFO - 'NO_EM_RESTART': '1', 04:35:50 INFO - 'PAGER': '/bin/cat', 04:35:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:50 INFO - 'PWD': '/builds/slave/test', 04:35:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:50 INFO - 'SHELL': '/bin/bash', 04:35:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0cQNU2PPd9/Listeners', 04:35:50 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 04:35:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:50 INFO - 'USER': 'cltbld', 04:35:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:50 INFO - 'XPC_FLAGS': '0x0', 04:35:50 INFO - 'XPC_SERVICE_NAME': '0', 04:35:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:35:51 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 04:35:51 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 04:35:51 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 04:35:51 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 04:35:51 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 04:35:51 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 04:35:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:35:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:35:53 INFO - Installing collected packages: mozsystemmonitor 04:35:53 INFO - Running setup.py install for mozsystemmonitor 04:35:53 INFO - Successfully installed mozsystemmonitor 04:35:53 INFO - Cleaning up... 04:35:53 INFO - Return code: 0 04:35:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:53 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 0x10be50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be60420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d8c74b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcefe00>, '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 0x10bb58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bceab20>, '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.XUBCZG0MPI/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.0cQNU2PPd9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 04:35:53 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 04:35:53 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 04:35:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XUBCZG0MPI/Render', 04:35:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:53 INFO - 'HOME': '/Users/cltbld', 04:35:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:53 INFO - 'LOGNAME': 'cltbld', 04:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:53 INFO - 'MOZ_NO_REMOTE': '1', 04:35:53 INFO - 'NO_EM_RESTART': '1', 04:35:53 INFO - 'PAGER': '/bin/cat', 04:35:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:53 INFO - 'PWD': '/builds/slave/test', 04:35:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:53 INFO - 'SHELL': '/bin/bash', 04:35:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0cQNU2PPd9/Listeners', 04:35:53 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 04:35:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:53 INFO - 'USER': 'cltbld', 04:35:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:53 INFO - 'XPC_FLAGS': '0x0', 04:35:53 INFO - 'XPC_SERVICE_NAME': '0', 04:35:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:56 INFO - Downloading blobuploader-1.2.4.tar.gz 04:35:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:35:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:35:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:35:57 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 04:35:57 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 04:35:57 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 04:35:57 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 04:35:57 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 04:35:57 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 04:35:57 INFO - Downloading docopt-0.6.1.tar.gz 04:35:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:35:57 INFO - Installing collected packages: blobuploader, requests, docopt 04:35:57 INFO - Running setup.py install for blobuploader 04:35:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:35:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:35:58 INFO - Running setup.py install for requests 04:35:58 INFO - Running setup.py install for docopt 04:35:58 INFO - Successfully installed blobuploader requests docopt 04:35:58 INFO - Cleaning up... 04:35:58 INFO - Return code: 0 04:35:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:58 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 0x10be50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be60420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d8c74b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcefe00>, '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 0x10bb58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bceab20>, '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.XUBCZG0MPI/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.0cQNU2PPd9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 04:35:58 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 04:35:58 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 04:35:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XUBCZG0MPI/Render', 04:35:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:58 INFO - 'HOME': '/Users/cltbld', 04:35:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:58 INFO - 'LOGNAME': 'cltbld', 04:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:58 INFO - 'MOZ_NO_REMOTE': '1', 04:35:58 INFO - 'NO_EM_RESTART': '1', 04:35:58 INFO - 'PAGER': '/bin/cat', 04:35:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:58 INFO - 'PWD': '/builds/slave/test', 04:35:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:58 INFO - 'SHELL': '/bin/bash', 04:35:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0cQNU2PPd9/Listeners', 04:35:58 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 04:35:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:58 INFO - 'USER': 'cltbld', 04:35:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:58 INFO - 'XPC_FLAGS': '0x0', 04:35:58 INFO - 'XPC_SERVICE_NAME': '0', 04:35:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:59 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-DLgt5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:59 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-QeixvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:59 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-dKwnzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:59 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-pLjj4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:59 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-OZqKdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:59 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-nG0UB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:59 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Fzw7Ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:59 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-ByCywp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:59 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-NEHihW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:00 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-LyG1iT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:00 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-WtB5Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:00 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-waaIYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:00 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-mwvI0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:00 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-1d2yK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:00 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-ju0iRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:00 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-LF5FNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:00 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-igzUR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:36:00 INFO - Running setup.py install for manifestparser 04:36:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:36:01 INFO - Running setup.py install for mozcrash 04:36:01 INFO - Running setup.py install for mozdebug 04:36:01 INFO - Running setup.py install for mozdevice 04:36:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:36:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:36:01 INFO - Running setup.py install for mozfile 04:36:01 INFO - Running setup.py install for mozhttpd 04:36:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:36:01 INFO - Running setup.py install for mozinfo 04:36:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:36:01 INFO - Running setup.py install for mozInstall 04:36:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Running setup.py install for mozleak 04:36:02 INFO - Running setup.py install for mozlog 04:36:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Running setup.py install for moznetwork 04:36:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Running setup.py install for mozprocess 04:36:02 INFO - Running setup.py install for mozprofile 04:36:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:36:02 INFO - Running setup.py install for mozrunner 04:36:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:36:03 INFO - Running setup.py install for mozscreenshot 04:36:03 INFO - Running setup.py install for moztest 04:36:03 INFO - Running setup.py install for mozversion 04:36:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:36:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:36:03 INFO - Cleaning up... 04:36:03 INFO - Return code: 0 04:36:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:03 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')]} 04:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:03 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')]} 04:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:03 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 0x10be50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be60420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d8c74b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcefe00>, '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 0x10bb58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bceab20>, '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.XUBCZG0MPI/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.0cQNU2PPd9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 04:36:03 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 04:36:03 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 04:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XUBCZG0MPI/Render', 04:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:03 INFO - 'HOME': '/Users/cltbld', 04:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:03 INFO - 'LOGNAME': 'cltbld', 04:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:03 INFO - 'MOZ_NO_REMOTE': '1', 04:36:03 INFO - 'NO_EM_RESTART': '1', 04:36:03 INFO - 'PAGER': '/bin/cat', 04:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:03 INFO - 'PWD': '/builds/slave/test', 04:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:03 INFO - 'SHELL': '/bin/bash', 04:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0cQNU2PPd9/Listeners', 04:36:03 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 04:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:03 INFO - 'USER': 'cltbld', 04:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:03 INFO - 'XPC_FLAGS': '0x0', 04:36:03 INFO - 'XPC_SERVICE_NAME': '0', 04:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:03 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-8bqeqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:03 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)) 04:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:03 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-fBqfPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:03 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)) 04:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:03 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-fRIlTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:04 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)) 04:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:04 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-YXSPcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:04 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)) 04:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:04 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-rH04bT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:04 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)) 04:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:04 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-AFfkrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:04 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)) 04:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:04 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-3Sg2bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:04 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)) 04:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:04 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-6T5sqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:04 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)) 04:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:04 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-SWrvOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:04 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)) 04:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:04 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-kLsc4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:04 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)) 04:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:04 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-RoPV4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:04 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)) 04:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:04 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-m2zLLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:04 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)) 04:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:04 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-hf_VPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:05 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)) 04:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:05 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-izR3CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:05 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)) 04:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:05 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-WAhOk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:05 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)) 04:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:05 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Uvbj_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:05 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)) 04:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:05 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-FogIMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:05 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)) 04:36:05 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)) 04:36:05 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)) 04:36:05 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)) 04:36:05 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)) 04:36:05 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)) 04:36:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:07 INFO - Downloading blessings-1.6.tar.gz 04:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:36:08 INFO - Installing collected packages: blessings 04:36:08 INFO - Running setup.py install for blessings 04:36:08 INFO - Successfully installed blessings 04:36:08 INFO - Cleaning up... 04:36:08 INFO - Return code: 0 04:36:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:36:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:08 INFO - Reading from file tmpfile_stdout 04:36:08 INFO - Current package versions: 04:36:08 INFO - blessings == 1.6 04:36:08 INFO - blobuploader == 1.2.4 04:36:08 INFO - docopt == 0.6.1 04:36:08 INFO - manifestparser == 1.1 04:36:08 INFO - mozInstall == 1.12 04:36:08 INFO - mozcrash == 0.17 04:36:08 INFO - mozdebug == 0.1 04:36:08 INFO - mozdevice == 0.48 04:36:08 INFO - mozfile == 1.2 04:36:08 INFO - mozhttpd == 0.7 04:36:08 INFO - mozinfo == 0.9 04:36:08 INFO - mozleak == 0.1 04:36:08 INFO - mozlog == 3.1 04:36:08 INFO - moznetwork == 0.27 04:36:08 INFO - mozprocess == 0.22 04:36:08 INFO - mozprofile == 0.28 04:36:08 INFO - mozrunner == 6.11 04:36:08 INFO - mozscreenshot == 0.1 04:36:08 INFO - mozsystemmonitor == 0.0 04:36:08 INFO - moztest == 0.7 04:36:08 INFO - mozversion == 1.4 04:36:08 INFO - psutil == 3.1.1 04:36:08 INFO - requests == 1.2.3 04:36:08 INFO - wsgiref == 0.1.2 04:36:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:08 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 0x10be50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be60420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d8c74b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcefe00>, '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 0x10bb58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bceab20>, '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.XUBCZG0MPI/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.0cQNU2PPd9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 04:36:08 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 04:36:08 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 04:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XUBCZG0MPI/Render', 04:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:08 INFO - 'HOME': '/Users/cltbld', 04:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:08 INFO - 'LOGNAME': 'cltbld', 04:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:08 INFO - 'MOZ_NO_REMOTE': '1', 04:36:08 INFO - 'NO_EM_RESTART': '1', 04:36:08 INFO - 'PAGER': '/bin/cat', 04:36:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:08 INFO - 'PWD': '/builds/slave/test', 04:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:08 INFO - 'SHELL': '/bin/bash', 04:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0cQNU2PPd9/Listeners', 04:36:08 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 04:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:08 INFO - 'USER': 'cltbld', 04:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:08 INFO - 'XPC_FLAGS': '0x0', 04:36:08 INFO - 'XPC_SERVICE_NAME': '0', 04:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:08 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)) 04:36:08 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)) 04:36:08 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)) 04:36:08 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)) 04:36:08 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)) 04:36:08 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)) 04:36:08 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)) 04:36:08 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)) 04:36:08 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)) 04:36:08 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)) 04:36:08 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)) 04:36:08 INFO - Cleaning up... 04:36:08 INFO - Return code: 0 04:36:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be60420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d8c74b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcefe00>, '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 0x10bb58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bceab20>, '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.XUBCZG0MPI/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.0cQNU2PPd9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 04:36: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', 'jsonschema'] in /builds/slave/test/build 04:36: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 jsonschema 04:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XUBCZG0MPI/Render', 04:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:08 INFO - 'HOME': '/Users/cltbld', 04:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:08 INFO - 'LOGNAME': 'cltbld', 04:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:08 INFO - 'MOZ_NO_REMOTE': '1', 04:36:08 INFO - 'NO_EM_RESTART': '1', 04:36:08 INFO - 'PAGER': '/bin/cat', 04:36:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:08 INFO - 'PWD': '/builds/slave/test', 04:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:08 INFO - 'SHELL': '/bin/bash', 04:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0cQNU2PPd9/Listeners', 04:36:08 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 04:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:08 INFO - 'USER': 'cltbld', 04:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:08 INFO - 'XPC_FLAGS': '0x0', 04:36:08 INFO - 'XPC_SERVICE_NAME': '0', 04:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:09 INFO - Downloading/unpacking jsonschema 04:36:09 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 04:36:09 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 04:36:09 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 04:36:09 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 04:36:09 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 04:36:09 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 04:36:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:36:11 INFO - Downloading/unpacking functools32 (from jsonschema) 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:11 INFO - Downloading functools32-3.2.3-2.tar.gz 04:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:36:11 INFO - warning: no files found matching '*.txt' 04:36:11 INFO - no previously-included directories found matching 'build' 04:36:11 INFO - no previously-included directories found matching 'dist' 04:36:11 INFO - no previously-included directories found matching '.git*' 04:36:11 INFO - Installing collected packages: jsonschema, functools32 04:36:12 INFO - Running setup.py install for functools32 04:36:12 INFO - warning: no files found matching '*.txt' 04:36:12 INFO - no previously-included directories found matching 'build' 04:36:12 INFO - no previously-included directories found matching 'dist' 04:36:12 INFO - no previously-included directories found matching '.git*' 04:36:12 INFO - Successfully installed jsonschema functools32 04:36:12 INFO - Cleaning up... 04:36:12 INFO - Return code: 0 04:36:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:36:12 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')]} 04:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:12 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')]} 04:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:12 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 0x10be50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be60420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87d8c74b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcefe00>, '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 0x10bb58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bceab20>, '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.XUBCZG0MPI/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.0cQNU2PPd9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 04:36:12 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 04:36:12 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 04:36:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XUBCZG0MPI/Render', 04:36:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:12 INFO - 'HOME': '/Users/cltbld', 04:36:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:12 INFO - 'LOGNAME': 'cltbld', 04:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:12 INFO - 'MOZ_NO_REMOTE': '1', 04:36:12 INFO - 'NO_EM_RESTART': '1', 04:36:12 INFO - 'PAGER': '/bin/cat', 04:36:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:12 INFO - 'PWD': '/builds/slave/test', 04:36:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:12 INFO - 'SHELL': '/bin/bash', 04:36:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0cQNU2PPd9/Listeners', 04:36:12 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 04:36:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:12 INFO - 'USER': 'cltbld', 04:36:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:12 INFO - 'XPC_FLAGS': '0x0', 04:36:12 INFO - 'XPC_SERVICE_NAME': '0', 04:36:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:12 INFO - Downloading/unpacking flake8 04:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:36:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:36:14 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 04:36:14 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 04:36:14 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 04:36:14 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 04:36:14 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 04:36:14 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 04:36:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:36:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:36:15 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 04:36:15 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 04:36:15 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 04:36:15 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 04:36:15 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 04:36:15 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 04:36:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:36:15 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 04:36:15 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 04:36:15 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 04:36:15 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 04:36:15 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 04:36:15 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 04:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:36:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:36:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:36:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:36:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:36:16 INFO - no previously-included directories found matching 'docs/_build' 04:36:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:36:16 INFO - Running setup.py install for pep8 04:36:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:36:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:36:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:36:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:36:16 INFO - no previously-included directories found matching 'docs/_build' 04:36:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:36:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:36:16 INFO - Cleaning up... 04:36:16 INFO - Return code: 0 04:36:16 INFO - Running post-action listener: _resource_record_post_action 04:36:16 INFO - Running post-action listener: _start_resource_monitoring 04:36:16 INFO - Starting resource monitoring. 04:36:16 INFO - ##### 04:36:16 INFO - ##### Running install step. 04:36:16 INFO - ##### 04:36:16 INFO - Running pre-action listener: _resource_record_pre_action 04:36:16 INFO - Running main action method: install 04:36:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:16 INFO - Reading from file tmpfile_stdout 04:36:16 INFO - Detecting whether we're running mozinstall >=1.0... 04:36:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:36:16 INFO - Reading from file tmpfile_stdout 04:36:16 INFO - Output received: 04:36:16 INFO - Usage: mozinstall [options] installer 04:36:16 INFO - Options: 04:36:16 INFO - -h, --help show this help message and exit 04:36:16 INFO - -d DEST, --destination=DEST 04:36:16 INFO - Directory to install application into. [default: 04:36:16 INFO - "/builds/slave/test"] 04:36:16 INFO - --app=APP Application being installed. [default: firefox] 04:36:16 INFO - mkdir: /builds/slave/test/build/application 04:36:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:36:38 INFO - Reading from file tmpfile_stdout 04:36:38 INFO - Output received: 04:36:38 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:36:38 INFO - Running post-action listener: _resource_record_post_action 04:36:38 INFO - ##### 04:36:38 INFO - ##### Running run-tests step. 04:36:38 INFO - ##### 04:36:38 INFO - Running pre-action listener: _resource_record_pre_action 04:36:38 INFO - Running main action method: run_tests 04:36:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:36:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:36:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:36:38 INFO - 2016-06-24 04:36:38.780 screenresolution[6177:104197] starting screenresolution argv=screenresolution get 04:36:38 INFO - 2016-06-24 04:36:38.782 screenresolution[6177:104197] Display 0: 1600x1200x32@60 04:36:38 INFO - 2016-06-24 04:36:38.788 screenresolution[6178:104199] starting screenresolution argv=screenresolution list 04:36:38 INFO - Available Modes on Display 0 04:36:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:36:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:36:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:36:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:36:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:36:39 INFO - Intel Iris: 04:36:39 INFO - Chipset Model: Intel Iris 04:36:39 INFO - Type: GPU 04:36:39 INFO - Bus: Built-In 04:36:39 INFO - VRAM (Dynamic, Max): 1536 MB 04:36:39 INFO - Vendor: Intel (0x8086) 04:36:39 INFO - Device ID: 0x0a2e 04:36:39 INFO - Revision ID: 0x0009 04:36:39 INFO - Displays: 04:36:39 INFO - Display: 04:36:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:36:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:36:39 INFO - Display Serial Number: 1600x1200 60 04:36:39 INFO - Main Display: Yes 04:36:39 INFO - Mirror: Off 04:36:39 INFO - Online: Yes 04:36:39 INFO - Rotation: Supported 04:36:39 INFO - Return code: 0 04:36:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:36:39 INFO - Python 2.7.3 04:36:39 INFO - Return code: 0 04:36:39 INFO - grabbing minidump binary from tooltool 04:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:39 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 0x10bcefe00>, '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 0x10bb58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bceab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:36:39 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 04:36:39 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 04:36:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:36:39 INFO - Return code: 0 04:36:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:36:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:36:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:36:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:36:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:36:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:36:40 INFO - Return code: 0 04:36:40 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/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0256', '--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 04:36:40 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/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0256 --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 04:36:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XUBCZG0MPI/Render', 04:36:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:40 INFO - 'HOME': '/Users/cltbld', 04:36:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:40 INFO - 'LOGNAME': 'cltbld', 04:36:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:36:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:40 INFO - 'MOZ_NO_REMOTE': '1', 04:36:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:36:40 INFO - 'NO_EM_RESTART': '1', 04:36:40 INFO - 'PAGER': '/bin/cat', 04:36:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:40 INFO - 'PWD': '/builds/slave/test', 04:36:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:36:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:40 INFO - 'SHELL': '/bin/bash', 04:36:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0cQNU2PPd9/Listeners', 04:36:40 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 04:36:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:40 INFO - 'USER': 'cltbld', 04:36:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:40 INFO - 'XPC_FLAGS': '0x0', 04:36:40 INFO - 'XPC_SERVICE_NAME': '0', 04:36:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:40 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/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0256', '--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 04:36:40 INFO - mozversion application_buildid: 20160624023758 04:36:40 INFO - mozversion application_changeset: cc7b9052413aea1efe4f89e13b941ca2f5cc2915 04:36:40 INFO - mozversion application_display_name: Firefox 04:36:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:36:40 INFO - mozversion application_name: Firefox 04:36:40 INFO - mozversion application_remotingname: firefox 04:36:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:36:40 INFO - mozversion application_vendor: Mozilla 04:36:40 INFO - mozversion application_version: 48.0 04:36:40 INFO - mozversion platform_buildid: 20160624023758 04:36:40 INFO - mozversion platform_changeset: cc7b9052413aea1efe4f89e13b941ca2f5cc2915 04:36:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:36:40 INFO - mozversion platform_version: 48.0 04:36:40 INFO - using testdate: 1466768200 04:36:40 INFO - actual date: 1466768200 04:36:40 INFO - starting webserver on 'localhost:56758' 04:36:40 INFO - SUITE-START | Running 2 tests 04:36:40 INFO - TEST-START | dromaeo_css 04:36:40 INFO - operating with platform_type : mac_ 04:36:40 INFO - Initialising browser for dromaeo_css test... 04:36:40 INFO - TEST-INFO | started process 6196 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpYiht0h/profile http://localhost:56758/getInfo.html) 04:36:43 INFO - PROCESS | 6196 | __metrics Screen width/height:1600/1200 04:36:43 INFO - PROCESS | 6196 | colorDepth:24 04:36:43 INFO - PROCESS | 6196 | Browser inner width/height: 1024/689 04:36:43 INFO - PROCESS | 6196 | __metrics 04:36:43 ERROR - PROCESS | 6196 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:36:43 INFO - TEST-INFO | 6196: exit 0 04:36:43 INFO - Browser initialized. 04:36:43 INFO - Running cycle 1/1 for dromaeo_css test... 04:36:43 INFO - TEST-INFO | started process 6201 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpYiht0h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:55 INFO - PROCESS | 6201 | RSS: Main: 170717184 04:36:55 INFO - PROCESS | 6201 | 04:37:45 INFO - PROCESS | 6201 | 1466768265457 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] 04:39:55 INFO - PROCESS | 6201 | Cycle 1(1): loaded http://localhost:56758/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56758/tests/dromaeo/cssquery-ext.html) 04:39:56 INFO - PROCESS | 6201 | RSS: Main: 181985280 04:39:56 INFO - PROCESS | 6201 | 04:42:58 INFO - PROCESS | 6201 | Cycle 1(1): loaded http://localhost:56758/tests/dromaeo/cssquery-ext.html (next: http://localhost:56758/tests/dromaeo/cssquery-jquery.html) 04:42:59 INFO - PROCESS | 6201 | RSS: Main: 192512000 04:42:59 INFO - PROCESS | 6201 | 04:46:01 INFO - PROCESS | 6201 | Cycle 1(1): loaded http://localhost:56758/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56758/tests/dromaeo/cssquery-mootools.html) 04:46:01 INFO - PROCESS | 6201 | RSS: Main: 194478080 04:46:01 INFO - PROCESS | 6201 | 04:49:03 INFO - PROCESS | 6201 | Cycle 1(1): loaded http://localhost:56758/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56758/tests/dromaeo/cssquery-prototype.html) 04:49:03 INFO - PROCESS | 6201 | RSS: Main: 198311936 04:49:03 INFO - PROCESS | 6201 | 04:52:06 INFO - PROCESS | 6201 | Cycle 1(1): loaded http://localhost:56758/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56758/tests/dromaeo/cssquery-yui.html) 04:52:07 INFO - PROCESS | 6201 | RSS: Main: 197488640 04:52:07 INFO - PROCESS | 6201 | 04:55:09 INFO - PROCESS | 6201 | Cycle 1(1): loaded http://localhost:56758/tests/dromaeo/cssquery-yui.html (next: http://localhost:56758/tests/dromaeo/cssquery-dojo.html) 04:55:09 INFO - PROCESS | 6201 | RSS: Main: 202895360 04:55:09 INFO - PROCESS | 6201 | 04:55:09 INFO - PROCESS | 6201 | __start_tp_report 04:55:09 INFO - PROCESS | 6201 | _x_x_mozilla_page_load 04:55:09 INFO - PROCESS | 6201 | _x_x_mozilla_page_load_details 04:55:09 INFO - PROCESS | 6201 | |i|pagename|runs| 04:55:09 INFO - PROCESS | 6201 | |0;dojo.html;3599.8200089995503;3638.890833275002;3639.6724294813494;3668.596454390017;3688.9077773055687;4889.8533044008645;5900.527957763379;5984;5995.160677505148;6020.608660437074;6011.669358185298;6028.397160283969;6035.849103772408;6050.110721305768;6066.332703402633;5368.489993450636;5402.6758394496455;5443.156310771837;5449.754761035763;5542.972285138589;5392.433794451585;5411.134218525017;5475.151351540518;5493.697846618435;5520.309961254843;5463.399026107145;5491.588130890179;5512.91730624041;5518.089515229983;5524.889502209953;5464;5479.835604931858;5487.039768040617;5495.175723641446;5531.197976293455;5243.895122097537;5248.239005344204;5380.461953804627;5391.056565101131;5430.321209848769;5682.7442765075675;5739.7991070312755;5821.563382746269;5836.883262334772;5884;6268.373162683741;6293.716782744787;6312.116303717483;6323.715432805535;6328.367163283681;6275.529335299825;6307.148534947769;6364.363563643645;6394.9360506394805;6402.743890244385;6061.272647282354;6167.105769663419;6172.166757487771;6172.444479996777;6179.412955769195;6384.32964538726;6560.343965603497;6579.967100164468;6587.110740050032;6601.075849381091;5380.488853558905;5584.246126772915;5634.943650563442;6226;6334.081558174131;6392.904106438407;6413.486921046305;6413.615183088937;6431;6440.774572889926;6213;6249.9062514062325;6311.715972781236;6340.112384266206;6354.173957385603;6248.562600617913;6293.842653933688;6308.7476500940365;6322.683865806691;6327.778527751599;5118.360204974379;5118.360204974379;5135.12702840518;5135.922961155586;5141.100307446182;3868.2456920900154;4585.931211031837;4594.5864872161;4616.446026476777;4677.368555245066;5991.7902873399225;6114.510839132859;6142.437386315926;6142.969285153635;6191.4118158774845;6430.549861509649;6432.839179020562;6468.417842394207;6468.741250350027;6486.837829054217;6039.396060394013;6094.939050609437;6203.16257305267;6207.255129384413;6210.4100110489435;5553.389127196006;5622.100463925753;5625.606207565431;5628.831135065954;5673.687947162945;6675.198976122896;6690.665466726644;6691.364320389555;6702.966485167543;6731.865362692816;6314.210723659543;6316.936830631635;6458.483321334376;6466;6471.514636402195;5505.504504594445;6687.933120668926;6697.933020669731;6699.9665001674675;6706.597604143767;6346.650934198663;6361.395667411589;6377.23473183221;6392.169018027626;6402.743890244338;6292.905606415999;6382.266039405342;6384.521160913043;6395.1046853441485;6486.156799616208;6161.876762464636;6277.497800176066;6291.96854015727;6293.056041593614;6324.30432652417;6294.118823364641;6308.905366419415;6315.115883776183;6325.746970121328;6327.430531252209;6093.268807742922;6125.021800333928;6163.445289923929;6226.59527130735;6267.874642507216;6227.314995350417;6291.307956124914;6303.6532990685955;6303.747850085945;6322.525810564134;6253.687315634291;6266.373362663697;6294.433500984934;6303.495720342454;6314.652694101868 04:55:09 INFO - PROCESS | 6201 | |1;ext.html;546.5654804430477;551.8647931256842;563.9812624646352;596.5645079092262;600.9633382415332;31299;39643.80178099105;40391.99020024501;40404.59595404045;40526.18947621049;40928.59071409285;41064.79467602658;42344.941376465526;42359.78820105895;42535.14929701404;9431.905680943188;9566.378185417925;9629.711108666716;9672.371295865782;9674.226061915066;9642.035796420372;9746.269029822755;9770.218382529381;9825;9873.308868379216;9741.415515069084;9778.07108324708;9824.06671366219;9877.308588398815;9951.353162044481;9687.273454490942;9753.853692194623;9878.654247101389;9882.752931176707;9906.603735850558;8152.714654987047;9530.809383812284;9660.951695241549;9671.226301895831;9692.41845489273;33687.4946875797;40044;40765.592344076475;40793.184136317104;41105.588944110474;3151.5272709093592;3332.23358627517;3353.597568291796;3408.590969083701;3538.6815186633326;26362.736372636413;26641.467170656477;27374.726252737615;27527.449451010867;28043.579346309616;2652.2838833514843;2667.906623268176;2697.0560303893676;2766.764824989858;2891.898783542587;271111;272312;272402;272581;273944;35381;35626.28747425089;37408.81295593505;37940.861774146266;38148.61851381451;36581.26837463236;36997.07507312285;37179.814100929325;37227.813860930524;37275.440868387;16128.274227659784;16139.596510087342;16160;16671.6665666686;16936.407225747287;13736.175829450265;13772.24252666113;14159.362828672734;14251.144931304156;14271.714565708628;8296.8340633187;8349.45728527656;8596.828063438696;8632.438891472035;8688.695895643623;3479.304139172176;3513.4378499439968;3555.3955827509385;3571.714262858965;3577.94633080504;1000.6897861662908;1014.4978235773192;1020.3214862116757;1059.3008614314515;1085.10478854945;30862.845685771426;30972.380552388826;30996.915107971112;31229.53155702666;31238.062858114292;1118.2563595209094;1138.846255755479;1151.0791366906442;1158.4960542164185;1161.5760247509597;13081.803772943413;15706.842931570767;15819.604509887115;15865.603359916095;16209.027458352537;513967;627008;635503;639912;647579;61874.69062654748;62168;62980;63044;63284.683576581825;1474.741920163967;1490.2027415332961;1492.276246020679;1505.0743792567491;1508.5775982724854;30122.24694382658;30368.230036293033;30613.085577872524;30698;30810.229744256572;52085;52722.736386317825;52906.73546632396;53203.201951969975;53227.467725322254;583900;584932;586079;586189;586797;27137;27541.86229068842;27627.585586216625;27727.861360693874;28038.439231214852;47122.76438617785;47823.28265075957;49209.75395123001;49789.004219916125;49814.750926245135;37829.621703782606;37860;37877.621223787406;37996.2400751989;38201.23597528089;38988.610113898496;39112.804435978775;39271.97513963936;39534.80232598819;39871.80384588467;33137;37009;37566.248675026894;39301.60698392979;39414.605853941095;32162.03513894493;32245.67754322427;32478.837605812765;32615.510767338033;32789.344213116085;24913.750862491142;25189.49621007533;25607.359816004748;25652.743472565035;25760.969561217342 04:55:09 INFO - PROCESS | 6201 | |2;jquery.html;417.1739954889319;417.54070522425314;419.2830260254964;420.3106904676331;429.3516789647633;17747.73378399325;18820.588455865796;21106.472338191554;21672;21913.780862191372;21164.36506904795;21197.046132924017;21538.13847446104;21574.1370345186;21716.2399316024;5109.3613298337705;5136.768845401947;5569.470900264469;6052.485538729214;6074.726637301332;5909.4090590941;5913.793017244398;5929.495992840613;5967.641941483504;6067.150598916155;5919.526437884959;5940.821775346746;5951.137085122655;5953.523718102541;5989.85025374367;5908.291005079375;5911.438413350725;5928.081147422156;5942.910856337158;5947.881042379171;5127.9743601282125;5187;5202.193659982709;5273.86815329616;5293.920591191135;26718;26854.328641783915;27066.45867082667;27167.04915327974;27257.591136132974;2256.4133325335365;2264.603694353498;2371.5968285391523;2438.112705398036;2674.104175101324;15606.765898511532;15673.059616422937;15841.049537027815;15919.681606367807;15934.60163495922;1846.7599212102475;1848.8705790594663;1858.637565674694;1882.7081802320663;1913.483359492943;107448;112504.43747781208;117203.99999999914;117900.82099178983;121601;9879.703608891745;11469.827952580717;11748.412579371168;11990.100742444352;12063.819042714365;13358.465661373437;14198.645033874236;14298.714025719428;14662.486812961495;14778.18719970412;9147;9222;9341.859872101788;9419.90580094204;9513.476758778195;9719.076687714656;9735.269854760922;9769.169620582188;9831.31180817336;9896.25778066648;7140.214576396592;7246.818829529198;7248.6738096785775;7258.165310989304;7285.453590980697;1764.682357175695;1990.601879624081;1996.3511858645998;2026.0578830843433;2041.7141600175987;965.2422848064236;1016.2124353625851;1067.9679609611724;1068.4444089073793;1092.8633920759905;21204.36386908395;21594.028268727943;21983.34049978503;22994.885025574764;23011.769882300963;1063.7500187456096;1064.7018834726289;1069.2301542889106;1073.2755390111643;1086.6305456144948;10050.849237261447;12043.397830108635;12234;12249.69375765613;12252.162175673542;578482;661198;662832;684292;684794;106584;110084.89915100907;115935;118007.40996294963;120179;1092.9453527323442;1094.3215206571817;1111.183280288987;1113.0761467981556;1117.3072694929033;19418.931958742403;20106.396808095782;20360.083796228908;20370.79629203689;20424.591508169455;50317.74205644888;50809.491905080475;51729.482705172464;52024.73987630037;52121.218181726545;77828.61085694535;79415.20584794079;82091.58954205191;82833.58583207046;83593;8174.67301307941;8332.33341332704;8547.059823419295;8636.395452318277;8933.106689331014;12733.681657958625;12964.35178241103;13193.60419187426;13266.800997984845;13333.333333333489;11321.264117832314;11332.263402878787;11558.30650160993;11643.010344120845;11790.705232369259;11177.105831533296;11278.661640150809;11367.602133925273;11543.076553875502;11560.537578496765;9261.86107208379;11596.188266821242;11857;12085.758284834079;12210.389480526115;6496.382843629847;8568.485890846569;8697.043325234092;8784;8807.647694092164;9314.161725444743;9961.50192490387;10984.634885148309;11645.126615503701;11973.580924667594 04:55:09 INFO - PROCESS | 6201 | |3;mootools.html;1601.9599510012251;1639.590102474381;1891.177337858032;1972.7928567500412;2005.9598808023832;8460.02709688386;9016.323775716815;9353.953230233848;9571.18644915183;9586.185174260188;9050.502222377767;9066.501342426163;9200.769980750469;9201.217896478807;9219.35464517484;2537.061287323693;2561.5517284475236;2571.6785401824773;2584.0697348954363;2584.3151564835334;2057.5370541628163;2358.8348815582917;2393.5997441496747;2551.285640020797;2623.0950322138833;2094.5915546468445;2559.6288538161957;2576.8196226264167;2598.376389666476;2606.2311618072617;2542.9618555721677;2546.057958555328;2547.8726063696927;2571.0872640212738;2601.609758536216;2606.973930260692;2619.4499155177436;2630.04003538707;2642.365832200258;2651;9298.302627302979;9327.673531426435;9389.342746007782;9399.671011514563;9419.576119074589;5750.166225897264;5858.297004359504;5935.49548288396;5937.228160339128;5948.494377977877;3484.059303987909;3582.7492075554724;3692.8892133236045;3820.9617903821163;3830.559485659157;1052.731553453872;1063.8191507443753;1067.925245232834;1073.2326386633595;1084.5282302198568;12288.447019884126;12299.692507687201;12425.565105221274;12572.874271257262;12603.873961260453;4186.558942343026;5067.797288108508;5182.740862956837;5187.948120518822;5247.4490178530705;10650.201234907412;10707.304025238334;10770.569177232823;10812.78374432507;10837.45812709377;4775.21209000518;5084.720340381241;5627.634203776824;5863.677497737665;5890.204822348928;4373.628241599499;5084.288199652052;5165.9483405165465;5194.454582268883;5215.217717342353;4330.501992270929;4346.500152482505;4357.760323182255;4424.11517696462;4452.8218871245435;1384.7715127004133;1425.0594607558962;1427.543905216694;1433.7383102869408;1437.0874494695943;951.9190868776232;982.3123813330698;987.3680844259679;995.4027583449872;997.1823105053786;6151.292601350902;6170.753169873245;6190.876182476415;6236.345183755731;6281.214848143982;477.1054273237679;488.3821965214007;492.6354497671697;495.8512446266106;501.018004710771;4053.7365071270274;4123.092919557753;4126.8761937141935;4319.049809042006;4372.628326592276;10455.84316235257;11570.76858462826;11579;11595;11609.593664221711;10970.122390208764;11006.009459148716;11042.227044106836;11186.888131118747;11265.26775759573;8616.870746938675;8631;8887.333449991276;8908.955455222813;8910.287177025823;6012.8797424052145;6107.4197951194565;6153.230846144232;6165.475934545614;6222.906656400067;9748.317617766688;9974.800503990025;10128.59485620567;10148.695539133838;10260.025297596716;7434.405247580073;10107.64623238183;10392.06471417576;10392.90874458171;10443.268971171945;7157.284271572801;7736.922630773845;7739.690412383442;7942.364610831235;7954.721584744506;8568.014678312074;8568.485890846569;8720.694775682821;8730.65077396897;8762.07998160184;7642.847143057219;7682.884756728766;7784.026996625422;7855.842883142191;7909.8813517796125;6405.807825765234;7565.356944659546;7589.747691630819;7611.238876112345;7692.538447693157;7199.784006479814;7220.314070163537;7265.527740696838;7295.927040729524;7316.890246646198;4963.851084467472;5012.69669885825;5135.38375394955;5173;5181.248718935809;4929.334539837076;5041.823536176216;5147.742612869416;5167.302414174189;5347.5721942243745 04:55:09 INFO - PROCESS | 6201 | |4;prototype.html;345.32661310444655;346.3955397830785;351.20452175821754;354.1800731307024;361.6311362410343;7030.824229394268;7053.858922821541;7071.540349877261;7071.9292807071915;7072.115985501812;6950.131233595801;7002.334778196076;7009.544379615334;7027.789166325006;7042.366187043165;4880.560234730763;4947.6784009039475;5132.461091585367;5174.974125129369;5184.507471790174;3815.828287727059;5137;5148.665336753118;5189.922151167735;5203.765830537635;5127.769250383723;5127.974360128194;5137.332146820908;5141.845744627667;5146.176611742122;5137.743112844361;5148;5153;5160.509751573594;5169.844904652848;4407.889802754925;4408.096340250241;4409.669274804371;4417.602415782563;4418.072204836988;5690.260266165414;6519.4132528072705;6800.353966373186;6807.5575087619145;6847.657617119125;5965.642061476326;6018.097285407181;6030.66831324277;6034.336223015464;6046.788362407295;7466.402687784964;7483.176850546435;7521.135069466972;7534.773956781305;7561.281678240558;3968.6428221460205;4785.976070119627;4800.087983283165;4800.3279540864305;4824.7828847701585;7610.9238907611325;7849.646765895492;7915.96042019792;7931.444798864082;7965.920340796576;4778.1638213312535;4815.9886423851385;4825.131476334293;4866.05112003156;4873.220284754422;4973.850784476472;4975.104481193348;4984.551390374883;4986.401631804134;4988.775505102279;5995.61028533144;5998.340182579913;6020;6022.879542409128;6033.245844269466;7494.6627401767055;7501.849963000709;7534.397248220129;7571.734989275349;7598.164201937782;1499.1005396761855;1647.1187914465704;1653.3551914753016;1699.6175860431551;1730.9913450432666;915.7435917942987;958.5878072428923;1065.984010239847;1084.1868598551087;1093.8577984861918;6891.896621550681;6961;6977.058097156819;7003.824904377431;7020.403265722369;6375.139356186948;7470.663820128108;7578.204288549733;7710.228977102245;7721.112072111779;7031.964840175767;7064.293570642894;7065;7130.073090498202;7138.750143744944;3311.817850018224;4099.8975025624;4154.189932963043;4158.209940111369;4170.020045289354;8206.097329293772;8226.506409615442;8245.917540824636;8265.710700125466;8265.752027439186;7901.407394445325;8128.9187108129345;8131.308838748654;8166.510009399455;8188.099309075997;6570.8357291068105;8266.917330826735;8278.296344810758;8279.047909490486;8289.875651865226;7824.061112666516;7850.803729906798;7852.254035866584;7858.685652574061;7881.330086942674;7405.8148546286775;7710.1133369660965;7715.614219288901;7717.691292348243;7720.884186737091;8217.671293148207;8238.711645092393;8270.214329638675;8297.585120743817;8304.83390332202;4819.759012049313;4868.707877527218;4878.170710979071;4879.316895634543;4913.410390753133;7828.84342313162;7861.449698521049;7878.881816772639;7883.802904927423;7891.368690504861;6031.728572214173;6173.135760993554;7369.77890663281;7556.357709594746;7593.354564862048;7520.924790752022;7582.658780355007;7594.5063570867715;7596.924030759622;7599.088109426904;7296;7317.19510853795;7361.9754567494365;7365.447591430771;7394.558061178019;6658.768127896355;7493.662785174789;7525.8494830102;7548.018757561702;7559.659815308214;6094.238220222473;7164.749233776793;7401.888971665537;7423.888641670272;7425 04:55:09 INFO - PROCESS | 6201 | |5;yui.html;704.6547191875981;711.4983936324893;748.5882764479535;775.4974538494723;780.9414293927953;15082.547523574283;15338.693226135485;15412.69174616507;15475.14886681232;15499.22503874806;13983.580492585214;14210.218437985932;14392;14926.253687315619;15000.549983500485;933.9626414943411;934.5747684803432;951.6098399656142;956.9138777510022;958.904109589039;824.3652387661497;927.8561822917425;950.4677380666849;954.1269738189549;954.904509549043;854.2567965869702;1020.596864238629;1023.5342918971887;1024.354656566362;1025.9794804103913;952.3238500664537;1015.725754046407;1017.2828156149897;1018.9759291911655;1019.3476175247847;731.8426538294292;749.6401727170988;755.1617704348224;755.2938002967243;764.4419573711166;13634.023066655378;13734;13959.581212563638;14019.439222431192;14025.158490490501;11431.428428578538;11541.134414918915;11651.359175245358;11805.23265987708;11962.521499140024;9408.811823763555;9425.104615061628;9512.857307140399;9617.56720947559;9638.277129215267;3468.843902024415;3488.232588830453;3496.6328535503662;3515.5781306243157;3547.822608869546;67722;75988.62005690047;77671.61164194143;77779.44441111146;84694.72957905637;9677.854832177523;10117.190624750003;10161.949190254149;10191.847122293171;10203.132733717568;22030.559388812133;22103.115875365125;22827.543449130924;22870.656940145913;22915.88542057279;7623.69505219785;7668.271514206142;7712.691492340244;7714.074311082593;7933.761987140395;4124.319487284564;4160.563140870226;4186.895327616773;4206.390073439396;4262.616364527207;3785.3943369061367;3796.37359835624;3798.9932667843045;3831.5210598675167;3864.265789499986;646.5344951634816;674.9088873002082;688.834679676884;718.052171134098;718.7699936020423;583.5012057040267;604.1391017799618;605.3280858247342;608.14251904814;614.8247749391492;7560.773176804704;7802.510476930901;8374.832503349899;8523.360747943929;8706.521141337287;451.54845154845157;557.3312025569332;583.9007368747323;614.6158650843223;619.8109576579096;3967.8412863485714;3977.204559088194;3981.900452488711;3994.460747799068;4064.4968051117976;95876;99407;99574;100491.49754251182;101054.98945010603;70497.64751176313;78609;79772.0056998568;80401;82593.348133037;68025.65987170032;68158;68245.63508729897;68292;68747.96878046833;8553.871691924502;8678.218960293603;8774.034856165945;8860.04823350991;8872.467651940904;36778.8161059193;50607;53302.46697532975;53328.2000769981;53856;68050.63898722097;73811.63094184495;74585;75176.24823751912;77335.61332193304;10853.240273181118;10858.728531786768;10990.285631433931;11060.281081729661;11195.60815371458;12074.939625301817;12117.69705757363;12152.088593355356;12451;12490.937545312216;10035.14701250402;10193.74515637115;10326.173906087344;10517.684469465928;10916.617918372818;10213.182945364502;10326.328788628714;10331.380117192992;10687.412192329497;10738.087262582456;9680.4675742832;10012.899871001488;10048.949755251177;10062.39625622465;10117.544710488193;7382.6677799498075;8654.913450865412;8746.125387461203;8899.377043606886;9085;7760.18518055596;8455.873161902453;8912.777180570538;8928.642854285756;8973.955130224307 04:55:09 INFO - PROCESS | 6201 | __end_tp_report 04:55:09 INFO - PROCESS | 6201 | __start_cc_report 04:55:09 INFO - PROCESS | 6201 | _x_x_mozilla_cycle_collect,400 04:55:09 INFO - PROCESS | 6201 | __end_cc_report 04:55:09 INFO - PROCESS | 6201 | __startTimestamp1466769309316__endTimestamp 04:55:09 INFO - PROCESS | 6201 | 04:55:09 INFO - PROCESS | 6201 | ------- Summary: start ------- 04:55:09 INFO - PROCESS | 6201 | Number of tests: 6 04:55:09 INFO - PROCESS | 6201 | 04:55:09 INFO - PROCESS | 6201 | [#0] dojo.html Cycles:165 Average:5947.52 Median:6210.41 stddev:647.24 (10.4%) stddev-sans-first:622.47 04:55:09 INFO - PROCESS | 6201 | Values: 3599.8 3638.9 3639.7 3668.6 3688.9 4889.9 5900.5 5984.0 5995.2 6020.6 6011.7 6028.4 6035.8 6050.1 6066.3 5368.5 5402.7 5443.2 5449.8 5543.0 5392.4 5411.1 5475.2 5493.7 5520.3 5463.4 5491.6 5512.9 5518.1 5524.9 5464.0 5479.8 5487.0 5495.2 5531.2 5243.9 5248.2 5380.5 5391.1 5430.3 5682.7 5739.8 5821.6 5836.9 5884.0 6268.4 6293.7 6312.1 6323.7 6328.4 6275.5 6307.1 6364.4 6394.9 6402.7 6061.3 6167.1 6172.2 6172.4 6179.4 6384.3 6560.3 6580.0 6587.1 6601.1 5380.5 5584.2 5634.9 6226.0 6334.1 6392.9 6413.5 6413.6 6431.0 6440.8 6213.0 6249.9 6311.7 6340.1 6354.2 6248.6 6293.8 6308.7 6322.7 6327.8 5118.4 5118.4 5135.1 5135.9 5141.1 3868.2 4585.9 4594.6 4616.4 4677.4 5991.8 6114.5 6142.4 6143.0 6191.4 6430.5 6432.8 6468.4 6468.7 6486.8 6039.4 6094.9 6203.2 6207.3 6210.4 5553.4 5622.1 5625.6 5628.8 5673.7 6675.2 6690.7 6691.4 6703.0 6731.9 6314.2 6316.9 6458.5 6466.0 6471.5 5505.5 6687.9 6697.9 6700.0 6706.6 6346.7 6361.4 6377.2 6392.2 6402.7 6292.9 6382.3 6384.5 6395.1 6486.2 6161.9 6277.5 6292.0 6293.1 6324.3 6294.1 6308.9 6315.1 6325.7 6327.4 6093.3 6125.0 6163.4 6226.6 6267.9 6227.3 6291.3 6303.7 6303.7 6322.5 6253.7 6266.4 6294.4 6303.5 6314.7 04:55:09 INFO - PROCESS | 6201 | 04:55:09 INFO - PROCESS | 6201 | [#1] ext.html Cycles:180 Average:62056.38 Median:37342.13 stddev:138215.08 (370.1%) stddev-sans-first:138525.66 04:55:09 INFO - PROCESS | 6201 | Values: 546.6 551.9 564.0 596.6 601.0 31299.0 39643.8 40392.0 40404.6 40526.2 40928.6 41064.8 42344.9 42359.8 42535.1 9431.9 9566.4 9629.7 9672.4 9674.2 9642.0 9746.3 9770.2 9825.0 9873.3 9741.4 9778.1 9824.1 9877.3 9951.4 9687.3 9753.9 9878.7 9882.8 9906.6 8152.7 9530.8 9661.0 9671.2 9692.4 33687.5 40044.0 40765.6 40793.2 41105.6 3151.5 3332.2 3353.6 3408.6 3538.7 26362.7 26641.5 27374.7 27527.4 28043.6 2652.3 2667.9 2697.1 2766.8 2891.9 271111.0 272312.0 272402.0 272581.0 273944.0 35381.0 35626.3 37408.8 37940.9 38148.6 36581.3 36997.1 37179.8 37227.8 37275.4 16128.3 16139.6 16160.0 16671.7 16936.4 13736.2 13772.2 14159.4 14251.1 14271.7 8296.8 8349.5 8596.8 8632.4 8688.7 3479.3 3513.4 3555.4 3571.7 3577.9 1000.7 1014.5 1020.3 1059.3 1085.1 30862.8 30972.4 30996.9 31229.5 31238.1 1118.3 1138.8 1151.1 1158.5 1161.6 13081.8 15706.8 15819.6 15865.6 16209.0 513967.0 627008.0 635503.0 639912.0 647579.0 61874.7 62168.0 62980.0 63044.0 63284.7 1474.7 1490.2 1492.3 1505.1 1508.6 30122.2 30368.2 30613.1 30698.0 30810.2 52085.0 52722.7 52906.7 53203.2 53227.5 583900.0 584932.0 586079.0 586189.0 586797.0 27137.0 27541.9 27627.6 27727.9 28038.4 47122.8 47823.3 49209.8 49789.0 49814.8 37829.6 37860.0 37877.6 37996.2 38201.2 38988.6 39112.8 39272.0 39534.8 39871.8 33137.0 37009.0 37566.2 39301.6 39414.6 32162.0 32245.7 32478.8 32615.5 32789.3 24913.8 25189.5 25607.4 25652.7 25761.0 04:55:09 INFO - PROCESS | 6201 | 04:55:09 INFO - PROCESS | 6201 | [#2] jquery.html Cycles:180 Average:36679.66 Median:21815.01 stddev:108483.66 (497.3%) stddev-sans-first:108753.81 04:55:09 INFO - PROCESS | 6201 | Values: 417.2 417.5 419.3 420.3 429.4 17747.7 18820.6 21106.5 21672.0 21913.8 21164.4 21197.0 21538.1 21574.1 21716.2 5109.4 5136.8 5569.5 6052.5 6074.7 5909.4 5913.8 5929.5 5967.6 6067.2 5919.5 5940.8 5951.1 5953.5 5989.9 5908.3 5911.4 5928.1 5942.9 5947.9 5128.0 5187.0 5202.2 5273.9 5293.9 26718.0 26854.3 27066.5 27167.0 27257.6 2256.4 2264.6 2371.6 2438.1 2674.1 15606.8 15673.1 15841.0 15919.7 15934.6 1846.8 1848.9 1858.6 1882.7 1913.5 107448.0 112504.4 117204.0 117900.8 121601.0 9879.7 11469.8 11748.4 11990.1 12063.8 13358.5 14198.6 14298.7 14662.5 14778.2 9147.0 9222.0 9341.9 9419.9 9513.5 9719.1 9735.3 9769.2 9831.3 9896.3 7140.2 7246.8 7248.7 7258.2 7285.5 1764.7 1990.6 1996.4 2026.1 2041.7 965.2 1016.2 1068.0 1068.4 1092.9 21204.4 21594.0 21983.3 22994.9 23011.8 1063.8 1064.7 1069.2 1073.3 1086.6 10050.8 12043.4 12234.0 12249.7 12252.2 578482.0 661198.0 662832.0 684292.0 684794.0 106584.0 110084.9 115935.0 118007.4 120179.0 1092.9 1094.3 1111.2 1113.1 1117.3 19418.9 20106.4 20360.1 20370.8 20424.6 50317.7 50809.5 51729.5 52024.7 52121.2 77828.6 79415.2 82091.6 82833.6 83593.0 8174.7 8332.3 8547.1 8636.4 8933.1 12733.7 12964.4 13193.6 13266.8 13333.3 11321.3 11332.3 11558.3 11643.0 11790.7 11177.1 11278.7 11367.6 11543.1 11560.5 9261.9 11596.2 11857.0 12085.8 12210.4 6496.4 8568.5 8697.0 8784.0 8807.6 9314.2 9961.5 10984.6 11645.1 11973.6 04:55:09 INFO - PROCESS | 6201 | 04:55:09 INFO - PROCESS | 6201 | [#3] mootools.html Cycles:180 Average:5980.84 Median:2732.43 stddev:3350.02 (122.6%) stddev-sans-first:3343.26 04:55:09 INFO - PROCESS | 6201 | Values: 1602.0 1639.6 1891.2 1972.8 2006.0 8460.0 9016.3 9354.0 9571.2 9586.2 9050.5 9066.5 9200.8 9201.2 9219.4 2537.1 2561.6 2571.7 2584.1 2584.3 2057.5 2358.8 2393.6 2551.3 2623.1 2094.6 2559.6 2576.8 2598.4 2606.2 2543.0 2546.1 2547.9 2571.1 2601.6 2607.0 2619.4 2630.0 2642.4 2651.0 9298.3 9327.7 9389.3 9399.7 9419.6 5750.2 5858.3 5935.5 5937.2 5948.5 3484.1 3582.7 3692.9 3821.0 3830.6 1052.7 1063.8 1067.9 1073.2 1084.5 12288.4 12299.7 12425.6 12572.9 12603.9 4186.6 5067.8 5182.7 5187.9 5247.4 10650.2 10707.3 10770.6 10812.8 10837.5 4775.2 5084.7 5627.6 5863.7 5890.2 4373.6 5084.3 5165.9 5194.5 5215.2 4330.5 4346.5 4357.8 4424.1 4452.8 1384.8 1425.1 1427.5 1433.7 1437.1 951.9 982.3 987.4 995.4 997.2 6151.3 6170.8 6190.9 6236.3 6281.2 477.1 488.4 492.6 495.9 501.0 4053.7 4123.1 4126.9 4319.0 4372.6 10455.8 11570.8 11579.0 11595.0 11609.6 10970.1 11006.0 11042.2 11186.9 11265.3 8616.9 8631.0 8887.3 8909.0 8910.3 6012.9 6107.4 6153.2 6165.5 6222.9 9748.3 9974.8 10128.6 10148.7 10260.0 7434.4 10107.6 10392.1 10392.9 10443.3 7157.3 7736.9 7739.7 7942.4 7954.7 8568.0 8568.5 8720.7 8730.7 8762.1 7642.8 7682.9 7784.0 7855.8 7909.9 6405.8 7565.4 7589.7 7611.2 7692.5 7199.8 7220.3 7265.5 7295.9 7316.9 4963.9 5012.7 5135.4 5173.0 5181.2 4929.3 5041.8 5147.7 5167.3 5347.6 04:55:09 INFO - PROCESS | 6201 | 04:55:09 INFO - PROCESS | 6201 | [#4] prototype.html Cycles:180 Average:6116.95 Median:7014.97 stddev:2005.50 (28.6%) stddev-sans-first:1963.78 04:55:09 INFO - PROCESS | 6201 | Values: 345.3 346.4 351.2 354.2 361.6 7030.8 7053.9 7071.5 7071.9 7072.1 6950.1 7002.3 7009.5 7027.8 7042.4 4880.6 4947.7 5132.5 5175.0 5184.5 3815.8 5137.0 5148.7 5189.9 5203.8 5127.8 5128.0 5137.3 5141.8 5146.2 5137.7 5148.0 5153.0 5160.5 5169.8 4407.9 4408.1 4409.7 4417.6 4418.1 5690.3 6519.4 6800.4 6807.6 6847.7 5965.6 6018.1 6030.7 6034.3 6046.8 7466.4 7483.2 7521.1 7534.8 7561.3 3968.6 4786.0 4800.1 4800.3 4824.8 7610.9 7849.6 7916.0 7931.4 7965.9 4778.2 4816.0 4825.1 4866.1 4873.2 4973.9 4975.1 4984.6 4986.4 4988.8 5995.6 5998.3 6020.0 6022.9 6033.2 7494.7 7501.8 7534.4 7571.7 7598.2 1499.1 1647.1 1653.4 1699.6 1731.0 915.7 958.6 1066.0 1084.2 1093.9 6891.9 6961.0 6977.1 7003.8 7020.4 6375.1 7470.7 7578.2 7710.2 7721.1 7032.0 7064.3 7065.0 7130.1 7138.8 3311.8 4099.9 4154.2 4158.2 4170.0 8206.1 8226.5 8245.9 8265.7 8265.8 7901.4 8128.9 8131.3 8166.5 8188.1 6570.8 8266.9 8278.3 8279.0 8289.9 7824.1 7850.8 7852.3 7858.7 7881.3 7405.8 7710.1 7715.6 7717.7 7720.9 8217.7 8238.7 8270.2 8297.6 8304.8 4819.8 4868.7 4878.2 4879.3 4913.4 7828.8 7861.4 7878.9 7883.8 7891.4 6031.7 6173.1 7369.8 7556.4 7593.4 7520.9 7582.7 7594.5 7596.9 7599.1 7296.0 7317.2 7362.0 7365.4 7394.6 6658.8 7493.7 7525.8 7548.0 7559.7 6094.2 7164.7 7401.9 7423.9 7425.0 04:55:09 INFO - PROCESS | 6201 | 04:55:09 INFO - PROCESS | 6201 | [#5] yui.html Cycles:180 Average:18396.89 Median:583.70 stddev:26351.82 (4514.6%) stddev-sans-first:26392.26 04:55:09 INFO - PROCESS | 6201 | Values: 704.7 711.5 748.6 775.5 780.9 15082.5 15338.7 15412.7 15475.1 15499.2 13983.6 14210.2 14392.0 14926.3 15000.5 934.0 934.6 951.6 956.9 958.9 824.4 927.9 950.5 954.1 954.9 854.3 1020.6 1023.5 1024.4 1026.0 952.3 1015.7 1017.3 1019.0 1019.3 731.8 749.6 755.2 755.3 764.4 13634.0 13734.0 13959.6 14019.4 14025.2 11431.4 11541.1 11651.4 11805.2 11962.5 9408.8 9425.1 9512.9 9617.6 9638.3 3468.8 3488.2 3496.6 3515.6 3547.8 67722.0 75988.6 77671.6 77779.4 84694.7 9677.9 10117.2 10161.9 10191.8 10203.1 22030.6 22103.1 22827.5 22870.7 22915.9 7623.7 7668.3 7712.7 7714.1 7933.8 4124.3 4160.6 4186.9 4206.4 4262.6 3785.4 3796.4 3799.0 3831.5 3864.3 646.5 674.9 688.8 718.1 718.8 583.5 604.1 605.3 608.1 614.8 7560.8 7802.5 8374.8 8523.4 8706.5 451.5 557.3 583.9 614.6 619.8 3967.8 3977.2 3981.9 3994.5 4064.5 95876.0 99407.0 99574.0 100491.5 101055.0 70497.6 78609.0 79772.0 80401.0 82593.3 68025.7 68158.0 68245.6 68292.0 68748.0 8553.9 8678.2 8774.0 8860.0 8872.5 36778.8 50607.0 53302.5 53328.2 53856.0 68050.6 73811.6 74585.0 75176.2 77335.6 10853.2 10858.7 10990.3 11060.3 11195.6 12074.9 12117.7 12152.1 12451.0 12490.9 10035.1 10193.7 10326.2 10517.7 10916.6 10213.2 10326.3 10331.4 10687.4 10738.1 9680.5 10012.9 10048.9 10062.4 10117.5 7382.7 8654.9 8746.1 8899.4 9085.0 7760.2 8455.9 8912.8 8928.6 8974.0 04:55:09 INFO - PROCESS | 6201 | -------- Summary: end -------- 04:55:09 INFO - PROCESS | 6201 | 04:55:09 INFO - TEST-INFO | 6201: exit 0 04:55:09 INFO - TEST-OK | dromaeo_css | took 1109378ms 04:55:09 INFO - TEST-START | kraken 04:55:09 INFO - operating with platform_type : mac_ 04:55:09 INFO - Initialising browser for kraken test... 04:55:09 INFO - TEST-INFO | started process 6205 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpOEGZnU/profile http://localhost:56758/getInfo.html) 04:55:12 INFO - PROCESS | 6205 | __metrics Screen width/height:1600/1200 04:55:12 INFO - PROCESS | 6205 | colorDepth:24 04:55:12 INFO - PROCESS | 6205 | Browser inner width/height: 1024/689 04:55:12 INFO - PROCESS | 6205 | __metrics 04:55:12 ERROR - PROCESS | 6205 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:55:13 INFO - TEST-INFO | 6205: exit 0 04:55:13 INFO - Browser initialized. 04:55:13 INFO - Running cycle 1/1 for kraken test... 04:55:13 INFO - TEST-INFO | started process 6209 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpOEGZnU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:25 INFO - PROCESS | 6209 | RSS: Main: 170618880 04:55:25 INFO - PROCESS | 6209 | 04:55:27 INFO - PROCESS | 6209 | Cycle 1(1): loaded http://localhost:56758/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56758/tests/kraken/driver.html?testName=audio-beat-detection) 04:55:28 INFO - PROCESS | 6209 | RSS: Main: 183336960 04:55:28 INFO - PROCESS | 6209 | 04:55:31 INFO - PROCESS | 6209 | Cycle 1(1): loaded http://localhost:56758/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56758/tests/kraken/driver.html?testName=audio-dft) 04:55:32 INFO - PROCESS | 6209 | RSS: Main: 192528384 04:55:32 INFO - PROCESS | 6209 | 04:55:35 INFO - PROCESS | 6209 | Cycle 1(1): loaded http://localhost:56758/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56758/tests/kraken/driver.html?testName=audio-fft) 04:55:35 INFO - PROCESS | 6209 | RSS: Main: 195575808 04:55:35 INFO - PROCESS | 6209 | 04:55:37 INFO - PROCESS | 6209 | Cycle 1(1): loaded http://localhost:56758/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56758/tests/kraken/driver.html?testName=audio-oscillator) 04:55:38 INFO - PROCESS | 6209 | RSS: Main: 195821568 04:55:38 INFO - PROCESS | 6209 | 04:55:40 INFO - PROCESS | 6209 | Cycle 1(1): loaded http://localhost:56758/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56758/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:55:41 INFO - PROCESS | 6209 | RSS: Main: 196079616 04:55:41 INFO - PROCESS | 6209 | 04:55:43 INFO - PROCESS | 6209 | Cycle 1(1): loaded http://localhost:56758/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56758/tests/kraken/driver.html?testName=imaging-darkroom) 04:55:44 INFO - PROCESS | 6209 | RSS: Main: 197844992 04:55:44 INFO - PROCESS | 6209 | 04:55:47 INFO - PROCESS | 6209 | Cycle 1(1): loaded http://localhost:56758/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56758/tests/kraken/driver.html?testName=imaging-desaturate) 04:55:48 INFO - PROCESS | 6209 | RSS: Main: 197627904 04:55:48 INFO - PROCESS | 6209 | 04:55:50 INFO - PROCESS | 6209 | Cycle 1(1): loaded http://localhost:56758/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56758/tests/kraken/driver.html?testName=json-parse-financial) 04:55:51 INFO - PROCESS | 6209 | RSS: Main: 197918720 04:55:51 INFO - PROCESS | 6209 | 04:55:53 INFO - PROCESS | 6209 | Cycle 1(1): loaded http://localhost:56758/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56758/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:55:53 INFO - PROCESS | 6209 | RSS: Main: 197296128 04:55:53 INFO - PROCESS | 6209 | 04:55:55 INFO - PROCESS | 6209 | Cycle 1(1): loaded http://localhost:56758/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56758/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:55:56 INFO - PROCESS | 6209 | RSS: Main: 197439488 04:55:56 INFO - PROCESS | 6209 | 04:55:58 INFO - PROCESS | 6209 | Cycle 1(1): loaded http://localhost:56758/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56758/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:55:59 INFO - PROCESS | 6209 | RSS: Main: 197697536 04:55:59 INFO - PROCESS | 6209 | 04:56:01 INFO - PROCESS | 6209 | Cycle 1(1): loaded http://localhost:56758/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56758/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:56:02 INFO - PROCESS | 6209 | RSS: Main: 198017024 04:56:02 INFO - PROCESS | 6209 | 04:56:04 INFO - PROCESS | 6209 | Cycle 1(1): loaded http://localhost:56758/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56758/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:56:05 INFO - PROCESS | 6209 | RSS: Main: 197939200 04:56:05 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | Cycle 1(1): loaded http://localhost:56758/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56758/tests/kraken/driver.html?testName=ai-astar) 04:56:07 INFO - PROCESS | 6209 | RSS: Main: 199585792 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | __start_tp_report 04:56:07 INFO - PROCESS | 6209 | _x_x_mozilla_page_load 04:56:07 INFO - PROCESS | 6209 | _x_x_mozilla_page_load_details 04:56:07 INFO - PROCESS | 6209 | |i|pagename|runs| 04:56:07 INFO - PROCESS | 6209 | |0;ai-astar;113;118;107;115;118;117;104;114;115;115 04:56:07 INFO - PROCESS | 6209 | |1;audio-beat-detection;153;123;147;168;120;140;162;155;171;139 04:56:07 INFO - PROCESS | 6209 | |2;audio-dft;227;252;199;192;194;195;192;193;201;194 04:56:07 INFO - PROCESS | 6209 | |3;audio-fft;66;80;75;144;59;56;57;67;127;55 04:56:07 INFO - PROCESS | 6209 | |4;audio-oscillator;77;83;126;76;88;91;124;66;92;162 04:56:07 INFO - PROCESS | 6209 | |5;imaging-gaussian-blur;88;86;88;86;88;86;89;85;88;86 04:56:07 INFO - PROCESS | 6209 | |6;imaging-darkroom;93;95;94;94;95;94;93;95;122;150 04:56:07 INFO - PROCESS | 6209 | |7;imaging-desaturate;89;93;91;128;93;143;142;122;91;90 04:56:07 INFO - PROCESS | 6209 | |8;json-parse-financial;59;60;62;63;64;81;74;80;61;59 04:56:07 INFO - PROCESS | 6209 | |9;json-stringify-tinderbox;60;63;66;71;69;77;70;65;64;66 04:56:07 INFO - PROCESS | 6209 | |10;stanford-crypto-aes;82;79;81;81;80;80;81;80;82;82 04:56:07 INFO - PROCESS | 6209 | |11;stanford-crypto-ccm;128;126;126;124;123;127;123;125;176;146 04:56:07 INFO - PROCESS | 6209 | |12;stanford-crypto-pbkdf2;164;164;160;163;162;161;164;163;164;163 04:56:07 INFO - PROCESS | 6209 | |13;stanford-crypto-sha256-iterative;67;66;64;67;66;68;71;66;68;67 04:56:07 INFO - PROCESS | 6209 | __end_tp_report 04:56:07 INFO - PROCESS | 6209 | __start_cc_report 04:56:07 INFO - PROCESS | 6209 | _x_x_mozilla_cycle_collect,1059 04:56:07 INFO - PROCESS | 6209 | __end_cc_report 04:56:07 INFO - PROCESS | 6209 | __startTimestamp1466769367529__endTimestamp 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | ------- Summary: start ------- 04:56:07 INFO - PROCESS | 6209 | Number of tests: 14 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:4.62 (4.0%) stddev-sans-first:4.90 04:56:07 INFO - PROCESS | 6209 | Values: 113.0 118.0 107.0 115.0 118.0 117.0 104.0 114.0 115.0 115.0 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:154.00 stddev:17.49 (11.4%) stddev-sans-first:18.45 04:56:07 INFO - PROCESS | 6209 | Values: 153.0 123.0 147.0 168.0 120.0 140.0 162.0 155.0 171.0 139.0 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | [#2] audio-dft Cycles:10 Average:203.90 Median:197.00 stddev:19.88 (10.1%) stddev-sans-first:19.25 04:56:07 INFO - PROCESS | 6209 | Values: 227.0 252.0 199.0 192.0 194.0 195.0 192.0 193.0 201.0 194.0 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | [#3] audio-fft Cycles:10 Average:78.60 Median:62.50 stddev:31.35 (50.2%) stddev-sans-first:32.92 04:56:07 INFO - PROCESS | 6209 | Values: 66.0 80.0 75.0 144.0 59.0 56.0 57.0 67.0 127.0 55.0 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:80.00 stddev:29.65 (37.1%) stddev-sans-first:30.41 04:56:07 INFO - PROCESS | 6209 | Values: 77.0 83.0 126.0 76.0 88.0 91.0 124.0 66.0 92.0 162.0 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.00 stddev:1.33 (1.5%) stddev-sans-first:1.36 04:56:07 INFO - PROCESS | 6209 | Values: 88.0 86.0 88.0 86.0 88.0 86.0 89.0 85.0 88.0 86.0 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | [#6] imaging-darkroom Cycles:10 Average:102.50 Median:94.00 stddev:18.86 (20.1%) stddev-sans-first:19.69 04:56:07 INFO - PROCESS | 6209 | Values: 93.0 95.0 94.0 94.0 95.0 94.0 93.0 95.0 122.0 150.0 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | [#7] imaging-desaturate Cycles:10 Average:108.20 Median:90.50 stddev:22.83 (25.2%) stddev-sans-first:23.13 04:56:07 INFO - PROCESS | 6209 | Values: 89.0 93.0 91.0 128.0 93.0 143.0 142.0 122.0 91.0 90.0 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:63.50 stddev:8.64 (13.6%) stddev-sans-first:8.75 04:56:07 INFO - PROCESS | 6209 | Values: 59.0 60.0 62.0 63.0 64.0 81.0 74.0 80.0 61.0 59.0 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.50 stddev:4.82 (7.1%) stddev-sans-first:4.37 04:56:07 INFO - PROCESS | 6209 | Values: 60.0 63.0 66.0 71.0 69.0 77.0 70.0 65.0 64.0 66.0 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:81.00 stddev:1.03 (1.3%) stddev-sans-first:1.00 04:56:07 INFO - PROCESS | 6209 | Values: 82.0 79.0 81.0 81.0 80.0 80.0 81.0 80.0 82.0 82.0 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:126.50 stddev:16.73 (13.2%) stddev-sans-first:17.67 04:56:07 INFO - PROCESS | 6209 | Values: 128.0 126.0 126.0 124.0 123.0 127.0 123.0 125.0 176.0 146.0 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:163.50 stddev:1.40 (0.9%) stddev-sans-first:1.41 04:56:07 INFO - PROCESS | 6209 | Values: 164.0 164.0 160.0 163.0 162.0 161.0 164.0 163.0 164.0 163.0 04:56:07 INFO - PROCESS | 6209 | 04:56:07 INFO - PROCESS | 6209 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.83 (2.7%) stddev-sans-first:1.94 04:56:07 INFO - PROCESS | 6209 | Values: 67.0 66.0 64.0 67.0 66.0 68.0 71.0 66.0 68.0 67.0 04:56:07 INFO - PROCESS | 6209 | -------- Summary: end -------- 04:56:07 INFO - PROCESS | 6209 | 04:56:08 INFO - TEST-INFO | 6209: exit 0 04:56:08 INFO - TEST-OK | kraken | took 58453ms 04:56:08 INFO - SUITE-END | took 1167s 04:56:08 INFO - Completed test suite (00:19:28) 04:56:08 INFO - javascript benchmark 04:56:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3599.8200089995503, 3638.890833275002, 3639.6724294813494, 3668.596454390017, 3688.9077773055687, 4889.8533044008645, 5900.527957763379, 5984.0, 5995.160677505148, 6020.608660437074, 6011.669358185298, 6028.397160283969, 6035.849103772408, 6050.110721305768, 6066.332703402633, 5368.489993450636, 5402.6758394496455, 5443.156310771837, 5449.754761035763, 5542.972285138589, 5392.433794451585, 5411.134218525017, 5475.151351540518, 5493.697846618435, 5520.309961254843, 5463.399026107145, 5491.588130890179, 5512.91730624041, 5518.089515229983, 5524.889502209953, 5464.0, 5479.835604931858, 5487.039768040617, 5495.175723641446, 5531.197976293455, 5243.895122097537, 5248.239005344204, 5380.461953804627, 5391.056565101131, 5430.321209848769, 5682.7442765075675, 5739.7991070312755, 5821.563382746269, 5836.883262334772, 5884.0, 6268.373162683741, 6293.716782744787, 6312.116303717483, 6323.715432805535, 6328.367163283681, 6275.529335299825, 6307.148534947769, 6364.363563643645, 6394.9360506394805, 6402.743890244385, 6061.272647282354, 6167.105769663419, 6172.166757487771, 6172.444479996777, 6179.412955769195, 6384.32964538726, 6560.343965603497, 6579.967100164468, 6587.110740050032, 6601.075849381091, 5380.488853558905, 5584.246126772915, 5634.943650563442, 6226.0, 6334.081558174131, 6392.904106438407, 6413.486921046305, 6413.615183088937, 6431.0, 6440.774572889926, 6213.0, 6249.9062514062325, 6311.715972781236, 6340.112384266206, 6354.173957385603, 6248.562600617913, 6293.842653933688, 6308.7476500940365, 6322.683865806691, 6327.778527751599, 5118.360204974379, 5118.360204974379, 5135.12702840518, 5135.922961155586, 5141.100307446182, 3868.2456920900154, 4585.931211031837, 4594.5864872161, 4616.446026476777, 4677.368555245066, 5991.7902873399225, 6114.510839132859, 6142.437386315926, 6142.969285153635, 6191.4118158774845, 6430.549861509649, 6432.839179020562, 6468.417842394207, 6468.741250350027, 6486.837829054217, 6039.396060394013, 6094.939050609437, 6203.16257305267, 6207.255129384413, 6210.4100110489435, 5553.389127196006, 5622.100463925753, 5625.606207565431, 5628.831135065954, 5673.687947162945, 6675.198976122896, 6690.665466726644, 6691.364320389555, 6702.966485167543, 6731.865362692816, 6314.210723659543, 6316.936830631635, 6458.483321334376, 6466.0, 6471.514636402195, 5505.504504594445, 6687.933120668926, 6697.933020669731, 6699.9665001674675, 6706.597604143767, 6346.650934198663, 6361.395667411589, 6377.23473183221, 6392.169018027626, 6402.743890244338, 6292.905606415999, 6382.266039405342, 6384.521160913043, 6395.1046853441485, 6486.156799616208, 6161.876762464636, 6277.497800176066, 6291.96854015727, 6293.056041593614, 6324.30432652417, 6294.118823364641, 6308.905366419415, 6315.115883776183, 6325.746970121328, 6327.430531252209, 6093.268807742922, 6125.021800333928, 6163.445289923929, 6226.59527130735, 6267.874642507216, 6227.314995350417, 6291.307956124914, 6303.6532990685955, 6303.747850085945, 6322.525810564134, 6253.687315634291, 6266.373362663697, 6294.433500984934, 6303.495720342454, 6314.652694101868], "value": 5908.440753416865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.5654804430477, 551.8647931256842, 563.9812624646352, 596.5645079092262, 600.9633382415332, 31299.0, 39643.80178099105, 40391.99020024501, 40404.59595404045, 40526.18947621049, 40928.59071409285, 41064.79467602658, 42344.941376465526, 42359.78820105895, 42535.14929701404, 9431.905680943188, 9566.378185417925, 9629.711108666716, 9672.371295865782, 9674.226061915066, 9642.035796420372, 9746.269029822755, 9770.218382529381, 9825.0, 9873.308868379216, 9741.415515069084, 9778.07108324708, 9824.06671366219, 9877.308588398815, 9951.353162044481, 9687.273454490942, 9753.853692194623, 9878.654247101389, 9882.752931176707, 9906.603735850558, 8152.714654987047, 9530.809383812284, 9660.951695241549, 9671.226301895831, 9692.41845489273, 33687.4946875797, 40044.0, 40765.592344076475, 40793.184136317104, 41105.588944110474, 3151.5272709093592, 3332.23358627517, 3353.597568291796, 3408.590969083701, 3538.6815186633326, 26362.736372636413, 26641.467170656477, 27374.726252737615, 27527.449451010867, 28043.579346309616, 2652.2838833514843, 2667.906623268176, 2697.0560303893676, 2766.764824989858, 2891.898783542587, 271111.0, 272312.0, 272402.0, 272581.0, 273944.0, 35381.0, 35626.28747425089, 37408.81295593505, 37940.861774146266, 38148.61851381451, 36581.26837463236, 36997.07507312285, 37179.814100929325, 37227.813860930524, 37275.440868387, 16128.274227659784, 16139.596510087342, 16160.0, 16671.6665666686, 16936.407225747287, 13736.175829450265, 13772.24252666113, 14159.362828672734, 14251.144931304156, 14271.714565708628, 8296.8340633187, 8349.45728527656, 8596.828063438696, 8632.438891472035, 8688.695895643623, 3479.304139172176, 3513.4378499439968, 3555.3955827509385, 3571.714262858965, 3577.94633080504, 1000.6897861662908, 1014.4978235773192, 1020.3214862116757, 1059.3008614314515, 1085.10478854945, 30862.845685771426, 30972.380552388826, 30996.915107971112, 31229.53155702666, 31238.062858114292, 1118.2563595209094, 1138.846255755479, 1151.0791366906442, 1158.4960542164185, 1161.5760247509597, 13081.803772943413, 15706.842931570767, 15819.604509887115, 15865.603359916095, 16209.027458352537, 513967.0, 627008.0, 635503.0, 639912.0, 647579.0, 61874.69062654748, 62168.0, 62980.0, 63044.0, 63284.683576581825, 1474.741920163967, 1490.2027415332961, 1492.276246020679, 1505.0743792567491, 1508.5775982724854, 30122.24694382658, 30368.230036293033, 30613.085577872524, 30698.0, 30810.229744256572, 52085.0, 52722.736386317825, 52906.73546632396, 53203.201951969975, 53227.467725322254, 583900.0, 584932.0, 586079.0, 586189.0, 586797.0, 27137.0, 27541.86229068842, 27627.585586216625, 27727.861360693874, 28038.439231214852, 47122.76438617785, 47823.28265075957, 49209.75395123001, 49789.004219916125, 49814.750926245135, 37829.621703782606, 37860.0, 37877.621223787406, 37996.2400751989, 38201.23597528089, 38988.610113898496, 39112.804435978775, 39271.97513963936, 39534.80232598819, 39871.80384588467, 33137.0, 37009.0, 37566.248675026894, 39301.60698392979, 39414.605853941095, 32162.03513894493, 32245.67754322427, 32478.837605812765, 32615.510767338033, 32789.344213116085, 24913.750862491142, 25189.49621007533, 25607.359816004748, 25652.743472565035, 25760.969561217342], "value": 18449.04508137058, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.1739954889319, 417.54070522425314, 419.2830260254964, 420.3106904676331, 429.3516789647633, 17747.73378399325, 18820.588455865796, 21106.472338191554, 21672.0, 21913.780862191372, 21164.36506904795, 21197.046132924017, 21538.13847446104, 21574.1370345186, 21716.2399316024, 5109.3613298337705, 5136.768845401947, 5569.470900264469, 6052.485538729214, 6074.726637301332, 5909.4090590941, 5913.793017244398, 5929.495992840613, 5967.641941483504, 6067.150598916155, 5919.526437884959, 5940.821775346746, 5951.137085122655, 5953.523718102541, 5989.85025374367, 5908.291005079375, 5911.438413350725, 5928.081147422156, 5942.910856337158, 5947.881042379171, 5127.9743601282125, 5187.0, 5202.193659982709, 5273.86815329616, 5293.920591191135, 26718.0, 26854.328641783915, 27066.45867082667, 27167.04915327974, 27257.591136132974, 2256.4133325335365, 2264.603694353498, 2371.5968285391523, 2438.112705398036, 2674.104175101324, 15606.765898511532, 15673.059616422937, 15841.049537027815, 15919.681606367807, 15934.60163495922, 1846.7599212102475, 1848.8705790594663, 1858.637565674694, 1882.7081802320663, 1913.483359492943, 107448.0, 112504.43747781208, 117203.99999999914, 117900.82099178983, 121601.0, 9879.703608891745, 11469.827952580717, 11748.412579371168, 11990.100742444352, 12063.819042714365, 13358.465661373437, 14198.645033874236, 14298.714025719428, 14662.486812961495, 14778.18719970412, 9147.0, 9222.0, 9341.859872101788, 9419.90580094204, 9513.476758778195, 9719.076687714656, 9735.269854760922, 9769.169620582188, 9831.31180817336, 9896.25778066648, 7140.214576396592, 7246.818829529198, 7248.6738096785775, 7258.165310989304, 7285.453590980697, 1764.682357175695, 1990.601879624081, 1996.3511858645998, 2026.0578830843433, 2041.7141600175987, 965.2422848064236, 1016.2124353625851, 1067.9679609611724, 1068.4444089073793, 1092.8633920759905, 21204.36386908395, 21594.028268727943, 21983.34049978503, 22994.885025574764, 23011.769882300963, 1063.7500187456096, 1064.7018834726289, 1069.2301542889106, 1073.2755390111643, 1086.6305456144948, 10050.849237261447, 12043.397830108635, 12234.0, 12249.69375765613, 12252.162175673542, 578482.0, 661198.0, 662832.0, 684292.0, 684794.0, 106584.0, 110084.89915100907, 115935.0, 118007.40996294963, 120179.0, 1092.9453527323442, 1094.3215206571817, 1111.183280288987, 1113.0761467981556, 1117.3072694929033, 19418.931958742403, 20106.396808095782, 20360.083796228908, 20370.79629203689, 20424.591508169455, 50317.74205644888, 50809.491905080475, 51729.482705172464, 52024.73987630037, 52121.218181726545, 77828.61085694535, 79415.20584794079, 82091.58954205191, 82833.58583207046, 83593.0, 8174.67301307941, 8332.33341332704, 8547.059823419295, 8636.395452318277, 8933.106689331014, 12733.681657958625, 12964.35178241103, 13193.60419187426, 13266.800997984845, 13333.333333333489, 11321.264117832314, 11332.263402878787, 11558.30650160993, 11643.010344120845, 11790.705232369259, 11177.105831533296, 11278.661640150809, 11367.602133925273, 11543.076553875502, 11560.537578496765, 9261.86107208379, 11596.188266821242, 11857.0, 12085.758284834079, 12210.389480526115, 6496.382843629847, 8568.485890846569, 8697.043325234092, 8784.0, 8807.647694092164, 9314.161725444743, 9961.50192490387, 10984.634885148309, 11645.126615503701, 11973.580924667594], "value": 10128.297450618167, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1601.9599510012251, 1639.590102474381, 1891.177337858032, 1972.7928567500412, 2005.9598808023832, 8460.02709688386, 9016.323775716815, 9353.953230233848, 9571.18644915183, 9586.185174260188, 9050.502222377767, 9066.501342426163, 9200.769980750469, 9201.217896478807, 9219.35464517484, 2537.061287323693, 2561.5517284475236, 2571.6785401824773, 2584.0697348954363, 2584.3151564835334, 2057.5370541628163, 2358.8348815582917, 2393.5997441496747, 2551.285640020797, 2623.0950322138833, 2094.5915546468445, 2559.6288538161957, 2576.8196226264167, 2598.376389666476, 2606.2311618072617, 2542.9618555721677, 2546.057958555328, 2547.8726063696927, 2571.0872640212738, 2601.609758536216, 2606.973930260692, 2619.4499155177436, 2630.04003538707, 2642.365832200258, 2651.0, 9298.302627302979, 9327.673531426435, 9389.342746007782, 9399.671011514563, 9419.576119074589, 5750.166225897264, 5858.297004359504, 5935.49548288396, 5937.228160339128, 5948.494377977877, 3484.059303987909, 3582.7492075554724, 3692.8892133236045, 3820.9617903821163, 3830.559485659157, 1052.731553453872, 1063.8191507443753, 1067.925245232834, 1073.2326386633595, 1084.5282302198568, 12288.447019884126, 12299.692507687201, 12425.565105221274, 12572.874271257262, 12603.873961260453, 4186.558942343026, 5067.797288108508, 5182.740862956837, 5187.948120518822, 5247.4490178530705, 10650.201234907412, 10707.304025238334, 10770.569177232823, 10812.78374432507, 10837.45812709377, 4775.21209000518, 5084.720340381241, 5627.634203776824, 5863.677497737665, 5890.204822348928, 4373.628241599499, 5084.288199652052, 5165.9483405165465, 5194.454582268883, 5215.217717342353, 4330.501992270929, 4346.500152482505, 4357.760323182255, 4424.11517696462, 4452.8218871245435, 1384.7715127004133, 1425.0594607558962, 1427.543905216694, 1433.7383102869408, 1437.0874494695943, 951.9190868776232, 982.3123813330698, 987.3680844259679, 995.4027583449872, 997.1823105053786, 6151.292601350902, 6170.753169873245, 6190.876182476415, 6236.345183755731, 6281.214848143982, 477.1054273237679, 488.3821965214007, 492.6354497671697, 495.8512446266106, 501.018004710771, 4053.7365071270274, 4123.092919557753, 4126.8761937141935, 4319.049809042006, 4372.628326592276, 10455.84316235257, 11570.76858462826, 11579.0, 11595.0, 11609.593664221711, 10970.122390208764, 11006.009459148716, 11042.227044106836, 11186.888131118747, 11265.26775759573, 8616.870746938675, 8631.0, 8887.333449991276, 8908.955455222813, 8910.287177025823, 6012.8797424052145, 6107.4197951194565, 6153.230846144232, 6165.475934545614, 6222.906656400067, 9748.317617766688, 9974.800503990025, 10128.59485620567, 10148.695539133838, 10260.025297596716, 7434.405247580073, 10107.64623238183, 10392.06471417576, 10392.90874458171, 10443.268971171945, 7157.284271572801, 7736.922630773845, 7739.690412383442, 7942.364610831235, 7954.721584744506, 8568.014678312074, 8568.485890846569, 8720.694775682821, 8730.65077396897, 8762.07998160184, 7642.847143057219, 7682.884756728766, 7784.026996625422, 7855.842883142191, 7909.8813517796125, 6405.807825765234, 7565.356944659546, 7589.747691630819, 7611.238876112345, 7692.538447693157, 7199.784006479814, 7220.314070163537, 7265.527740696838, 7295.927040729524, 7316.890246646198, 4963.851084467472, 5012.69669885825, 5135.38375394955, 5173.0, 5181.248718935809, 4929.334539837076, 5041.823536176216, 5147.742612869416, 5167.302414174189, 5347.5721942243745], "value": 4754.081266180221, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.32661310444655, 346.3955397830785, 351.20452175821754, 354.1800731307024, 361.6311362410343, 7030.824229394268, 7053.858922821541, 7071.540349877261, 7071.9292807071915, 7072.115985501812, 6950.131233595801, 7002.334778196076, 7009.544379615334, 7027.789166325006, 7042.366187043165, 4880.560234730763, 4947.6784009039475, 5132.461091585367, 5174.974125129369, 5184.507471790174, 3815.828287727059, 5137.0, 5148.665336753118, 5189.922151167735, 5203.765830537635, 5127.769250383723, 5127.974360128194, 5137.332146820908, 5141.845744627667, 5146.176611742122, 5137.743112844361, 5148.0, 5153.0, 5160.509751573594, 5169.844904652848, 4407.889802754925, 4408.096340250241, 4409.669274804371, 4417.602415782563, 4418.072204836988, 5690.260266165414, 6519.4132528072705, 6800.353966373186, 6807.5575087619145, 6847.657617119125, 5965.642061476326, 6018.097285407181, 6030.66831324277, 6034.336223015464, 6046.788362407295, 7466.402687784964, 7483.176850546435, 7521.135069466972, 7534.773956781305, 7561.281678240558, 3968.6428221460205, 4785.976070119627, 4800.087983283165, 4800.3279540864305, 4824.7828847701585, 7610.9238907611325, 7849.646765895492, 7915.96042019792, 7931.444798864082, 7965.920340796576, 4778.1638213312535, 4815.9886423851385, 4825.131476334293, 4866.05112003156, 4873.220284754422, 4973.850784476472, 4975.104481193348, 4984.551390374883, 4986.401631804134, 4988.775505102279, 5995.61028533144, 5998.340182579913, 6020.0, 6022.879542409128, 6033.245844269466, 7494.6627401767055, 7501.849963000709, 7534.397248220129, 7571.734989275349, 7598.164201937782, 1499.1005396761855, 1647.1187914465704, 1653.3551914753016, 1699.6175860431551, 1730.9913450432666, 915.7435917942987, 958.5878072428923, 1065.984010239847, 1084.1868598551087, 1093.8577984861918, 6891.896621550681, 6961.0, 6977.058097156819, 7003.824904377431, 7020.403265722369, 6375.139356186948, 7470.663820128108, 7578.204288549733, 7710.228977102245, 7721.112072111779, 7031.964840175767, 7064.293570642894, 7065.0, 7130.073090498202, 7138.750143744944, 3311.817850018224, 4099.8975025624, 4154.189932963043, 4158.209940111369, 4170.020045289354, 8206.097329293772, 8226.506409615442, 8245.917540824636, 8265.710700125466, 8265.752027439186, 7901.407394445325, 8128.9187108129345, 8131.308838748654, 8166.510009399455, 8188.099309075997, 6570.8357291068105, 8266.917330826735, 8278.296344810758, 8279.047909490486, 8289.875651865226, 7824.061112666516, 7850.803729906798, 7852.254035866584, 7858.685652574061, 7881.330086942674, 7405.8148546286775, 7710.1133369660965, 7715.614219288901, 7717.691292348243, 7720.884186737091, 8217.671293148207, 8238.711645092393, 8270.214329638675, 8297.585120743817, 8304.83390332202, 4819.759012049313, 4868.707877527218, 4878.170710979071, 4879.316895634543, 4913.410390753133, 7828.84342313162, 7861.449698521049, 7878.881816772639, 7883.802904927423, 7891.368690504861, 6031.728572214173, 6173.135760993554, 7369.77890663281, 7556.357709594746, 7593.354564862048, 7520.924790752022, 7582.658780355007, 7594.5063570867715, 7596.924030759622, 7599.088109426904, 7296.0, 7317.19510853795, 7361.9754567494365, 7365.447591430771, 7394.558061178019, 6658.768127896355, 7493.662785174789, 7525.8494830102, 7548.018757561702, 7559.659815308214, 6094.238220222473, 7164.749233776793, 7401.888971665537, 7423.888641670272, 7425.0], "value": 5436.297081364968, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.6547191875981, 711.4983936324893, 748.5882764479535, 775.4974538494723, 780.9414293927953, 15082.547523574283, 15338.693226135485, 15412.69174616507, 15475.14886681232, 15499.22503874806, 13983.580492585214, 14210.218437985932, 14392.0, 14926.253687315619, 15000.549983500485, 933.9626414943411, 934.5747684803432, 951.6098399656142, 956.9138777510022, 958.904109589039, 824.3652387661497, 927.8561822917425, 950.4677380666849, 954.1269738189549, 954.904509549043, 854.2567965869702, 1020.596864238629, 1023.5342918971887, 1024.354656566362, 1025.9794804103913, 952.3238500664537, 1015.725754046407, 1017.2828156149897, 1018.9759291911655, 1019.3476175247847, 731.8426538294292, 749.6401727170988, 755.1617704348224, 755.2938002967243, 764.4419573711166, 13634.023066655378, 13734.0, 13959.581212563638, 14019.439222431192, 14025.158490490501, 11431.428428578538, 11541.134414918915, 11651.359175245358, 11805.23265987708, 11962.521499140024, 9408.811823763555, 9425.104615061628, 9512.857307140399, 9617.56720947559, 9638.277129215267, 3468.843902024415, 3488.232588830453, 3496.6328535503662, 3515.5781306243157, 3547.822608869546, 67722.0, 75988.62005690047, 77671.61164194143, 77779.44441111146, 84694.72957905637, 9677.854832177523, 10117.190624750003, 10161.949190254149, 10191.847122293171, 10203.132733717568, 22030.559388812133, 22103.115875365125, 22827.543449130924, 22870.656940145913, 22915.88542057279, 7623.69505219785, 7668.271514206142, 7712.691492340244, 7714.074311082593, 7933.761987140395, 4124.319487284564, 4160.563140870226, 4186.895327616773, 4206.390073439396, 4262.616364527207, 3785.3943369061367, 3796.37359835624, 3798.9932667843045, 3831.5210598675167, 3864.265789499986, 646.5344951634816, 674.9088873002082, 688.834679676884, 718.052171134098, 718.7699936020423, 583.5012057040267, 604.1391017799618, 605.3280858247342, 608.14251904814, 614.8247749391492, 7560.773176804704, 7802.510476930901, 8374.832503349899, 8523.360747943929, 8706.521141337287, 451.54845154845157, 557.3312025569332, 583.9007368747323, 614.6158650843223, 619.8109576579096, 3967.8412863485714, 3977.204559088194, 3981.900452488711, 3994.460747799068, 4064.4968051117976, 95876.0, 99407.0, 99574.0, 100491.49754251182, 101054.98945010603, 70497.64751176313, 78609.0, 79772.0056998568, 80401.0, 82593.348133037, 68025.65987170032, 68158.0, 68245.63508729897, 68292.0, 68747.96878046833, 8553.871691924502, 8678.218960293603, 8774.034856165945, 8860.04823350991, 8872.467651940904, 36778.8161059193, 50607.0, 53302.46697532975, 53328.2000769981, 53856.0, 68050.63898722097, 73811.63094184495, 74585.0, 75176.24823751912, 77335.61332193304, 10853.240273181118, 10858.728531786768, 10990.285631433931, 11060.281081729661, 11195.60815371458, 12074.939625301817, 12117.69705757363, 12152.088593355356, 12451.0, 12490.937545312216, 10035.14701250402, 10193.74515637115, 10326.173906087344, 10517.684469465928, 10916.617918372818, 10213.182945364502, 10326.328788628714, 10331.380117192992, 10687.412192329497, 10738.087262582456, 9680.4675742832, 10012.899871001488, 10048.949755251177, 10062.39625622465, 10117.544710488193, 7382.6677799498075, 8654.913450865412, 8746.125387461203, 8899.377043606886, 9085.0, 7760.18518055596, 8455.873161902453, 8912.777180570538, 8928.642854285756, 8973.955130224307], "value": 6924.295490622729, "unit": "score"}], "name": "dromaeo_css", "value": 7631.797530323717, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 107.0, 115.0, 118.0, 117.0, 104.0, 114.0, 115.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 147.0, 168.0, 120.0, 140.0, 162.0, 155.0, 171.0, 139.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [227.0, 252.0, 199.0, 192.0, 194.0, 195.0, 192.0, 193.0, 201.0, 194.0], "value": 203.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 80.0, 75.0, 144.0, 59.0, 56.0, 57.0, 67.0, 127.0, 55.0], "value": 78.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 126.0, 76.0, 88.0, 91.0, 124.0, 66.0, 92.0, 162.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 88.0, 86.0, 89.0, 85.0, 88.0, 86.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 94.0, 95.0, 94.0, 93.0, 95.0, 122.0, 150.0], "value": 102.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 93.0, 91.0, 128.0, 93.0, 143.0, 142.0, 122.0, 91.0, 90.0], "value": 108.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 62.0, 63.0, 64.0, 81.0, 74.0, 80.0, 61.0, 59.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 66.0, 71.0, 69.0, 77.0, 70.0, 65.0, 64.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 81.0, 81.0, 80.0, 80.0, 81.0, 80.0, 82.0, 82.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 126.0, 124.0, 123.0, 127.0, 123.0, 125.0, 176.0, 146.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 160.0, 163.0, 162.0, 161.0, 164.0, 163.0, 164.0, 163.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 64.0, 67.0, 66.0, 68.0, 71.0, 66.0, 68.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1516.5, "alertThreshold": 2.0}]} 04:56:08 INFO - Return code: 0 04:56:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:56:08 ERROR - # TBPL SUCCESS # 04:56:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:56:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:56:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:56:08 INFO - 2016-06-24 04:56:08.881 screenresolution[6214:106960] starting screenresolution argv=screenresolution get 04:56:08 INFO - 2016-06-24 04:56:08.883 screenresolution[6214:106960] Display 0: 1600x1200x32@60 04:56:08 INFO - 2016-06-24 04:56:08.889 screenresolution[6215:106963] starting screenresolution argv=screenresolution list 04:56:08 INFO - Available Modes on Display 0 04:56:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:56:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:56:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:56:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:56:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:56:09 INFO - Intel Iris: 04:56:09 INFO - Chipset Model: Intel Iris 04:56:09 INFO - Type: GPU 04:56:09 INFO - Bus: Built-In 04:56:09 INFO - VRAM (Dynamic, Max): 1536 MB 04:56:09 INFO - Vendor: Intel (0x8086) 04:56:09 INFO - Device ID: 0x0a2e 04:56:09 INFO - Revision ID: 0x0009 04:56:09 INFO - Displays: 04:56:09 INFO - Display: 04:56:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:56:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:56:09 INFO - Display Serial Number: 1600x1200 60 04:56:09 INFO - Main Display: Yes 04:56:09 INFO - Mirror: Off 04:56:09 INFO - Online: Yes 04:56:09 INFO - Rotation: Supported 04:56:09 INFO - Return code: 0 04:56:09 INFO - Running post-action listener: _resource_record_post_action 04:56:09 INFO - Running post-run listener: _resource_record_post_run 04:56:10 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 1613312; Write bytes: 496150016; Read time: 21; Write time: 1547 04:56:10 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193174016; Write bytes: 188028928; Read time: 17570; Write time: 400 04:56:10 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 1588736; Write bytes: 298380800; Read time: 19; Write time: 1111 04:56:10 INFO - Running post-run listener: _upload_blobber_files 04:56:10 INFO - Blob upload gear active. 04:56:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:56:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:56:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:56:10 INFO - (blobuploader) - INFO - Open directory for files ... 04:56:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:56:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:56:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:11 INFO - (blobuploader) - INFO - Done attempting. 04:56:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:56:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:56:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:12 INFO - (blobuploader) - INFO - Done attempting. 04:56:12 INFO - (blobuploader) - INFO - Iteration through files over. 04:56:12 INFO - Return code: 0 04:56:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:56:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:56:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6f0b504b3570ca4021a0c8a0ac7ef52669f810b9b6dfb65f8446c7280349ca37026db4e7373f3beba7178c98b18a76f99021e89d2bffaef76ea7ae18bcb56a45", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73164e37965b879e4bf84cb54c787de46a41210ecccd7457d35fa8048e696b1c7e952f05d284e219eacc28934412cd0a191a9b84e16037eb558a5e43739908e9"} 04:56:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:56:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:56:12 INFO - Contents: 04:56:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6f0b504b3570ca4021a0c8a0ac7ef52669f810b9b6dfb65f8446c7280349ca37026db4e7373f3beba7178c98b18a76f99021e89d2bffaef76ea7ae18bcb56a45", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73164e37965b879e4bf84cb54c787de46a41210ecccd7457d35fa8048e696b1c7e952f05d284e219eacc28934412cd0a191a9b84e16037eb558a5e43739908e9"} 04:56:12 INFO - Running post-run listener: copy_logs_to_upload_dir 04:56:12 INFO - Copying logs to upload dir... 04:56:12 INFO - mkdir: /builds/slave/test/build/upload/logs 04:56:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.252803 ========= master_lag: 1.92 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-24 04:56:12.808664) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 04:56:12.812550) ========= 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.XUBCZG0MPI/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.0cQNU2PPd9/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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/6f0b504b3570ca4021a0c8a0ac7ef52669f810b9b6dfb65f8446c7280349ca37026db4e7373f3beba7178c98b18a76f99021e89d2bffaef76ea7ae18bcb56a45", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73164e37965b879e4bf84cb54c787de46a41210ecccd7457d35fa8048e696b1c7e952f05d284e219eacc28934412cd0a191a9b84e16037eb558a5e43739908e9"} build_url:https://queue.taskcluster.net/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011444 build_url: 'https://queue.taskcluster.net/v1/task/JoJH7F8UTHegrBxPqwK8gg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6f0b504b3570ca4021a0c8a0ac7ef52669f810b9b6dfb65f8446c7280349ca37026db4e7373f3beba7178c98b18a76f99021e89d2bffaef76ea7ae18bcb56a45", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73164e37965b879e4bf84cb54c787de46a41210ecccd7457d35fa8048e696b1c7e952f05d284e219eacc28934412cd0a191a9b84e16037eb558a5e43739908e9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 04:56:12.846053) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 04:56:12.846396) ========= 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.XUBCZG0MPI/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.0cQNU2PPd9/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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.005397 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 04:56:12.895171) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 04:56:12.895486) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 04:56:12.895818) ========= ========= Total master_lag: 20.20 =========