builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0068 starttime: 1461701643.03 results: success (0) buildid: 20160425205003 builduid: 68a02e46d6d349f3b74437b25b685305 revision: 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 13:14:03.035528) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 13:14:03.036580) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 13:14:03.037282) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 13:14:03.058483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:14:03.059058) ========= 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.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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-26 13:14:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2016-04-26 13:14:03 (18.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.302823 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:14:03.385595) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:14:03.386086) ========= 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.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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.026835 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:14:03.435307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:14:03.435707) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 --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 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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-26 13:14:03,509 truncating revision to first 12 chars 2016-04-26 13:14:03,509 Setting DEBUG logging. 2016-04-26 13:14:03,509 attempt 1/10 2016-04-26 13:14:03,509 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5bbf2e7c2fc6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 13:14:03,993 unpacking tar archive at: mozilla-beta-5bbf2e7c2fc6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.732263 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:14:04.185543) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 13:14:04.185916) ========= script_repo_revision: 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 13:14:04.186394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 13:14:04.186704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 13:14:04.200530) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-04-26 13:14:04.200840) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 13:14:04 INFO - MultiFileLogger online at 20160426 13:14:04 in /builds/slave/test 13:14:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:14:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:14:04 INFO - {'append_to_log': False, 13:14:04 INFO - 'base_work_dir': '/builds/slave/test', 13:14:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:14:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:14:04 INFO - 'branch': 'Mozilla-Beta', 13:14:04 INFO - 'buildbot_json_path': 'buildprops.json', 13:14:04 INFO - 'config_files': ('talos/mac_config.py',), 13:14:04 INFO - 'default_actions': ('clobber', 13:14:04 INFO - 'read-buildbot-config', 13:14:04 INFO - 'download-and-extract', 13:14:04 INFO - 'populate-webroot', 13:14:04 INFO - 'create-virtualenv', 13:14:04 INFO - 'install', 13:14:04 INFO - 'run-tests'), 13:14:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:14:04 INFO - 'download_minidump_stackwalk': True, 13:14:04 INFO - 'download_symbols': 'ondemand', 13:14:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:14:04 INFO - 'tooltool.py': '/tools/tooltool.py', 13:14:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:14:04 INFO - '/tools/misc-python/virtualenv.py')}, 13:14:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:14:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:14:04 INFO - 'installer_path': 'installer.exe', 13:14:04 INFO - 'log_level': 'info', 13:14:04 INFO - 'log_name': 'talos', 13:14:04 INFO - 'log_to_console': True, 13:14:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:14:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:14:04 INFO - 'opt_config_files': (), 13:14:04 INFO - 'pip_index': False, 13:14:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:14:04 INFO - 'cmd': ('bash', 13:14:04 INFO - '-c', 13:14:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:14:04 INFO - 'enabled': True, 13:14:04 INFO - 'halt_on_failure': False, 13:14:04 INFO - 'name': 'check_screen_resolution'},), 13:14:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:14:04 INFO - 'cmd': ('bash', 13:14:04 INFO - '-c', 13:14:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:14:04 INFO - 'enabled': True, 13:14:04 INFO - 'halt_on_failure': False, 13:14:04 INFO - 'name': 'check_screen_resolution'},), 13:14:04 INFO - 'run_cmd_checks_enabled': True, 13:14:04 INFO - 'sps_profile': False, 13:14:04 INFO - 'sps_profile_interval': 0, 13:14:04 INFO - 'suite': 'dromaeojs', 13:14:04 INFO - 'system_bits': '32', 13:14:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:14:04 INFO - 'title': 't-yosemite-r7-0068', 13:14:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:14:04 INFO - 'use_talos_json': True, 13:14:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:14:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:14:04 INFO - 'work_dir': 'build'} 13:14:04 INFO - ##### 13:14:04 INFO - ##### Running clobber step. 13:14:04 INFO - ##### 13:14:04 INFO - Running pre-action listener: _resource_record_pre_action 13:14:04 INFO - Running main action method: clobber 13:14:04 INFO - rmtree: /builds/slave/test/build 13:14:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:14:06 INFO - Running post-action listener: _resource_record_post_action 13:14:06 INFO - ##### 13:14:06 INFO - ##### Running read-buildbot-config step. 13:14:06 INFO - ##### 13:14:06 INFO - Running pre-action listener: _resource_record_pre_action 13:14:06 INFO - Running main action method: read_buildbot_config 13:14:06 INFO - Using buildbot properties: 13:14:06 INFO - { 13:14:06 INFO - "project": "", 13:14:06 INFO - "product": "firefox", 13:14:06 INFO - "script_repo_revision": "production", 13:14:06 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 13:14:06 INFO - "repository": "", 13:14:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 13:14:06 INFO - "buildid": "20160425205003", 13:14:06 INFO - "pgo_build": "False", 13:14:06 INFO - "basedir": "/builds/slave/test", 13:14:06 INFO - "buildnumber": 54, 13:14:06 INFO - "slavename": "t-yosemite-r7-0068", 13:14:06 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:14:06 INFO - "platform": "yosemite_r7", 13:14:06 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:14:06 INFO - "branch": "mozilla-beta", 13:14:06 INFO - "repo_path": "releases/mozilla-beta", 13:14:06 INFO - "revision": "5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2", 13:14:06 INFO - "stage_platform": "macosx64", 13:14:06 INFO - "builduid": "68a02e46d6d349f3b74437b25b685305", 13:14:06 INFO - "slavebuilddir": "test" 13:14:06 INFO - } 13:14:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 13:14:06 INFO - Running post-action listener: _resource_record_post_action 13:14:06 INFO - ##### 13:14:06 INFO - ##### Running download-and-extract step. 13:14:06 INFO - ##### 13:14:06 INFO - Running pre-action listener: _resource_record_pre_action 13:14:06 INFO - Running main action method: download_and_extract 13:14:06 INFO - mkdir: /builds/slave/test/build/tests 13:14: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')]} 13:14:06 INFO - https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:14:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 13:14:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 13:14:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/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 13:14:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/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 13:14:07 INFO - Downloaded 1241 bytes. 13:14:07 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 13:14:07 INFO - Using the following test package requirements: 13:14:07 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 13:14:07 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:14:07 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 13:14:07 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:14:07 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 13:14:07 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:14:07 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:14:07 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 13:14:07 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 13:14:07 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:14:07 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 13:14:07 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:14:07 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 13:14:07 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:14:07 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 13:14:07 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 13:14:07 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:14:07 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 13:14:07 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 13:14:07 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')]} 13:14:07 INFO - https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:14:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 13:14:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 13:14:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/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 13:14:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/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 13:14:09 INFO - Downloaded 17745664 bytes. 13:14:09 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'] 13:14:09 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 13:14:12 INFO - Return code: 0 13:14:12 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 13:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:12 INFO - https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:14:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 13:14:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 13:14:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/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 13:14:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/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 13:14:14 INFO - Downloaded 17745664 bytes. 13:14:14 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'] 13:14:14 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 13:14:17 INFO - Return code: 0 13:14:17 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')]} 13:14:17 INFO - https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:14:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 13:14:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 13:14:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/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 13:14:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/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 13:14:50 INFO - Downloaded 10845194 bytes. 13:14:50 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'] 13:14:50 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 13:14:50 INFO - Return code: 0 13:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:50 INFO - https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 13:14:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 13:14:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 13:14:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 13:14:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/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 13:15:12 INFO - Downloaded 88299541 bytes. 13:15:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 13:15:12 INFO - mkdir: /builds/slave/test/properties 13:15:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:15:12 INFO - Writing to file /builds/slave/test/properties/build_url 13:15:12 INFO - Contents: 13:15:12 INFO - build_url:https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 13:15:13 INFO - Running post-action listener: _resource_record_post_action 13:15:13 INFO - Running post-action listener: set_extra_try_arguments 13:15:13 INFO - ##### 13:15:13 INFO - ##### Running populate-webroot step. 13:15:13 INFO - ##### 13:15:13 INFO - Running pre-action listener: _resource_record_pre_action 13:15:13 INFO - Running main action method: populate_webroot 13:15:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:15:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:15:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:15:13 INFO - '--tppagecycles', 13:15:13 INFO - '7'], 13:15:13 INFO - 'tests': ['tsvgm']}}, 13:15:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:15:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:15:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:15:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:15:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:15:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:15:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:15:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:13 INFO - 'talos_options': ['--e10s'], 13:15:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:15:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:13 INFO - 'tests': ['damp', 'tps']}, 13:15:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:13 INFO - 'talos_options': ['--e10s'], 13:15:13 INFO - 'tests': ['damp', 'tps']}, 13:15:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:15:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:15:13 INFO - 'other': {'tests': ['a11yr', 13:15:13 INFO - 'ts_paint', 13:15:13 INFO - 'tpaint', 13:15:13 INFO - 'sessionrestore', 13:15:13 INFO - 'sessionrestore_no_auto_restore', 13:15:13 INFO - 'tabpaint']}, 13:15:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:15:13 INFO - 'tests': ['a11yr', 13:15:13 INFO - 'ts_paint', 13:15:13 INFO - 'tpaint', 13:15:13 INFO - 'sessionrestore', 13:15:13 INFO - 'sessionrestore_no_auto_restore', 13:15:13 INFO - 'tabpaint']}, 13:15:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:15:13 INFO - 'tests': ['a11yr', 13:15:13 INFO - 'ts_paint', 13:15:13 INFO - 'tpaint', 13:15:13 INFO - 'sessionrestore', 13:15:13 INFO - 'sessionrestore_no_auto_restore', 13:15:13 INFO - 'tabpaint']}, 13:15:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:15:13 INFO - 'tests': ['a11yr', 13:15:13 INFO - 'ts_paint', 13:15:13 INFO - 'tpaint', 13:15:13 INFO - 'sessionrestore', 13:15:13 INFO - 'sessionrestore_no_auto_restore', 13:15:13 INFO - 'tabpaint']}, 13:15:13 INFO - 'other_l64': {'tests': ['a11yr', 13:15:13 INFO - 'ts_paint', 13:15:13 INFO - 'tpaint', 13:15:13 INFO - 'sessionrestore', 13:15:13 INFO - 'sessionrestore_no_auto_restore', 13:15:13 INFO - 'tabpaint']}, 13:15:13 INFO - 'other_nol64': {'tests': ['a11yr', 13:15:13 INFO - 'ts_paint', 13:15:13 INFO - 'tpaint', 13:15:13 INFO - 'sessionrestore', 13:15:13 INFO - 'sessionrestore_no_auto_restore', 13:15:13 INFO - 'tabpaint']}, 13:15:13 INFO - 'svgr': {'tests': ['tsvgx', 13:15:13 INFO - 'tsvgr_opacity', 13:15:13 INFO - 'tart', 13:15:13 INFO - 'tscrollx', 13:15:13 INFO - 'cart']}, 13:15:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:15:13 INFO - 'tests': ['tsvgx', 13:15:13 INFO - 'tsvgr_opacity', 13:15:13 INFO - 'tart', 13:15:13 INFO - 'tscrollx', 13:15:13 INFO - 'cart']}, 13:15:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:13 INFO - 'tests': ['tp5o']}, 13:15:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:13 INFO - 'talos_options': ['--e10s'], 13:15:13 INFO - 'tests': ['tp5o']}, 13:15:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:13 INFO - 'talos_options': ['--xperf_path', 13:15:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:15:13 INFO - 'tests': ['tp5n']}, 13:15:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:13 INFO - 'talos_options': ['--e10s', 13:15:13 INFO - '--xperf_path', 13:15:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:15:13 INFO - 'tests': ['tp5n']}}, 13:15:13 INFO - 'talos.zip': {'path': '', 13:15:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:15:13 INFO - Running post-action listener: _resource_record_post_action 13:15:13 INFO - ##### 13:15:13 INFO - ##### Running create-virtualenv step. 13:15:13 INFO - ##### 13:15:13 INFO - Running pre-action listener: _resource_record_pre_action 13:15:13 INFO - Running main action method: create_virtualenv 13:15:13 INFO - Creating virtualenv /builds/slave/test/build/venv 13:15:13 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 13:15:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:15:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:15:13 INFO - Using real prefix '/tools/python27' 13:15:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:15:14 INFO - Installing distribute.............................................................................................................................................................................................done. 13:15:17 INFO - Installing pip.................done. 13:15:17 INFO - Return code: 0 13:15:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:15:17 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')]} 13:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:17 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')]} 13:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:17 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 0x100a0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a144c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8534cc700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008b1d30>, '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 0x100715db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008a8b20>, '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.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 13:15:17 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 13:15:17 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 13:15:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V2DGE5TaYr/Render', 13:15:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:17 INFO - 'HOME': '/Users/cltbld', 13:15:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:17 INFO - 'LOGNAME': 'cltbld', 13:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:17 INFO - 'MOZ_NO_REMOTE': '1', 13:15:17 INFO - 'NO_EM_RESTART': '1', 13:15:17 INFO - 'PAGER': '/bin/cat', 13:15:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:17 INFO - 'PWD': '/builds/slave/test', 13:15:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:17 INFO - 'SHELL': '/bin/bash', 13:15:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KgcuJKy6lJ/Listeners', 13:15:17 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 13:15:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:17 INFO - 'USER': 'cltbld', 13:15:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:17 INFO - 'XPC_FLAGS': '0x0', 13:15:17 INFO - 'XPC_SERVICE_NAME': '0', 13:15:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:17 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 13:15:17 INFO - Cleaning up... 13:15:17 INFO - Return code: 0 13:15:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:15:17 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')]} 13:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:17 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')]} 13:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:17 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 0x100a0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a144c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8534cc700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008b1d30>, '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 0x100715db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008a8b20>, '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.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 13:15:17 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 13:15:17 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 13:15:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V2DGE5TaYr/Render', 13:15:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:17 INFO - 'HOME': '/Users/cltbld', 13:15:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:17 INFO - 'LOGNAME': 'cltbld', 13:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:17 INFO - 'MOZ_NO_REMOTE': '1', 13:15:17 INFO - 'NO_EM_RESTART': '1', 13:15:17 INFO - 'PAGER': '/bin/cat', 13:15:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:17 INFO - 'PWD': '/builds/slave/test', 13:15:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:17 INFO - 'SHELL': '/bin/bash', 13:15:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KgcuJKy6lJ/Listeners', 13:15:17 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 13:15:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:17 INFO - 'USER': 'cltbld', 13:15:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:17 INFO - 'XPC_FLAGS': '0x0', 13:15:17 INFO - 'XPC_SERVICE_NAME': '0', 13:15:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:18 INFO - Downloading/unpacking psutil>=0.7.1 13:15:18 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 13:15:18 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 13:15:18 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 13:15:18 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 13:15:18 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 13:15:18 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 13:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:15:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:15:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:15:20 INFO - Installing collected packages: psutil 13:15:20 INFO - Running setup.py install for psutil 13:15:21 INFO - building 'psutil._psutil_osx' extension 13:15:21 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 13:15:21 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 13:15:21 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 13:15:21 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 13:15:21 INFO - building 'psutil._psutil_posix' extension 13:15:21 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 13:15:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:15:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:15:21 INFO - ^ 13:15:21 INFO - 1 warning generated. 13:15:21 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 13:15:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:15:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:15:22 INFO - Successfully installed psutil 13:15:22 INFO - Cleaning up... 13:15:22 INFO - Return code: 0 13:15:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:15:22 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')]} 13:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:22 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')]} 13:15:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:22 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 0x100a0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a144c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8534cc700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008b1d30>, '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 0x100715db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008a8b20>, '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.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 13:15:22 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 13:15:22 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 13:15:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V2DGE5TaYr/Render', 13:15:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:22 INFO - 'HOME': '/Users/cltbld', 13:15:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:22 INFO - 'LOGNAME': 'cltbld', 13:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:22 INFO - 'MOZ_NO_REMOTE': '1', 13:15:22 INFO - 'NO_EM_RESTART': '1', 13:15:22 INFO - 'PAGER': '/bin/cat', 13:15:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:22 INFO - 'PWD': '/builds/slave/test', 13:15:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:22 INFO - 'SHELL': '/bin/bash', 13:15:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KgcuJKy6lJ/Listeners', 13:15:22 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 13:15:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:22 INFO - 'USER': 'cltbld', 13:15:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:22 INFO - 'XPC_FLAGS': '0x0', 13:15:22 INFO - 'XPC_SERVICE_NAME': '0', 13:15:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:15:22 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 13:15:22 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 13:15:22 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 13:15:22 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 13:15:22 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 13:15:22 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 13:15:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:15:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:15:24 INFO - Installing collected packages: mozsystemmonitor 13:15:24 INFO - Running setup.py install for mozsystemmonitor 13:15:25 INFO - Successfully installed mozsystemmonitor 13:15:25 INFO - Cleaning up... 13:15:25 INFO - Return code: 0 13:15:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:15: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')]} 13:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15: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')]} 13:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:25 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 0x100a0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a144c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8534cc700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008b1d30>, '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 0x100715db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008a8b20>, '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.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 13:15:25 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 13:15:25 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 13:15:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V2DGE5TaYr/Render', 13:15:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:25 INFO - 'HOME': '/Users/cltbld', 13:15:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:25 INFO - 'LOGNAME': 'cltbld', 13:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:25 INFO - 'MOZ_NO_REMOTE': '1', 13:15:25 INFO - 'NO_EM_RESTART': '1', 13:15:25 INFO - 'PAGER': '/bin/cat', 13:15:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:25 INFO - 'PWD': '/builds/slave/test', 13:15:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:25 INFO - 'SHELL': '/bin/bash', 13:15:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KgcuJKy6lJ/Listeners', 13:15:25 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 13:15:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:25 INFO - 'USER': 'cltbld', 13:15:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:25 INFO - 'XPC_FLAGS': '0x0', 13:15:25 INFO - 'XPC_SERVICE_NAME': '0', 13:15:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:25 INFO - Downloading/unpacking blobuploader==1.2.4 13:15:25 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 13:15:25 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 13:15:25 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 13:15:25 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 13:15:25 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 13:15:25 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 13:15:27 INFO - Downloading blobuploader-1.2.4.tar.gz 13:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:15:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:15:27 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 13:15:27 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 13:15:27 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 13:15:27 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 13:15:27 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 13:15:27 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 13:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:15:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:15:28 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 13:15:28 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 13:15:28 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 13:15:28 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 13:15:28 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 13:15:28 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 13:15:28 INFO - Downloading docopt-0.6.1.tar.gz 13:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:15:29 INFO - Installing collected packages: blobuploader, requests, docopt 13:15:29 INFO - Running setup.py install for blobuploader 13:15:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:15:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:15:29 INFO - Running setup.py install for requests 13:15:29 INFO - Running setup.py install for docopt 13:15:29 INFO - Successfully installed blobuploader requests docopt 13:15:29 INFO - Cleaning up... 13:15:29 INFO - Return code: 0 13:15:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:29 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 0x100a0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a144c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8534cc700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008b1d30>, '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 0x100715db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008a8b20>, '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.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 13:15:29 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 13:15:29 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 13:15:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V2DGE5TaYr/Render', 13:15:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:29 INFO - 'HOME': '/Users/cltbld', 13:15:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:29 INFO - 'LOGNAME': 'cltbld', 13:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:29 INFO - 'MOZ_NO_REMOTE': '1', 13:15:29 INFO - 'NO_EM_RESTART': '1', 13:15:29 INFO - 'PAGER': '/bin/cat', 13:15:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:29 INFO - 'PWD': '/builds/slave/test', 13:15:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:29 INFO - 'SHELL': '/bin/bash', 13:15:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KgcuJKy6lJ/Listeners', 13:15:29 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 13:15:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:29 INFO - 'USER': 'cltbld', 13:15:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:29 INFO - 'XPC_FLAGS': '0x0', 13:15:29 INFO - 'XPC_SERVICE_NAME': '0', 13:15:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:30 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-wMKDRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:30 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-b3aITg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:30 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-MGYjOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:30 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-SyAjg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:30 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-6ph2aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:30 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-J_4CLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:30 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-IYb4ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:30 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-t61f35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:30 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-IM0hVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:31 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-93g3Qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:31 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-7vP7Xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:31 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-mY4US3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:31 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-j_aIT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:31 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-UCPteP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:31 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-5Ah2PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:15:31 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-yVp93l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:31 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-VM8xd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:15:31 INFO - Running setup.py install for manifestparser 13:15:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:15:32 INFO - Running setup.py install for mozcrash 13:15:32 INFO - Running setup.py install for mozdebug 13:15:32 INFO - Running setup.py install for mozdevice 13:15:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:15:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:15:32 INFO - Running setup.py install for mozfile 13:15:32 INFO - Running setup.py install for mozhttpd 13:15:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:15:32 INFO - Running setup.py install for mozinfo 13:15:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:15:32 INFO - Running setup.py install for mozInstall 13:15:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:15:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:15:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:15:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:15:33 INFO - Running setup.py install for mozleak 13:15:33 INFO - Running setup.py install for mozlog 13:15:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:15:33 INFO - Running setup.py install for moznetwork 13:15:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:15:33 INFO - Running setup.py install for mozprocess 13:15:33 INFO - Running setup.py install for mozprofile 13:15:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:15:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:15:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:15:33 INFO - Running setup.py install for mozrunner 13:15:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:15:34 INFO - Running setup.py install for mozscreenshot 13:15:34 INFO - Running setup.py install for moztest 13:15:34 INFO - Running setup.py install for mozversion 13:15:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:15:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:15:34 INFO - Cleaning up... 13:15:34 INFO - Return code: 0 13:15:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:34 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 0x100a0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a144c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8534cc700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008b1d30>, '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 0x100715db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008a8b20>, '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.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 13:15:34 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 13:15:34 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 13:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V2DGE5TaYr/Render', 13:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:34 INFO - 'HOME': '/Users/cltbld', 13:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:34 INFO - 'LOGNAME': 'cltbld', 13:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:34 INFO - 'MOZ_NO_REMOTE': '1', 13:15:34 INFO - 'NO_EM_RESTART': '1', 13:15:34 INFO - 'PAGER': '/bin/cat', 13:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:34 INFO - 'PWD': '/builds/slave/test', 13:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:34 INFO - 'SHELL': '/bin/bash', 13:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KgcuJKy6lJ/Listeners', 13:15:34 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 13:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:34 INFO - 'USER': 'cltbld', 13:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:34 INFO - 'XPC_FLAGS': '0x0', 13:15:34 INFO - 'XPC_SERVICE_NAME': '0', 13:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:34 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-xgRFSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:34 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)) 13:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:34 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-skPqop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:34 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)) 13:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:34 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-kuUmJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:35 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)) 13:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:35 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-U22PaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:35 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)) 13:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:35 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-VGssAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:35 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)) 13:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:35 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-KpbY0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:35 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)) 13:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:35 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-XwDHqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:35 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)) 13:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:35 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-i_yD8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:35 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)) 13:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:35 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-vs7zoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:35 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)) 13:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:35 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-NN2Wzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:35 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)) 13:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:35 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-Gx2LoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:35 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)) 13:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:35 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-QLDNMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:36 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)) 13:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:36 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-DsjI1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:36 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)) 13:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:36 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-i_BqLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:15:36 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)) 13:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:36 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-kWFiss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:36 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)) 13:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:15:36 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-OXQmOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:36 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)) 13:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:36 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-AhkSwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:36 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)) 13:15:36 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)) 13:15:36 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)) 13:15:36 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)) 13:15:36 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)) 13:15:36 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)) 13:15:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:38 INFO - Downloading blessings-1.6.tar.gz 13:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:15:39 INFO - Installing collected packages: blessings 13:15:39 INFO - Running setup.py install for blessings 13:15:39 INFO - Successfully installed blessings 13:15:39 INFO - Cleaning up... 13:15:39 INFO - Return code: 0 13:15:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:15:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:39 INFO - Reading from file tmpfile_stdout 13:15:39 INFO - Current package versions: 13:15:39 INFO - blessings == 1.6 13:15:39 INFO - blobuploader == 1.2.4 13:15:39 INFO - docopt == 0.6.1 13:15:39 INFO - manifestparser == 1.1 13:15:39 INFO - mozInstall == 1.12 13:15:39 INFO - mozcrash == 0.17 13:15:39 INFO - mozdebug == 0.1 13:15:39 INFO - mozdevice == 0.48 13:15:39 INFO - mozfile == 1.2 13:15:39 INFO - mozhttpd == 0.7 13:15:39 INFO - mozinfo == 0.9 13:15:39 INFO - mozleak == 0.1 13:15:39 INFO - mozlog == 3.1 13:15:39 INFO - moznetwork == 0.27 13:15:39 INFO - mozprocess == 0.22 13:15:39 INFO - mozprofile == 0.28 13:15:39 INFO - mozrunner == 6.11 13:15:39 INFO - mozscreenshot == 0.1 13:15:39 INFO - mozsystemmonitor == 0.0 13:15:39 INFO - moztest == 0.7 13:15:39 INFO - mozversion == 1.4 13:15:39 INFO - psutil == 3.1.1 13:15:39 INFO - requests == 1.2.3 13:15:39 INFO - wsgiref == 0.1.2 13:15:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:39 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 0x100a0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a144c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8534cc700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008b1d30>, '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 0x100715db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008a8b20>, '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.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 13:15:39 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 13:15:39 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 13:15:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V2DGE5TaYr/Render', 13:15:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:39 INFO - 'HOME': '/Users/cltbld', 13:15:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:39 INFO - 'LOGNAME': 'cltbld', 13:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:39 INFO - 'MOZ_NO_REMOTE': '1', 13:15:39 INFO - 'NO_EM_RESTART': '1', 13:15:39 INFO - 'PAGER': '/bin/cat', 13:15:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:39 INFO - 'PWD': '/builds/slave/test', 13:15:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:39 INFO - 'SHELL': '/bin/bash', 13:15:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KgcuJKy6lJ/Listeners', 13:15:39 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 13:15:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:39 INFO - 'USER': 'cltbld', 13:15:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:39 INFO - 'XPC_FLAGS': '0x0', 13:15:39 INFO - 'XPC_SERVICE_NAME': '0', 13:15:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:39 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)) 13:15:39 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)) 13:15:39 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)) 13:15:39 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)) 13:15:39 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)) 13:15:39 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)) 13:15:39 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)) 13:15:39 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)) 13:15:39 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)) 13:15:39 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)) 13:15:39 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)) 13:15:39 INFO - Cleaning up... 13:15:39 INFO - Return code: 0 13:15:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:39 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 0x100a0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a144c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8534cc700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008b1d30>, '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 0x100715db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008a8b20>, '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.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 13:15:39 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 13:15:39 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 13:15:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V2DGE5TaYr/Render', 13:15:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:39 INFO - 'HOME': '/Users/cltbld', 13:15:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:39 INFO - 'LOGNAME': 'cltbld', 13:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:39 INFO - 'MOZ_NO_REMOTE': '1', 13:15:39 INFO - 'NO_EM_RESTART': '1', 13:15:39 INFO - 'PAGER': '/bin/cat', 13:15:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:39 INFO - 'PWD': '/builds/slave/test', 13:15:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:39 INFO - 'SHELL': '/bin/bash', 13:15:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KgcuJKy6lJ/Listeners', 13:15:39 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 13:15:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:39 INFO - 'USER': 'cltbld', 13:15:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:39 INFO - 'XPC_FLAGS': '0x0', 13:15:39 INFO - 'XPC_SERVICE_NAME': '0', 13:15:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:40 INFO - Downloading/unpacking jsonschema 13:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:15:42 INFO - Downloading/unpacking functools32 (from jsonschema) 13:15:42 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 13:15:42 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 13:15:42 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 13:15:42 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 13:15:42 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 13:15:42 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 13:15:42 INFO - Downloading functools32-3.2.3-2.tar.gz 13:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:15:42 INFO - warning: no files found matching '*.txt' 13:15:42 INFO - no previously-included directories found matching 'build' 13:15:42 INFO - no previously-included directories found matching 'dist' 13:15:42 INFO - no previously-included directories found matching '.git*' 13:15:42 INFO - Installing collected packages: jsonschema, functools32 13:15:43 INFO - Running setup.py install for functools32 13:15:43 INFO - warning: no files found matching '*.txt' 13:15:43 INFO - no previously-included directories found matching 'build' 13:15:43 INFO - no previously-included directories found matching 'dist' 13:15:43 INFO - no previously-included directories found matching '.git*' 13:15:43 INFO - Successfully installed jsonschema functools32 13:15:43 INFO - Cleaning up... 13:15:43 INFO - Return code: 0 13:15:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a144c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8534cc700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008b1d30>, '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 0x100715db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008a8b20>, '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.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 13:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:15:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V2DGE5TaYr/Render', 13:15:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:43 INFO - 'HOME': '/Users/cltbld', 13:15:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:43 INFO - 'LOGNAME': 'cltbld', 13:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:43 INFO - 'MOZ_NO_REMOTE': '1', 13:15:43 INFO - 'NO_EM_RESTART': '1', 13:15:43 INFO - 'PAGER': '/bin/cat', 13:15:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:43 INFO - 'PWD': '/builds/slave/test', 13:15:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:43 INFO - 'SHELL': '/bin/bash', 13:15:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KgcuJKy6lJ/Listeners', 13:15:43 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 13:15:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:43 INFO - 'USER': 'cltbld', 13:15:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:43 INFO - 'XPC_FLAGS': '0x0', 13:15:43 INFO - 'XPC_SERVICE_NAME': '0', 13:15:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:43 INFO - Downloading/unpacking flake8 13:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:15:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:15:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:15:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:15:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:15:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:15:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:15:47 INFO - no previously-included directories found matching 'docs/_build' 13:15:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:15:47 INFO - Running setup.py install for pep8 13:15:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:15:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:15:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:15:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:15:47 INFO - no previously-included directories found matching 'docs/_build' 13:15:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:15:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:15:47 INFO - Cleaning up... 13:15:47 INFO - Return code: 0 13:15:47 INFO - Running post-action listener: _resource_record_post_action 13:15:47 INFO - Running post-action listener: _start_resource_monitoring 13:15:47 INFO - Starting resource monitoring. 13:15:47 INFO - ##### 13:15:47 INFO - ##### Running install step. 13:15:47 INFO - ##### 13:15:47 INFO - Running pre-action listener: _resource_record_pre_action 13:15:47 INFO - Running main action method: install 13:15:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:47 INFO - Reading from file tmpfile_stdout 13:15:47 INFO - Detecting whether we're running mozinstall >=1.0... 13:15:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:15:47 INFO - Reading from file tmpfile_stdout 13:15:47 INFO - Output received: 13:15:47 INFO - Usage: mozinstall [options] installer 13:15:47 INFO - Options: 13:15:47 INFO - -h, --help show this help message and exit 13:15:47 INFO - -d DEST, --destination=DEST 13:15:47 INFO - Directory to install application into. [default: 13:15:47 INFO - "/builds/slave/test"] 13:15:47 INFO - --app=APP Application being installed. [default: firefox] 13:15:47 INFO - mkdir: /builds/slave/test/build/application 13:15:47 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'] 13:15:47 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 13:16:10 INFO - Reading from file tmpfile_stdout 13:16:10 INFO - Output received: 13:16:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:16:10 INFO - Running post-action listener: _resource_record_post_action 13:16:10 INFO - ##### 13:16:10 INFO - ##### Running run-tests step. 13:16:10 INFO - ##### 13:16:10 INFO - Running pre-action listener: _resource_record_pre_action 13:16:10 INFO - Running main action method: run_tests 13:16:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:16:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:16:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:16:10 INFO - 2016-04-26 13:16:10.400 screenresolution[1643:7576] starting screenresolution argv=screenresolution get 13:16:10 INFO - 2016-04-26 13:16:10.403 screenresolution[1643:7576] Display 0: 1600x1200x32@60 13:16:10 INFO - 2016-04-26 13:16:10.408 screenresolution[1644:7578] starting screenresolution argv=screenresolution list 13:16:10 INFO - Available Modes on Display 0 13:16:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:16:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:16:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:16:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:16:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:16:10 INFO - Intel Iris: 13:16:10 INFO - Chipset Model: Intel Iris 13:16:10 INFO - Type: GPU 13:16:10 INFO - Bus: Built-In 13:16:10 INFO - VRAM (Dynamic, Max): 1536 MB 13:16:10 INFO - Vendor: Intel (0x8086) 13:16:10 INFO - Device ID: 0x0a2e 13:16:10 INFO - Revision ID: 0x0009 13:16:10 INFO - Displays: 13:16:10 INFO - Display: 13:16:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:16:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:16:10 INFO - Display Serial Number: 1600x1200 60 13:16:10 INFO - Main Display: Yes 13:16:10 INFO - Mirror: Off 13:16:10 INFO - Online: Yes 13:16:10 INFO - Rotation: Supported 13:16:10 INFO - Return code: 0 13:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:16:10 INFO - Python 2.7.3 13:16:10 INFO - Return code: 0 13:16:10 INFO - grabbing minidump binary from tooltool 13:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:10 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 0x1008b1d30>, '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 0x100715db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008a8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:16:10 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 13:16:10 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 13:16:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:16:10 INFO - Return code: 0 13:16:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:16:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:16:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:16:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:16:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:16:11 INFO - Return code: 0 13:16:11 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', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:16:11 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 --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:16:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V2DGE5TaYr/Render', 13:16:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:16:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:16:11 INFO - 'HOME': '/Users/cltbld', 13:16:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:16:11 INFO - 'LOGNAME': 'cltbld', 13:16:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:16:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:11 INFO - 'MOZ_NO_REMOTE': '1', 13:16:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:16:11 INFO - 'NO_EM_RESTART': '1', 13:16:11 INFO - 'PAGER': '/bin/cat', 13:16:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:11 INFO - 'PWD': '/builds/slave/test', 13:16:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:16:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:16:11 INFO - 'SHELL': '/bin/bash', 13:16:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KgcuJKy6lJ/Listeners', 13:16:11 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 13:16:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:16:11 INFO - 'USER': 'cltbld', 13:16:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:16:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:11 INFO - 'XPC_FLAGS': '0x0', 13:16:11 INFO - 'XPC_SERVICE_NAME': '0', 13:16:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:16:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:16:12 INFO - mozversion application_buildid: 20160425205003 13:16:12 INFO - mozversion application_changeset: 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 13:16:12 INFO - mozversion application_display_name: Firefox 13:16:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:16:12 INFO - mozversion application_name: Firefox 13:16:12 INFO - mozversion application_remotingname: firefox 13:16:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:16:12 INFO - mozversion application_vendor: Mozilla 13:16:12 INFO - mozversion application_version: 47.0 13:16:12 INFO - mozversion platform_buildid: 20160425205003 13:16:12 INFO - mozversion platform_changeset: 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 13:16:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:16:12 INFO - mozversion platform_version: 47.0 13:16:12 INFO - using testdate: 1461701772 13:16:12 INFO - actual date: 1461701772 13:16:12 INFO - starting webserver on 'localhost:49278' 13:16:12 INFO - SUITE-START | Running 2 tests 13:16:12 INFO - TEST-START | dromaeo_css 13:16:12 INFO - operating with platform_type : mac_ 13:16:12 INFO - Initialising browser for dromaeo_css test... 13:16:12 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpLRtakN/profile http://localhost:49278/getInfo.html) 13:16:14 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 13:16:14 INFO - PROCESS | 1662 | colorDepth:24 13:16:14 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 13:16:14 INFO - PROCESS | 1662 | __metrics 13:16:14 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:16:14 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:16:15 INFO - TEST-INFO | 1662: exit 0 13:16:15 INFO - Browser initialized. 13:16:15 INFO - Running cycle 1/1 for dromaeo_css test... 13:16:15 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpLRtakN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:16:27 INFO - PROCESS | 1665 | RSS: Main: 157143040 13:16:27 INFO - PROCESS | 1665 | 13:17:17 INFO - PROCESS | 1665 | 1461701837906 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] 13:19:27 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 13:19:28 INFO - PROCESS | 1665 | RSS: Main: 279343104 13:19:28 INFO - PROCESS | 1665 | 13:22:31 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 13:22:31 INFO - PROCESS | 1665 | RSS: Main: 290664448 13:22:31 INFO - PROCESS | 1665 | 13:25:33 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 13:25:34 INFO - PROCESS | 1665 | RSS: Main: 295817216 13:25:34 INFO - PROCESS | 1665 | 13:28:36 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 13:28:36 INFO - PROCESS | 1665 | RSS: Main: 255954944 13:28:36 INFO - PROCESS | 1665 | 13:31:39 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 13:31:40 INFO - PROCESS | 1665 | RSS: Main: 256073728 13:31:40 INFO - PROCESS | 1665 | 13:34:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 13:34:42 INFO - PROCESS | 1665 | RSS: Main: 303132672 13:34:42 INFO - PROCESS | 1665 | 13:34:42 INFO - PROCESS | 1665 | __start_tp_report 13:34:42 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 13:34:42 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 13:34:42 INFO - PROCESS | 1665 | |i|pagename|runs| 13:34:42 INFO - PROCESS | 1665 | |0;dojo.html;3537.982310088449;3616.6202548732367;3643.544556930384;3643.580988186358;3704.1480459494314;5851.79518716845;5878.294604647443;5878.382769809173;5894.587378883474;5942.61373010754;5876.324222714389;5893.351731309553;5899.351071382155;5913.024350982094;5915.083162109869;5232.110541208004;5246.737663116848;5267.104592219332;5311.760970756325;5323.866903327428;5392.757325920343;5402;5405.729713514309;5407.188921661763;5412.91880621789;5320.494553017457;5355.303810504648;5358.062339090663;5376.973115134439;5379.220013098098;5375.274337964383;5382.440498451718;5399.838004859841;5409.594280428944;5464.808731694411;5146.6911985281;5332.146856502941;5332.200169974496;5353.571714262888;5361.276227709287;5747;5782.7108644568025;5786.363500014995;5799.18811366409;5827.592068555203;6208.72060757267;6288.182536270301;6290.402411770874;6293.685315734241;6300.401461861115;5084.339035925343;6215.56491045627;6260.718267677966;6278.87442251157;6279.6860156992425;6052.213212282375;6058.757649694007;6077.453029227347;6081.908771368433;6105.786297479655;6190.876182476415;6239.376062393815;6381.266154392211;6396.0725694774;6399.8080057598345;6302.275238347557;6330.3669633036325;6330.52521060913;6332.810015699536;6358.682065896779;6274.027525733519;6295.716692748837;6301.243850737941;6313.179286692701;6317.810465686037;6198.101275315054;6236.376362363727;6240.594361366497;6261.843453913598;6310.4636105930595;6273.749050038039;6279.120923070774;6290.21372328459;6294.590851594632;6320.652364119926;4947.431045429749;4955.4548999610015;4966.453690094087;4968.875778105504;4979.4771548987555;3871.9806400967814;4441;4465.307877279027;4534.614557762628;4536.637069034469;6047.848803779941;6063.029915213633;6064;6075.149479072933;6095.786647467317;6234.470070044097;6246.063090536365;6279.717412716439;6281.528885333527;6289.591176573508;5866.7066646668345;5968.283805943314;6030.728617212236;6054.939450605526;6112.7554897804475;5445.50990410865;5448.618596698272;5469.644473109235;5484.698341591251;5488.890222195613;6457.61254324742;6462.095306657072;6468.514861385415;6481.125048118443;6491.896377615817;6190.938090619036;6231.875362492634;6286.968565157145;6292.2134733158355;6295.779647712308;5536.173062889156;6457.838554035999;6482.286948435574;6492.64290464029;6503.219613646393;5740.454656807597;5937.762489500545;6228.937710623017;6291.874162516632;6312.621242725451;6223.782167624111;6259.405356491126;6270;6271.843203919939;6291.591046581958;5953.940460595339;6105.3894610540365;6158.384161583985;6166.691665416622;6178.474829639531;5440.265564148789;6086.873928323274;6176.474999625082;6254;6271.811845644638;6004.489618382487;6069.666168360606;6079.240094988127;6096.02463605821;6111.755529778759;6215.160953271251;6294.8111556653375;6296.874062518632;6307.180066591497;6334.6832658365975;5942.346341902301;6062.060380641008;6072.969635151796;6159.84600384994;6171.7531298749345 13:34:42 INFO - PROCESS | 1665 | |1;ext.html;498.6135744797784;594.8126340202839;597.3309892919928;603.0110618585519;676.2054585861612;40210.79894600526;40722;40872.79563602185;40899.38650920235;40994.18011639769;43443.13113737731;44310.55689443104;44424.3336349955;44430.33354499677;44481.555184448145;9819.410835349901;10099.949500252489;10113.848292275621;10120.089191972758;10121.291509594332;9931.255155863302;10065.446400447972;10091.899081009205;10093.899061009406;10099.889012208689;10045.64840230592;10121.746956326077;10122.595096196143;10128.493575321205;10138.03688649577;10002.399856008626;10087.798244035152;10094.79810403795;10096.394216347042;10103.696889093339;10000.59997600095;10098.192144628412;10135.341202821794;10135.645252416203;10142.847857282073;43190.35214471786;43572.346414803804;43643.56356436459;43664.563354366685;43669.563304367184;3293.4565796643524;3477.23500829817;3516.9800757780213;3729.198222382201;3984.900377490557;29364.26589335262;30432.391352172832;30726.620071792084;30741.077767667004;30970.845145774354;2802.201372608817;2840.630718006646;2872.138358492444;2900.376419069889;2924.2250803536867;403492;445870.99999999674;461396;462710;464525;71550.64224678843;71821;71906.28093719101;72008.27991720015;72055.6397218021;76412.23587764162;78933.60533197297;78937;79082.6045869767;79141;18779.906100469685;18841.81158188428;19072.237110515423;19105.713414298796;19119.33082342139;14480.637984050272;14524.709505809824;14569.562913112624;14571.708565828623;14579.635509112357;22875.97058132388;23084.07663693467;23204.41988950256;23240.41898952506;23658.64512032321;9027.593758280893;9263.25893928484;9284.071592840663;9286.489243091695;9312.255019598417;976.2043934193609;1028.095276156977;1051.4795176387738;1066.946652667379;1078.2075174746556;28283.858580707376;29164.979225727;29297.56053659197;29682;29780.702192978228;1118.5917140243753;1193.9104567157324;1225.3444407242082;1265.784816581165;1283.1723538317733;14918.627034324229;15155.014924029903;15286.082835029934;15421;15638.2180890955;658058;669327;674612;674663;675497.6225118843;63111.73776524444;64970.350296497374;65019.67490162519;65033.34966650367;65084.02373964394;1398.6573289544126;1420.6803469219549;1522.3910435825758;1529.8164220293636;1559.563322269789;30019.849900750356;30173;30726;31756.682433175374;31942;51752.482475174766;52130.95738085293;52905.7354713224;52921.206181906535;52943.20585191302;399833;401103;403511;404525;404711;30128.69871301259;34548.136296592784;35259.294814103065;35464.822675886455;35484.935451936486;48576.271355928984;51060;52563.21155182752;53044.73477632587;53874.42067424156;37877.24245515019;38794.6120538791;39106.6089339103;39117.41323880087;39268.215270476634;38952;39006.6099339003;39143.60856391399;39406.802965986135;39743;38201;38480.23039539137;38769.4184587237;38874.22251555009;39550.40674389829;32804.835975820926;33629.495557566166;34069;34205.315893682484;34259.657403426645;25273.11544095948;25355.873220633777;25591.87204063968;25917.870410647825;26047.73952260453 13:34:42 INFO - PROCESS | 1665 | |2;jquery.html;330.97848639838406;381.49832969644916;382.10015413700734;389.7408223531352;393.2704832535648;20319;20967.790322096775;21160.25939092132;21810.563788724216;21861.234856780015;11308.92565206306;11683.474243659035;12456.937715311411;12530.436130374132;12552.121351505399;5045.016221836743;6268.811935641938;6290.276618188921;6306.243250809886;6331.936680633204;5976.282846058457;6156.445919867211;6242.219722534684;6267.404596563342;6271.498280137578;6217;6235.625862448245;6236.781712640059;6241.7191226394925;6246.906296405557;5625.268715067056;5868.882622347572;6203.100550420187;6216.564840461169;6217.968910155466;5414.620976531644;5446.782128714846;5454.400015998237;5458.8908221835345;5465.098258787295;13974.231417272045;14163.929180354033;22538.661920071212;26431.867840660867;26550;2199.230269405711;2216.6728019818715;2264.275431861805;2518.798496120306;2668.292902380851;9850.852237216448;9937.304388692794;10053.497325133787;10181;10293.176545876388;1662.2104500362352;1797.7932537758063;1820.3719716697717;1878.3707458001586;1962.2445358536922;99830;105673;109031.36452953212;111526.44236778845;112142.75714485665;11460.19778615489;11580.942095289469;11639.47622356996;11658.94170529142;11792.646220613395;14427;14490.985631005939;14495;14502.709945801025;14509.564713058626;9012.41419307743;9143.54282285883;9145.725628231165;9176;9282.30382721285;8285.710000149966;9193.712880196777;9475.952620236854;9530.282510157378;9562.139407453362;4544.6818722689095;4568.0863827234025;4576.816927322936;4582.495925448198;4630.930536041962;1803.9368622098164;1880.9341673041379;1935.9806401936082;1938.4378530226077;1943.5626983928503;853.7865533616596;905.7780843693338;963.5375019990444;997.5760301871676;1048.501961568249;16817.15914204285;19370.80629193718;19731;19866.60266794656;20266.996958452262;994.6071301835879;1028.5268776362957;1031.3863251365426;1045;1052.2897044494935;11177.441127943734;11366.976972072553;11398.94300528492;11402.258853174517;11419.771604568028;643826.561734386;648020;652251;660672.6966365234;661556;121169.78830211761;121391;123110;123558;127204.36397817952;1071.3250652089134;1083.3012706804225;1088.559133550929;1105.5522513382093;1105.5633024955098;17797.11014449298;17889.19498622539;18112.27550898002;18148.909255453636;18407.355742548945;49861.75069124776;51209;51226;52489.737551312;52622.73688631685;73586;74734.76856619984;76060.61969690117;76204.094897628;76966.2303376959;8220.424570280024;8227.13615070409;8350.958245208734;8354.289885359813;8570.757240200011;12751.788415361756;13308.866911330762;13419.731605368033;13733.793993090312;14065.789013164605;11764.82352764692;11836.053115750547;11958.402079896145;12096.092793040732;12100.515979360727;5541.695206763667;8482.57587120629;11581.826272606086;11796;11821.704457388634;11776.646700598996;12136.029117670389;12419.441125149571;12447;12519.374031298217;8325.25072743456;8354.45696029756;8361.289290410139;8532.957335213285;8674.696385626472;8742.38803283764;11380.487878045342;11970;12103;12133.817992730294 13:34:42 INFO - PROCESS | 1665 | |3;mootools.html;1522.2540954932088;1688.569414799226;1714.8542373898217;2081.2611522909365;2125.904334304956;8246.91753082469;8875.467471951679;9011.324150688692;9025.999999999984;9059.048799876009;8806.16341447563;8934.463932164075;8939.508327042011;8940.418872773282;8980.32647551433;2558.219742978391;2592.8055395845386;2598.2984594159566;2600.8049396295355;2604.0625374865035;2530.342111051131;2593.209071233273;2603.0759080526423;2604.726503717111;2616.502864455757;2353.9058437662475;2515.7861581765574;2587.7024142223695;2613.216035189445;2613.3466633341664;2561.8078644101674;2587.0815860369485;2597.6623039004903;2598.9090381836736;2602.0112357304292;2557.3734435063343;2591.7796987256106;2595.3252154439792;2600.388908606476;2600.6489123968213;8808.295336373074;8919.598618062202;8944.955275223647;9024.909750902472;9041.909580904172;5612.214289999362;5710.14347847822;5713.428657134295;5722.971385143048;5759.164921086419;3628.981855090734;3741.1956429367815;3746.831392587313;3789.829457674411;3805.847766089353;1065.690949624608;1083.0523292119397;1085.9511321990528;1104.6465131158034;1124.5839039555335;11967.26474661178;12314.322712250823;12328.95203907678;12336.876631233752;12362.134650574464;4457.77711114443;4756.500567440438;4794.541017084198;4874.049560335771;4898.926516102261;9535.094166054214;9546.570404331822;9582.233421326277;9593.088656577615;9609.759756006155;4816.686915350491;5509.338879334506;5555.2222688823595;5559.833205003856;5564.582656300794;4549.545045495424;4719.457262414798;4935.555799978019;5057.595392368602;5184.196449550326;3327.434336162858;3822.1782316801464;3894.337962546374;3911.4915061041884;3945.270125026879;1110.4947249001846;1245.9003279737599;1246.8628450870578;1247.1106273994906;1259.7480503899258;1159.5014143918027;1163.5752950173126;1272.8027155790867;1416.7095745372173;1439.0861802755117;8394.8321033579;8459.703910363107;8493.193146651058;8493.787655308543;8503.617337219715;540.1303900719838;545.8062387852335;550.2763865516913;552.3840917377096;553.5820455556029;6264.655443950626;6274.905876411857;6377.617342959345;6379.266384365857;6380.489560835122;10903.945480272549;11285.774284514264;11293;11433.542658293742;11435.542578296941;10741.78516429667;11089.944550277198;11118.499667514981;11201.831972520418;11218.831717524243;8661.956690216635;8707.521086340186;8746.69386571467;8749.47503149813;8760.123987601317;8045.477043992122;8149.79625509367;8155.592220389076;8211.096779354148;8235.176482351717;9329.72010839676;9828.31201815866;9934.006599340297;10119.645812396531;10228.64199753005;9650.613975440903;9950.601975921172;10092.747681308027;10118.747031323981;10120.493975301353;7457.440691948234;7578.772636820904;7647.38820894316;7669.309762121436;7671.769846904602;8368.288695460955;8394.45436046655;8456.534890581077;8465.915340846514;8583.141685831368;7377.594232317274;7532.096148462;7593.468457207942;7624.27569380908;7655.923440765521;7004.649767511706;7057.929420705727;7143.357097861218;7211.42308615299;7553.32020118192;7195.100612423447;8010.158933311918;8029.558374289237;8038.87941680887;8045.275925166763;7141.678624461808;7204.279572042754;7210.206877243604;7218.061651985208;7295.343419092307;7281.05346304977;7292.744753933587;7329;7345.192028876712;7347.8163045924275 13:34:42 INFO - PROCESS | 1665 | |4;prototype.html;292.88577454792636;343.56024288910186;347.8573784748254;353.79833494907905;354.2737388353874;6000.829838181551;6636.004599310106;6702.597844129344;6706.195256569206;6714.597124172553;6676.165479315086;6681.892919792295;6689.799306020815;6692.899606505906;6706.664666766655;4011.638952494275;4054.331035379159;4953.851384458454;4968.105740966625;5059.29169916213;4132.29750942339;4891.779869905845;4951.93533390321;4991.5258050485145;5006.349174607296;4926.064047830919;4933.679310844802;4942.827001054964;4955.331030310916;4965.975170124144;4068.776217308032;4929.383827021622;4948.455669876311;4953.3560637117125;4967.627427942919;4103.753774773523;4156.358238495807;4258.510271318807;4273.3162693969125;4276.2089013532595;6230.844228894269;6325.430711235965;6353.8411539711415;6355.269144048448;6375.489960803125;5874.5006674432725;5886.587938844283;5892.941070589282;5897.8230653080045;5907.645541267538;7108.431325493948;7115;7117.110361204849;7128.821779455555;7142.4286057115305;4661.440627124767;4802.039592081563;4814.614830813526;4816.277558366238;4816.951830481686;7386.409087273005;7449.106107267163;7485.887711684329;7486.101667799844;7507.587082710449;4932.161532539477;4944.777485013183;4951.207806750903;4953.23224900141;4958.603311735053;5057.69653820772;5061.898762024739;5063.8987220255385;5064.366954130734;5071.366079240095;5916.911246331309;5928.199693041384;5930.436608522184;5934.109883517507;5940.762369505172;6896.137982752156;7139.178994415709;7148.64256787169;7159.248278930741;7177.497575169792;1722.84494395505;1727.93952211672;1744.6423483185915;1748.2744660965811;1752.229019231534;1121.2039451989017;1121.5794077221042;1142.9085673146128;1145.2727518026113;1147.8565179352581;6617.437517810944;6756.4932630052945;6829.078074459983;6854.862902741917;6860.931390686029;5902.793402230901;7278.381337586258;7288;7305.086864141982;7376.668049937765;6866.244713081557;6867.450603951672;6868.690908909111;6875.621840798804;6880.179126558087;3196.680331966831;3863.2273545291055;3907.5897030811925;3912.5304963404574;3912.7261091723876;6738.898916516257;6742.393184613408;7741.61291935401;7758.185390533913;7764.417668674872;6229.56393052482;7565.546067235983;7628.80927976805;7643.350315223268;7648.42636802242;7687.461877668509;7707.421943354271;7723.227677232232;7729.343005844454;7739.419543534257;7367.852642947004;7382.2617738225745;7384.704611815468;7391.704331826667;7412.221716719882;7000.334968178015;7241.275872412716;7282.271772822675;7294.671739771829;7299.197088320174;7657.234276572298;7714.729984450517;7715.884261735966;7718.189590093184;7740.729074482366;4919.311296418433;4920.48334924842;4925.901481970269;4932.0135972804865;4934;7345.265473452612;7356.852862942818;7371.963140184264;7377.926220737939;7383.778486645409;6785.93214067853;7116.181639111568;7116.644167791486;7118.0034795127685;7126.821829454305;7017.228104908558;7050.15398152225;7054.435645148478;7074.398676112588;7080.964595176991;6924.930750692429;6939.89590156138;6943.340382663639;6952.130983627047;6960.582365058112;5833.737481813413;7074.752383666547;7077.858442831011;7085.787426377217;7088.362047415757;6698.196216454056;6710.094137291403;6834.248232694499;6959;6974.128233970754 13:34:42 INFO - PROCESS | 1665 | |5;yui.html;740.5593671765298;767.3707559800965;781.2773184804058;793.6785601831259;825.1418524734277;12972.545960891372;15511.844881551182;15878.603034924132;15888.443904463345;15890.84109158908;14954.700905981874;15026.248687565605;15040.924795376035;15057.096574205556;15080.472183473581;828.70580943765;839.1147339556766;985.8126955878378;992.7716625176214;1016.5628779624758;1018.6892997635755;1024.2062401638752;1025.6717850287912;1027.203916964355;1027.3425007994852;1075.9246852720312;1076.6447072466106;1078.2236789511578;1081.1026847716416;1082.631905152248;854.0136142755097;867.7049803066956;1038.5274700011478;1062.54310646422;1065.6589891234808;789.0294937227185;789.1989630525022;790.8932294140333;791.5923299500762;791.6714563456159;15674.608134796606;15687.372505099782;15728.37086516538;15742.763858542132;15768.526944191693;11807.763844723057;13167.473301067947;13171.934140329333;13324.467021319135;13384.799228011587;10191.694249172462;10218.18254539635;10271.229657775622;10557.313774604627;10575.312604680672;3569.0720412692885;3599.2801439711902;3641.0715267606856;3684.9815750921075;3853.1523064925673;87209;87578.56210718905;89646;90005.54997225037;90101.19797604077;9846.901530984598;9916.702498925044;9973;10198.541065652063;10279.074883260542;23731;23745.40636484067;23770.64344034841;23779;23834;7673.155952845183;7697.461177717506;7771;7771.222877712184;7943.292192178594;4135;4173.812178451977;4180.372944058355;4326.697131200785;4349.717268377545;3730.347189241872;3784.996975801415;3789.7157713171073;3791;3800.25894950482;644.5423749138071;661.7022339947043;663.0783211336246;670.735059651435;681.9556728812611;530.7638101045075;570.8858228354263;590.5039766595994;617.1699064757894;628.151994807016;7745.148033716287;7849.450538462367;8137.881665158783;8363.247307742333;8500.277476414574;502.30932467856695;601.3145014683265;604.4620287943645;606.548121649374;629.4618101523223;3616.439451884962;3920.0787814863484;4006.559278479365;4033.9713373089676;4084.959150408458;81127;96970;98810;100663;100706.49646751866;80743;81186;82493;83263;83941.74087388694;72427.63786181141;73556;73582.6320868403;73751;74604.25395745973;7898.960505197438;8001.319887809602;8128.065272493739;8158.224968627971;8181.590920453835;38477.80761096177;45300.09399811919;46434.53565464302;47142;47481.05037899292;59072.11391829212;68355;68760.6561967187;69499;70545;11042.447877605928;11341.716457088638;11401.144914131308;11502.82745758831;11670.299782013106;12005.339706316236;12235.632931012084;12318.260904345769;12663.430145643284;12748.872511274769;11632.767344653228;11750.823737643772;12039.518419263131;12199.634010979686;12346.197497162655;11815.822762658396;11931.880681193077;11988.400579971141;12081.335526546125;12462.875371246535;11581.42092895335;11758.00056995165;11891;12431.75136497247;12449.626511204679;9707.805843883225;9779;10129.240306976859;10228.335158214692;10391.53238104272;9601.183899368632;9832.950835245778;9898.10917017472;9941.532157313304;9953.601855925972 13:34:42 INFO - PROCESS | 1665 | __end_tp_report 13:34:42 INFO - PROCESS | 1665 | __start_cc_report 13:34:42 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1093 13:34:42 INFO - PROCESS | 1665 | __end_cc_report 13:34:42 INFO - PROCESS | 1665 | __startTimestamp1461702882852__endTimestamp 13:34:42 INFO - PROCESS | 1665 | 13:34:42 INFO - PROCESS | 1665 | ------- Summary: start ------- 13:34:42 INFO - PROCESS | 1665 | Number of tests: 6 13:34:42 INFO - PROCESS | 1665 | 13:34:42 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5847.36 Median:6079.24 stddev:626.27 (10.3%) stddev-sans-first:601.41 13:34:42 INFO - PROCESS | 1665 | Values: 3538.0 3616.6 3643.5 3643.6 3704.1 5851.8 5878.3 5878.4 5894.6 5942.6 5876.3 5893.4 5899.4 5913.0 5915.1 5232.1 5246.7 5267.1 5311.8 5323.9 5392.8 5402.0 5405.7 5407.2 5412.9 5320.5 5355.3 5358.1 5377.0 5379.2 5375.3 5382.4 5399.8 5409.6 5464.8 5146.7 5332.1 5332.2 5353.6 5361.3 5747.0 5782.7 5786.4 5799.2 5827.6 6208.7 6288.2 6290.4 6293.7 6300.4 5084.3 6215.6 6260.7 6278.9 6279.7 6052.2 6058.8 6077.5 6081.9 6105.8 6190.9 6239.4 6381.3 6396.1 6399.8 6302.3 6330.4 6330.5 6332.8 6358.7 6274.0 6295.7 6301.2 6313.2 6317.8 6198.1 6236.4 6240.6 6261.8 6310.5 6273.7 6279.1 6290.2 6294.6 6320.7 4947.4 4955.5 4966.5 4968.9 4979.5 3872.0 4441.0 4465.3 4534.6 4536.6 6047.8 6063.0 6064.0 6075.1 6095.8 6234.5 6246.1 6279.7 6281.5 6289.6 5866.7 5968.3 6030.7 6054.9 6112.8 5445.5 5448.6 5469.6 5484.7 5488.9 6457.6 6462.1 6468.5 6481.1 6491.9 6190.9 6231.9 6287.0 6292.2 6295.8 5536.2 6457.8 6482.3 6492.6 6503.2 5740.5 5937.8 6228.9 6291.9 6312.6 6223.8 6259.4 6270.0 6271.8 6291.6 5953.9 6105.4 6158.4 6166.7 6178.5 5440.3 6086.9 6176.5 6254.0 6271.8 6004.5 6069.7 6079.2 6096.0 6111.8 6215.2 6294.8 6296.9 6307.2 6334.7 5942.3 6062.1 6073.0 6159.8 6171.8 13:34:42 INFO - PROCESS | 1665 | 13:34:42 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:67005.22 Median:3497.11 stddev:138796.24 (3968.9%) stddev-sans-first:139095.77 13:34:42 INFO - PROCESS | 1665 | Values: 498.6 594.8 597.3 603.0 676.2 40210.8 40722.0 40872.8 40899.4 40994.2 43443.1 44310.6 44424.3 44430.3 44481.6 9819.4 10099.9 10113.8 10120.1 10121.3 9931.3 10065.4 10091.9 10093.9 10099.9 10045.6 10121.7 10122.6 10128.5 10138.0 10002.4 10087.8 10094.8 10096.4 10103.7 10000.6 10098.2 10135.3 10135.6 10142.8 43190.4 43572.3 43643.6 43664.6 43669.6 3293.5 3477.2 3517.0 3729.2 3984.9 29364.3 30432.4 30726.6 30741.1 30970.8 2802.2 2840.6 2872.1 2900.4 2924.2 403492.0 445871.0 461396.0 462710.0 464525.0 71550.6 71821.0 71906.3 72008.3 72055.6 76412.2 78933.6 78937.0 79082.6 79141.0 18779.9 18841.8 19072.2 19105.7 19119.3 14480.6 14524.7 14569.6 14571.7 14579.6 22876.0 23084.1 23204.4 23240.4 23658.6 9027.6 9263.3 9284.1 9286.5 9312.3 976.2 1028.1 1051.5 1066.9 1078.2 28283.9 29165.0 29297.6 29682.0 29780.7 1118.6 1193.9 1225.3 1265.8 1283.2 14918.6 15155.0 15286.1 15421.0 15638.2 658058.0 669327.0 674612.0 674663.0 675497.6 63111.7 64970.4 65019.7 65033.3 65084.0 1398.7 1420.7 1522.4 1529.8 1559.6 30019.8 30173.0 30726.0 31756.7 31942.0 51752.5 52131.0 52905.7 52921.2 52943.2 399833.0 401103.0 403511.0 404525.0 404711.0 30128.7 34548.1 35259.3 35464.8 35484.9 48576.3 51060.0 52563.2 53044.7 53874.4 37877.2 38794.6 39106.6 39117.4 39268.2 38952.0 39006.6 39143.6 39406.8 39743.0 38201.0 38480.2 38769.4 38874.2 39550.4 32804.8 33629.5 34069.0 34205.3 34259.7 25273.1 25355.9 25591.9 25917.9 26047.7 13:34:42 INFO - PROCESS | 1665 | 13:34:42 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:35779.44 Median:12030.23 stddev:108242.44 (899.8%) stddev-sans-first:108513.36 13:34:42 INFO - PROCESS | 1665 | Values: 331.0 381.5 382.1 389.7 393.3 20319.0 20967.8 21160.3 21810.6 21861.2 11308.9 11683.5 12456.9 12530.4 12552.1 5045.0 6268.8 6290.3 6306.2 6331.9 5976.3 6156.4 6242.2 6267.4 6271.5 6217.0 6235.6 6236.8 6241.7 6246.9 5625.3 5868.9 6203.1 6216.6 6218.0 5414.6 5446.8 5454.4 5458.9 5465.1 13974.2 14163.9 22538.7 26431.9 26550.0 2199.2 2216.7 2264.3 2518.8 2668.3 9850.9 9937.3 10053.5 10181.0 10293.2 1662.2 1797.8 1820.4 1878.4 1962.2 99830.0 105673.0 109031.4 111526.4 112142.8 11460.2 11580.9 11639.5 11658.9 11792.6 14427.0 14491.0 14495.0 14502.7 14509.6 9012.4 9143.5 9145.7 9176.0 9282.3 8285.7 9193.7 9476.0 9530.3 9562.1 4544.7 4568.1 4576.8 4582.5 4630.9 1803.9 1880.9 1936.0 1938.4 1943.6 853.8 905.8 963.5 997.6 1048.5 16817.2 19370.8 19731.0 19866.6 20267.0 994.6 1028.5 1031.4 1045.0 1052.3 11177.4 11367.0 11398.9 11402.3 11419.8 643826.6 648020.0 652251.0 660672.7 661556.0 121169.8 121391.0 123110.0 123558.0 127204.4 1071.3 1083.3 1088.6 1105.6 1105.6 17797.1 17889.2 18112.3 18148.9 18407.4 49861.8 51209.0 51226.0 52489.7 52622.7 73586.0 74734.8 76060.6 76204.1 76966.2 8220.4 8227.1 8351.0 8354.3 8570.8 12751.8 13308.9 13419.7 13733.8 14065.8 11764.8 11836.1 11958.4 12096.1 12100.5 5541.7 8482.6 11581.8 11796.0 11821.7 11776.6 12136.0 12419.4 12447.0 12519.4 8325.3 8354.5 8361.3 8533.0 8674.7 8742.4 11380.5 11970.0 12103.0 12133.8 13:34:42 INFO - PROCESS | 1665 | 13:34:42 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:6189.18 Median:552.98 stddev:3286.88 (594.4%) stddev-sans-first:3277.38 13:34:42 INFO - PROCESS | 1665 | Values: 1522.3 1688.6 1714.9 2081.3 2125.9 8246.9 8875.5 9011.3 9026.0 9059.0 8806.2 8934.5 8939.5 8940.4 8980.3 2558.2 2592.8 2598.3 2600.8 2604.1 2530.3 2593.2 2603.1 2604.7 2616.5 2353.9 2515.8 2587.7 2613.2 2613.3 2561.8 2587.1 2597.7 2598.9 2602.0 2557.4 2591.8 2595.3 2600.4 2600.6 8808.3 8919.6 8945.0 9024.9 9041.9 5612.2 5710.1 5713.4 5723.0 5759.2 3629.0 3741.2 3746.8 3789.8 3805.8 1065.7 1083.1 1086.0 1104.6 1124.6 11967.3 12314.3 12329.0 12336.9 12362.1 4457.8 4756.5 4794.5 4874.0 4898.9 9535.1 9546.6 9582.2 9593.1 9609.8 4816.7 5509.3 5555.2 5559.8 5564.6 4549.5 4719.5 4935.6 5057.6 5184.2 3327.4 3822.2 3894.3 3911.5 3945.3 1110.5 1245.9 1246.9 1247.1 1259.7 1159.5 1163.6 1272.8 1416.7 1439.1 8394.8 8459.7 8493.2 8493.8 8503.6 540.1 545.8 550.3 552.4 553.6 6264.7 6274.9 6377.6 6379.3 6380.5 10903.9 11285.8 11293.0 11433.5 11435.5 10741.8 11089.9 11118.5 11201.8 11218.8 8662.0 8707.5 8746.7 8749.5 8760.1 8045.5 8149.8 8155.6 8211.1 8235.2 9329.7 9828.3 9934.0 10119.6 10228.6 9650.6 9950.6 10092.7 10118.7 10120.5 7457.4 7578.8 7647.4 7669.3 7671.8 8368.3 8394.5 8456.5 8465.9 8583.1 7377.6 7532.1 7593.5 7624.3 7655.9 7004.6 7057.9 7143.4 7211.4 7553.3 7195.1 8010.2 8029.6 8038.9 8045.3 7141.7 7204.3 7210.2 7218.1 7295.3 7281.1 7292.7 7329.0 7345.2 7347.8 13:34:42 INFO - PROCESS | 1665 | 13:34:42 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:5850.34 Median:6700.40 stddev:1838.23 (27.4%) stddev-sans-first:1795.43 13:34:42 INFO - PROCESS | 1665 | Values: 292.9 343.6 347.9 353.8 354.3 6000.8 6636.0 6702.6 6706.2 6714.6 6676.2 6681.9 6689.8 6692.9 6706.7 4011.6 4054.3 4953.9 4968.1 5059.3 4132.3 4891.8 4951.9 4991.5 5006.3 4926.1 4933.7 4942.8 4955.3 4966.0 4068.8 4929.4 4948.5 4953.4 4967.6 4103.8 4156.4 4258.5 4273.3 4276.2 6230.8 6325.4 6353.8 6355.3 6375.5 5874.5 5886.6 5892.9 5897.8 5907.6 7108.4 7115.0 7117.1 7128.8 7142.4 4661.4 4802.0 4814.6 4816.3 4817.0 7386.4 7449.1 7485.9 7486.1 7507.6 4932.2 4944.8 4951.2 4953.2 4958.6 5057.7 5061.9 5063.9 5064.4 5071.4 5916.9 5928.2 5930.4 5934.1 5940.8 6896.1 7139.2 7148.6 7159.2 7177.5 1722.8 1727.9 1744.6 1748.3 1752.2 1121.2 1121.6 1142.9 1145.3 1147.9 6617.4 6756.5 6829.1 6854.9 6860.9 5902.8 7278.4 7288.0 7305.1 7376.7 6866.2 6867.5 6868.7 6875.6 6880.2 3196.7 3863.2 3907.6 3912.5 3912.7 6738.9 6742.4 7741.6 7758.2 7764.4 6229.6 7565.5 7628.8 7643.4 7648.4 7687.5 7707.4 7723.2 7729.3 7739.4 7367.9 7382.3 7384.7 7391.7 7412.2 7000.3 7241.3 7282.3 7294.7 7299.2 7657.2 7714.7 7715.9 7718.2 7740.7 4919.3 4920.5 4925.9 4932.0 4934.0 7345.3 7356.9 7372.0 7377.9 7383.8 6785.9 7116.2 7116.6 7118.0 7126.8 7017.2 7050.2 7054.4 7074.4 7081.0 6924.9 6939.9 6943.3 6952.1 6960.6 5833.7 7074.8 7077.9 7085.8 7088.4 6698.2 6710.1 6834.2 6959.0 6974.1 13:34:42 INFO - PROCESS | 1665 | 13:34:42 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:18960.33 Median:4059.47 stddev:26823.71 (660.8%) stddev-sans-first:26864.07 13:34:42 INFO - PROCESS | 1665 | Values: 740.6 767.4 781.3 793.7 825.1 12972.5 15511.8 15878.6 15888.4 15890.8 14954.7 15026.2 15040.9 15057.1 15080.5 828.7 839.1 985.8 992.8 1016.6 1018.7 1024.2 1025.7 1027.2 1027.3 1075.9 1076.6 1078.2 1081.1 1082.6 854.0 867.7 1038.5 1062.5 1065.7 789.0 789.2 790.9 791.6 791.7 15674.6 15687.4 15728.4 15742.8 15768.5 11807.8 13167.5 13171.9 13324.5 13384.8 10191.7 10218.2 10271.2 10557.3 10575.3 3569.1 3599.3 3641.1 3685.0 3853.2 87209.0 87578.6 89646.0 90005.5 90101.2 9846.9 9916.7 9973.0 10198.5 10279.1 23731.0 23745.4 23770.6 23779.0 23834.0 7673.2 7697.5 7771.0 7771.2 7943.3 4135.0 4173.8 4180.4 4326.7 4349.7 3730.3 3785.0 3789.7 3791.0 3800.3 644.5 661.7 663.1 670.7 682.0 530.8 570.9 590.5 617.2 628.2 7745.1 7849.5 8137.9 8363.2 8500.3 502.3 601.3 604.5 606.5 629.5 3616.4 3920.1 4006.6 4034.0 4085.0 81127.0 96970.0 98810.0 100663.0 100706.5 80743.0 81186.0 82493.0 83263.0 83941.7 72427.6 73556.0 73582.6 73751.0 74604.3 7899.0 8001.3 8128.1 8158.2 8181.6 38477.8 45300.1 46434.5 47142.0 47481.1 59072.1 68355.0 68760.7 69499.0 70545.0 11042.4 11341.7 11401.1 11502.8 11670.3 12005.3 12235.6 12318.3 12663.4 12748.9 11632.8 11750.8 12039.5 12199.6 12346.2 11815.8 11931.9 11988.4 12081.3 12462.9 11581.4 11758.0 11891.0 12431.8 12449.6 9707.8 9779.0 10129.2 10228.3 10391.5 9601.2 9833.0 9898.1 9941.5 9953.6 13:34:42 INFO - PROCESS | 1665 | -------- Summary: end -------- 13:34:42 INFO - PROCESS | 1665 | 13:34:43 INFO - TEST-INFO | 1665: exit 0 13:34:43 INFO - TEST-OK | dromaeo_css | took 1111240ms 13:34:43 INFO - TEST-START | kraken 13:34:43 INFO - operating with platform_type : mac_ 13:34:43 INFO - Initialising browser for kraken test... 13:34:43 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpxOOn7G/profile http://localhost:49278/getInfo.html) 13:34:45 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 13:34:45 INFO - PROCESS | 1673 | colorDepth:24 13:34:45 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 13:34:45 INFO - PROCESS | 1673 | __metrics 13:34:45 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:34:45 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:34:45 INFO - TEST-INFO | 1673: exit 0 13:34:45 INFO - Browser initialized. 13:34:45 INFO - Running cycle 1/1 for kraken test... 13:34:45 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpxOOn7G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:34:57 INFO - PROCESS | 1676 | RSS: Main: 157261824 13:34:57 INFO - PROCESS | 1676 | 13:35:00 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 13:35:00 INFO - PROCESS | 1676 | RSS: Main: 213848064 13:35:00 INFO - PROCESS | 1676 | 13:35:03 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 13:35:04 INFO - PROCESS | 1676 | RSS: Main: 223592448 13:35:04 INFO - PROCESS | 1676 | 13:35:07 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 13:35:08 INFO - PROCESS | 1676 | RSS: Main: 213192704 13:35:08 INFO - PROCESS | 1676 | 13:35:09 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 13:35:10 INFO - PROCESS | 1676 | RSS: Main: 215498752 13:35:10 INFO - PROCESS | 1676 | 13:35:12 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:35:13 INFO - PROCESS | 1676 | RSS: Main: 215207936 13:35:13 INFO - PROCESS | 1676 | 13:35:15 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 13:35:16 INFO - PROCESS | 1676 | RSS: Main: 215105536 13:35:16 INFO - PROCESS | 1676 | 13:35:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 13:35:19 INFO - PROCESS | 1676 | RSS: Main: 214872064 13:35:19 INFO - PROCESS | 1676 | 13:35:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 13:35:23 INFO - PROCESS | 1676 | RSS: Main: 215916544 13:35:23 INFO - PROCESS | 1676 | 13:35:24 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:35:25 INFO - PROCESS | 1676 | RSS: Main: 249614336 13:35:25 INFO - PROCESS | 1676 | 13:35:27 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:35:27 INFO - PROCESS | 1676 | RSS: Main: 249970688 13:35:27 INFO - PROCESS | 1676 | 13:35:29 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:35:30 INFO - PROCESS | 1676 | RSS: Main: 254767104 13:35:30 INFO - PROCESS | 1676 | 13:35:32 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:35:33 INFO - PROCESS | 1676 | RSS: Main: 257507328 13:35:33 INFO - PROCESS | 1676 | 13:35:35 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:35:36 INFO - PROCESS | 1676 | RSS: Main: 257433600 13:35:36 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 13:35:38 INFO - PROCESS | 1676 | RSS: Main: 319950848 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | __start_tp_report 13:35:38 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 13:35:38 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 13:35:38 INFO - PROCESS | 1676 | |i|pagename|runs| 13:35:38 INFO - PROCESS | 1676 | |0;ai-astar;112;108;111;110;113;113;119;112;110;111 13:35:38 INFO - PROCESS | 1676 | |1;audio-beat-detection;152;121;181;170;112;143;162;140;167;138 13:35:38 INFO - PROCESS | 1676 | |2;audio-dft;185;193;250;205;186;186;185;183;184;188 13:35:38 INFO - PROCESS | 1676 | |3;audio-fft;73;71;76;115;55;58;57;58;114;56 13:35:38 INFO - PROCESS | 1676 | |4;audio-oscillator;91;93;129;81;78;85;118;77;105;148 13:35:38 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;86;84;86;84;87;83;91;85;87;82 13:35:38 INFO - PROCESS | 1676 | |6;imaging-darkroom;133;142;93;93;93;93;93;93;92;93 13:35:38 INFO - PROCESS | 1676 | |7;imaging-desaturate;87;85;84;84;87;86;85;85;85;86 13:35:38 INFO - PROCESS | 1676 | |8;json-parse-financial;54;57;58;57;58;58;57;69;71;52 13:35:38 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;63;61;64;76;69;65;63;66;65;65 13:35:38 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;81;77;80;80;81;78;82;80;81;83 13:35:38 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;130;122;126;137;123;122;139;103;132;128 13:35:38 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;133;135;136;134;129;123;134;132;133;132 13:35:38 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;65;65;64;66;66;66;65;69;65;64 13:35:38 INFO - PROCESS | 1676 | __end_tp_report 13:35:38 INFO - PROCESS | 1676 | __start_cc_report 13:35:38 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1193 13:35:38 INFO - PROCESS | 1676 | __end_cc_report 13:35:38 INFO - PROCESS | 1676 | __startTimestamp1461702938443__endTimestamp 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | ------- Summary: start ------- 13:35:38 INFO - PROCESS | 1676 | Number of tests: 14 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:2.92 (2.6%) stddev-sans-first:3.10 13:35:38 INFO - PROCESS | 1676 | Values: 112.0 108.0 111.0 110.0 113.0 113.0 119.0 112.0 110.0 111.0 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:157.00 stddev:22.00 (14.0%) stddev-sans-first:23.30 13:35:38 INFO - PROCESS | 1676 | Values: 152.0 121.0 181.0 170.0 112.0 143.0 162.0 140.0 167.0 138.0 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:194.50 Median:187.00 stddev:20.55 (11.0%) stddev-sans-first:21.51 13:35:38 INFO - PROCESS | 1676 | Values: 185.0 193.0 250.0 205.0 186.0 186.0 185.0 183.0 184.0 188.0 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:73.30 Median:58.00 stddev:23.04 (39.7%) stddev-sans-first:24.43 13:35:38 INFO - PROCESS | 1676 | Values: 73.0 71.0 76.0 115.0 55.0 58.0 57.0 58.0 114.0 56.0 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:100.50 Median:79.50 stddev:24.08 (30.3%) stddev-sans-first:25.30 13:35:38 INFO - PROCESS | 1676 | Values: 91.0 93.0 129.0 81.0 78.0 85.0 118.0 77.0 105.0 148.0 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.00 stddev:2.55 (3.0%) stddev-sans-first:2.70 13:35:38 INFO - PROCESS | 1676 | Values: 86.0 84.0 86.0 84.0 87.0 83.0 91.0 85.0 87.0 82.0 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:101.80 Median:93.00 stddev:18.94 (20.4%) stddev-sans-first:16.38 13:35:38 INFO - PROCESS | 1676 | Values: 133.0 142.0 93.0 93.0 93.0 93.0 93.0 93.0 92.0 93.0 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:1.07 (1.3%) stddev-sans-first:0.97 13:35:38 INFO - PROCESS | 1676 | Values: 87.0 85.0 84.0 84.0 87.0 86.0 85.0 85.0 85.0 86.0 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:58.00 stddev:6.08 (10.5%) stddev-sans-first:6.16 13:35:38 INFO - PROCESS | 1676 | Values: 54.0 57.0 58.0 57.0 58.0 58.0 57.0 69.0 71.0 52.0 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:65.00 stddev:4.19 (6.4%) stddev-sans-first:4.33 13:35:38 INFO - PROCESS | 1676 | Values: 63.0 61.0 64.0 76.0 69.0 65.0 63.0 66.0 65.0 65.0 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:81.00 stddev:1.77 (2.2%) stddev-sans-first:1.86 13:35:38 INFO - PROCESS | 1676 | Values: 81.0 77.0 80.0 80.0 81.0 78.0 82.0 80.0 81.0 83.0 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:129.00 stddev:10.09 (7.8%) stddev-sans-first:10.60 13:35:38 INFO - PROCESS | 1676 | Values: 130.0 122.0 126.0 137.0 123.0 122.0 139.0 103.0 132.0 128.0 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.10 Median:133.50 stddev:3.73 (2.8%) stddev-sans-first:3.94 13:35:38 INFO - PROCESS | 1676 | Values: 133.0 135.0 136.0 134.0 129.0 123.0 134.0 132.0 133.0 132.0 13:35:38 INFO - PROCESS | 1676 | 13:35:38 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.43 (2.2%) stddev-sans-first:1.51 13:35:38 INFO - PROCESS | 1676 | Values: 65.0 65.0 64.0 66.0 66.0 66.0 65.0 69.0 65.0 64.0 13:35:38 INFO - PROCESS | 1676 | -------- Summary: end -------- 13:35:38 INFO - PROCESS | 1676 | 13:35:39 INFO - TEST-INFO | 1676: exit 0 13:35:39 INFO - TEST-OK | kraken | took 55848ms 13:35:39 INFO - SUITE-END | took 1167s 13:35:39 INFO - Completed test suite (00:19:27) 13:35:39 INFO - javascript benchmark 13:35:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3537.982310088449, 3616.6202548732367, 3643.544556930384, 3643.580988186358, 3704.1480459494314, 5851.79518716845, 5878.294604647443, 5878.382769809173, 5894.587378883474, 5942.61373010754, 5876.324222714389, 5893.351731309553, 5899.351071382155, 5913.024350982094, 5915.083162109869, 5232.110541208004, 5246.737663116848, 5267.104592219332, 5311.760970756325, 5323.866903327428, 5392.757325920343, 5402.0, 5405.729713514309, 5407.188921661763, 5412.91880621789, 5320.494553017457, 5355.303810504648, 5358.062339090663, 5376.973115134439, 5379.220013098098, 5375.274337964383, 5382.440498451718, 5399.838004859841, 5409.594280428944, 5464.808731694411, 5146.6911985281, 5332.146856502941, 5332.200169974496, 5353.571714262888, 5361.276227709287, 5747.0, 5782.7108644568025, 5786.363500014995, 5799.18811366409, 5827.592068555203, 6208.72060757267, 6288.182536270301, 6290.402411770874, 6293.685315734241, 6300.401461861115, 5084.339035925343, 6215.56491045627, 6260.718267677966, 6278.87442251157, 6279.6860156992425, 6052.213212282375, 6058.757649694007, 6077.453029227347, 6081.908771368433, 6105.786297479655, 6190.876182476415, 6239.376062393815, 6381.266154392211, 6396.0725694774, 6399.8080057598345, 6302.275238347557, 6330.3669633036325, 6330.52521060913, 6332.810015699536, 6358.682065896779, 6274.027525733519, 6295.716692748837, 6301.243850737941, 6313.179286692701, 6317.810465686037, 6198.101275315054, 6236.376362363727, 6240.594361366497, 6261.843453913598, 6310.4636105930595, 6273.749050038039, 6279.120923070774, 6290.21372328459, 6294.590851594632, 6320.652364119926, 4947.431045429749, 4955.4548999610015, 4966.453690094087, 4968.875778105504, 4979.4771548987555, 3871.9806400967814, 4441.0, 4465.307877279027, 4534.614557762628, 4536.637069034469, 6047.848803779941, 6063.029915213633, 6064.0, 6075.149479072933, 6095.786647467317, 6234.470070044097, 6246.063090536365, 6279.717412716439, 6281.528885333527, 6289.591176573508, 5866.7066646668345, 5968.283805943314, 6030.728617212236, 6054.939450605526, 6112.7554897804475, 5445.50990410865, 5448.618596698272, 5469.644473109235, 5484.698341591251, 5488.890222195613, 6457.61254324742, 6462.095306657072, 6468.514861385415, 6481.125048118443, 6491.896377615817, 6190.938090619036, 6231.875362492634, 6286.968565157145, 6292.2134733158355, 6295.779647712308, 5536.173062889156, 6457.838554035999, 6482.286948435574, 6492.64290464029, 6503.219613646393, 5740.454656807597, 5937.762489500545, 6228.937710623017, 6291.874162516632, 6312.621242725451, 6223.782167624111, 6259.405356491126, 6270.0, 6271.843203919939, 6291.591046581958, 5953.940460595339, 6105.3894610540365, 6158.384161583985, 6166.691665416622, 6178.474829639531, 5440.265564148789, 6086.873928323274, 6176.474999625082, 6254.0, 6271.811845644638, 6004.489618382487, 6069.666168360606, 6079.240094988127, 6096.02463605821, 6111.755529778759, 6215.160953271251, 6294.8111556653375, 6296.874062518632, 6307.180066591497, 6334.6832658365975, 5942.346341902301, 6062.060380641008, 6072.969635151796, 6159.84600384994, 6171.7531298749345], "unit": "score", "name": "dojo.html", "value": 5809.955984651779}, {"lowerIsBetter": false, "replicates": [498.6135744797784, 594.8126340202839, 597.3309892919928, 603.0110618585519, 676.2054585861612, 40210.79894600526, 40722.0, 40872.79563602185, 40899.38650920235, 40994.18011639769, 43443.13113737731, 44310.55689443104, 44424.3336349955, 44430.33354499677, 44481.555184448145, 9819.410835349901, 10099.949500252489, 10113.848292275621, 10120.089191972758, 10121.291509594332, 9931.255155863302, 10065.446400447972, 10091.899081009205, 10093.899061009406, 10099.889012208689, 10045.64840230592, 10121.746956326077, 10122.595096196143, 10128.493575321205, 10138.03688649577, 10002.399856008626, 10087.798244035152, 10094.79810403795, 10096.394216347042, 10103.696889093339, 10000.59997600095, 10098.192144628412, 10135.341202821794, 10135.645252416203, 10142.847857282073, 43190.35214471786, 43572.346414803804, 43643.56356436459, 43664.563354366685, 43669.563304367184, 3293.4565796643524, 3477.23500829817, 3516.9800757780213, 3729.198222382201, 3984.900377490557, 29364.26589335262, 30432.391352172832, 30726.620071792084, 30741.077767667004, 30970.845145774354, 2802.201372608817, 2840.630718006646, 2872.138358492444, 2900.376419069889, 2924.2250803536867, 403492.0, 445870.99999999674, 461396.0, 462710.0, 464525.0, 71550.64224678843, 71821.0, 71906.28093719101, 72008.27991720015, 72055.6397218021, 76412.23587764162, 78933.60533197297, 78937.0, 79082.6045869767, 79141.0, 18779.906100469685, 18841.81158188428, 19072.237110515423, 19105.713414298796, 19119.33082342139, 14480.637984050272, 14524.709505809824, 14569.562913112624, 14571.708565828623, 14579.635509112357, 22875.97058132388, 23084.07663693467, 23204.41988950256, 23240.41898952506, 23658.64512032321, 9027.593758280893, 9263.25893928484, 9284.071592840663, 9286.489243091695, 9312.255019598417, 976.2043934193609, 1028.095276156977, 1051.4795176387738, 1066.946652667379, 1078.2075174746556, 28283.858580707376, 29164.979225727, 29297.56053659197, 29682.0, 29780.702192978228, 1118.5917140243753, 1193.9104567157324, 1225.3444407242082, 1265.784816581165, 1283.1723538317733, 14918.627034324229, 15155.014924029903, 15286.082835029934, 15421.0, 15638.2180890955, 658058.0, 669327.0, 674612.0, 674663.0, 675497.6225118843, 63111.73776524444, 64970.350296497374, 65019.67490162519, 65033.34966650367, 65084.02373964394, 1398.6573289544126, 1420.6803469219549, 1522.3910435825758, 1529.8164220293636, 1559.563322269789, 30019.849900750356, 30173.0, 30726.0, 31756.682433175374, 31942.0, 51752.482475174766, 52130.95738085293, 52905.7354713224, 52921.206181906535, 52943.20585191302, 399833.0, 401103.0, 403511.0, 404525.0, 404711.0, 30128.69871301259, 34548.136296592784, 35259.294814103065, 35464.822675886455, 35484.935451936486, 48576.271355928984, 51060.0, 52563.21155182752, 53044.73477632587, 53874.42067424156, 37877.24245515019, 38794.6120538791, 39106.6089339103, 39117.41323880087, 39268.215270476634, 38952.0, 39006.6099339003, 39143.60856391399, 39406.802965986135, 39743.0, 38201.0, 38480.23039539137, 38769.4184587237, 38874.22251555009, 39550.40674389829, 32804.835975820926, 33629.495557566166, 34069.0, 34205.315893682484, 34259.657403426645, 25273.11544095948, 25355.873220633777, 25591.87204063968, 25917.870410647825, 26047.73952260453], "unit": "score", "name": "ext.html", "value": 21127.697135463357}, {"lowerIsBetter": false, "replicates": [330.97848639838406, 381.49832969644916, 382.10015413700734, 389.7408223531352, 393.2704832535648, 20319.0, 20967.790322096775, 21160.25939092132, 21810.563788724216, 21861.234856780015, 11308.92565206306, 11683.474243659035, 12456.937715311411, 12530.436130374132, 12552.121351505399, 5045.016221836743, 6268.811935641938, 6290.276618188921, 6306.243250809886, 6331.936680633204, 5976.282846058457, 6156.445919867211, 6242.219722534684, 6267.404596563342, 6271.498280137578, 6217.0, 6235.625862448245, 6236.781712640059, 6241.7191226394925, 6246.906296405557, 5625.268715067056, 5868.882622347572, 6203.100550420187, 6216.564840461169, 6217.968910155466, 5414.620976531644, 5446.782128714846, 5454.400015998237, 5458.8908221835345, 5465.098258787295, 13974.231417272045, 14163.929180354033, 22538.661920071212, 26431.867840660867, 26550.0, 2199.230269405711, 2216.6728019818715, 2264.275431861805, 2518.798496120306, 2668.292902380851, 9850.852237216448, 9937.304388692794, 10053.497325133787, 10181.0, 10293.176545876388, 1662.2104500362352, 1797.7932537758063, 1820.3719716697717, 1878.3707458001586, 1962.2445358536922, 99830.0, 105673.0, 109031.36452953212, 111526.44236778845, 112142.75714485665, 11460.19778615489, 11580.942095289469, 11639.47622356996, 11658.94170529142, 11792.646220613395, 14427.0, 14490.985631005939, 14495.0, 14502.709945801025, 14509.564713058626, 9012.41419307743, 9143.54282285883, 9145.725628231165, 9176.0, 9282.30382721285, 8285.710000149966, 9193.712880196777, 9475.952620236854, 9530.282510157378, 9562.139407453362, 4544.6818722689095, 4568.0863827234025, 4576.816927322936, 4582.495925448198, 4630.930536041962, 1803.9368622098164, 1880.9341673041379, 1935.9806401936082, 1938.4378530226077, 1943.5626983928503, 853.7865533616596, 905.7780843693338, 963.5375019990444, 997.5760301871676, 1048.501961568249, 16817.15914204285, 19370.80629193718, 19731.0, 19866.60266794656, 20266.996958452262, 994.6071301835879, 1028.5268776362957, 1031.3863251365426, 1045.0, 1052.2897044494935, 11177.441127943734, 11366.976972072553, 11398.94300528492, 11402.258853174517, 11419.771604568028, 643826.561734386, 648020.0, 652251.0, 660672.6966365234, 661556.0, 121169.78830211761, 121391.0, 123110.0, 123558.0, 127204.36397817952, 1071.3250652089134, 1083.3012706804225, 1088.559133550929, 1105.5522513382093, 1105.5633024955098, 17797.11014449298, 17889.19498622539, 18112.27550898002, 18148.909255453636, 18407.355742548945, 49861.75069124776, 51209.0, 51226.0, 52489.737551312, 52622.73688631685, 73586.0, 74734.76856619984, 76060.61969690117, 76204.094897628, 76966.2303376959, 8220.424570280024, 8227.13615070409, 8350.958245208734, 8354.289885359813, 8570.757240200011, 12751.788415361756, 13308.866911330762, 13419.731605368033, 13733.793993090312, 14065.789013164605, 11764.82352764692, 11836.053115750547, 11958.402079896145, 12096.092793040732, 12100.515979360727, 5541.695206763667, 8482.57587120629, 11581.826272606086, 11796.0, 11821.704457388634, 11776.646700598996, 12136.029117670389, 12419.441125149571, 12447.0, 12519.374031298217, 8325.25072743456, 8354.45696029756, 8361.289290410139, 8532.957335213285, 8674.696385626472, 8742.38803283764, 11380.487878045342, 11970.0, 12103.0, 12133.817992730294], "unit": "score", "name": "jquery.html", "value": 9537.920765156825}, {"lowerIsBetter": false, "replicates": [1522.2540954932088, 1688.569414799226, 1714.8542373898217, 2081.2611522909365, 2125.904334304956, 8246.91753082469, 8875.467471951679, 9011.324150688692, 9025.999999999984, 9059.048799876009, 8806.16341447563, 8934.463932164075, 8939.508327042011, 8940.418872773282, 8980.32647551433, 2558.219742978391, 2592.8055395845386, 2598.2984594159566, 2600.8049396295355, 2604.0625374865035, 2530.342111051131, 2593.209071233273, 2603.0759080526423, 2604.726503717111, 2616.502864455757, 2353.9058437662475, 2515.7861581765574, 2587.7024142223695, 2613.216035189445, 2613.3466633341664, 2561.8078644101674, 2587.0815860369485, 2597.6623039004903, 2598.9090381836736, 2602.0112357304292, 2557.3734435063343, 2591.7796987256106, 2595.3252154439792, 2600.388908606476, 2600.6489123968213, 8808.295336373074, 8919.598618062202, 8944.955275223647, 9024.909750902472, 9041.909580904172, 5612.214289999362, 5710.14347847822, 5713.428657134295, 5722.971385143048, 5759.164921086419, 3628.981855090734, 3741.1956429367815, 3746.831392587313, 3789.829457674411, 3805.847766089353, 1065.690949624608, 1083.0523292119397, 1085.9511321990528, 1104.6465131158034, 1124.5839039555335, 11967.26474661178, 12314.322712250823, 12328.95203907678, 12336.876631233752, 12362.134650574464, 4457.77711114443, 4756.500567440438, 4794.541017084198, 4874.049560335771, 4898.926516102261, 9535.094166054214, 9546.570404331822, 9582.233421326277, 9593.088656577615, 9609.759756006155, 4816.686915350491, 5509.338879334506, 5555.2222688823595, 5559.833205003856, 5564.582656300794, 4549.545045495424, 4719.457262414798, 4935.555799978019, 5057.595392368602, 5184.196449550326, 3327.434336162858, 3822.1782316801464, 3894.337962546374, 3911.4915061041884, 3945.270125026879, 1110.4947249001846, 1245.9003279737599, 1246.8628450870578, 1247.1106273994906, 1259.7480503899258, 1159.5014143918027, 1163.5752950173126, 1272.8027155790867, 1416.7095745372173, 1439.0861802755117, 8394.8321033579, 8459.703910363107, 8493.193146651058, 8493.787655308543, 8503.617337219715, 540.1303900719838, 545.8062387852335, 550.2763865516913, 552.3840917377096, 553.5820455556029, 6264.655443950626, 6274.905876411857, 6377.617342959345, 6379.266384365857, 6380.489560835122, 10903.945480272549, 11285.774284514264, 11293.0, 11433.542658293742, 11435.542578296941, 10741.78516429667, 11089.944550277198, 11118.499667514981, 11201.831972520418, 11218.831717524243, 8661.956690216635, 8707.521086340186, 8746.69386571467, 8749.47503149813, 8760.123987601317, 8045.477043992122, 8149.79625509367, 8155.592220389076, 8211.096779354148, 8235.176482351717, 9329.72010839676, 9828.31201815866, 9934.006599340297, 10119.645812396531, 10228.64199753005, 9650.613975440903, 9950.601975921172, 10092.747681308027, 10118.747031323981, 10120.493975301353, 7457.440691948234, 7578.772636820904, 7647.38820894316, 7669.309762121436, 7671.769846904602, 8368.288695460955, 8394.45436046655, 8456.534890581077, 8465.915340846514, 8583.141685831368, 7377.594232317274, 7532.096148462, 7593.468457207942, 7624.27569380908, 7655.923440765521, 7004.649767511706, 7057.929420705727, 7143.357097861218, 7211.42308615299, 7553.32020118192, 7195.100612423447, 8010.158933311918, 8029.558374289237, 8038.87941680887, 8045.275925166763, 7141.678624461808, 7204.279572042754, 7210.206877243604, 7218.061651985208, 7295.343419092307, 7281.05346304977, 7292.744753933587, 7329.0, 7345.192028876712, 7347.8163045924275], "unit": "score", "name": "mootools.html", "value": 4965.448412576519}, {"lowerIsBetter": false, "replicates": [292.88577454792636, 343.56024288910186, 347.8573784748254, 353.79833494907905, 354.2737388353874, 6000.829838181551, 6636.004599310106, 6702.597844129344, 6706.195256569206, 6714.597124172553, 6676.165479315086, 6681.892919792295, 6689.799306020815, 6692.899606505906, 6706.664666766655, 4011.638952494275, 4054.331035379159, 4953.851384458454, 4968.105740966625, 5059.29169916213, 4132.29750942339, 4891.779869905845, 4951.93533390321, 4991.5258050485145, 5006.349174607296, 4926.064047830919, 4933.679310844802, 4942.827001054964, 4955.331030310916, 4965.975170124144, 4068.776217308032, 4929.383827021622, 4948.455669876311, 4953.3560637117125, 4967.627427942919, 4103.753774773523, 4156.358238495807, 4258.510271318807, 4273.3162693969125, 4276.2089013532595, 6230.844228894269, 6325.430711235965, 6353.8411539711415, 6355.269144048448, 6375.489960803125, 5874.5006674432725, 5886.587938844283, 5892.941070589282, 5897.8230653080045, 5907.645541267538, 7108.431325493948, 7115.0, 7117.110361204849, 7128.821779455555, 7142.4286057115305, 4661.440627124767, 4802.039592081563, 4814.614830813526, 4816.277558366238, 4816.951830481686, 7386.409087273005, 7449.106107267163, 7485.887711684329, 7486.101667799844, 7507.587082710449, 4932.161532539477, 4944.777485013183, 4951.207806750903, 4953.23224900141, 4958.603311735053, 5057.69653820772, 5061.898762024739, 5063.8987220255385, 5064.366954130734, 5071.366079240095, 5916.911246331309, 5928.199693041384, 5930.436608522184, 5934.109883517507, 5940.762369505172, 6896.137982752156, 7139.178994415709, 7148.64256787169, 7159.248278930741, 7177.497575169792, 1722.84494395505, 1727.93952211672, 1744.6423483185915, 1748.2744660965811, 1752.229019231534, 1121.2039451989017, 1121.5794077221042, 1142.9085673146128, 1145.2727518026113, 1147.8565179352581, 6617.437517810944, 6756.4932630052945, 6829.078074459983, 6854.862902741917, 6860.931390686029, 5902.793402230901, 7278.381337586258, 7288.0, 7305.086864141982, 7376.668049937765, 6866.244713081557, 6867.450603951672, 6868.690908909111, 6875.621840798804, 6880.179126558087, 3196.680331966831, 3863.2273545291055, 3907.5897030811925, 3912.5304963404574, 3912.7261091723876, 6738.898916516257, 6742.393184613408, 7741.61291935401, 7758.185390533913, 7764.417668674872, 6229.56393052482, 7565.546067235983, 7628.80927976805, 7643.350315223268, 7648.42636802242, 7687.461877668509, 7707.421943354271, 7723.227677232232, 7729.343005844454, 7739.419543534257, 7367.852642947004, 7382.2617738225745, 7384.704611815468, 7391.704331826667, 7412.221716719882, 7000.334968178015, 7241.275872412716, 7282.271772822675, 7294.671739771829, 7299.197088320174, 7657.234276572298, 7714.729984450517, 7715.884261735966, 7718.189590093184, 7740.729074482366, 4919.311296418433, 4920.48334924842, 4925.901481970269, 4932.0135972804865, 4934.0, 7345.265473452612, 7356.852862942818, 7371.963140184264, 7377.926220737939, 7383.778486645409, 6785.93214067853, 7116.181639111568, 7116.644167791486, 7118.0034795127685, 7126.821829454305, 7017.228104908558, 7050.15398152225, 7054.435645148478, 7074.398676112588, 7080.964595176991, 6924.930750692429, 6939.89590156138, 6943.340382663639, 6952.130983627047, 6960.582365058112, 5833.737481813413, 7074.752383666547, 7077.858442831011, 7085.787426377217, 7088.362047415757, 6698.196216454056, 6710.094137291403, 6834.248232694499, 6959.0, 6974.128233970754], "unit": "score", "name": "prototype.html", "value": 5242.200694082616}, {"lowerIsBetter": false, "replicates": [740.5593671765298, 767.3707559800965, 781.2773184804058, 793.6785601831259, 825.1418524734277, 12972.545960891372, 15511.844881551182, 15878.603034924132, 15888.443904463345, 15890.84109158908, 14954.700905981874, 15026.248687565605, 15040.924795376035, 15057.096574205556, 15080.472183473581, 828.70580943765, 839.1147339556766, 985.8126955878378, 992.7716625176214, 1016.5628779624758, 1018.6892997635755, 1024.2062401638752, 1025.6717850287912, 1027.203916964355, 1027.3425007994852, 1075.9246852720312, 1076.6447072466106, 1078.2236789511578, 1081.1026847716416, 1082.631905152248, 854.0136142755097, 867.7049803066956, 1038.5274700011478, 1062.54310646422, 1065.6589891234808, 789.0294937227185, 789.1989630525022, 790.8932294140333, 791.5923299500762, 791.6714563456159, 15674.608134796606, 15687.372505099782, 15728.37086516538, 15742.763858542132, 15768.526944191693, 11807.763844723057, 13167.473301067947, 13171.934140329333, 13324.467021319135, 13384.799228011587, 10191.694249172462, 10218.18254539635, 10271.229657775622, 10557.313774604627, 10575.312604680672, 3569.0720412692885, 3599.2801439711902, 3641.0715267606856, 3684.9815750921075, 3853.1523064925673, 87209.0, 87578.56210718905, 89646.0, 90005.54997225037, 90101.19797604077, 9846.901530984598, 9916.702498925044, 9973.0, 10198.541065652063, 10279.074883260542, 23731.0, 23745.40636484067, 23770.64344034841, 23779.0, 23834.0, 7673.155952845183, 7697.461177717506, 7771.0, 7771.222877712184, 7943.292192178594, 4135.0, 4173.812178451977, 4180.372944058355, 4326.697131200785, 4349.717268377545, 3730.347189241872, 3784.996975801415, 3789.7157713171073, 3791.0, 3800.25894950482, 644.5423749138071, 661.7022339947043, 663.0783211336246, 670.735059651435, 681.9556728812611, 530.7638101045075, 570.8858228354263, 590.5039766595994, 617.1699064757894, 628.151994807016, 7745.148033716287, 7849.450538462367, 8137.881665158783, 8363.247307742333, 8500.277476414574, 502.30932467856695, 601.3145014683265, 604.4620287943645, 606.548121649374, 629.4618101523223, 3616.439451884962, 3920.0787814863484, 4006.559278479365, 4033.9713373089676, 4084.959150408458, 81127.0, 96970.0, 98810.0, 100663.0, 100706.49646751866, 80743.0, 81186.0, 82493.0, 83263.0, 83941.74087388694, 72427.63786181141, 73556.0, 73582.6320868403, 73751.0, 74604.25395745973, 7898.960505197438, 8001.319887809602, 8128.065272493739, 8158.224968627971, 8181.590920453835, 38477.80761096177, 45300.09399811919, 46434.53565464302, 47142.0, 47481.05037899292, 59072.11391829212, 68355.0, 68760.6561967187, 69499.0, 70545.0, 11042.447877605928, 11341.716457088638, 11401.144914131308, 11502.82745758831, 11670.299782013106, 12005.339706316236, 12235.632931012084, 12318.260904345769, 12663.430145643284, 12748.872511274769, 11632.767344653228, 11750.823737643772, 12039.518419263131, 12199.634010979686, 12346.197497162655, 11815.822762658396, 11931.880681193077, 11988.400579971141, 12081.335526546125, 12462.875371246535, 11581.42092895335, 11758.00056995165, 11891.0, 12431.75136497247, 12449.626511204679, 9707.805843883225, 9779.0, 10129.240306976859, 10228.335158214692, 10391.53238104272, 9601.183899368632, 9832.950835245778, 9898.10917017472, 9941.532157313304, 9953.601855925972], "unit": "score", "name": "yui.html", "value": 7202.9447910141}], "name": "dromaeo_css", "value": 7766.931524255017}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 110.0, 113.0, 113.0, 119.0, 112.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [152.0, 121.0, 181.0, 170.0, 112.0, 143.0, 162.0, 140.0, 167.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [185.0, 193.0, 250.0, 205.0, 186.0, 186.0, 185.0, 183.0, 184.0, 188.0], "unit": "score", "name": "audio-dft", "value": 194.5}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 76.0, 115.0, 55.0, 58.0, 57.0, 58.0, 114.0, 56.0], "unit": "score", "name": "audio-fft", "value": 73.3}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 129.0, 81.0, 78.0, 85.0, 118.0, 77.0, 105.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 100.5}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 86.0, 84.0, 87.0, 83.0, 91.0, 85.0, 87.0, 82.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.5}, {"lowerIsBetter": true, "replicates": [133.0, 142.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 101.8}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 84.0, 84.0, 87.0, 86.0, 85.0, 85.0, 85.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.4}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 58.0, 57.0, 58.0, 58.0, 57.0, 69.0, 71.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [63.0, 61.0, 64.0, 76.0, 69.0, 65.0, 63.0, 66.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [81.0, 77.0, 80.0, 80.0, 81.0, 78.0, 82.0, 80.0, 81.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.3}, {"lowerIsBetter": true, "replicates": [130.0, 122.0, 126.0, 137.0, 123.0, 122.0, 139.0, 103.0, 132.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.2}, {"lowerIsBetter": true, "replicates": [133.0, 135.0, 136.0, 134.0, 129.0, 123.0, 134.0, 132.0, 133.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.1}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 66.0, 66.0, 66.0, 65.0, 69.0, 65.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1430.3999999999999}]} 13:35:39 INFO - Return code: 0 13:35:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:35:39 INFO - # TBPL SUCCESS # 13:35:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:35:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:35:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:35:39 INFO - 2016-04-26 13:35:39.757 screenresolution[1680:9785] starting screenresolution argv=screenresolution get 13:35:39 INFO - 2016-04-26 13:35:39.760 screenresolution[1680:9785] Display 0: 1600x1200x32@60 13:35:39 INFO - 2016-04-26 13:35:39.765 screenresolution[1681:9788] starting screenresolution argv=screenresolution list 13:35:39 INFO - Available Modes on Display 0 13:35:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:35:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:35:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:35:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:35:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:35:39 INFO - Intel Iris: 13:35:39 INFO - Chipset Model: Intel Iris 13:35:39 INFO - Type: GPU 13:35:39 INFO - Bus: Built-In 13:35:39 INFO - VRAM (Dynamic, Max): 1536 MB 13:35:39 INFO - Vendor: Intel (0x8086) 13:35:39 INFO - Device ID: 0x0a2e 13:35:39 INFO - Revision ID: 0x0009 13:35:39 INFO - Displays: 13:35:39 INFO - Display: 13:35:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:35:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:35:39 INFO - Display Serial Number: 1600x1200 60 13:35:39 INFO - Main Display: Yes 13:35:39 INFO - Mirror: Off 13:35:39 INFO - Online: Yes 13:35:39 INFO - Rotation: Supported 13:35:39 INFO - Return code: 0 13:35:39 INFO - Running post-action listener: _resource_record_post_action 13:35:39 INFO - Running post-run listener: _resource_record_post_run 13:35:41 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 37729792; Write bytes: 508820480; Read time: 392; Write time: 1596 13:35:41 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 202045952; Write bytes: 196161536; Read time: 17976; Write time: 340 13:35:41 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 31481344; Write bytes: 302701568; Read time: 309; Write time: 1228 13:35:41 INFO - Running post-run listener: _upload_blobber_files 13:35:41 INFO - Blob upload gear active. 13:35:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:35:41 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 13:35:41 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'] 13:35:41 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 13:35:41 INFO - (blobuploader) - INFO - Open directory for files ... 13:35:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:35:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:35:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:42 INFO - (blobuploader) - INFO - Done attempting. 13:35:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:35:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:35:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:43 INFO - (blobuploader) - INFO - Done attempting. 13:35:43 INFO - (blobuploader) - INFO - Iteration through files over. 13:35:43 INFO - Return code: 0 13:35:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:35:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:35:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/404492066a45d793cc5a4fb1e81f0a76fa27cd9fff8bf0844594c2e21d9a504022c682ad13aaab2b15217d2bcfab841c82c714d102ba82dc565fecb36b7e0969", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d82502d3eb0136236e46795b268d7c22753f5334d18b8866f563c2b39c9917bc38e6b7b878a52885181f9860e11f54de34dac6b4e1887bf2f7584bd7e039cc6"} 13:35:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:35:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:35:43 INFO - Contents: 13:35:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/404492066a45d793cc5a4fb1e81f0a76fa27cd9fff8bf0844594c2e21d9a504022c682ad13aaab2b15217d2bcfab841c82c714d102ba82dc565fecb36b7e0969", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d82502d3eb0136236e46795b268d7c22753f5334d18b8866f563c2b39c9917bc38e6b7b878a52885181f9860e11f54de34dac6b4e1887bf2f7584bd7e039cc6"} 13:35:43 INFO - Running post-run listener: copy_logs_to_upload_dir 13:35:43 INFO - Copying logs to upload dir... 13:35:43 INFO - mkdir: /builds/slave/test/build/upload/logs 13:35:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1298.932631 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-04-26 13:35:43.278942) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 13:35:43.282588) ========= 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.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/404492066a45d793cc5a4fb1e81f0a76fa27cd9fff8bf0844594c2e21d9a504022c682ad13aaab2b15217d2bcfab841c82c714d102ba82dc565fecb36b7e0969", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d82502d3eb0136236e46795b268d7c22753f5334d18b8866f563c2b39c9917bc38e6b7b878a52885181f9860e11f54de34dac6b4e1887bf2f7584bd7e039cc6"} build_url:https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011038 build_url: 'https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/404492066a45d793cc5a4fb1e81f0a76fa27cd9fff8bf0844594c2e21d9a504022c682ad13aaab2b15217d2bcfab841c82c714d102ba82dc565fecb36b7e0969", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d82502d3eb0136236e46795b268d7c22753f5334d18b8866f563c2b39c9917bc38e6b7b878a52885181f9860e11f54de34dac6b4e1887bf2f7584bd7e039cc6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 13:35:43.316385) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:35:43.316777) ========= 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.V2DGE5TaYr/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.KgcuJKy6lJ/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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.005027 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 13:35:43.365211) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 13:35:43.365604) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 13:35:43.365994) ========= ========= Total master_lag: 0.28 =========