builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0178 starttime: 1461619096.76 results: success (0) buildid: 20160425095909 builduid: bf4af95f322a4411b3423b15fcf5776e revision: dcaf0a6fa115ad73bf7505a8e76464250b971a04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:16.764326) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:16.764753) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:16.765036) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:16.782900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:16.783194) ========= 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.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-25 14:18:16-- 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% 203M=0s 2016-04-25 14:18:16 (203 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123968 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:16.924072) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:16.927400) ========= 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.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.019706 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:16.975723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 14:18:16.976055) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dcaf0a6fa115ad73bf7505a8e76464250b971a04 --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 dcaf0a6fa115ad73bf7505a8e76464250b971a04 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-25 14:18:17,004 truncating revision to first 12 chars 2016-04-25 14:18:17,004 Setting DEBUG logging. 2016-04-25 14:18:17,004 attempt 1/10 2016-04-25 14:18:17,004 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/dcaf0a6fa115?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 14:18:18,044 unpacking tar archive at: mozilla-beta-dcaf0a6fa115/testing/mozharness/ program finished with exit code 0 elapsedTime=1.279449 ========= master_lag: 0.32 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 14:18:18.571381) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:18.571719) ========= script_repo_revision: dcaf0a6fa115ad73bf7505a8e76464250b971a04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:18.575218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:18.575508) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:18.602533) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-25 14:18:18.602848) ========= /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.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 14:18:18 INFO - MultiFileLogger online at 20160425 14:18:18 in /builds/slave/test 14:18:18 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 14:18:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:18:18 INFO - {'append_to_log': False, 14:18:18 INFO - 'base_work_dir': '/builds/slave/test', 14:18:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:18:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:18:18 INFO - 'branch': 'Mozilla-Beta', 14:18:18 INFO - 'buildbot_json_path': 'buildprops.json', 14:18:18 INFO - 'config_files': ('talos/mac_config.py',), 14:18:18 INFO - 'default_actions': ('clobber', 14:18:18 INFO - 'read-buildbot-config', 14:18:18 INFO - 'download-and-extract', 14:18:18 INFO - 'populate-webroot', 14:18:18 INFO - 'create-virtualenv', 14:18:18 INFO - 'install', 14:18:18 INFO - 'run-tests'), 14:18:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:18:18 INFO - 'download_minidump_stackwalk': True, 14:18:18 INFO - 'download_symbols': 'ondemand', 14:18:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:18:18 INFO - 'tooltool.py': '/tools/tooltool.py', 14:18:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:18:18 INFO - '/tools/misc-python/virtualenv.py')}, 14:18:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:18:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:18:18 INFO - 'installer_path': 'installer.exe', 14:18:18 INFO - 'log_level': 'info', 14:18:18 INFO - 'log_name': 'talos', 14:18:18 INFO - 'log_to_console': True, 14:18:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:18:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:18:18 INFO - 'opt_config_files': (), 14:18:18 INFO - 'pip_index': False, 14:18:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:18:18 INFO - 'cmd': ('bash', 14:18:18 INFO - '-c', 14:18:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:18:18 INFO - 'enabled': True, 14:18:18 INFO - 'halt_on_failure': False, 14:18:18 INFO - 'name': 'check_screen_resolution'},), 14:18:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:18:18 INFO - 'cmd': ('bash', 14:18:18 INFO - '-c', 14:18:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:18:18 INFO - 'enabled': True, 14:18:18 INFO - 'halt_on_failure': False, 14:18:18 INFO - 'name': 'check_screen_resolution'},), 14:18:18 INFO - 'run_cmd_checks_enabled': True, 14:18:18 INFO - 'sps_profile': False, 14:18:18 INFO - 'sps_profile_interval': 0, 14:18:18 INFO - 'suite': 'dromaeojs-e10s', 14:18:18 INFO - 'system_bits': '32', 14:18:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:18:18 INFO - 'title': 't-yosemite-r7-0178', 14:18:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:18:18 INFO - 'use_talos_json': True, 14:18:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:18:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:18:18 INFO - 'work_dir': 'build'} 14:18:18 INFO - ##### 14:18:18 INFO - ##### Running clobber step. 14:18:18 INFO - ##### 14:18:18 INFO - Running pre-action listener: _resource_record_pre_action 14:18:18 INFO - Running main action method: clobber 14:18:18 INFO - rmtree: /builds/slave/test/build 14:18:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:18:20 INFO - Running post-action listener: _resource_record_post_action 14:18:20 INFO - ##### 14:18:20 INFO - ##### Running read-buildbot-config step. 14:18:20 INFO - ##### 14:18:20 INFO - Running pre-action listener: _resource_record_pre_action 14:18:20 INFO - Running main action method: read_buildbot_config 14:18:20 INFO - Using buildbot properties: 14:18:20 INFO - { 14:18:20 INFO - "project": "", 14:18:20 INFO - "product": "firefox", 14:18:20 INFO - "script_repo_revision": "production", 14:18:20 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:18:20 INFO - "repository": "", 14:18:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:18:20 INFO - "buildid": "20160425095909", 14:18:20 INFO - "pgo_build": "False", 14:18:20 INFO - "basedir": "/builds/slave/test", 14:18:20 INFO - "buildnumber": 0, 14:18:20 INFO - "slavename": "t-yosemite-r7-0178", 14:18:20 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:18:20 INFO - "platform": "yosemite_r7", 14:18:20 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:18:20 INFO - "branch": "mozilla-beta", 14:18:20 INFO - "repo_path": "releases/mozilla-beta", 14:18:20 INFO - "revision": "dcaf0a6fa115ad73bf7505a8e76464250b971a04", 14:18:20 INFO - "stage_platform": "macosx64", 14:18:20 INFO - "builduid": "bf4af95f322a4411b3423b15fcf5776e", 14:18:20 INFO - "slavebuilddir": "test" 14:18:20 INFO - } 14:18:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 14:18:20 INFO - Running post-action listener: _resource_record_post_action 14:18:20 INFO - ##### 14:18:20 INFO - ##### Running download-and-extract step. 14:18:20 INFO - ##### 14:18:20 INFO - Running pre-action listener: _resource_record_pre_action 14:18:20 INFO - Running main action method: download_and_extract 14:18:20 INFO - mkdir: /builds/slave/test/build/tests 14:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:20 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:18:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 14:18:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 14:18:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 14:18:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 14:18:21 INFO - Downloaded 1241 bytes. 14:18:21 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 14:18:21 INFO - Using the following test package requirements: 14:18:21 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:18:21 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:18:21 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 14:18:21 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:18:21 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 14:18:21 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:18:21 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:18:21 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 14:18:21 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:18:21 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:18:21 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 14:18:21 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:18:21 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 14:18:21 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:18:21 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 14:18:21 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:18:21 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:18:21 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 14:18:21 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 14:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:21 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:18:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:18:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:18:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 14:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 14:18:22 INFO - Downloaded 17745658 bytes. 14:18:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:18:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:18:25 INFO - Return code: 0 14:18:25 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:18: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')]} 14:18:25 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:18:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:18:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:18:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 14:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 14:18:26 INFO - Downloaded 17745658 bytes. 14:18:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:18:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:18:30 INFO - Return code: 0 14:18: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')]} 14:18:30 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:18:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 14:18:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 14:18:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 14:18:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 14:18:31 INFO - Downloaded 10845194 bytes. 14:18:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:18:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:18:31 INFO - Return code: 0 14:18:31 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')]} 14:18:31 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 14:18:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:18:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:18:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 14:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 14:18:35 INFO - Downloaded 88300452 bytes. 14:18:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:18:35 INFO - mkdir: /builds/slave/test/properties 14:18:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:18:35 INFO - Writing to file /builds/slave/test/properties/build_url 14:18:35 INFO - Contents: 14:18:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:18:37 INFO - Running post-action listener: _resource_record_post_action 14:18:37 INFO - Running post-action listener: set_extra_try_arguments 14:18:37 INFO - ##### 14:18:37 INFO - ##### Running populate-webroot step. 14:18:37 INFO - ##### 14:18:37 INFO - Running pre-action listener: _resource_record_pre_action 14:18:37 INFO - Running main action method: populate_webroot 14:18:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:18:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:18:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:18:37 INFO - '--tppagecycles', 14:18:37 INFO - '7'], 14:18:37 INFO - 'tests': ['tsvgm']}}, 14:18:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:18:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:18:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:18:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:18:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:18:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:18:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:37 INFO - 'talos_options': ['--e10s'], 14:18:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:37 INFO - 'tests': ['damp', 'tps']}, 14:18:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:37 INFO - 'talos_options': ['--e10s'], 14:18:37 INFO - 'tests': ['damp', 'tps']}, 14:18:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:18:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:18:37 INFO - 'other': {'tests': ['a11yr', 14:18:37 INFO - 'ts_paint', 14:18:37 INFO - 'tpaint', 14:18:37 INFO - 'sessionrestore', 14:18:37 INFO - 'sessionrestore_no_auto_restore', 14:18:37 INFO - 'tabpaint']}, 14:18:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:18:37 INFO - 'tests': ['a11yr', 14:18:37 INFO - 'ts_paint', 14:18:37 INFO - 'tpaint', 14:18:37 INFO - 'sessionrestore', 14:18:37 INFO - 'sessionrestore_no_auto_restore', 14:18:37 INFO - 'tabpaint']}, 14:18:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:18:37 INFO - 'tests': ['a11yr', 14:18:37 INFO - 'ts_paint', 14:18:37 INFO - 'tpaint', 14:18:37 INFO - 'sessionrestore', 14:18:37 INFO - 'sessionrestore_no_auto_restore', 14:18:37 INFO - 'tabpaint']}, 14:18:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:18:37 INFO - 'tests': ['a11yr', 14:18:37 INFO - 'ts_paint', 14:18:37 INFO - 'tpaint', 14:18:37 INFO - 'sessionrestore', 14:18:37 INFO - 'sessionrestore_no_auto_restore', 14:18:37 INFO - 'tabpaint']}, 14:18:37 INFO - 'other_l64': {'tests': ['a11yr', 14:18:37 INFO - 'ts_paint', 14:18:37 INFO - 'tpaint', 14:18:37 INFO - 'sessionrestore', 14:18:37 INFO - 'sessionrestore_no_auto_restore', 14:18:37 INFO - 'tabpaint']}, 14:18:37 INFO - 'other_nol64': {'tests': ['a11yr', 14:18:37 INFO - 'ts_paint', 14:18:37 INFO - 'tpaint', 14:18:37 INFO - 'sessionrestore', 14:18:37 INFO - 'sessionrestore_no_auto_restore', 14:18:37 INFO - 'tabpaint']}, 14:18:37 INFO - 'svgr': {'tests': ['tsvgx', 14:18:37 INFO - 'tsvgr_opacity', 14:18:37 INFO - 'tart', 14:18:37 INFO - 'tscrollx', 14:18:37 INFO - 'cart']}, 14:18:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:18:37 INFO - 'tests': ['tsvgx', 14:18:37 INFO - 'tsvgr_opacity', 14:18:37 INFO - 'tart', 14:18:37 INFO - 'tscrollx', 14:18:37 INFO - 'cart']}, 14:18:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:37 INFO - 'tests': ['tp5o']}, 14:18:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:37 INFO - 'talos_options': ['--e10s'], 14:18:37 INFO - 'tests': ['tp5o']}, 14:18:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:37 INFO - 'talos_options': ['--xperf_path', 14:18:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:37 INFO - 'tests': ['tp5n']}, 14:18:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:37 INFO - 'talos_options': ['--e10s', 14:18:37 INFO - '--xperf_path', 14:18:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:37 INFO - 'tests': ['tp5n']}}, 14:18:37 INFO - 'talos.zip': {'path': '', 14:18:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:18:37 INFO - Running post-action listener: _resource_record_post_action 14:18:37 INFO - ##### 14:18:37 INFO - ##### Running create-virtualenv step. 14:18:37 INFO - ##### 14:18:37 INFO - Running pre-action listener: _resource_record_pre_action 14:18:37 INFO - Running main action method: create_virtualenv 14:18:37 INFO - Creating virtualenv /builds/slave/test/build/venv 14:18:37 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 14:18:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:18:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:18:37 INFO - Using real prefix '/tools/python27' 14:18:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:18:37 INFO - Installing distribute.............................................................................................................................................................................................done. 14:18:40 INFO - Installing pip.................done. 14:18:40 INFO - Return code: 0 14:18:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:18:40 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')]} 14:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:40 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')]} 14:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:40 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 0x104827a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad50cbbc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cbd30>, '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 0x10452fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2b20>, '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.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 14:18:40 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 14:18:40 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 14:18:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BHR0blZ7Sw/Render', 14:18:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:40 INFO - 'HOME': '/Users/cltbld', 14:18:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:40 INFO - 'LOGNAME': 'cltbld', 14:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:40 INFO - 'MOZ_NO_REMOTE': '1', 14:18:40 INFO - 'NO_EM_RESTART': '1', 14:18:40 INFO - 'PAGER': '/bin/cat', 14:18:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:40 INFO - 'PWD': '/builds/slave/test', 14:18:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:40 INFO - 'SHELL': '/bin/bash', 14:18:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCz6FXnn9O/Listeners', 14:18:40 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 14:18:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:40 INFO - 'USER': 'cltbld', 14:18:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:40 INFO - 'XPC_FLAGS': '0x0', 14:18:40 INFO - 'XPC_SERVICE_NAME': '0', 14:18:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:41 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 14:18:41 INFO - Cleaning up... 14:18:41 INFO - Return code: 0 14:18:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104827a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad50cbbc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cbd30>, '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 0x10452fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2b20>, '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.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 14:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:18:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BHR0blZ7Sw/Render', 14:18:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:41 INFO - 'HOME': '/Users/cltbld', 14:18:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:41 INFO - 'LOGNAME': 'cltbld', 14:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:41 INFO - 'MOZ_NO_REMOTE': '1', 14:18:41 INFO - 'NO_EM_RESTART': '1', 14:18:41 INFO - 'PAGER': '/bin/cat', 14:18:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:41 INFO - 'PWD': '/builds/slave/test', 14:18:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:41 INFO - 'SHELL': '/bin/bash', 14:18:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCz6FXnn9O/Listeners', 14:18:41 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 14:18:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:41 INFO - 'USER': 'cltbld', 14:18:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:41 INFO - 'XPC_FLAGS': '0x0', 14:18:41 INFO - 'XPC_SERVICE_NAME': '0', 14:18:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:41 INFO - Downloading/unpacking psutil>=0.7.1 14:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:18:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:44 INFO - Installing collected packages: psutil 14:18:44 INFO - Running setup.py install for psutil 14:18:44 INFO - building 'psutil._psutil_osx' extension 14:18:44 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 14:18:44 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 14:18:44 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 14:18:44 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 14:18:44 INFO - building 'psutil._psutil_posix' extension 14:18:44 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 14:18:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:18:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:18:44 INFO - ^ 14:18:44 INFO - 1 warning generated. 14:18:44 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 14:18:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:45 INFO - Successfully installed psutil 14:18:45 INFO - Cleaning up... 14:18:45 INFO - Return code: 0 14:18:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:18:45 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')]} 14:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:45 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')]} 14:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:45 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 0x104827a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad50cbbc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cbd30>, '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 0x10452fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2b20>, '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.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 14:18:45 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 14:18:45 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 14:18:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BHR0blZ7Sw/Render', 14:18:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:45 INFO - 'HOME': '/Users/cltbld', 14:18:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:45 INFO - 'LOGNAME': 'cltbld', 14:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:45 INFO - 'MOZ_NO_REMOTE': '1', 14:18:45 INFO - 'NO_EM_RESTART': '1', 14:18:45 INFO - 'PAGER': '/bin/cat', 14:18:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:45 INFO - 'PWD': '/builds/slave/test', 14:18:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:45 INFO - 'SHELL': '/bin/bash', 14:18:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCz6FXnn9O/Listeners', 14:18:45 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 14:18:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:45 INFO - 'USER': 'cltbld', 14:18:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:45 INFO - 'XPC_FLAGS': '0x0', 14:18:45 INFO - 'XPC_SERVICE_NAME': '0', 14:18:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:18:45 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 14:18:45 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 14:18:45 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 14:18:45 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 14:18:45 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 14:18:45 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 14:18:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:18:47 INFO - Installing collected packages: mozsystemmonitor 14:18:47 INFO - Running setup.py install for mozsystemmonitor 14:18:48 INFO - Successfully installed mozsystemmonitor 14:18:48 INFO - Cleaning up... 14:18:48 INFO - Return code: 0 14:18:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:18:48 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')]} 14:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:48 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')]} 14:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:48 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 0x104827a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad50cbbc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cbd30>, '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 0x10452fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2b20>, '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.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 14:18:48 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 14:18:48 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 14:18:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BHR0blZ7Sw/Render', 14:18:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:48 INFO - 'HOME': '/Users/cltbld', 14:18:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:48 INFO - 'LOGNAME': 'cltbld', 14:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:48 INFO - 'MOZ_NO_REMOTE': '1', 14:18:48 INFO - 'NO_EM_RESTART': '1', 14:18:48 INFO - 'PAGER': '/bin/cat', 14:18:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:48 INFO - 'PWD': '/builds/slave/test', 14:18:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:48 INFO - 'SHELL': '/bin/bash', 14:18:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCz6FXnn9O/Listeners', 14:18:48 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 14:18:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:48 INFO - 'USER': 'cltbld', 14:18:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:48 INFO - 'XPC_FLAGS': '0x0', 14:18:48 INFO - 'XPC_SERVICE_NAME': '0', 14:18:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:48 INFO - Downloading/unpacking blobuploader==1.2.4 14:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:50 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:18:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:51 INFO - Downloading docopt-0.6.1.tar.gz 14:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:52 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:52 INFO - Running setup.py install for blobuploader 14:18:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:18:52 INFO - Running setup.py install for requests 14:18:52 INFO - Running setup.py install for docopt 14:18:52 INFO - Successfully installed blobuploader requests docopt 14:18:52 INFO - Cleaning up... 14:18:52 INFO - Return code: 0 14:18:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:52 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')]} 14:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:52 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')]} 14:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:52 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 0x104827a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad50cbbc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cbd30>, '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 0x10452fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2b20>, '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.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 14:18:52 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 14:18:52 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 14:18:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BHR0blZ7Sw/Render', 14:18:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:52 INFO - 'HOME': '/Users/cltbld', 14:18:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:52 INFO - 'LOGNAME': 'cltbld', 14:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:52 INFO - 'MOZ_NO_REMOTE': '1', 14:18:52 INFO - 'NO_EM_RESTART': '1', 14:18:52 INFO - 'PAGER': '/bin/cat', 14:18:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:52 INFO - 'PWD': '/builds/slave/test', 14:18:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:52 INFO - 'SHELL': '/bin/bash', 14:18:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCz6FXnn9O/Listeners', 14:18:52 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 14:18:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:52 INFO - 'USER': 'cltbld', 14:18:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:52 INFO - 'XPC_FLAGS': '0x0', 14:18:52 INFO - 'XPC_SERVICE_NAME': '0', 14:18:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-F7tj0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Ai5FN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ah5Yob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-GT6Oi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-A93KwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-au25dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-PIiYP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-PmZ_1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-CLSJC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-IHzb9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-CdorM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-5SqZmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-1sAS9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-YMHqlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-eIKHDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-pWLlbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-4IF9Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:18:54 INFO - Running setup.py install for manifestparser 14:18:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Running setup.py install for mozcrash 14:18:55 INFO - Running setup.py install for mozdebug 14:18:55 INFO - Running setup.py install for mozdevice 14:18:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Running setup.py install for mozfile 14:18:55 INFO - Running setup.py install for mozhttpd 14:18:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Running setup.py install for mozinfo 14:18:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Running setup.py install for mozInstall 14:18:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Running setup.py install for mozleak 14:18:56 INFO - Running setup.py install for mozlog 14:18:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Running setup.py install for moznetwork 14:18:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Running setup.py install for mozprocess 14:18:56 INFO - Running setup.py install for mozprofile 14:18:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:18:56 INFO - Running setup.py install for mozrunner 14:18:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:18:57 INFO - Running setup.py install for mozscreenshot 14:18:57 INFO - Running setup.py install for moztest 14:18:57 INFO - Running setup.py install for mozversion 14:18:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:18:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:57 INFO - Cleaning up... 14:18:57 INFO - Return code: 0 14:18:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:57 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')]} 14:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:57 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')]} 14:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:57 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 0x104827a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad50cbbc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cbd30>, '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 0x10452fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2b20>, '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.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 14:18:57 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 14:18:57 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 14:18:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BHR0blZ7Sw/Render', 14:18:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:57 INFO - 'HOME': '/Users/cltbld', 14:18:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:57 INFO - 'LOGNAME': 'cltbld', 14:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:57 INFO - 'MOZ_NO_REMOTE': '1', 14:18:57 INFO - 'NO_EM_RESTART': '1', 14:18:57 INFO - 'PAGER': '/bin/cat', 14:18:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:57 INFO - 'PWD': '/builds/slave/test', 14:18:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:57 INFO - 'SHELL': '/bin/bash', 14:18:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCz6FXnn9O/Listeners', 14:18:57 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 14:18:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:57 INFO - 'USER': 'cltbld', 14:18:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:57 INFO - 'XPC_FLAGS': '0x0', 14:18:57 INFO - 'XPC_SERVICE_NAME': '0', 14:18:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:57 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-6SCKco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:57 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)) 14:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:57 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-WbTCXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:58 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)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-rvgE7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:58 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)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-4zIV78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:58 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)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-SAb9NT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:58 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)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-jGhDLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:58 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)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-QZudUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:58 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)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ffZEbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:58 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)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-4Kg8hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:58 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)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-1LmqRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:58 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)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-fP9vRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:58 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)) 14:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-lzS499-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:59 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)) 14:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:59 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-HxIPyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:59 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)) 14:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:59 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-QgE0w7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:59 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)) 14:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:59 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ecIiLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:59 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)) 14:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:59 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-qYqtDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:59 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)) 14:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:59 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-rNy1QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:59 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)) 14:18:59 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)) 14:18:59 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)) 14:18:59 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)) 14:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:59 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)) 14:18:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:02 INFO - Downloading blessings-1.6.tar.gz 14:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:19:02 INFO - Installing collected packages: blessings 14:19:02 INFO - Running setup.py install for blessings 14:19:02 INFO - Successfully installed blessings 14:19:02 INFO - Cleaning up... 14:19:02 INFO - Return code: 0 14:19:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:19:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:02 INFO - Reading from file tmpfile_stdout 14:19:02 INFO - Current package versions: 14:19:02 INFO - blessings == 1.6 14:19:02 INFO - blobuploader == 1.2.4 14:19:02 INFO - docopt == 0.6.1 14:19:02 INFO - manifestparser == 1.1 14:19:02 INFO - mozInstall == 1.12 14:19:02 INFO - mozcrash == 0.17 14:19:02 INFO - mozdebug == 0.1 14:19:02 INFO - mozdevice == 0.48 14:19:02 INFO - mozfile == 1.2 14:19:02 INFO - mozhttpd == 0.7 14:19:02 INFO - mozinfo == 0.9 14:19:02 INFO - mozleak == 0.1 14:19:02 INFO - mozlog == 3.1 14:19:02 INFO - moznetwork == 0.27 14:19:02 INFO - mozprocess == 0.22 14:19:02 INFO - mozprofile == 0.28 14:19:02 INFO - mozrunner == 6.11 14:19:02 INFO - mozscreenshot == 0.1 14:19:02 INFO - mozsystemmonitor == 0.0 14:19:02 INFO - moztest == 0.7 14:19:02 INFO - mozversion == 1.4 14:19:02 INFO - psutil == 3.1.1 14:19:02 INFO - requests == 1.2.3 14:19:02 INFO - wsgiref == 0.1.2 14:19:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:02 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 0x104827a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad50cbbc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cbd30>, '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 0x10452fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2b20>, '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.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 14:19:02 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 14:19:02 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 14:19:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BHR0blZ7Sw/Render', 14:19:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:02 INFO - 'HOME': '/Users/cltbld', 14:19:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:02 INFO - 'LOGNAME': 'cltbld', 14:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:02 INFO - 'MOZ_NO_REMOTE': '1', 14:19:02 INFO - 'NO_EM_RESTART': '1', 14:19:02 INFO - 'PAGER': '/bin/cat', 14:19:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:02 INFO - 'PWD': '/builds/slave/test', 14:19:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:02 INFO - 'SHELL': '/bin/bash', 14:19:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCz6FXnn9O/Listeners', 14:19:02 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 14:19:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:02 INFO - 'USER': 'cltbld', 14:19:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:02 INFO - 'XPC_FLAGS': '0x0', 14:19:02 INFO - 'XPC_SERVICE_NAME': '0', 14:19:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:02 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)) 14:19:02 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)) 14:19:02 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)) 14:19:02 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)) 14:19:02 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)) 14:19:02 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)) 14:19:02 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)) 14:19:02 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)) 14:19:02 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)) 14:19:02 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)) 14:19:02 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)) 14:19:02 INFO - Cleaning up... 14:19:02 INFO - Return code: 0 14:19:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104827a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad50cbbc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cbd30>, '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 0x10452fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2b20>, '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.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 14:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:19:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BHR0blZ7Sw/Render', 14:19:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:02 INFO - 'HOME': '/Users/cltbld', 14:19:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:02 INFO - 'LOGNAME': 'cltbld', 14:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:02 INFO - 'MOZ_NO_REMOTE': '1', 14:19:02 INFO - 'NO_EM_RESTART': '1', 14:19:02 INFO - 'PAGER': '/bin/cat', 14:19:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:02 INFO - 'PWD': '/builds/slave/test', 14:19:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:02 INFO - 'SHELL': '/bin/bash', 14:19:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCz6FXnn9O/Listeners', 14:19:02 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 14:19:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:02 INFO - 'USER': 'cltbld', 14:19:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:02 INFO - 'XPC_FLAGS': '0x0', 14:19:02 INFO - 'XPC_SERVICE_NAME': '0', 14:19:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:03 INFO - Downloading/unpacking jsonschema 14:19:03 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 14:19:03 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 14:19:03 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 14:19:03 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 14:19:03 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 14:19:03 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 14:19:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:19:05 INFO - Downloading/unpacking functools32 (from jsonschema) 14:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:05 INFO - Downloading functools32-3.2.3-2.tar.gz 14:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:19:06 INFO - warning: no files found matching '*.txt' 14:19:06 INFO - no previously-included directories found matching 'build' 14:19:06 INFO - no previously-included directories found matching 'dist' 14:19:06 INFO - no previously-included directories found matching '.git*' 14:19:06 INFO - Installing collected packages: jsonschema, functools32 14:19:06 INFO - Running setup.py install for functools32 14:19:06 INFO - warning: no files found matching '*.txt' 14:19:06 INFO - no previously-included directories found matching 'build' 14:19:06 INFO - no previously-included directories found matching 'dist' 14:19:06 INFO - no previously-included directories found matching '.git*' 14:19:06 INFO - Successfully installed jsonschema functools32 14:19:06 INFO - Cleaning up... 14:19:06 INFO - Return code: 0 14:19:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:06 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 0x104827a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad50cbbc60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cbd30>, '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 0x10452fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2b20>, '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.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 14:19:06 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 14:19:06 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 14:19:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BHR0blZ7Sw/Render', 14:19:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:06 INFO - 'HOME': '/Users/cltbld', 14:19:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:06 INFO - 'LOGNAME': 'cltbld', 14:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:06 INFO - 'MOZ_NO_REMOTE': '1', 14:19:06 INFO - 'NO_EM_RESTART': '1', 14:19:06 INFO - 'PAGER': '/bin/cat', 14:19:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:06 INFO - 'PWD': '/builds/slave/test', 14:19:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:06 INFO - 'SHELL': '/bin/bash', 14:19:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCz6FXnn9O/Listeners', 14:19:06 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 14:19:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:06 INFO - 'USER': 'cltbld', 14:19:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:06 INFO - 'XPC_FLAGS': '0x0', 14:19:06 INFO - 'XPC_SERVICE_NAME': '0', 14:19:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:06 INFO - Downloading/unpacking flake8 14:19:06 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 14:19:06 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 14:19:06 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 14:19:06 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 14:19:06 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 14:19:06 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 14:19:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:19:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:19:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:19:10 INFO - no previously-included directories found matching 'docs/_build' 14:19:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:19:10 INFO - Running setup.py install for pep8 14:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:19:10 INFO - no previously-included directories found matching 'docs/_build' 14:19:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:19:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:19:10 INFO - Cleaning up... 14:19:10 INFO - Return code: 0 14:19:10 INFO - Running post-action listener: _resource_record_post_action 14:19:10 INFO - Running post-action listener: _start_resource_monitoring 14:19:10 INFO - Starting resource monitoring. 14:19:10 INFO - ##### 14:19:10 INFO - ##### Running install step. 14:19:10 INFO - ##### 14:19:10 INFO - Running pre-action listener: _resource_record_pre_action 14:19:10 INFO - Running main action method: install 14:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:10 INFO - Reading from file tmpfile_stdout 14:19:10 INFO - Detecting whether we're running mozinstall >=1.0... 14:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:19:11 INFO - Reading from file tmpfile_stdout 14:19:11 INFO - Output received: 14:19:11 INFO - Usage: mozinstall [options] installer 14:19:11 INFO - Options: 14:19:11 INFO - -h, --help show this help message and exit 14:19:11 INFO - -d DEST, --destination=DEST 14:19:11 INFO - Directory to install application into. [default: 14:19:11 INFO - "/builds/slave/test"] 14:19:11 INFO - --app=APP Application being installed. [default: firefox] 14:19:11 INFO - mkdir: /builds/slave/test/build/application 14:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:19:33 INFO - Reading from file tmpfile_stdout 14:19:33 INFO - Output received: 14:19:33 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:19:33 INFO - Running post-action listener: _resource_record_post_action 14:19:33 INFO - ##### 14:19:33 INFO - ##### Running run-tests step. 14:19:33 INFO - ##### 14:19:33 INFO - Running pre-action listener: _resource_record_pre_action 14:19:33 INFO - Running main action method: run_tests 14:19:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:19:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:19:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:19:33 INFO - 2016-04-25 14:19:33.386 screenresolution[1923:11196] starting screenresolution argv=screenresolution get 14:19:33 INFO - 2016-04-25 14:19:33.389 screenresolution[1923:11196] Display 0: 1600x1200x32@60 14:19:33 INFO - 2016-04-25 14:19:33.395 screenresolution[1924:11198] starting screenresolution argv=screenresolution list 14:19:33 INFO - Available Modes on Display 0 14:19:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:19:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:19:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:19:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:19:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:19:33 INFO - Intel Iris: 14:19:33 INFO - Chipset Model: Intel Iris 14:19:33 INFO - Type: GPU 14:19:33 INFO - Bus: Built-In 14:19:33 INFO - VRAM (Dynamic, Max): 1536 MB 14:19:33 INFO - Vendor: Intel (0x8086) 14:19:33 INFO - Device ID: 0x0a2e 14:19:33 INFO - Revision ID: 0x0009 14:19:33 INFO - Displays: 14:19:33 INFO - Display: 14:19:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:19:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:19:33 INFO - Display Serial Number: 1600x1200 60 14:19:33 INFO - Main Display: Yes 14:19:33 INFO - Mirror: Off 14:19:33 INFO - Online: Yes 14:19:33 INFO - Rotation: Supported 14:19:33 INFO - Return code: 0 14:19:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:19:33 INFO - Python 2.7.3 14:19:33 INFO - Return code: 0 14:19:33 INFO - grabbing minidump binary from tooltool 14:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:33 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 0x1046cbd30>, '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 0x10452fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:19:33 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 14:19:33 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 14:19:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:19:33 INFO - Return code: 0 14:19:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:19:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:19:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:19:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:19:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:19:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:19:34 INFO - Return code: 0 14:19:34 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/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--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 14:19:34 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/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0178 --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 14:19:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BHR0blZ7Sw/Render', 14:19:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:34 INFO - 'HOME': '/Users/cltbld', 14:19:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:34 INFO - 'LOGNAME': 'cltbld', 14:19:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:19:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:34 INFO - 'MOZ_NO_REMOTE': '1', 14:19:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:19:34 INFO - 'NO_EM_RESTART': '1', 14:19:34 INFO - 'PAGER': '/bin/cat', 14:19:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:34 INFO - 'PWD': '/builds/slave/test', 14:19:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:19:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:34 INFO - 'SHELL': '/bin/bash', 14:19:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCz6FXnn9O/Listeners', 14:19:34 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 14:19:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:34 INFO - 'USER': 'cltbld', 14:19:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:34 INFO - 'XPC_FLAGS': '0x0', 14:19:34 INFO - 'XPC_SERVICE_NAME': '0', 14:19:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:34 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/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--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 14:19:35 INFO - mozversion application_buildid: 20160425095909 14:19:35 INFO - mozversion application_changeset: dcaf0a6fa115ad73bf7505a8e76464250b971a04 14:19:35 INFO - mozversion application_display_name: Firefox 14:19:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:19:35 INFO - mozversion application_name: Firefox 14:19:35 INFO - mozversion application_remotingname: firefox 14:19:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:19:35 INFO - mozversion application_vendor: Mozilla 14:19:35 INFO - mozversion application_version: 47.0 14:19:35 INFO - mozversion platform_buildid: 20160425095909 14:19:35 INFO - mozversion platform_changeset: dcaf0a6fa115ad73bf7505a8e76464250b971a04 14:19:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:19:35 INFO - mozversion platform_version: 47.0 14:19:35 INFO - using testdate: 1461619175 14:19:35 INFO - actual date: 1461619175 14:19:35 INFO - starting webserver on 'localhost:50271' 14:19:35 INFO - SUITE-START | Running 2 tests 14:19:35 INFO - TEST-START | dromaeo_css 14:19:35 INFO - operating with platform_type : mac_ 14:19:35 INFO - Initialising browser for dromaeo_css test... 14:19:35 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpf53aBw/profile http://localhost:50271/getInfo.html) 14:19:37 INFO - PROCESS | 1942 | __metrics Screen width/height:1600/1200 14:19:37 INFO - PROCESS | 1942 | colorDepth:24 14:19:37 INFO - PROCESS | 1942 | Browser inner width/height: 1024/689 14:19:37 INFO - PROCESS | 1942 | __metrics 14:19:38 ERROR - PROCESS | 1942 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:19:38 INFO - TEST-INFO | 1942: exit 0 14:19:38 INFO - Browser initialized. 14:19:38 INFO - Running cycle 1/1 for dromaeo_css test... 14:19:38 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpf53aBw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:50 INFO - PROCESS | 1946 | RSS: Main: 167587840 14:19:50 INFO - PROCESS | 1946 | 14:20:40 INFO - PROCESS | 1946 | 1461619240192 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] 14:22:50 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:50271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50271/tests/dromaeo/cssquery-ext.html) 14:22:51 INFO - PROCESS | 1946 | RSS: Main: 178995200 14:22:51 INFO - PROCESS | 1946 | 14:25:53 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:50271/tests/dromaeo/cssquery-ext.html (next: http://localhost:50271/tests/dromaeo/cssquery-jquery.html) 14:25:54 INFO - PROCESS | 1946 | RSS: Main: 189308928 14:25:54 INFO - PROCESS | 1946 | 14:28:55 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:50271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50271/tests/dromaeo/cssquery-mootools.html) 14:28:56 INFO - PROCESS | 1946 | RSS: Main: 190914560 14:28:56 INFO - PROCESS | 1946 | 14:31:58 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:50271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50271/tests/dromaeo/cssquery-prototype.html) 14:31:58 INFO - PROCESS | 1946 | RSS: Main: 194629632 14:31:58 INFO - PROCESS | 1946 | 14:35:01 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:50271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50271/tests/dromaeo/cssquery-yui.html) 14:35:02 INFO - PROCESS | 1946 | RSS: Main: 193949696 14:35:02 INFO - PROCESS | 1946 | 14:38:04 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:50271/tests/dromaeo/cssquery-yui.html (next: http://localhost:50271/tests/dromaeo/cssquery-dojo.html) 14:38:04 INFO - PROCESS | 1946 | RSS: Main: 199188480 14:38:04 INFO - PROCESS | 1946 | 14:38:04 INFO - PROCESS | 1946 | __start_tp_report 14:38:04 INFO - PROCESS | 1946 | _x_x_mozilla_page_load 14:38:04 INFO - PROCESS | 1946 | _x_x_mozilla_page_load_details 14:38:04 INFO - PROCESS | 1946 | |i|pagename|runs| 14:38:04 INFO - PROCESS | 1946 | |0;dojo.html;3641.7086633069353;3648.288583726173;3670.2109046554983;3699.075231192202;3716.702663786898;4307.78461076946;5218.947810521893;5925.585209035364;5946.554008449362;5984.132300816379;5940.584159108864;6002.489788367994;6002.789902353407;6012.789552365668;6015.578909476328;5319.281896943911;5363.570914326844;5446.591505637073;5447.754851031713;5481.588880833953;5309.283246761695;5373.220882971967;5426.996005738951;5479.726013699319;5516.889662206753;5260.605454590902;5442.564594832424;5449.56403487722;5464.672119672812;5493.862653433656;5409.053415652245;5430.8913821723545;5478.534324582415;5487.75305111271;5551.9722401388135;5202.505761952609;5232.764525596357;5292.9735351323;5325.4940780625775;5352.902654955725;5695.829125126253;5805.88388232233;5841.620294680874;5852.151438041503;5861.062230043172;6126;6215.875682486325;6261.843453913643;6276.623402595813;6290.276618188921;6280.340564240734;6332.715027823759;6355.682215889187;6358.395952384562;6367.140436041168;5911.231539899829;6075.544334174954;6081.331053584102;6089.3910608939195;6091.604045737057;6280.811575652647;6399.680015999182;6416.037594360883;6417.7753778617525;6454.6449945252525;6130.141780150782;6151;6167.907481387782;6168.321484636686;6176.104464852571;6262.060690896402;6270.216222972129;6286.119943207955;6289.245290565162;6296.370362963758;5201.7919283229;6098.756049758049;6163.537734669828;6182.629042257389;6203.2245969253845;6119.724612392453;6197.349278325801;6214.098955651405;6236.064590311399;6263.123162757218;4884.65807393479;5005.599552035828;5011.3986321640905;5012.323336349619;5047.192449208109;3845.3462911305146;4372.956270437318;4397.890052748643;4404.471463424409;4491.258942274553;6111.388861113853;6117.694115294217;6126.877462450726;6168.814935551941;6185.319614842364;5973.626066004843;6214.720337584819;6231.345708700612;6265.028920517327;6292.559520833589;5472.699001554873;5990.9101363479585;5999.760009599567;6082.2093127893095;6084.847878802977;5488.121900495981;5516.365617953907;5520.723963801794;5526.281583394133;5531.446855314436;6470.514711396664;6487.837804054936;6507.056476810931;6520.413162815369;6536.346365363425;6144.771045790771;6234.1583886174785;6244.750209991549;6255.40573645503;6305.274893387319;6435.163428754419;6437.324080971431;6442.967785161044;6457.483401327976;6461.095446637569;6151.0773383992755;6153.815385538441;6186.783462578788;6227.0970709246;6235.407636274546;6185;6215.844603884939;6263.091851681572;6281.842953926189;6283.434490895841;6083.391660833881;6188.721507532262;6211.9068213975925;6230.6884655767935;6253.593516421418;6102.216595924137;6140.228185505611;6228.875422491616;6230.906536402048;6234.096056071753;6040.214772079602;6066.211392518944;6084.6349219047;6131.284916201153;6147.569670123048;5138.332016837787;6093.878122437438;6182.922646358548;6215.316315205414;6240.095186197885;6023.277206735044;6139.386061393825;6159.260888693386;6176.227971503562;6208.161898143693 14:38:04 INFO - PROCESS | 1946 | |1;ext.html;590.4302348233954;631.7725618777242;635.2059925093633;687.4122625155492;700.7302188657367;38678.83963481093;39155.60844391555;39371.0157246069;39463.802680986555;39497.60502394975;41273.58726412735;41312.38031429531;41338.58661413385;41389.79305103478;41568.96077598062;9689.757756056084;9838.704838854846;9860.408375497493;9916.702498925044;9926.106650401462;9836.754081147958;9912.513123031567;9944.154746846527;10010.499475026256;10012.449315287657;9958.751031224241;9978.401295922231;10002;10060.195184385231;10065.899341006569;9932.652357167464;9963.701088967342;9982.450965196911;10038.498075096217;10058;9801.852972205423;9832.164266037395;9894.30739848211;9923.354981926224;9948.801023979553;33942.49086263708;39524.209515809525;39669.40495892564;40343.59656403428;40505.98735031618;3202.151429871086;3420.1449637590604;3515.367233897897;3655.4151335786414;4034.1326614777963;23880;27971.44057118846;28369.432611347864;29292.560611590845;30031.798728050853;2785.7492825645586;2800.537911244642;2818.5208514552573;2852.7717782577342;3017.1401150671954;142704;144088;144501;145040;145207;50941;51786;76625.61687191528;77014;77981.61009195031;51068.23397649038;52124.739376302874;52133.218001730005;52159.73920130375;52385.2142217867;17905.015224162795;18042.639147217244;18069.367572134914;18076.367327143485;18129.18418671163;14247.216403097722;14250.643733906736;14541.927290363692;14703.191324477042;14704.705905881823;15952.601184970468;16109.033457992558;16357.854950153613;16571.585710357336;16693.415730449375;6761.053452516651;7041.225465198824;7124.216336203013;7184.47960499362;7203.315685009916;899.8515244984635;1053.8419237114495;1099.1481601758542;1136.170595465315;1239.324568110382;30193.849030755144;30595.847020764755;30971.070867874;31159;31160.22099447532;1122.7978963786434;1148.6381789736206;1184.3308530680138;1243.1981372015;1272.5100836177953;15463.38146474151;15467.535973920576;15593.68812623764;15732.60668483297;15953.361865525249;526392;528581;528968;532561;535887;59625.70187149037;60053.39946600478;60140.398596014355;60373;60456;1547.0562956596468;1574.8818838587151;1598.7202239608023;1601.375463569209;1608.316465502157;29541.26146846346;30143.643536040494;30246;30617.54073688941;30693.23266918345;52704;52878;53091.46908530865;53338.73330633322;53437;517620;521084.3945780247;521973;525535;527313;34653.65346346605;34972;35736.821315893256;35749;36474.45288320624;45700.771496142304;45952.77023614861;46138.07723845571;47497;48158.759206203744;38046.13945341273;38601;38773.2245355097;38986;39959.40060899147;37455.81272093622;37887.05282367963;37948.05129871775;38453.61546384612;39087.80456097701;38055.238895222494;38363.80818095891;38803.417948730224;38836;39129.80435097806;32752.67247327496;34104.829475853454;34209.973700789014;34228;34328;25902.352441188366;25921.611175832753;25930.870345648153;26011.739882601687;26425.867870660524 14:38:04 INFO - PROCESS | 1946 | |2;jquery.html;351.83639607582467;380.1313997515677;380.1807105687244;386.12927847703423;389.2681758294406;20539.189965769667;21762.367822413322;21824;21909;22259.44351391216;22824.08703651852;22847.42881427965;23100.191493297738;23119.884400578016;23257.302280931555;5740.741666625012;5884.646921184722;6033.818985430444;6183.690815459209;6219.5957262778;4143.647789937859;5226.294450249225;5824.767009319622;5892.764289428439;6070.57505974582;5067.974660126694;6008.729607167688;6035.637861728288;6035.668038257894;6059.0608455689435;6301.590396624205;6561.639109848957;6567.211934567882;6568.343165683417;6620.106285651424;5459.617826752129;5749.59752817303;5785.710714464302;5807.245058142415;5820.708964551755;13986.93006534971;14042.859571404257;14112.941529385338;14217.21805300708;16993.660126797397;2110.356341315898;2137.967930481044;2155.224119317045;2234.5642599693065;2278.270953294946;9476.810463790685;9850.162736167435;10249.487525623688;10303.124234440007;10320;1826.1964735516462;1880.8495320374336;1887.1885089411685;1941.631090092892;1987.7316562264054;101931;105181.47409262905;110635.89364106336;113005.43497282462;117181.24228136585;11617.012553933011;11659.183857130089;11691.473883675255;11793.113101903655;11886.821697674543;14070.944679149105;14233.572992810232;14434.711305773826;14497.565073047825;14509.347079381454;9152.084791520927;9217.400868943498;9284.396514226553;9295.488748118918;9316.767080822898;7693.422993275527;9385;9491.003444638352;9519.714408567754;9611.183049440875;3816.713746469026;4577.977110114494;4641.86074417768;4660.370849935283;4685.4143232095985;1830.1199369746992;1877.8216069473378;1932.5941552273898;1963.813437723414;2008.8192062714427;940.5767404667927;956.9377990430739;959.8320293948531;1001.1490233301636;1064.893510648929;20199;20486;20566.794332056787;20890;20898.895505522374;989.2284018465608;995.9402435853872;996.5764550066193;1020.6070662794878;1062.6705721226444;11427.828582571268;11459.476640526842;11513.136514761427;11564.826527602092;11617.012553933011;652369;682823;700877;722501;729185.8327951893;109461;114398;114819;115123.42438287922;123432;1036.6268143468346;1043.7181960870523;1052.7736536644659;1061.506399524225;1066.429460238784;18547.16537755831;18759.249630014645;19224.423267302005;19282.22871085141;19335.226590936207;51508.484915151865;53573;54261.72869135629;54804.72597636986;54883.176752349544;55910;72474.91287630584;77447.61276193809;77478.22521774935;78594.03514912173;8451.788705282417;8584.613692383733;8588.957055214683;8669.089745576875;8688.739337819876;9575.186109180797;11141.053010494199;11327.660170194908;13532.79700804469;14221.14673119616;11014.559417623206;11558.768824623628;11905.583304584297;12059.81910271329;12138.453769580567;9180.44917304964;11464.598739044093;11714.76570468603;11897.940510297392;11926.701832453911;11835.507516461672;11931.76136477283;12099.092568057607;12236.085881897234;12300.692482688004;8271.95864020676;8311.916880831115;8565.914340856762;8567.27178189861;8753.956230218808;10176.949115254673;11619.621540321787;11974.281543107441;12116;12130 14:38:04 INFO - PROCESS | 1946 | |3;mootools.html;1499.1080307217205;1634.2727486268607;1915.971260431093;2046.1917542570684;2048.3445297504804;8509.957450212756;9026.819463610724;9145.725628231155;9374.296927730422;9391.34260601758;7808.960955195216;9115.817683646323;9175.908240917588;9277.443353398801;9298.070192980715;2579.496998085374;2611.177479094089;2621.724718904516;2624.0422245880213;2624.7244039375782;2549.1587776033866;2642.1809239135832;2644.7090820009785;2651.814372993891;2654.53545629515;2557.897684092634;2585.2373549802855;2586.4180559374086;2607.38726399296;2614.2680049586147;2577.36854470654;2594.0272397850804;2605.2965699261094;2618.725033871445;2628.487444948236;2554.5784945483974;2569.4861027794327;2575.7166711661703;2645.7883369330407;2671.252049426164;9253.953730231306;9257.814843703089;9407.20038796703;9420.481873496956;9507.001764814664;5816.360200377955;5875.882482350372;5974.402559744034;6025.939740602582;6027.9752442084955;3155.668654791237;3764.4353346997896;3866.903327416837;3900.161465284949;3909.6676782473523;1072.8390741388775;1077.6282182646974;1078.1213311151387;1113.8774734779167;1117.3463523838564;12315.815262771066;12457;12460.937695311555;12522.624321270376;12533.498660053587;5149.9742501287255;5162.716050617252;5221.6083793715625;5270.78916843322;5277.868053298698;9224.49265290402;10932.180086493545;10943.616973405893;10956.616518421817;10974.615888444026;5728.484436400744;5737.655740655574;5793.2179155814265;5960.970195148997;5994.07091900756;4733.242681170997;5050.772715227824;5135;5149.330587023663;5161.329027226511;3482.89551313461;4100.487439070116;4192.517860446027;4201.159768046342;4270.081932384553;1372.7529044771836;1378.5519706095358;1381.0677792490028;1381.2195959907817;1382.2259534660623;1382.9446822127002;1405.1498843199922;1428.1859340176;1431.3487363249697;1446.8263808343065;8648.740537783877;8852.070532594114;8886.777830554158;8910.287177025823;8918.910810891808;1278.194737315504;1279.4306533592462;1281.6030526725726;1292.8190053392532;1302.2642207152928;6517.152770139946;6605.24039735427;6606.768763093365;6679.866402672016;6690.330966903271;10897.964693354119;10951.561937522569;11234.988851003449;11267.943660281646;11317.660470185907;10770.299930504492;11130.332180069221;11163.386013769321;11232.438378081064;11388.316700997966;8848.646054157762;8896.288296936229;8949.552522373855;8975.192232699088;8994;8177.509349439053;8243.0520490142;8402.07577166499;8405.621747021276;8415.242628163494;9957.153641940517;10193.337433066827;10197.337173083726;10264.948675256575;10314;10167.491625418552;10275.691729248134;10565.313254638424;10628.096611788085;10633.734156646145;6797.28628494001;7192.31672991065;7332.23011583776;7405.407567394704;7459.552426854406;8619.353548484014;8675.956620216859;8694.565271736514;8705;8720.78198045054;7516.586587737727;7736.883946740916;7750.573718445539;7750.728724494841;7753.418493612889;7507.399408047234;7537.095548533992;7571.318581327487;7609.695612175451;7659.272369124924;8063.35493160534;8071.959640201761;8087.272145506932;8173.18268173178;8182.7545173644885;7253.891191632024;7391.40868730511;7441.479096463196;7462.179160292255;7479.065116860393;6853.7943861684225;6981.917802740583;7521.172671006294;7566.962165189138;7639.006929099181 14:38:04 INFO - PROCESS | 1946 | |4;prototype.html;347.4076699227817;349.3885700024956;353.4556782554866;354.7339495378466;354.85628320530185;5631.57763167762;7102.218755936843;7105.396041336486;7121.181064177621;7127.251638577946;7030.929690703091;7033.804253276942;7039.683214255358;7051.15386153661;7065.187503437106;5017.422996355429;5128.333316668828;5218.895622087556;5224.477552244764;5279.5512381447525;4019.3970904364287;5068.79724811009;5201.609879259052;5215.713135777531;5227.137522308814;5128.948710512903;5136.383633963929;5144.639875208737;5161.690298582078;5229.686218826882;4221.852235171769;4269.7224680395675;4635.165670179366;4742.170120228963;5243.973780131075;4521.819127234907;4524.886877828048;4525.434320709911;4528.07174529224;4554.453465584151;6518;6797;6851.828704282433;6892.620905850176;6903.482238832108;5924.614900031527;5924.7333869975955;5926.348101708809;5940.673262970535;6002.639841609517;7640.73257435987;7649.961750191269;7651.1583725790115;7658.081030276347;7667.0416197975255;4875.853724388274;4882.389701287339;4890.217565189552;4894.951050489485;4903.289023091667;7242.855142897165;7935.523868567904;8039.075506316732;8056.798580035487;8105.27052565272;4846.709197448094;4886.998165376161;4939.382577177853;4943.72809495474;4947.084789313988;4191.161767646483;5052.848414547496;5066.797328106908;5093.821716239914;5106.846794596094;6026.126211699367;6034.185384972972;6053.636781793019;6062.545309101835;6086.147939288503;7644.235576442311;7644.655990480442;7652.387808975269;7672.079350477979;7673.539587624648;1685.0900513722697;1724.4654157211305;1757.2882982392152;1757.604538978745;1757.912104394775;936.8547875079373;1082.767205050918;1095.2661716649864;1106.7011906785124;1111.2332490581473;7187;7265.365292809076;7267.672954716944;7271.600061996641;7303.853922921512;5965.642061476326;7878.684852605947;7887.132415434297;7904.881426778603;7922.286994170552;5909.704514774244;6488.448481879093;6833.111695479556;7239.20368759436;7261.854762904818;3111.128883912508;3378.7803792753884;4140.171965606891;4170.562090980464;4176.352665336878;6518.598501322239;7503;7719.649061414342;8156.5513896735065;8355.665773369119;7056.223815380304;8226.670933162726;8252.958735206286;8256.050554186226;8268.586570671443;8266.090730019692;8319.792005199797;8335.499350194917;8337.791555211046;8341.290990265896;7664.501807382502;7938.087119981045;7947.364210863233;7980.082290536662;8008.039035315799;7692.42306826979;7757.534547927143;7790.688372465264;7792.415568832247;7827.334676552557;7139.357457828821;8354.58227088631;8366.456180348501;8373.916260837314;8396.622152003296;4960.958198778297;4972.776225069808;4984.925226121539;4989.850304490871;5002.074616196015;7710.653020614198;7786.104597971079;7881.527108373516;7885.2114788520685;7920.247576480225;7548.509346892434;7576.886346704694;7618.5809780462605;7644.579548124684;7648.464607477423;6889.138857642794;7566.924330756842;7595.658195381332;7613.847723045619;7625.618719064136;6913.896291555731;7147.3210045045635;7457.664405101892;7471.140818805907;7475.551466912003;6922.480813938874;7594.962025189839;7631.465797394129;7638.732644357421;7646.235376462309;7113.608751518716;7484.513506622052;7487.176410594721;7489.28851759082;7514.812129696801 14:38:04 INFO - PROCESS | 1946 | |5;yui.html;700.0584214231859;710.7965307546606;727.3817255332967;758.2484460895329;767.5855038279329;15148.62128446788;15445.536633900972;15483.922580387096;15509.379624815023;15590.688186236282;13671.589852304422;14148.363323650434;14578.927105364484;14692;14743.557693269218;966.5070813884934;984.3995162950595;994.24934174698;1012.4684540616198;1012.9696109116701;949.3449519831329;989.1789814454022;991.2714155095998;993.061556828797;1010.4947526236881;1004.8191325561432;1049.9055085042344;1055.5144633468615;1063.0485715284854;1065.3820783945293;999.6950929966357;1008.4907121903465;1044.6187141693226;1044.7962647283782;1060.2260349944545;773.4856320546829;778.2956424435895;778.7936196907824;781.2656103262972;795.2524626850742;13964.72070558583;14030.158190508602;14031;14123.223222722747;15797.684046319124;13084.345782710827;13100.868991310155;13127.737445251138;13309.933450332783;13756.365919532791;10297.74255643615;10526.210534209966;10848.403337816417;11506.482208300647;11560.94219528897;4217.261979153636;4271.700980931336;4272.230998420283;4295.334223195409;4577.313402989545;69159;85686.71469927956;87519.56240218758;88658.5567072167;88864;10068.697939061693;10095.24285678577;10115.342502737298;10251.179905607683;10401.84397234027;18686.252549898123;23049.539009219723;23053.42366440819;23061.423464413525;23089;7816.140224575292;7901.683932642745;8028.558429286329;8032.919670803334;8116.837663246702;4250.511191212988;4263.786810659454;4335.631471324909;4370.2570563004365;4437.29003359461;3758.8684396046006;3771.4342848572933;3813.4279858020964;3820.7707537547835;3826.215625796705;583.7898356591709;684.9863002739917;688.2326206280062;689.1351354050735;691.9688614012382;526.7392640642906;541.2422608348344;571.5427657873685;600.9969950150221;616.5499185594541;8351.331893448509;8708;8733.126687331343;8837.469751814911;9027.09729027092;618.329112912495;619.9690015499207;622.5984240165068;624.0607885132846;626.1609443345939;3813.9427908581392;3955.208958208312;3989.5412027616617;4035.1324465240114;4183.414321994923;85164.57417712871;86339;86805.1319486797;86888;89384;70125.29812226433;85292.72060919092;86796;87307;87987;66835.66582167058;70660.64669676722;70700.2929970704;70713.64643176751;71261.64369178224;8935.955320223356;8974.102589740975;8975.551222438982;8983.236424903957;9114.40756350835;49547.752261239904;50749.746251269986;51142.48857511377;52082.958340832214;52338.73830630822;70775;74992;75362.62318688372;76468;77082.6145869267;11582.247153934968;11748;11951.820722688994;12133.939330303292;12272.325022123869;12149.392530373269;12229.388530573613;12304.692382690504;12439;13311.66720831987;11283.266587671775;11721.238119522204;11750.706232343919;12048.915597596259;12144.14990950625;11858.229215100991;12010.279383236684;12076.577319793765;12193.939030304791;12326.630201093982;11468.4265786712;11657.475413606238;11785.233959792586;12157.392130393268;12234.694132646755;9176.724698259062;9896.406215626797;10170.898291016994;10190.439525825854;10614.310069845435;10037.89962100399;10391.428471434143;10537.683869483928;10561.471926403803;10611.09805666527 14:38:04 INFO - PROCESS | 1946 | __end_tp_report 14:38:04 INFO - PROCESS | 1946 | __start_cc_report 14:38:04 INFO - PROCESS | 1946 | _x_x_mozilla_cycle_collect,348 14:38:04 INFO - PROCESS | 1946 | __end_cc_report 14:38:04 INFO - PROCESS | 1946 | __startTimestamp1461620284266__endTimestamp 14:38:04 INFO - PROCESS | 1946 | 14:38:04 INFO - PROCESS | 1946 | ------- Summary: start ------- 14:38:04 INFO - PROCESS | 1946 | Number of tests: 6 14:38:04 INFO - PROCESS | 1946 | 14:38:04 INFO - PROCESS | 1946 | [#0] dojo.html Cycles:165 Average:5845.10 Median:6117.69 stddev:630.64 (10.3%) stddev-sans-first:608.42 14:38:04 INFO - PROCESS | 1946 | Values: 3641.7 3648.3 3670.2 3699.1 3716.7 4307.8 5218.9 5925.6 5946.6 5984.1 5940.6 6002.5 6002.8 6012.8 6015.6 5319.3 5363.6 5446.6 5447.8 5481.6 5309.3 5373.2 5427.0 5479.7 5516.9 5260.6 5442.6 5449.6 5464.7 5493.9 5409.1 5430.9 5478.5 5487.8 5552.0 5202.5 5232.8 5293.0 5325.5 5352.9 5695.8 5805.9 5841.6 5852.2 5861.1 6126.0 6215.9 6261.8 6276.6 6290.3 6280.3 6332.7 6355.7 6358.4 6367.1 5911.2 6075.5 6081.3 6089.4 6091.6 6280.8 6399.7 6416.0 6417.8 6454.6 6130.1 6151.0 6167.9 6168.3 6176.1 6262.1 6270.2 6286.1 6289.2 6296.4 5201.8 6098.8 6163.5 6182.6 6203.2 6119.7 6197.3 6214.1 6236.1 6263.1 4884.7 5005.6 5011.4 5012.3 5047.2 3845.3 4373.0 4397.9 4404.5 4491.3 6111.4 6117.7 6126.9 6168.8 6185.3 5973.6 6214.7 6231.3 6265.0 6292.6 5472.7 5990.9 5999.8 6082.2 6084.8 5488.1 5516.4 5520.7 5526.3 5531.4 6470.5 6487.8 6507.1 6520.4 6536.3 6144.8 6234.2 6244.8 6255.4 6305.3 6435.2 6437.3 6443.0 6457.5 6461.1 6151.1 6153.8 6186.8 6227.1 6235.4 6185.0 6215.8 6263.1 6281.8 6283.4 6083.4 6188.7 6211.9 6230.7 6253.6 6102.2 6140.2 6228.9 6230.9 6234.1 6040.2 6066.2 6084.6 6131.3 6147.6 5138.3 6093.9 6182.9 6215.3 6240.1 6023.3 6139.4 6159.3 6176.2 6208.2 14:38:04 INFO - PROCESS | 1946 | 14:38:04 INFO - PROCESS | 1946 | [#1] ext.html Cycles:180 Average:56332.53 Median:38209.52 stddev:117440.68 (307.4%) stddev-sans-first:117695.56 14:38:04 INFO - PROCESS | 1946 | Values: 590.4 631.8 635.2 687.4 700.7 38678.8 39155.6 39371.0 39463.8 39497.6 41273.6 41312.4 41338.6 41389.8 41569.0 9689.8 9838.7 9860.4 9916.7 9926.1 9836.8 9912.5 9944.2 10010.5 10012.4 9958.8 9978.4 10002.0 10060.2 10065.9 9932.7 9963.7 9982.5 10038.5 10058.0 9801.9 9832.2 9894.3 9923.4 9948.8 33942.5 39524.2 39669.4 40343.6 40506.0 3202.2 3420.1 3515.4 3655.4 4034.1 23880.0 27971.4 28369.4 29292.6 30031.8 2785.7 2800.5 2818.5 2852.8 3017.1 142704.0 144088.0 144501.0 145040.0 145207.0 50941.0 51786.0 76625.6 77014.0 77981.6 51068.2 52124.7 52133.2 52159.7 52385.2 17905.0 18042.6 18069.4 18076.4 18129.2 14247.2 14250.6 14541.9 14703.2 14704.7 15952.6 16109.0 16357.9 16571.6 16693.4 6761.1 7041.2 7124.2 7184.5 7203.3 899.9 1053.8 1099.1 1136.2 1239.3 30193.8 30595.8 30971.1 31159.0 31160.2 1122.8 1148.6 1184.3 1243.2 1272.5 15463.4 15467.5 15593.7 15732.6 15953.4 526392.0 528581.0 528968.0 532561.0 535887.0 59625.7 60053.4 60140.4 60373.0 60456.0 1547.1 1574.9 1598.7 1601.4 1608.3 29541.3 30143.6 30246.0 30617.5 30693.2 52704.0 52878.0 53091.5 53338.7 53437.0 517620.0 521084.4 521973.0 525535.0 527313.0 34653.7 34972.0 35736.8 35749.0 36474.5 45700.8 45952.8 46138.1 47497.0 48158.8 38046.1 38601.0 38773.2 38986.0 39959.4 37455.8 37887.1 37948.1 38453.6 39087.8 38055.2 38363.8 38803.4 38836.0 39129.8 32752.7 34104.8 34210.0 34228.0 34328.0 25902.4 25921.6 25930.9 26011.7 26425.9 14:38:04 INFO - PROCESS | 1946 | 14:38:04 INFO - PROCESS | 1946 | [#2] jquery.html Cycles:180 Average:37026.46 Median:21866.50 stddev:115235.57 (527.0%) stddev-sans-first:115525.93 14:38:04 INFO - PROCESS | 1946 | Values: 351.8 380.1 380.2 386.1 389.3 20539.2 21762.4 21824.0 21909.0 22259.4 22824.1 22847.4 23100.2 23119.9 23257.3 5740.7 5884.6 6033.8 6183.7 6219.6 4143.6 5226.3 5824.8 5892.8 6070.6 5068.0 6008.7 6035.6 6035.7 6059.1 6301.6 6561.6 6567.2 6568.3 6620.1 5459.6 5749.6 5785.7 5807.2 5820.7 13986.9 14042.9 14112.9 14217.2 16993.7 2110.4 2138.0 2155.2 2234.6 2278.3 9476.8 9850.2 10249.5 10303.1 10320.0 1826.2 1880.8 1887.2 1941.6 1987.7 101931.0 105181.5 110635.9 113005.4 117181.2 11617.0 11659.2 11691.5 11793.1 11886.8 14070.9 14233.6 14434.7 14497.6 14509.3 9152.1 9217.4 9284.4 9295.5 9316.8 7693.4 9385.0 9491.0 9519.7 9611.2 3816.7 4578.0 4641.9 4660.4 4685.4 1830.1 1877.8 1932.6 1963.8 2008.8 940.6 956.9 959.8 1001.1 1064.9 20199.0 20486.0 20566.8 20890.0 20898.9 989.2 995.9 996.6 1020.6 1062.7 11427.8 11459.5 11513.1 11564.8 11617.0 652369.0 682823.0 700877.0 722501.0 729185.8 109461.0 114398.0 114819.0 115123.4 123432.0 1036.6 1043.7 1052.8 1061.5 1066.4 18547.2 18759.2 19224.4 19282.2 19335.2 51508.5 53573.0 54261.7 54804.7 54883.2 55910.0 72474.9 77447.6 77478.2 78594.0 8451.8 8584.6 8589.0 8669.1 8688.7 9575.2 11141.1 11327.7 13532.8 14221.1 11014.6 11558.8 11905.6 12059.8 12138.5 9180.4 11464.6 11714.8 11897.9 11926.7 11835.5 11931.8 12099.1 12236.1 12300.7 8272.0 8311.9 8565.9 8567.3 8754.0 10176.9 11619.6 11974.3 12116.0 12130.0 14:38:04 INFO - PROCESS | 1946 | 14:38:04 INFO - PROCESS | 1946 | [#3] mootools.html Cycles:180 Average:6388.60 Median:5142.17 stddev:3332.34 (64.8%) stddev-sans-first:3321.42 14:38:04 INFO - PROCESS | 1946 | Values: 1499.1 1634.3 1916.0 2046.2 2048.3 8510.0 9026.8 9145.7 9374.3 9391.3 7809.0 9115.8 9175.9 9277.4 9298.1 2579.5 2611.2 2621.7 2624.0 2624.7 2549.2 2642.2 2644.7 2651.8 2654.5 2557.9 2585.2 2586.4 2607.4 2614.3 2577.4 2594.0 2605.3 2618.7 2628.5 2554.6 2569.5 2575.7 2645.8 2671.3 9254.0 9257.8 9407.2 9420.5 9507.0 5816.4 5875.9 5974.4 6025.9 6028.0 3155.7 3764.4 3866.9 3900.2 3909.7 1072.8 1077.6 1078.1 1113.9 1117.3 12315.8 12457.0 12460.9 12522.6 12533.5 5150.0 5162.7 5221.6 5270.8 5277.9 9224.5 10932.2 10943.6 10956.6 10974.6 5728.5 5737.7 5793.2 5961.0 5994.1 4733.2 5050.8 5135.0 5149.3 5161.3 3482.9 4100.5 4192.5 4201.2 4270.1 1372.8 1378.6 1381.1 1381.2 1382.2 1382.9 1405.1 1428.2 1431.3 1446.8 8648.7 8852.1 8886.8 8910.3 8918.9 1278.2 1279.4 1281.6 1292.8 1302.3 6517.2 6605.2 6606.8 6679.9 6690.3 10898.0 10951.6 11235.0 11267.9 11317.7 10770.3 11130.3 11163.4 11232.4 11388.3 8848.6 8896.3 8949.6 8975.2 8994.0 8177.5 8243.1 8402.1 8405.6 8415.2 9957.2 10193.3 10197.3 10264.9 10314.0 10167.5 10275.7 10565.3 10628.1 10633.7 6797.3 7192.3 7332.2 7405.4 7459.6 8619.4 8676.0 8694.6 8705.0 8720.8 7516.6 7736.9 7750.6 7750.7 7753.4 7507.4 7537.1 7571.3 7609.7 7659.3 8063.4 8072.0 8087.3 8173.2 8182.8 7253.9 7391.4 7441.5 7462.2 7479.1 6853.8 6981.9 7521.2 7567.0 7639.0 14:38:04 INFO - PROCESS | 1946 | 14:38:04 INFO - PROCESS | 1946 | [#4] prototype.html Cycles:180 Average:6147.62 Median:7045.42 stddev:2020.44 (28.7%) stddev-sans-first:1978.65 14:38:04 INFO - PROCESS | 1946 | Values: 347.4 349.4 353.5 354.7 354.9 5631.6 7102.2 7105.4 7121.2 7127.3 7030.9 7033.8 7039.7 7051.2 7065.2 5017.4 5128.3 5218.9 5224.5 5279.6 4019.4 5068.8 5201.6 5215.7 5227.1 5128.9 5136.4 5144.6 5161.7 5229.7 4221.9 4269.7 4635.2 4742.2 5244.0 4521.8 4524.9 4525.4 4528.1 4554.5 6518.0 6797.0 6851.8 6892.6 6903.5 5924.6 5924.7 5926.3 5940.7 6002.6 7640.7 7650.0 7651.2 7658.1 7667.0 4875.9 4882.4 4890.2 4895.0 4903.3 7242.9 7935.5 8039.1 8056.8 8105.3 4846.7 4887.0 4939.4 4943.7 4947.1 4191.2 5052.8 5066.8 5093.8 5106.8 6026.1 6034.2 6053.6 6062.5 6086.1 7644.2 7644.7 7652.4 7672.1 7673.5 1685.1 1724.5 1757.3 1757.6 1757.9 936.9 1082.8 1095.3 1106.7 1111.2 7187.0 7265.4 7267.7 7271.6 7303.9 5965.6 7878.7 7887.1 7904.9 7922.3 5909.7 6488.4 6833.1 7239.2 7261.9 3111.1 3378.8 4140.2 4170.6 4176.4 6518.6 7503.0 7719.6 8156.6 8355.7 7056.2 8226.7 8253.0 8256.1 8268.6 8266.1 8319.8 8335.5 8337.8 8341.3 7664.5 7938.1 7947.4 7980.1 8008.0 7692.4 7757.5 7790.7 7792.4 7827.3 7139.4 8354.6 8366.5 8373.9 8396.6 4961.0 4972.8 4984.9 4989.9 5002.1 7710.7 7786.1 7881.5 7885.2 7920.2 7548.5 7576.9 7618.6 7644.6 7648.5 6889.1 7566.9 7595.7 7613.8 7625.6 6913.9 7147.3 7457.7 7471.1 7475.6 6922.5 7595.0 7631.5 7638.7 7646.2 7113.6 7484.5 7487.2 7489.3 7514.8 14:38:04 INFO - PROCESS | 1946 | 14:38:04 INFO - PROCESS | 1946 | [#5] yui.html Cycles:180 Average:18931.35 Median:4233.89 stddev:26269.48 (620.5%) stddev-sans-first:26307.50 14:38:04 INFO - PROCESS | 1946 | Values: 700.1 710.8 727.4 758.2 767.6 15148.6 15445.5 15483.9 15509.4 15590.7 13671.6 14148.4 14578.9 14692.0 14743.6 966.5 984.4 994.2 1012.5 1013.0 949.3 989.2 991.3 993.1 1010.5 1004.8 1049.9 1055.5 1063.0 1065.4 999.7 1008.5 1044.6 1044.8 1060.2 773.5 778.3 778.8 781.3 795.3 13964.7 14030.2 14031.0 14123.2 15797.7 13084.3 13100.9 13127.7 13309.9 13756.4 10297.7 10526.2 10848.4 11506.5 11560.9 4217.3 4271.7 4272.2 4295.3 4577.3 69159.0 85686.7 87519.6 88658.6 88864.0 10068.7 10095.2 10115.3 10251.2 10401.8 18686.3 23049.5 23053.4 23061.4 23089.0 7816.1 7901.7 8028.6 8032.9 8116.8 4250.5 4263.8 4335.6 4370.3 4437.3 3758.9 3771.4 3813.4 3820.8 3826.2 583.8 685.0 688.2 689.1 692.0 526.7 541.2 571.5 601.0 616.5 8351.3 8708.0 8733.1 8837.5 9027.1 618.3 620.0 622.6 624.1 626.2 3813.9 3955.2 3989.5 4035.1 4183.4 85164.6 86339.0 86805.1 86888.0 89384.0 70125.3 85292.7 86796.0 87307.0 87987.0 66835.7 70660.6 70700.3 70713.6 71261.6 8936.0 8974.1 8975.6 8983.2 9114.4 49547.8 50749.7 51142.5 52083.0 52338.7 70775.0 74992.0 75362.6 76468.0 77082.6 11582.2 11748.0 11951.8 12133.9 12272.3 12149.4 12229.4 12304.7 12439.0 13311.7 11283.3 11721.2 11750.7 12048.9 12144.1 11858.2 12010.3 12076.6 12193.9 12326.6 11468.4 11657.5 11785.2 12157.4 12234.7 9176.7 9896.4 10170.9 10190.4 10614.3 10037.9 10391.4 10537.7 10561.5 10611.1 14:38:04 INFO - PROCESS | 1946 | -------- Summary: end -------- 14:38:04 INFO - PROCESS | 1946 | 14:38:04 INFO - TEST-INFO | 1946: exit 0 14:38:04 INFO - TEST-OK | dromaeo_css | took 1109673ms 14:38:04 INFO - TEST-START | kraken 14:38:04 INFO - operating with platform_type : mac_ 14:38:04 INFO - Initialising browser for kraken test... 14:38:04 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmp18PFM8/profile http://localhost:50271/getInfo.html) 14:38:07 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 14:38:07 INFO - PROCESS | 1953 | colorDepth:24 14:38:07 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 14:38:07 INFO - PROCESS | 1953 | __metrics 14:38:07 ERROR - PROCESS | 1953 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:38:07 INFO - TEST-INFO | 1953: exit 0 14:38:07 INFO - Browser initialized. 14:38:07 INFO - Running cycle 1/1 for kraken test... 14:38:07 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmp18PFM8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:19 INFO - PROCESS | 1957 | RSS: Main: 168165376 14:38:19 INFO - PROCESS | 1957 | 14:38:22 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50271/tests/kraken/driver.html?testName=audio-beat-detection) 14:38:23 INFO - PROCESS | 1957 | RSS: Main: 180211712 14:38:23 INFO - PROCESS | 1957 | 14:38:25 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50271/tests/kraken/driver.html?testName=audio-dft) 14:38:26 INFO - PROCESS | 1957 | RSS: Main: 188489728 14:38:26 INFO - PROCESS | 1957 | 14:38:29 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50271/tests/kraken/driver.html?testName=audio-fft) 14:38:30 INFO - PROCESS | 1957 | RSS: Main: 192151552 14:38:30 INFO - PROCESS | 1957 | 14:38:32 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50271/tests/kraken/driver.html?testName=audio-oscillator) 14:38:32 INFO - PROCESS | 1957 | RSS: Main: 193093632 14:38:32 INFO - PROCESS | 1957 | 14:38:35 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:38:35 INFO - PROCESS | 1957 | RSS: Main: 193052672 14:38:35 INFO - PROCESS | 1957 | 14:38:38 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50271/tests/kraken/driver.html?testName=imaging-darkroom) 14:38:39 INFO - PROCESS | 1957 | RSS: Main: 193400832 14:38:39 INFO - PROCESS | 1957 | 14:38:41 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50271/tests/kraken/driver.html?testName=imaging-desaturate) 14:38:42 INFO - PROCESS | 1957 | RSS: Main: 194359296 14:38:42 INFO - PROCESS | 1957 | 14:38:45 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50271/tests/kraken/driver.html?testName=json-parse-financial) 14:38:46 INFO - PROCESS | 1957 | RSS: Main: 194682880 14:38:46 INFO - PROCESS | 1957 | 14:38:47 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:38:48 INFO - PROCESS | 1957 | RSS: Main: 194433024 14:38:48 INFO - PROCESS | 1957 | 14:38:49 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:38:50 INFO - PROCESS | 1957 | RSS: Main: 194326528 14:38:50 INFO - PROCESS | 1957 | 14:38:52 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:38:53 INFO - PROCESS | 1957 | RSS: Main: 194461696 14:38:53 INFO - PROCESS | 1957 | 14:38:55 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:38:56 INFO - PROCESS | 1957 | RSS: Main: 194576384 14:38:56 INFO - PROCESS | 1957 | 14:38:58 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:38:59 INFO - PROCESS | 1957 | RSS: Main: 194703360 14:38:59 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50271/tests/kraken/driver.html?testName=ai-astar) 14:39:01 INFO - PROCESS | 1957 | RSS: Main: 196370432 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | __start_tp_report 14:39:01 INFO - PROCESS | 1957 | _x_x_mozilla_page_load 14:39:01 INFO - PROCESS | 1957 | _x_x_mozilla_page_load_details 14:39:01 INFO - PROCESS | 1957 | |i|pagename|runs| 14:39:01 INFO - PROCESS | 1957 | |0;ai-astar;116;105;108;167;170;179;116;115;135;101 14:39:01 INFO - PROCESS | 1957 | |1;audio-beat-detection;147;127;185;162;117;139;120;148;148;120 14:39:01 INFO - PROCESS | 1957 | |2;audio-dft;192;195;230;220;200;196;196;264;283;198 14:39:01 INFO - PROCESS | 1957 | |3;audio-fft;61;77;70;112;57;58;58;59;129;59 14:39:01 INFO - PROCESS | 1957 | |4;audio-oscillator;84;99;160;121;82;83;119;80;79;117 14:39:01 INFO - PROCESS | 1957 | |5;imaging-gaussian-blur;93;87;93;87;89;87;93;86;89;89 14:39:01 INFO - PROCESS | 1957 | |6;imaging-darkroom;94;95;103;94;96;94;94;99;94;94 14:39:01 INFO - PROCESS | 1957 | |7;imaging-desaturate;107;144;124;91;79;144;120;85;145;149 14:39:01 INFO - PROCESS | 1957 | |8;json-parse-financial;55;60;60;58;57;60;60;65;55;53 14:39:01 INFO - PROCESS | 1957 | |9;json-stringify-tinderbox;63;64;69;67;76;75;67;64;63;67 14:39:01 INFO - PROCESS | 1957 | |10;stanford-crypto-aes;84;85;83;80;81;83;82;95;81;85 14:39:01 INFO - PROCESS | 1957 | |11;stanford-crypto-ccm;125;123;131;109;132;150;144;120;117;141 14:39:01 INFO - PROCESS | 1957 | |12;stanford-crypto-pbkdf2;124;135;136;139;135;122;135;136;135;125 14:39:01 INFO - PROCESS | 1957 | |13;stanford-crypto-sha256-iterative;68;68;64;67;69;63;66;65;65;70 14:39:01 INFO - PROCESS | 1957 | __end_tp_report 14:39:01 INFO - PROCESS | 1957 | __start_cc_report 14:39:01 INFO - PROCESS | 1957 | _x_x_mozilla_cycle_collect,914 14:39:01 INFO - PROCESS | 1957 | __end_cc_report 14:39:01 INFO - PROCESS | 1957 | __startTimestamp1461620341282__endTimestamp 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | ------- Summary: start ------- 14:39:01 INFO - PROCESS | 1957 | Number of tests: 14 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | [#0] ai-astar Cycles:10 Average:131.20 Median:125.50 stddev:29.72 (23.7%) stddev-sans-first:31.01 14:39:01 INFO - PROCESS | 1957 | Values: 116.0 105.0 108.0 167.0 170.0 179.0 116.0 115.0 135.0 101.0 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:147.50 stddev:21.52 (14.6%) stddev-sans-first:22.73 14:39:01 INFO - PROCESS | 1957 | Values: 147.0 127.0 185.0 162.0 117.0 139.0 120.0 148.0 148.0 120.0 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | [#2] audio-dft Cycles:10 Average:217.40 Median:210.00 stddev:32.29 (15.4%) stddev-sans-first:32.91 14:39:01 INFO - PROCESS | 1957 | Values: 192.0 195.0 230.0 220.0 200.0 196.0 196.0 264.0 283.0 198.0 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | [#3] audio-fft Cycles:10 Average:74.00 Median:59.00 stddev:25.63 (43.4%) stddev-sans-first:26.75 14:39:01 INFO - PROCESS | 1957 | Values: 61.0 77.0 70.0 112.0 57.0 58.0 58.0 59.0 129.0 59.0 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:81.00 stddev:26.55 (32.8%) stddev-sans-first:27.31 14:39:01 INFO - PROCESS | 1957 | Values: 84.0 99.0 160.0 121.0 82.0 83.0 119.0 80.0 79.0 117.0 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:89.00 stddev:2.75 (3.1%) stddev-sans-first:2.57 14:39:01 INFO - PROCESS | 1957 | Values: 93.0 87.0 93.0 87.0 89.0 87.0 93.0 86.0 89.0 89.0 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:94.00 stddev:3.02 (3.2%) stddev-sans-first:3.14 14:39:01 INFO - PROCESS | 1957 | Values: 94.0 95.0 103.0 94.0 96.0 94.0 94.0 99.0 94.0 94.0 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | [#7] imaging-desaturate Cycles:10 Average:118.80 Median:147.00 stddev:26.95 (18.3%) stddev-sans-first:28.24 14:39:01 INFO - PROCESS | 1957 | Values: 107.0 144.0 124.0 91.0 79.0 144.0 120.0 85.0 145.0 149.0 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:60.00 stddev:3.47 (5.8%) stddev-sans-first:3.46 14:39:01 INFO - PROCESS | 1957 | Values: 55.0 60.0 60.0 58.0 57.0 60.0 60.0 65.0 55.0 53.0 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:4.67 (7.0%) stddev-sans-first:4.66 14:39:01 INFO - PROCESS | 1957 | Values: 63.0 64.0 69.0 67.0 76.0 75.0 67.0 64.0 63.0 67.0 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:4.25 (5.1%) stddev-sans-first:4.51 14:39:01 INFO - PROCESS | 1957 | Values: 84.0 85.0 83.0 80.0 81.0 83.0 82.0 95.0 81.0 85.0 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:131.50 stddev:12.91 (9.8%) stddev-sans-first:13.60 14:39:01 INFO - PROCESS | 1957 | Values: 125.0 123.0 131.0 109.0 132.0 150.0 144.0 120.0 117.0 141.0 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.20 Median:135.00 stddev:6.05 (4.5%) stddev-sans-first:5.64 14:39:01 INFO - PROCESS | 1957 | Values: 124.0 135.0 136.0 139.0 135.0 122.0 135.0 136.0 135.0 125.0 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - PROCESS | 1957 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.50 stddev:2.27 (3.4%) stddev-sans-first:2.35 14:39:01 INFO - PROCESS | 1957 | Values: 68.0 68.0 64.0 67.0 69.0 63.0 66.0 65.0 65.0 70.0 14:39:01 INFO - PROCESS | 1957 | -------- Summary: end -------- 14:39:01 INFO - PROCESS | 1957 | 14:39:01 INFO - TEST-INFO | 1957: exit 0 14:39:01 INFO - TEST-OK | kraken | took 57196ms 14:39:01 INFO - SUITE-END | took 1166s 14:39:02 INFO - Completed test suite (00:19:27) 14:39:02 INFO - javascript benchmark 14:39:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3641.7086633069353, 3648.288583726173, 3670.2109046554983, 3699.075231192202, 3716.702663786898, 4307.78461076946, 5218.947810521893, 5925.585209035364, 5946.554008449362, 5984.132300816379, 5940.584159108864, 6002.489788367994, 6002.789902353407, 6012.789552365668, 6015.578909476328, 5319.281896943911, 5363.570914326844, 5446.591505637073, 5447.754851031713, 5481.588880833953, 5309.283246761695, 5373.220882971967, 5426.996005738951, 5479.726013699319, 5516.889662206753, 5260.605454590902, 5442.564594832424, 5449.56403487722, 5464.672119672812, 5493.862653433656, 5409.053415652245, 5430.8913821723545, 5478.534324582415, 5487.75305111271, 5551.9722401388135, 5202.505761952609, 5232.764525596357, 5292.9735351323, 5325.4940780625775, 5352.902654955725, 5695.829125126253, 5805.88388232233, 5841.620294680874, 5852.151438041503, 5861.062230043172, 6126.0, 6215.875682486325, 6261.843453913643, 6276.623402595813, 6290.276618188921, 6280.340564240734, 6332.715027823759, 6355.682215889187, 6358.395952384562, 6367.140436041168, 5911.231539899829, 6075.544334174954, 6081.331053584102, 6089.3910608939195, 6091.604045737057, 6280.811575652647, 6399.680015999182, 6416.037594360883, 6417.7753778617525, 6454.6449945252525, 6130.141780150782, 6151.0, 6167.907481387782, 6168.321484636686, 6176.104464852571, 6262.060690896402, 6270.216222972129, 6286.119943207955, 6289.245290565162, 6296.370362963758, 5201.7919283229, 6098.756049758049, 6163.537734669828, 6182.629042257389, 6203.2245969253845, 6119.724612392453, 6197.349278325801, 6214.098955651405, 6236.064590311399, 6263.123162757218, 4884.65807393479, 5005.599552035828, 5011.3986321640905, 5012.323336349619, 5047.192449208109, 3845.3462911305146, 4372.956270437318, 4397.890052748643, 4404.471463424409, 4491.258942274553, 6111.388861113853, 6117.694115294217, 6126.877462450726, 6168.814935551941, 6185.319614842364, 5973.626066004843, 6214.720337584819, 6231.345708700612, 6265.028920517327, 6292.559520833589, 5472.699001554873, 5990.9101363479585, 5999.760009599567, 6082.2093127893095, 6084.847878802977, 5488.121900495981, 5516.365617953907, 5520.723963801794, 5526.281583394133, 5531.446855314436, 6470.514711396664, 6487.837804054936, 6507.056476810931, 6520.413162815369, 6536.346365363425, 6144.771045790771, 6234.1583886174785, 6244.750209991549, 6255.40573645503, 6305.274893387319, 6435.163428754419, 6437.324080971431, 6442.967785161044, 6457.483401327976, 6461.095446637569, 6151.0773383992755, 6153.815385538441, 6186.783462578788, 6227.0970709246, 6235.407636274546, 6185.0, 6215.844603884939, 6263.091851681572, 6281.842953926189, 6283.434490895841, 6083.391660833881, 6188.721507532262, 6211.9068213975925, 6230.6884655767935, 6253.593516421418, 6102.216595924137, 6140.228185505611, 6228.875422491616, 6230.906536402048, 6234.096056071753, 6040.214772079602, 6066.211392518944, 6084.6349219047, 6131.284916201153, 6147.569670123048, 5138.332016837787, 6093.878122437438, 6182.922646358548, 6215.316315205414, 6240.095186197885, 6023.277206735044, 6139.386061393825, 6159.260888693386, 6176.227971503562, 6208.161898143693], "unit": "score", "name": "dojo.html", "value": 5808.2465541574875}, {"lowerIsBetter": false, "replicates": [590.4302348233954, 631.7725618777242, 635.2059925093633, 687.4122625155492, 700.7302188657367, 38678.83963481093, 39155.60844391555, 39371.0157246069, 39463.802680986555, 39497.60502394975, 41273.58726412735, 41312.38031429531, 41338.58661413385, 41389.79305103478, 41568.96077598062, 9689.757756056084, 9838.704838854846, 9860.408375497493, 9916.702498925044, 9926.106650401462, 9836.754081147958, 9912.513123031567, 9944.154746846527, 10010.499475026256, 10012.449315287657, 9958.751031224241, 9978.401295922231, 10002.0, 10060.195184385231, 10065.899341006569, 9932.652357167464, 9963.701088967342, 9982.450965196911, 10038.498075096217, 10058.0, 9801.852972205423, 9832.164266037395, 9894.30739848211, 9923.354981926224, 9948.801023979553, 33942.49086263708, 39524.209515809525, 39669.40495892564, 40343.59656403428, 40505.98735031618, 3202.151429871086, 3420.1449637590604, 3515.367233897897, 3655.4151335786414, 4034.1326614777963, 23880.0, 27971.44057118846, 28369.432611347864, 29292.560611590845, 30031.798728050853, 2785.7492825645586, 2800.537911244642, 2818.5208514552573, 2852.7717782577342, 3017.1401150671954, 142704.0, 144088.0, 144501.0, 145040.0, 145207.0, 50941.0, 51786.0, 76625.61687191528, 77014.0, 77981.61009195031, 51068.23397649038, 52124.739376302874, 52133.218001730005, 52159.73920130375, 52385.2142217867, 17905.015224162795, 18042.639147217244, 18069.367572134914, 18076.367327143485, 18129.18418671163, 14247.216403097722, 14250.643733906736, 14541.927290363692, 14703.191324477042, 14704.705905881823, 15952.601184970468, 16109.033457992558, 16357.854950153613, 16571.585710357336, 16693.415730449375, 6761.053452516651, 7041.225465198824, 7124.216336203013, 7184.47960499362, 7203.315685009916, 899.8515244984635, 1053.8419237114495, 1099.1481601758542, 1136.170595465315, 1239.324568110382, 30193.849030755144, 30595.847020764755, 30971.070867874, 31159.0, 31160.22099447532, 1122.7978963786434, 1148.6381789736206, 1184.3308530680138, 1243.1981372015, 1272.5100836177953, 15463.38146474151, 15467.535973920576, 15593.68812623764, 15732.60668483297, 15953.361865525249, 526392.0, 528581.0, 528968.0, 532561.0, 535887.0, 59625.70187149037, 60053.39946600478, 60140.398596014355, 60373.0, 60456.0, 1547.0562956596468, 1574.8818838587151, 1598.7202239608023, 1601.375463569209, 1608.316465502157, 29541.26146846346, 30143.643536040494, 30246.0, 30617.54073688941, 30693.23266918345, 52704.0, 52878.0, 53091.46908530865, 53338.73330633322, 53437.0, 517620.0, 521084.3945780247, 521973.0, 525535.0, 527313.0, 34653.65346346605, 34972.0, 35736.821315893256, 35749.0, 36474.45288320624, 45700.771496142304, 45952.77023614861, 46138.07723845571, 47497.0, 48158.759206203744, 38046.13945341273, 38601.0, 38773.2245355097, 38986.0, 39959.40060899147, 37455.81272093622, 37887.05282367963, 37948.05129871775, 38453.61546384612, 39087.80456097701, 38055.238895222494, 38363.80818095891, 38803.417948730224, 38836.0, 39129.80435097806, 32752.67247327496, 34104.829475853454, 34209.973700789014, 34228.0, 34328.0, 25902.352441188366, 25921.611175832753, 25930.870345648153, 26011.739882601687, 26425.867870660524], "unit": "score", "name": "ext.html", "value": 19674.57055482263}, {"lowerIsBetter": false, "replicates": [351.83639607582467, 380.1313997515677, 380.1807105687244, 386.12927847703423, 389.2681758294406, 20539.189965769667, 21762.367822413322, 21824.0, 21909.0, 22259.44351391216, 22824.08703651852, 22847.42881427965, 23100.191493297738, 23119.884400578016, 23257.302280931555, 5740.741666625012, 5884.646921184722, 6033.818985430444, 6183.690815459209, 6219.5957262778, 4143.647789937859, 5226.294450249225, 5824.767009319622, 5892.764289428439, 6070.57505974582, 5067.974660126694, 6008.729607167688, 6035.637861728288, 6035.668038257894, 6059.0608455689435, 6301.590396624205, 6561.639109848957, 6567.211934567882, 6568.343165683417, 6620.106285651424, 5459.617826752129, 5749.59752817303, 5785.710714464302, 5807.245058142415, 5820.708964551755, 13986.93006534971, 14042.859571404257, 14112.941529385338, 14217.21805300708, 16993.660126797397, 2110.356341315898, 2137.967930481044, 2155.224119317045, 2234.5642599693065, 2278.270953294946, 9476.810463790685, 9850.162736167435, 10249.487525623688, 10303.124234440007, 10320.0, 1826.1964735516462, 1880.8495320374336, 1887.1885089411685, 1941.631090092892, 1987.7316562264054, 101931.0, 105181.47409262905, 110635.89364106336, 113005.43497282462, 117181.24228136585, 11617.012553933011, 11659.183857130089, 11691.473883675255, 11793.113101903655, 11886.821697674543, 14070.944679149105, 14233.572992810232, 14434.711305773826, 14497.565073047825, 14509.347079381454, 9152.084791520927, 9217.400868943498, 9284.396514226553, 9295.488748118918, 9316.767080822898, 7693.422993275527, 9385.0, 9491.003444638352, 9519.714408567754, 9611.183049440875, 3816.713746469026, 4577.977110114494, 4641.86074417768, 4660.370849935283, 4685.4143232095985, 1830.1199369746992, 1877.8216069473378, 1932.5941552273898, 1963.813437723414, 2008.8192062714427, 940.5767404667927, 956.9377990430739, 959.8320293948531, 1001.1490233301636, 1064.893510648929, 20199.0, 20486.0, 20566.794332056787, 20890.0, 20898.895505522374, 989.2284018465608, 995.9402435853872, 996.5764550066193, 1020.6070662794878, 1062.6705721226444, 11427.828582571268, 11459.476640526842, 11513.136514761427, 11564.826527602092, 11617.012553933011, 652369.0, 682823.0, 700877.0, 722501.0, 729185.8327951893, 109461.0, 114398.0, 114819.0, 115123.42438287922, 123432.0, 1036.6268143468346, 1043.7181960870523, 1052.7736536644659, 1061.506399524225, 1066.429460238784, 18547.16537755831, 18759.249630014645, 19224.423267302005, 19282.22871085141, 19335.226590936207, 51508.484915151865, 53573.0, 54261.72869135629, 54804.72597636986, 54883.176752349544, 55910.0, 72474.91287630584, 77447.61276193809, 77478.22521774935, 78594.03514912173, 8451.788705282417, 8584.613692383733, 8588.957055214683, 8669.089745576875, 8688.739337819876, 9575.186109180797, 11141.053010494199, 11327.660170194908, 13532.79700804469, 14221.14673119616, 11014.559417623206, 11558.768824623628, 11905.583304584297, 12059.81910271329, 12138.453769580567, 9180.44917304964, 11464.598739044093, 11714.76570468603, 11897.940510297392, 11926.701832453911, 11835.507516461672, 11931.76136477283, 12099.092568057607, 12236.085881897234, 12300.692482688004, 8271.95864020676, 8311.916880831115, 8565.914340856762, 8567.27178189861, 8753.956230218808, 10176.949115254673, 11619.621540321787, 11974.281543107441, 12116.0, 12130.0], "unit": "score", "name": "jquery.html", "value": 9639.183407632549}, {"lowerIsBetter": false, "replicates": [1499.1080307217205, 1634.2727486268607, 1915.971260431093, 2046.1917542570684, 2048.3445297504804, 8509.957450212756, 9026.819463610724, 9145.725628231155, 9374.296927730422, 9391.34260601758, 7808.960955195216, 9115.817683646323, 9175.908240917588, 9277.443353398801, 9298.070192980715, 2579.496998085374, 2611.177479094089, 2621.724718904516, 2624.0422245880213, 2624.7244039375782, 2549.1587776033866, 2642.1809239135832, 2644.7090820009785, 2651.814372993891, 2654.53545629515, 2557.897684092634, 2585.2373549802855, 2586.4180559374086, 2607.38726399296, 2614.2680049586147, 2577.36854470654, 2594.0272397850804, 2605.2965699261094, 2618.725033871445, 2628.487444948236, 2554.5784945483974, 2569.4861027794327, 2575.7166711661703, 2645.7883369330407, 2671.252049426164, 9253.953730231306, 9257.814843703089, 9407.20038796703, 9420.481873496956, 9507.001764814664, 5816.360200377955, 5875.882482350372, 5974.402559744034, 6025.939740602582, 6027.9752442084955, 3155.668654791237, 3764.4353346997896, 3866.903327416837, 3900.161465284949, 3909.6676782473523, 1072.8390741388775, 1077.6282182646974, 1078.1213311151387, 1113.8774734779167, 1117.3463523838564, 12315.815262771066, 12457.0, 12460.937695311555, 12522.624321270376, 12533.498660053587, 5149.9742501287255, 5162.716050617252, 5221.6083793715625, 5270.78916843322, 5277.868053298698, 9224.49265290402, 10932.180086493545, 10943.616973405893, 10956.616518421817, 10974.615888444026, 5728.484436400744, 5737.655740655574, 5793.2179155814265, 5960.970195148997, 5994.07091900756, 4733.242681170997, 5050.772715227824, 5135.0, 5149.330587023663, 5161.329027226511, 3482.89551313461, 4100.487439070116, 4192.517860446027, 4201.159768046342, 4270.081932384553, 1372.7529044771836, 1378.5519706095358, 1381.0677792490028, 1381.2195959907817, 1382.2259534660623, 1382.9446822127002, 1405.1498843199922, 1428.1859340176, 1431.3487363249697, 1446.8263808343065, 8648.740537783877, 8852.070532594114, 8886.777830554158, 8910.287177025823, 8918.910810891808, 1278.194737315504, 1279.4306533592462, 1281.6030526725726, 1292.8190053392532, 1302.2642207152928, 6517.152770139946, 6605.24039735427, 6606.768763093365, 6679.866402672016, 6690.330966903271, 10897.964693354119, 10951.561937522569, 11234.988851003449, 11267.943660281646, 11317.660470185907, 10770.299930504492, 11130.332180069221, 11163.386013769321, 11232.438378081064, 11388.316700997966, 8848.646054157762, 8896.288296936229, 8949.552522373855, 8975.192232699088, 8994.0, 8177.509349439053, 8243.0520490142, 8402.07577166499, 8405.621747021276, 8415.242628163494, 9957.153641940517, 10193.337433066827, 10197.337173083726, 10264.948675256575, 10314.0, 10167.491625418552, 10275.691729248134, 10565.313254638424, 10628.096611788085, 10633.734156646145, 6797.28628494001, 7192.31672991065, 7332.23011583776, 7405.407567394704, 7459.552426854406, 8619.353548484014, 8675.956620216859, 8694.565271736514, 8705.0, 8720.78198045054, 7516.586587737727, 7736.883946740916, 7750.573718445539, 7750.728724494841, 7753.418493612889, 7507.399408047234, 7537.095548533992, 7571.318581327487, 7609.695612175451, 7659.272369124924, 8063.35493160534, 8071.959640201761, 8087.272145506932, 8173.18268173178, 8182.7545173644885, 7253.891191632024, 7391.40868730511, 7441.479096463196, 7462.179160292255, 7479.065116860393, 6853.7943861684225, 6981.917802740583, 7521.172671006294, 7566.962165189138, 7639.006929099181], "unit": "score", "name": "mootools.html", "value": 5238.710261057257}, {"lowerIsBetter": false, "replicates": [347.4076699227817, 349.3885700024956, 353.4556782554866, 354.7339495378466, 354.85628320530185, 5631.57763167762, 7102.218755936843, 7105.396041336486, 7121.181064177621, 7127.251638577946, 7030.929690703091, 7033.804253276942, 7039.683214255358, 7051.15386153661, 7065.187503437106, 5017.422996355429, 5128.333316668828, 5218.895622087556, 5224.477552244764, 5279.5512381447525, 4019.3970904364287, 5068.79724811009, 5201.609879259052, 5215.713135777531, 5227.137522308814, 5128.948710512903, 5136.383633963929, 5144.639875208737, 5161.690298582078, 5229.686218826882, 4221.852235171769, 4269.7224680395675, 4635.165670179366, 4742.170120228963, 5243.973780131075, 4521.819127234907, 4524.886877828048, 4525.434320709911, 4528.07174529224, 4554.453465584151, 6518.0, 6797.0, 6851.828704282433, 6892.620905850176, 6903.482238832108, 5924.614900031527, 5924.7333869975955, 5926.348101708809, 5940.673262970535, 6002.639841609517, 7640.73257435987, 7649.961750191269, 7651.1583725790115, 7658.081030276347, 7667.0416197975255, 4875.853724388274, 4882.389701287339, 4890.217565189552, 4894.951050489485, 4903.289023091667, 7242.855142897165, 7935.523868567904, 8039.075506316732, 8056.798580035487, 8105.27052565272, 4846.709197448094, 4886.998165376161, 4939.382577177853, 4943.72809495474, 4947.084789313988, 4191.161767646483, 5052.848414547496, 5066.797328106908, 5093.821716239914, 5106.846794596094, 6026.126211699367, 6034.185384972972, 6053.636781793019, 6062.545309101835, 6086.147939288503, 7644.235576442311, 7644.655990480442, 7652.387808975269, 7672.079350477979, 7673.539587624648, 1685.0900513722697, 1724.4654157211305, 1757.2882982392152, 1757.604538978745, 1757.912104394775, 936.8547875079373, 1082.767205050918, 1095.2661716649864, 1106.7011906785124, 1111.2332490581473, 7187.0, 7265.365292809076, 7267.672954716944, 7271.600061996641, 7303.853922921512, 5965.642061476326, 7878.684852605947, 7887.132415434297, 7904.881426778603, 7922.286994170552, 5909.704514774244, 6488.448481879093, 6833.111695479556, 7239.20368759436, 7261.854762904818, 3111.128883912508, 3378.7803792753884, 4140.171965606891, 4170.562090980464, 4176.352665336878, 6518.598501322239, 7503.0, 7719.649061414342, 8156.5513896735065, 8355.665773369119, 7056.223815380304, 8226.670933162726, 8252.958735206286, 8256.050554186226, 8268.586570671443, 8266.090730019692, 8319.792005199797, 8335.499350194917, 8337.791555211046, 8341.290990265896, 7664.501807382502, 7938.087119981045, 7947.364210863233, 7980.082290536662, 8008.039035315799, 7692.42306826979, 7757.534547927143, 7790.688372465264, 7792.415568832247, 7827.334676552557, 7139.357457828821, 8354.58227088631, 8366.456180348501, 8373.916260837314, 8396.622152003296, 4960.958198778297, 4972.776225069808, 4984.925226121539, 4989.850304490871, 5002.074616196015, 7710.653020614198, 7786.104597971079, 7881.527108373516, 7885.2114788520685, 7920.247576480225, 7548.509346892434, 7576.886346704694, 7618.5809780462605, 7644.579548124684, 7648.464607477423, 6889.138857642794, 7566.924330756842, 7595.658195381332, 7613.847723045619, 7625.618719064136, 6913.896291555731, 7147.3210045045635, 7457.664405101892, 7471.140818805907, 7475.551466912003, 6922.480813938874, 7594.962025189839, 7631.465797394129, 7638.732644357421, 7646.235376462309, 7113.608751518716, 7484.513506622052, 7487.176410594721, 7489.28851759082, 7514.812129696801], "unit": "score", "name": "prototype.html", "value": 5469.433799197557}, {"lowerIsBetter": false, "replicates": [700.0584214231859, 710.7965307546606, 727.3817255332967, 758.2484460895329, 767.5855038279329, 15148.62128446788, 15445.536633900972, 15483.922580387096, 15509.379624815023, 15590.688186236282, 13671.589852304422, 14148.363323650434, 14578.927105364484, 14692.0, 14743.557693269218, 966.5070813884934, 984.3995162950595, 994.24934174698, 1012.4684540616198, 1012.9696109116701, 949.3449519831329, 989.1789814454022, 991.2714155095998, 993.061556828797, 1010.4947526236881, 1004.8191325561432, 1049.9055085042344, 1055.5144633468615, 1063.0485715284854, 1065.3820783945293, 999.6950929966357, 1008.4907121903465, 1044.6187141693226, 1044.7962647283782, 1060.2260349944545, 773.4856320546829, 778.2956424435895, 778.7936196907824, 781.2656103262972, 795.2524626850742, 13964.72070558583, 14030.158190508602, 14031.0, 14123.223222722747, 15797.684046319124, 13084.345782710827, 13100.868991310155, 13127.737445251138, 13309.933450332783, 13756.365919532791, 10297.74255643615, 10526.210534209966, 10848.403337816417, 11506.482208300647, 11560.94219528897, 4217.261979153636, 4271.700980931336, 4272.230998420283, 4295.334223195409, 4577.313402989545, 69159.0, 85686.71469927956, 87519.56240218758, 88658.5567072167, 88864.0, 10068.697939061693, 10095.24285678577, 10115.342502737298, 10251.179905607683, 10401.84397234027, 18686.252549898123, 23049.539009219723, 23053.42366440819, 23061.423464413525, 23089.0, 7816.140224575292, 7901.683932642745, 8028.558429286329, 8032.919670803334, 8116.837663246702, 4250.511191212988, 4263.786810659454, 4335.631471324909, 4370.2570563004365, 4437.29003359461, 3758.8684396046006, 3771.4342848572933, 3813.4279858020964, 3820.7707537547835, 3826.215625796705, 583.7898356591709, 684.9863002739917, 688.2326206280062, 689.1351354050735, 691.9688614012382, 526.7392640642906, 541.2422608348344, 571.5427657873685, 600.9969950150221, 616.5499185594541, 8351.331893448509, 8708.0, 8733.126687331343, 8837.469751814911, 9027.09729027092, 618.329112912495, 619.9690015499207, 622.5984240165068, 624.0607885132846, 626.1609443345939, 3813.9427908581392, 3955.208958208312, 3989.5412027616617, 4035.1324465240114, 4183.414321994923, 85164.57417712871, 86339.0, 86805.1319486797, 86888.0, 89384.0, 70125.29812226433, 85292.72060919092, 86796.0, 87307.0, 87987.0, 66835.66582167058, 70660.64669676722, 70700.2929970704, 70713.64643176751, 71261.64369178224, 8935.955320223356, 8974.102589740975, 8975.551222438982, 8983.236424903957, 9114.40756350835, 49547.752261239904, 50749.746251269986, 51142.48857511377, 52082.958340832214, 52338.73830630822, 70775.0, 74992.0, 75362.62318688372, 76468.0, 77082.6145869267, 11582.247153934968, 11748.0, 11951.820722688994, 12133.939330303292, 12272.325022123869, 12149.392530373269, 12229.388530573613, 12304.692382690504, 12439.0, 13311.66720831987, 11283.266587671775, 11721.238119522204, 11750.706232343919, 12048.915597596259, 12144.14990950625, 11858.229215100991, 12010.279383236684, 12076.577319793765, 12193.939030304791, 12326.630201093982, 11468.4265786712, 11657.475413606238, 11785.233959792586, 12157.392130393268, 12234.694132646755, 9176.724698259062, 9896.406215626797, 10170.898291016994, 10190.439525825854, 10614.310069845435, 10037.89962100399, 10391.428471434143, 10537.683869483928, 10561.471926403803, 10611.09805666527], "unit": "score", "name": "yui.html", "value": 7294.692958874845}], "name": "dromaeo_css", "value": 7828.872161303675}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 105.0, 108.0, 167.0, 170.0, 179.0, 116.0, 115.0, 135.0, 101.0], "unit": "score", "name": "ai-astar", "value": 131.2}, {"lowerIsBetter": true, "replicates": [147.0, 127.0, 185.0, 162.0, 117.0, 139.0, 120.0, 148.0, 148.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 141.3}, {"lowerIsBetter": true, "replicates": [192.0, 195.0, 230.0, 220.0, 200.0, 196.0, 196.0, 264.0, 283.0, 198.0], "unit": "score", "name": "audio-dft", "value": 217.4}, {"lowerIsBetter": true, "replicates": [61.0, 77.0, 70.0, 112.0, 57.0, 58.0, 58.0, 59.0, 129.0, 59.0], "unit": "score", "name": "audio-fft", "value": 74.0}, {"lowerIsBetter": true, "replicates": [84.0, 99.0, 160.0, 121.0, 82.0, 83.0, 119.0, 80.0, 79.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 102.4}, {"lowerIsBetter": true, "replicates": [93.0, 87.0, 93.0, 87.0, 89.0, 87.0, 93.0, 86.0, 89.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.3}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 103.0, 94.0, 96.0, 94.0, 94.0, 99.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 95.7}, {"lowerIsBetter": true, "replicates": [107.0, 144.0, 124.0, 91.0, 79.0, 144.0, 120.0, 85.0, 145.0, 149.0], "unit": "score", "name": "imaging-desaturate", "value": 118.8}, {"lowerIsBetter": true, "replicates": [55.0, 60.0, 60.0, 58.0, 57.0, 60.0, 60.0, 65.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 69.0, 67.0, 76.0, 75.0, 67.0, 64.0, 63.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 83.0, 80.0, 81.0, 83.0, 82.0, 95.0, 81.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [125.0, 123.0, 131.0, 109.0, 132.0, 150.0, 144.0, 120.0, 117.0, 141.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.2}, {"lowerIsBetter": true, "replicates": [124.0, 135.0, 136.0, 139.0, 135.0, 122.0, 135.0, 136.0, 135.0, 125.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 64.0, 67.0, 69.0, 63.0, 66.0, 65.0, 65.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1507.7}]} 14:39:02 INFO - Return code: 0 14:39:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:39:02 ERROR - # TBPL SUCCESS # 14:39:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:39:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:39:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:39:02 INFO - 2016-04-25 14:39:02.580 screenresolution[1962:13718] starting screenresolution argv=screenresolution get 14:39:02 INFO - 2016-04-25 14:39:02.582 screenresolution[1962:13718] Display 0: 1600x1200x32@60 14:39:02 INFO - 2016-04-25 14:39:02.588 screenresolution[1963:13721] starting screenresolution argv=screenresolution list 14:39:02 INFO - Available Modes on Display 0 14:39:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:39:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:39:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:39:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:39:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:39:02 INFO - Intel Iris: 14:39:02 INFO - Chipset Model: Intel Iris 14:39:02 INFO - Type: GPU 14:39:02 INFO - Bus: Built-In 14:39:02 INFO - VRAM (Dynamic, Max): 1536 MB 14:39:02 INFO - Vendor: Intel (0x8086) 14:39:02 INFO - Device ID: 0x0a2e 14:39:02 INFO - Revision ID: 0x0009 14:39:02 INFO - Displays: 14:39:02 INFO - Display: 14:39:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:39:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:39:02 INFO - Display Serial Number: 1600x1200 60 14:39:02 INFO - Main Display: Yes 14:39:02 INFO - Mirror: Off 14:39:02 INFO - Online: Yes 14:39:02 INFO - Rotation: Supported 14:39:02 INFO - Return code: 0 14:39:02 INFO - Running post-action listener: _resource_record_post_action 14:39:02 INFO - Running post-run listener: _resource_record_post_run 14:39:03 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 978944; Write bytes: 509205504; Read time: 14; Write time: 1802 14:39:03 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 198328832; Write bytes: 196149248; Read time: 17941; Write time: 353 14:39:03 INFO - run-tests - Wall time: 1169s; CPU: 53.0%; Read bytes: 978944; Write bytes: 302263296; Read time: 14; Write time: 1412 14:39:03 INFO - Running post-run listener: _upload_blobber_files 14:39:03 INFO - Blob upload gear active. 14:39:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:39:03 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 14:39:03 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'] 14:39:03 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 14:39:04 INFO - (blobuploader) - INFO - Open directory for files ... 14:39:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:39:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:39:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:05 INFO - (blobuploader) - INFO - Done attempting. 14:39:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:39:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:39:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:06 INFO - (blobuploader) - INFO - Done attempting. 14:39:06 INFO - (blobuploader) - INFO - Iteration through files over. 14:39:06 INFO - Return code: 0 14:39:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:39:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:39:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b01f8a0f3251a77fde4b66f0f022ad3f6e95d4a0cb8242c36357a08a0288f9c0ffd1c2834fa917d628babbafb1e2ef9d11232854894dd5b6b72cf623d75893f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fb2d4be8b5aa0bfaa207a2efd53bec1c28ef4c8dc2b89a9186753029f4aa3857ebb1c6b52438b46c56faa6fbb98f4fd35e726ae016f8053755661693118e509e"} 14:39:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:39:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:39:06 INFO - Contents: 14:39:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b01f8a0f3251a77fde4b66f0f022ad3f6e95d4a0cb8242c36357a08a0288f9c0ffd1c2834fa917d628babbafb1e2ef9d11232854894dd5b6b72cf623d75893f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fb2d4be8b5aa0bfaa207a2efd53bec1c28ef4c8dc2b89a9186753029f4aa3857ebb1c6b52438b46c56faa6fbb98f4fd35e726ae016f8053755661693118e509e"} 14:39:06 INFO - Running post-run listener: copy_logs_to_upload_dir 14:39:06 INFO - Copying logs to upload dir... 14:39:06 INFO - mkdir: /builds/slave/test/build/upload/logs 14:39:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.939882 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-25 14:39:06.602135) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 14:39:06.606452) ========= 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.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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/b01f8a0f3251a77fde4b66f0f022ad3f6e95d4a0cb8242c36357a08a0288f9c0ffd1c2834fa917d628babbafb1e2ef9d11232854894dd5b6b72cf623d75893f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fb2d4be8b5aa0bfaa207a2efd53bec1c28ef4c8dc2b89a9186753029f4aa3857ebb1c6b52438b46c56faa6fbb98f4fd35e726ae016f8053755661693118e509e"} build_url:https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b01f8a0f3251a77fde4b66f0f022ad3f6e95d4a0cb8242c36357a08a0288f9c0ffd1c2834fa917d628babbafb1e2ef9d11232854894dd5b6b72cf623d75893f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fb2d4be8b5aa0bfaa207a2efd53bec1c28ef4c8dc2b89a9186753029f4aa3857ebb1c6b52438b46c56faa6fbb98f4fd35e726ae016f8053755661693118e509e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 14:39:06.634418) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:39:06.634749) ========= 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.BHR0blZ7Sw/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.aCz6FXnn9O/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005328 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:39:06.691164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:39:06.691483) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:39:06.691906) ========= ========= Total master_lag: 0.49 =========