builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0019 starttime: 1461619136.45 results: success (0) buildid: 20160425095909 builduid: bf4af95f322a4411b3423b15fcf5776e revision: dcaf0a6fa115ad73bf7505a8e76464250b971a04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:56.454840) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:56.455246) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:56.455517) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:56.476039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:56.476365) ========= 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.y0fdgUQPFU/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.yaAcQw6K9J/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-25 14:18:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.4M=0.001s 2016-04-25 14:18:56 (16.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162778 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:56.656286) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:56.656598) ========= 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.y0fdgUQPFU/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.yaAcQw6K9J/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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.027176 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:56.707588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:56.707913) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dcaf0a6fa115ad73bf7505a8e76464250b971a04 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dcaf0a6fa115ad73bf7505a8e76464250b971a04 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y0fdgUQPFU/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.yaAcQw6K9J/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-25 14:18:56,738 truncating revision to first 12 chars 2016-04-25 14:18:56,738 Setting DEBUG logging. 2016-04-25 14:18:56,738 attempt 1/10 2016-04-25 14:18:56,738 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/dcaf0a6fa115?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 14:18:57,406 unpacking tar archive at: mozilla-beta-dcaf0a6fa115/testing/mozharness/ program finished with exit code 0 elapsedTime=0.927180 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:57.654413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:57.654726) ========= script_repo_revision: dcaf0a6fa115ad73bf7505a8e76464250b971a04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:57.658122) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:57.658391) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:57.673689) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-25 14:18:57.673957) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y0fdgUQPFU/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.yaAcQw6K9J/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:18:57 INFO - MultiFileLogger online at 20160425 14:18:57 in /builds/slave/test 14:18:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:18:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:18:57 INFO - {'append_to_log': False, 14:18:57 INFO - 'base_work_dir': '/builds/slave/test', 14:18:57 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:18:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:18:57 INFO - 'branch': 'Mozilla-Beta', 14:18:57 INFO - 'buildbot_json_path': 'buildprops.json', 14:18:57 INFO - 'config_files': ('talos/mac_config.py',), 14:18:57 INFO - 'default_actions': ('clobber', 14:18:57 INFO - 'read-buildbot-config', 14:18:57 INFO - 'download-and-extract', 14:18:57 INFO - 'populate-webroot', 14:18:57 INFO - 'create-virtualenv', 14:18:57 INFO - 'install', 14:18:57 INFO - 'run-tests'), 14:18:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:18:57 INFO - 'download_minidump_stackwalk': True, 14:18:57 INFO - 'download_symbols': 'ondemand', 14:18:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:18:57 INFO - 'tooltool.py': '/tools/tooltool.py', 14:18:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:18:57 INFO - '/tools/misc-python/virtualenv.py')}, 14:18:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:18:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:18:57 INFO - 'installer_path': 'installer.exe', 14:18:57 INFO - 'log_level': 'info', 14:18:57 INFO - 'log_name': 'talos', 14:18:57 INFO - 'log_to_console': True, 14:18:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:18:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:18:57 INFO - 'opt_config_files': (), 14:18:57 INFO - 'pip_index': False, 14:18:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:18:57 INFO - 'cmd': ('bash', 14:18:57 INFO - '-c', 14:18:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:18:57 INFO - 'enabled': True, 14:18:57 INFO - 'halt_on_failure': False, 14:18:57 INFO - 'name': 'check_screen_resolution'},), 14:18:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:18:57 INFO - 'cmd': ('bash', 14:18:57 INFO - '-c', 14:18:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:18:57 INFO - 'enabled': True, 14:18:57 INFO - 'halt_on_failure': False, 14:18:57 INFO - 'name': 'check_screen_resolution'},), 14:18:57 INFO - 'run_cmd_checks_enabled': True, 14:18:57 INFO - 'sps_profile': False, 14:18:57 INFO - 'sps_profile_interval': 0, 14:18:57 INFO - 'suite': 'dromaeojs-e10s', 14:18:57 INFO - 'system_bits': '32', 14:18:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:18:57 INFO - 'title': 't-yosemite-r7-0019', 14:18:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:18:57 INFO - 'use_talos_json': True, 14:18:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:18:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:18:57 INFO - 'work_dir': 'build'} 14:18:57 INFO - ##### 14:18:57 INFO - ##### Running clobber step. 14:18:57 INFO - ##### 14:18:57 INFO - Running pre-action listener: _resource_record_pre_action 14:18:57 INFO - Running main action method: clobber 14:18:57 INFO - rmtree: /builds/slave/test/build 14:18:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:18:59 INFO - Running post-action listener: _resource_record_post_action 14:18:59 INFO - ##### 14:18:59 INFO - ##### Running read-buildbot-config step. 14:18:59 INFO - ##### 14:18:59 INFO - Running pre-action listener: _resource_record_pre_action 14:18:59 INFO - Running main action method: read_buildbot_config 14:18:59 INFO - Using buildbot properties: 14:18:59 INFO - { 14:18:59 INFO - "project": "", 14:18:59 INFO - "product": "firefox", 14:18:59 INFO - "script_repo_revision": "production", 14:18:59 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:18:59 INFO - "repository": "", 14:18:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:18:59 INFO - "buildid": "20160425095909", 14:18:59 INFO - "pgo_build": "False", 14:18:59 INFO - "basedir": "/builds/slave/test", 14:18:59 INFO - "buildnumber": 4, 14:18:59 INFO - "slavename": "t-yosemite-r7-0019", 14:18:59 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:18:59 INFO - "platform": "yosemite_r7", 14:18:59 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:18:59 INFO - "branch": "mozilla-beta", 14:18:59 INFO - "repo_path": "releases/mozilla-beta", 14:18:59 INFO - "revision": "dcaf0a6fa115ad73bf7505a8e76464250b971a04", 14:18:59 INFO - "stage_platform": "macosx64", 14:18:59 INFO - "builduid": "bf4af95f322a4411b3423b15fcf5776e", 14:18:59 INFO - "slavebuilddir": "test" 14:18:59 INFO - } 14:18:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 14:18:59 INFO - Running post-action listener: _resource_record_post_action 14:18:59 INFO - ##### 14:18:59 INFO - ##### Running download-and-extract step. 14:18:59 INFO - ##### 14:18:59 INFO - Running pre-action listener: _resource_record_pre_action 14:18:59 INFO - Running main action method: download_and_extract 14:18:59 INFO - mkdir: /builds/slave/test/build/tests 14:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:59 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:18:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 14:18:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 14:18:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 14:18:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 14:19:00 INFO - Downloaded 1241 bytes. 14:19:00 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 14:19:00 INFO - Using the following test package requirements: 14:19:00 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:19:00 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:19:00 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 14:19:00 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:19:00 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 14:19:00 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:19:00 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:19:00 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 14:19:00 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:19:00 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:19:00 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 14:19:00 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:19:00 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 14:19:00 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:19:00 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 14:19:00 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:19:00 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:19:00 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 14:19:00 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 14:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:00 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:19:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:19:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:19:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 14:19:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 14:19:02 INFO - Downloaded 17745658 bytes. 14:19:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:19:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:19:05 INFO - Return code: 0 14:19:05 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:05 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:19:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:19:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:19:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 14:19:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 14:19:06 INFO - Downloaded 17745658 bytes. 14:19:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:19:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:19:09 INFO - Return code: 0 14:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:09 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:19:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 14:19:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 14:19:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 14:19:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 14:19:10 INFO - Downloaded 10845194 bytes. 14:19:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:19:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:19:11 INFO - Return code: 0 14:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:11 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 14:19:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:19:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:19:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 14:19:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 14:19:15 INFO - Downloaded 88300452 bytes. 14:19:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:19:15 INFO - mkdir: /builds/slave/test/properties 14:19:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:19:15 INFO - Writing to file /builds/slave/test/properties/build_url 14:19:15 INFO - Contents: 14:19:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:19:16 INFO - Running post-action listener: _resource_record_post_action 14:19:16 INFO - Running post-action listener: set_extra_try_arguments 14:19:16 INFO - ##### 14:19:16 INFO - ##### Running populate-webroot step. 14:19:16 INFO - ##### 14:19:16 INFO - Running pre-action listener: _resource_record_pre_action 14:19:16 INFO - Running main action method: populate_webroot 14:19:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:19:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:19:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:19:16 INFO - '--tppagecycles', 14:19:16 INFO - '7'], 14:19:16 INFO - 'tests': ['tsvgm']}}, 14:19:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:19:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:19:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:19:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:19:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:19:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:19:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:19:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:16 INFO - 'talos_options': ['--e10s'], 14:19:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:19:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:16 INFO - 'tests': ['damp', 'tps']}, 14:19:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:16 INFO - 'talos_options': ['--e10s'], 14:19:16 INFO - 'tests': ['damp', 'tps']}, 14:19:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:19:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:19:16 INFO - 'other': {'tests': ['a11yr', 14:19:16 INFO - 'ts_paint', 14:19:16 INFO - 'tpaint', 14:19:16 INFO - 'sessionrestore', 14:19:16 INFO - 'sessionrestore_no_auto_restore', 14:19:16 INFO - 'tabpaint']}, 14:19:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:19:16 INFO - 'tests': ['a11yr', 14:19:16 INFO - 'ts_paint', 14:19:16 INFO - 'tpaint', 14:19:16 INFO - 'sessionrestore', 14:19:16 INFO - 'sessionrestore_no_auto_restore', 14:19:16 INFO - 'tabpaint']}, 14:19:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:19:16 INFO - 'tests': ['a11yr', 14:19:16 INFO - 'ts_paint', 14:19:16 INFO - 'tpaint', 14:19:16 INFO - 'sessionrestore', 14:19:16 INFO - 'sessionrestore_no_auto_restore', 14:19:16 INFO - 'tabpaint']}, 14:19:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:19:16 INFO - 'tests': ['a11yr', 14:19:16 INFO - 'ts_paint', 14:19:16 INFO - 'tpaint', 14:19:16 INFO - 'sessionrestore', 14:19:16 INFO - 'sessionrestore_no_auto_restore', 14:19:16 INFO - 'tabpaint']}, 14:19:16 INFO - 'other_l64': {'tests': ['a11yr', 14:19:16 INFO - 'ts_paint', 14:19:16 INFO - 'tpaint', 14:19:16 INFO - 'sessionrestore', 14:19:16 INFO - 'sessionrestore_no_auto_restore', 14:19:16 INFO - 'tabpaint']}, 14:19:16 INFO - 'other_nol64': {'tests': ['a11yr', 14:19:16 INFO - 'ts_paint', 14:19:16 INFO - 'tpaint', 14:19:16 INFO - 'sessionrestore', 14:19:16 INFO - 'sessionrestore_no_auto_restore', 14:19:16 INFO - 'tabpaint']}, 14:19:16 INFO - 'svgr': {'tests': ['tsvgx', 14:19:16 INFO - 'tsvgr_opacity', 14:19:16 INFO - 'tart', 14:19:16 INFO - 'tscrollx', 14:19:16 INFO - 'cart']}, 14:19:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:19:16 INFO - 'tests': ['tsvgx', 14:19:16 INFO - 'tsvgr_opacity', 14:19:16 INFO - 'tart', 14:19:16 INFO - 'tscrollx', 14:19:16 INFO - 'cart']}, 14:19:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:16 INFO - 'tests': ['tp5o']}, 14:19:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:16 INFO - 'talos_options': ['--e10s'], 14:19:16 INFO - 'tests': ['tp5o']}, 14:19:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:16 INFO - 'talos_options': ['--xperf_path', 14:19:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:19:16 INFO - 'tests': ['tp5n']}, 14:19:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:16 INFO - 'talos_options': ['--e10s', 14:19:16 INFO - '--xperf_path', 14:19:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:19:16 INFO - 'tests': ['tp5n']}}, 14:19:16 INFO - 'talos.zip': {'path': '', 14:19:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:19:16 INFO - Running post-action listener: _resource_record_post_action 14:19:16 INFO - ##### 14:19:16 INFO - ##### Running create-virtualenv step. 14:19:16 INFO - ##### 14:19:16 INFO - Running pre-action listener: _resource_record_pre_action 14:19:16 INFO - Running main action method: create_virtualenv 14:19:16 INFO - Creating virtualenv /builds/slave/test/build/venv 14:19:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:19:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:19:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:19:16 INFO - Using real prefix '/tools/python27' 14:19:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:19:17 INFO - Installing distribute.............................................................................................................................................................................................done. 14:19:20 INFO - Installing pip.................done. 14:19:20 INFO - Return code: 0 14:19:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:20 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 0x10f915a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f91c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf6156cf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9d30>, '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 0x10f61ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b0b20>, '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.y0fdgUQPFU/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.yaAcQw6K9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:19:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y0fdgUQPFU/Render', 14:19:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:20 INFO - 'HOME': '/Users/cltbld', 14:19:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:20 INFO - 'LOGNAME': 'cltbld', 14:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:20 INFO - 'MOZ_NO_REMOTE': '1', 14:19:20 INFO - 'NO_EM_RESTART': '1', 14:19:20 INFO - 'PAGER': '/bin/cat', 14:19:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:20 INFO - 'PWD': '/builds/slave/test', 14:19:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:20 INFO - 'SHELL': '/bin/bash', 14:19:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yaAcQw6K9J/Listeners', 14:19:20 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:19:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:20 INFO - 'USER': 'cltbld', 14:19:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:20 INFO - 'XPC_FLAGS': '0x0', 14:19:20 INFO - 'XPC_SERVICE_NAME': '0', 14:19:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:19:20 INFO - Cleaning up... 14:19:20 INFO - Return code: 0 14:19:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:20 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 0x10f915a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f91c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf6156cf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9d30>, '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 0x10f61ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b0b20>, '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.y0fdgUQPFU/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.yaAcQw6K9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:19:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y0fdgUQPFU/Render', 14:19:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:20 INFO - 'HOME': '/Users/cltbld', 14:19:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:20 INFO - 'LOGNAME': 'cltbld', 14:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:20 INFO - 'MOZ_NO_REMOTE': '1', 14:19:20 INFO - 'NO_EM_RESTART': '1', 14:19:20 INFO - 'PAGER': '/bin/cat', 14:19:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:20 INFO - 'PWD': '/builds/slave/test', 14:19:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:20 INFO - 'SHELL': '/bin/bash', 14:19:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yaAcQw6K9J/Listeners', 14:19:20 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:19:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:20 INFO - 'USER': 'cltbld', 14:19:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:20 INFO - 'XPC_FLAGS': '0x0', 14:19:20 INFO - 'XPC_SERVICE_NAME': '0', 14:19:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:20 INFO - Downloading/unpacking psutil>=0.7.1 14:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:19:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:19:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:19:23 INFO - Installing collected packages: psutil 14:19:23 INFO - Running setup.py install for psutil 14:19:23 INFO - building 'psutil._psutil_osx' extension 14:19:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:19:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:19:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:19:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:19:24 INFO - building 'psutil._psutil_posix' extension 14:19:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:19:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:19:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:19:24 INFO - ^ 14:19:24 INFO - 1 warning generated. 14:19:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:19:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:19:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:19:25 INFO - Successfully installed psutil 14:19:25 INFO - Cleaning up... 14:19:25 INFO - Return code: 0 14:19:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19: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', '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 0x10f915a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f91c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf6156cf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9d30>, '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 0x10f61ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b0b20>, '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.y0fdgUQPFU/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.yaAcQw6K9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:19: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 mozsystemmonitor==0.0.0 14:19:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y0fdgUQPFU/Render', 14:19:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:25 INFO - 'HOME': '/Users/cltbld', 14:19:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:25 INFO - 'LOGNAME': 'cltbld', 14:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:25 INFO - 'MOZ_NO_REMOTE': '1', 14:19:25 INFO - 'NO_EM_RESTART': '1', 14:19:25 INFO - 'PAGER': '/bin/cat', 14:19:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:25 INFO - 'PWD': '/builds/slave/test', 14:19:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:25 INFO - 'SHELL': '/bin/bash', 14:19:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yaAcQw6K9J/Listeners', 14:19:25 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:19:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:25 INFO - 'USER': 'cltbld', 14:19:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:25 INFO - 'XPC_FLAGS': '0x0', 14:19:25 INFO - 'XPC_SERVICE_NAME': '0', 14:19:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:19:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:19:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:19:27 INFO - Installing collected packages: mozsystemmonitor 14:19:27 INFO - Running setup.py install for mozsystemmonitor 14:19:28 INFO - Successfully installed mozsystemmonitor 14:19:28 INFO - Cleaning up... 14:19:28 INFO - Return code: 0 14:19:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:28 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 0x10f915a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f91c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf6156cf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9d30>, '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 0x10f61ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b0b20>, '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.y0fdgUQPFU/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.yaAcQw6K9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:19:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y0fdgUQPFU/Render', 14:19:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:28 INFO - 'HOME': '/Users/cltbld', 14:19:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:28 INFO - 'LOGNAME': 'cltbld', 14:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:28 INFO - 'MOZ_NO_REMOTE': '1', 14:19:28 INFO - 'NO_EM_RESTART': '1', 14:19:28 INFO - 'PAGER': '/bin/cat', 14:19:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:28 INFO - 'PWD': '/builds/slave/test', 14:19:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:28 INFO - 'SHELL': '/bin/bash', 14:19:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yaAcQw6K9J/Listeners', 14:19:28 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:19:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:28 INFO - 'USER': 'cltbld', 14:19:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:28 INFO - 'XPC_FLAGS': '0x0', 14:19:28 INFO - 'XPC_SERVICE_NAME': '0', 14:19:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:28 INFO - Downloading/unpacking blobuploader==1.2.4 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:30 INFO - Downloading blobuploader-1.2.4.tar.gz 14:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:19:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:19:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:31 INFO - Downloading docopt-0.6.1.tar.gz 14:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:19:32 INFO - Installing collected packages: blobuploader, requests, docopt 14:19:32 INFO - Running setup.py install for blobuploader 14:19:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:19:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:19:32 INFO - Running setup.py install for requests 14:19:32 INFO - Running setup.py install for docopt 14:19:32 INFO - Successfully installed blobuploader requests docopt 14:19:32 INFO - Cleaning up... 14:19:32 INFO - Return code: 0 14:19:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:32 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 0x10f915a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f91c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf6156cf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9d30>, '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 0x10f61ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b0b20>, '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.y0fdgUQPFU/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.yaAcQw6K9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:19:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y0fdgUQPFU/Render', 14:19:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:32 INFO - 'HOME': '/Users/cltbld', 14:19:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:32 INFO - 'LOGNAME': 'cltbld', 14:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:32 INFO - 'MOZ_NO_REMOTE': '1', 14:19:32 INFO - 'NO_EM_RESTART': '1', 14:19:32 INFO - 'PAGER': '/bin/cat', 14:19:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:32 INFO - 'PWD': '/builds/slave/test', 14:19:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:32 INFO - 'SHELL': '/bin/bash', 14:19:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yaAcQw6K9J/Listeners', 14:19:32 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:19:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:32 INFO - 'USER': 'cltbld', 14:19:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:32 INFO - 'XPC_FLAGS': '0x0', 14:19:32 INFO - 'XPC_SERVICE_NAME': '0', 14:19:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:19:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-_HvJKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:19:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-C37XIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:19:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-g7ZPRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:19:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-tA_1kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:19:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-hueplq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:19:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-aHBNny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:19:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-yScQW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:19:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-GZsVQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:19:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-KeUQai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:19:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-_Kl5GB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:19:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-_BAKyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:19:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-FTnb6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:19:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-x1Yu1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:19:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-7osnNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-5YwWgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:19:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-TszQm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:19:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-JMt8T4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:19:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:19:34 INFO - Running setup.py install for manifestparser 14:19:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:19:35 INFO - Running setup.py install for mozcrash 14:19:35 INFO - Running setup.py install for mozdebug 14:19:35 INFO - Running setup.py install for mozdevice 14:19:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:19:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:19:35 INFO - Running setup.py install for mozfile 14:19:35 INFO - Running setup.py install for mozhttpd 14:19:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:19:35 INFO - Running setup.py install for mozinfo 14:19:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:19:36 INFO - Running setup.py install for mozInstall 14:19:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:19:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:19:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:19:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:19:36 INFO - Running setup.py install for mozleak 14:19:36 INFO - Running setup.py install for mozlog 14:19:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:19:36 INFO - Running setup.py install for moznetwork 14:19:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:19:36 INFO - Running setup.py install for mozprocess 14:19:36 INFO - Running setup.py install for mozprofile 14:19:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:19:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:19:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:19:36 INFO - Running setup.py install for mozrunner 14:19:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:19:37 INFO - Running setup.py install for mozscreenshot 14:19:37 INFO - Running setup.py install for moztest 14:19:37 INFO - Running setup.py install for mozversion 14:19:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:19:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:19:37 INFO - Cleaning up... 14:19:37 INFO - Return code: 0 14:19:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:37 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 0x10f915a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f91c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf6156cf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9d30>, '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 0x10f61ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b0b20>, '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.y0fdgUQPFU/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.yaAcQw6K9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:19:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y0fdgUQPFU/Render', 14:19:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:37 INFO - 'HOME': '/Users/cltbld', 14:19:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:37 INFO - 'LOGNAME': 'cltbld', 14:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:37 INFO - 'MOZ_NO_REMOTE': '1', 14:19:37 INFO - 'NO_EM_RESTART': '1', 14:19:37 INFO - 'PAGER': '/bin/cat', 14:19:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:37 INFO - 'PWD': '/builds/slave/test', 14:19:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:37 INFO - 'SHELL': '/bin/bash', 14:19:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yaAcQw6K9J/Listeners', 14:19:37 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:19:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:37 INFO - 'USER': 'cltbld', 14:19:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:37 INFO - 'XPC_FLAGS': '0x0', 14:19:37 INFO - 'XPC_SERVICE_NAME': '0', 14:19:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:19:37 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-OdDAjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:19:37 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-RGdlTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:19:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-Jw1rRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:19:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-fMjjjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:19:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-A4eT17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:19:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-0UqOcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:19:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-H7PKEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:19:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-RaseoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:19:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-eHzxVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:19:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-NE0SC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:19:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-hLvixv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:19:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-0WSGna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:19:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-xj5hXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:19:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-9ooSrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-0v_iie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:19:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-uS0MDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:19:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-_i0IWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:19:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:42 INFO - Downloading blessings-1.6.tar.gz 14:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:19:42 INFO - Installing collected packages: blessings 14:19:42 INFO - Running setup.py install for blessings 14:19:42 INFO - Successfully installed blessings 14:19:42 INFO - Cleaning up... 14:19:42 INFO - Return code: 0 14:19:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:19:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:42 INFO - Reading from file tmpfile_stdout 14:19:42 INFO - Current package versions: 14:19:42 INFO - blessings == 1.6 14:19:42 INFO - blobuploader == 1.2.4 14:19:42 INFO - docopt == 0.6.1 14:19:42 INFO - manifestparser == 1.1 14:19:42 INFO - mozInstall == 1.12 14:19:42 INFO - mozcrash == 0.17 14:19:42 INFO - mozdebug == 0.1 14:19:42 INFO - mozdevice == 0.48 14:19:42 INFO - mozfile == 1.2 14:19:42 INFO - mozhttpd == 0.7 14:19:42 INFO - mozinfo == 0.9 14:19:42 INFO - mozleak == 0.1 14:19:42 INFO - mozlog == 3.1 14:19:42 INFO - moznetwork == 0.27 14:19:42 INFO - mozprocess == 0.22 14:19:42 INFO - mozprofile == 0.28 14:19:42 INFO - mozrunner == 6.11 14:19:42 INFO - mozscreenshot == 0.1 14:19:42 INFO - mozsystemmonitor == 0.0 14:19:42 INFO - moztest == 0.7 14:19:42 INFO - mozversion == 1.4 14:19:42 INFO - psutil == 3.1.1 14:19:42 INFO - requests == 1.2.3 14:19:42 INFO - wsgiref == 0.1.2 14:19:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:42 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 0x10f915a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f91c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf6156cf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9d30>, '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 0x10f61ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b0b20>, '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.y0fdgUQPFU/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.yaAcQw6K9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:19:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y0fdgUQPFU/Render', 14:19:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:42 INFO - 'HOME': '/Users/cltbld', 14:19:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:42 INFO - 'LOGNAME': 'cltbld', 14:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:42 INFO - 'MOZ_NO_REMOTE': '1', 14:19:42 INFO - 'NO_EM_RESTART': '1', 14:19:42 INFO - 'PAGER': '/bin/cat', 14:19:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:42 INFO - 'PWD': '/builds/slave/test', 14:19:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:42 INFO - 'SHELL': '/bin/bash', 14:19:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yaAcQw6K9J/Listeners', 14:19:42 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:19:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:42 INFO - 'USER': 'cltbld', 14:19:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:42 INFO - 'XPC_FLAGS': '0x0', 14:19:42 INFO - 'XPC_SERVICE_NAME': '0', 14:19:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:19:43 INFO - Cleaning up... 14:19:43 INFO - Return code: 0 14:19:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:19: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')]} 14:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19: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')]} 14:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f915a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f91c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf6156cf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9d30>, '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 0x10f61ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b0b20>, '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.y0fdgUQPFU/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.yaAcQw6K9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19: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', 'jsonschema'] in /builds/slave/test/build 14:19: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 jsonschema 14:19:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y0fdgUQPFU/Render', 14:19:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:43 INFO - 'HOME': '/Users/cltbld', 14:19:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:43 INFO - 'LOGNAME': 'cltbld', 14:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:43 INFO - 'MOZ_NO_REMOTE': '1', 14:19:43 INFO - 'NO_EM_RESTART': '1', 14:19:43 INFO - 'PAGER': '/bin/cat', 14:19:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:43 INFO - 'PWD': '/builds/slave/test', 14:19:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:43 INFO - 'SHELL': '/bin/bash', 14:19:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yaAcQw6K9J/Listeners', 14:19:43 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:19:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:43 INFO - 'USER': 'cltbld', 14:19:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:43 INFO - 'XPC_FLAGS': '0x0', 14:19:43 INFO - 'XPC_SERVICE_NAME': '0', 14:19:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:43 INFO - Downloading/unpacking jsonschema 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:19:45 INFO - Downloading/unpacking functools32 (from jsonschema) 14:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:46 INFO - Downloading functools32-3.2.3-2.tar.gz 14:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:19:46 INFO - warning: no files found matching '*.txt' 14:19:46 INFO - no previously-included directories found matching 'build' 14:19:46 INFO - no previously-included directories found matching 'dist' 14:19:46 INFO - no previously-included directories found matching '.git*' 14:19:46 INFO - Installing collected packages: jsonschema, functools32 14:19:46 INFO - Running setup.py install for functools32 14:19:46 INFO - warning: no files found matching '*.txt' 14:19:46 INFO - no previously-included directories found matching 'build' 14:19:46 INFO - no previously-included directories found matching 'dist' 14:19:46 INFO - no previously-included directories found matching '.git*' 14:19:46 INFO - Successfully installed jsonschema functools32 14:19:46 INFO - Cleaning up... 14:19:46 INFO - Return code: 0 14:19:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f915a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f91c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf6156cf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b9d30>, '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 0x10f61ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b0b20>, '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.y0fdgUQPFU/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.yaAcQw6K9J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:19:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y0fdgUQPFU/Render', 14:19:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:46 INFO - 'HOME': '/Users/cltbld', 14:19:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:46 INFO - 'LOGNAME': 'cltbld', 14:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:46 INFO - 'MOZ_NO_REMOTE': '1', 14:19:46 INFO - 'NO_EM_RESTART': '1', 14:19:46 INFO - 'PAGER': '/bin/cat', 14:19:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:46 INFO - 'PWD': '/builds/slave/test', 14:19:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:46 INFO - 'SHELL': '/bin/bash', 14:19:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yaAcQw6K9J/Listeners', 14:19:46 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:19:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:46 INFO - 'USER': 'cltbld', 14:19:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:46 INFO - 'XPC_FLAGS': '0x0', 14:19:46 INFO - 'XPC_SERVICE_NAME': '0', 14:19:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:46 INFO - Downloading/unpacking flake8 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:19:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:19:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:19:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:19:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:19:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:19:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:19:50 INFO - no previously-included directories found matching 'docs/_build' 14:19:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:19:50 INFO - Running setup.py install for pep8 14:19:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:19:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:19:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:19:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:19:50 INFO - no previously-included directories found matching 'docs/_build' 14:19:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:19:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:19:50 INFO - Cleaning up... 14:19:50 INFO - Return code: 0 14:19:50 INFO - Running post-action listener: _resource_record_post_action 14:19:50 INFO - Running post-action listener: _start_resource_monitoring 14:19:50 INFO - Starting resource monitoring. 14:19:50 INFO - ##### 14:19:50 INFO - ##### Running install step. 14:19:50 INFO - ##### 14:19:50 INFO - Running pre-action listener: _resource_record_pre_action 14:19:50 INFO - Running main action method: install 14:19:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:51 INFO - Reading from file tmpfile_stdout 14:19:51 INFO - Detecting whether we're running mozinstall >=1.0... 14:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:19:51 INFO - Reading from file tmpfile_stdout 14:19:51 INFO - Output received: 14:19:51 INFO - Usage: mozinstall [options] installer 14:19:51 INFO - Options: 14:19:51 INFO - -h, --help show this help message and exit 14:19:51 INFO - -d DEST, --destination=DEST 14:19:51 INFO - Directory to install application into. [default: 14:19:51 INFO - "/builds/slave/test"] 14:19:51 INFO - --app=APP Application being installed. [default: firefox] 14:19:51 INFO - mkdir: /builds/slave/test/build/application 14:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:20:13 INFO - Reading from file tmpfile_stdout 14:20:13 INFO - Output received: 14:20:13 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:20:13 INFO - Running post-action listener: _resource_record_post_action 14:20:13 INFO - ##### 14:20:13 INFO - ##### Running run-tests step. 14:20:13 INFO - ##### 14:20:13 INFO - Running pre-action listener: _resource_record_pre_action 14:20:13 INFO - Running main action method: run_tests 14:20:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:20:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:20:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:20:13 INFO - 2016-04-25 14:20:13.490 screenresolution[1639:7376] starting screenresolution argv=screenresolution get 14:20:13 INFO - 2016-04-25 14:20:13.493 screenresolution[1639:7376] Display 0: 1600x1200x32@60 14:20:13 INFO - 2016-04-25 14:20:13.499 screenresolution[1640:7378] starting screenresolution argv=screenresolution list 14:20:13 INFO - Available Modes on Display 0 14:20:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:20:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:20:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:20:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:20:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:20:13 INFO - Intel Iris: 14:20:13 INFO - Chipset Model: Intel Iris 14:20:13 INFO - Type: GPU 14:20:13 INFO - Bus: Built-In 14:20:13 INFO - VRAM (Dynamic, Max): 1536 MB 14:20:13 INFO - Vendor: Intel (0x8086) 14:20:13 INFO - Device ID: 0x0a2e 14:20:13 INFO - Revision ID: 0x0009 14:20:13 INFO - Displays: 14:20:13 INFO - Display: 14:20:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:20:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:20:13 INFO - Display Serial Number: 1600x1200 60 14:20:13 INFO - Main Display: Yes 14:20:13 INFO - Mirror: Off 14:20:13 INFO - Online: Yes 14:20:13 INFO - Rotation: Supported 14:20:13 INFO - Return code: 0 14:20:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:20:13 INFO - Python 2.7.3 14:20:13 INFO - Return code: 0 14:20:13 INFO - grabbing minidump binary from tooltool 14:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:13 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 0x10f7b9d30>, '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 0x10f61ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7b0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:20:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:20:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:20:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:20:13 INFO - Return code: 0 14:20:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:20:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:20:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:20:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:20:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:20:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:20:15 INFO - Return code: 0 14:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:20:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y0fdgUQPFU/Render', 14:20:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:20:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:20:15 INFO - 'HOME': '/Users/cltbld', 14:20:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:20:15 INFO - 'LOGNAME': 'cltbld', 14:20:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:20:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:15 INFO - 'MOZ_NO_REMOTE': '1', 14:20:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:20:15 INFO - 'NO_EM_RESTART': '1', 14:20:15 INFO - 'PAGER': '/bin/cat', 14:20:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:15 INFO - 'PWD': '/builds/slave/test', 14:20:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:20:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:20:15 INFO - 'SHELL': '/bin/bash', 14:20:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yaAcQw6K9J/Listeners', 14:20:15 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:20:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:20:15 INFO - 'USER': 'cltbld', 14:20:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:20:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:15 INFO - 'XPC_FLAGS': '0x0', 14:20:15 INFO - 'XPC_SERVICE_NAME': '0', 14:20:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:20:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:20:15 INFO - mozversion application_buildid: 20160425095909 14:20:15 INFO - mozversion application_changeset: dcaf0a6fa115ad73bf7505a8e76464250b971a04 14:20:15 INFO - mozversion application_display_name: Firefox 14:20:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:20:15 INFO - mozversion application_name: Firefox 14:20:15 INFO - mozversion application_remotingname: firefox 14:20:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:20:15 INFO - mozversion application_vendor: Mozilla 14:20:15 INFO - mozversion application_version: 47.0 14:20:15 INFO - mozversion platform_buildid: 20160425095909 14:20:15 INFO - mozversion platform_changeset: dcaf0a6fa115ad73bf7505a8e76464250b971a04 14:20:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:20:15 INFO - mozversion platform_version: 47.0 14:20:15 INFO - using testdate: 1461619215 14:20:15 INFO - actual date: 1461619215 14:20:15 INFO - starting webserver on 'localhost:49278' 14:20:15 INFO - SUITE-START | Running 2 tests 14:20:15 INFO - TEST-START | dromaeo_css 14:20:15 INFO - operating with platform_type : mac_ 14:20:15 INFO - Initialising browser for dromaeo_css test... 14:20:15 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmp1cCbFy/profile http://localhost:49278/getInfo.html) 14:20:18 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 14:20:18 INFO - PROCESS | 1658 | colorDepth:24 14:20:18 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 14:20:18 INFO - PROCESS | 1658 | __metrics 14:20:18 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:20:18 INFO - TEST-INFO | 1658: exit 0 14:20:18 INFO - Browser initialized. 14:20:18 INFO - Running cycle 1/1 for dromaeo_css test... 14:20:18 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmp1cCbFy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:20:30 INFO - PROCESS | 1662 | RSS: Main: 167944192 14:20:30 INFO - PROCESS | 1662 | 14:21:20 INFO - PROCESS | 1662 | 1461619280486 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:23:30 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 14:23:32 INFO - PROCESS | 1662 | RSS: Main: 178057216 14:23:32 INFO - PROCESS | 1662 | 14:26:34 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 14:26:34 INFO - PROCESS | 1662 | RSS: Main: 189501440 14:26:34 INFO - PROCESS | 1662 | 14:29:36 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 14:29:36 INFO - PROCESS | 1662 | RSS: Main: 191541248 14:29:36 INFO - PROCESS | 1662 | 14:32:38 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 14:32:39 INFO - PROCESS | 1662 | RSS: Main: 195416064 14:32:39 INFO - PROCESS | 1662 | 14:35:41 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 14:35:42 INFO - PROCESS | 1662 | RSS: Main: 194187264 14:35:42 INFO - PROCESS | 1662 | 14:38:44 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 14:38:44 INFO - PROCESS | 1662 | RSS: Main: 200015872 14:38:44 INFO - PROCESS | 1662 | 14:38:44 INFO - PROCESS | 1662 | __start_tp_report 14:38:44 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 14:38:44 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 14:38:44 INFO - PROCESS | 1662 | |i|pagename|runs| 14:38:44 INFO - PROCESS | 1662 | |0;dojo.html;3247.7888937219077;3656.762310449819;3694.5935947045805;3724.0689827543115;3727.645873642004;4539.660800063981;5844.707764611763;5938.317093534245;5950.404959504053;5977.641341519512;4768.403949506312;5964.701764911748;5996.220491336131;6006.099085137232;6017.368176341487;5272.209168624709;5367.570594352443;5379.9731001345135;5425.6202065855405;5428.240046393508;5297.973510132444;5384.892302153955;5391.948570028826;5435.10320797068;5446.782128714846;5265.552428043621;5353.277307563488;5381.730913454312;5400.621956463049;5418.834950485645;5082.898342033176;5425.321834770653;5426.186072089179;5427.674339539621;5429.294191755086;5309.548688361494;5368.30212072432;5384.946150538483;5409.486098820606;5440.945590544123;5541.806036788734;5693.430656934315;5791;5874.882502349929;5876.177335173079;6201.224846894138;6255.968720156416;6261.436470717612;6267.874642507124;6284.402981716729;6321.146645202884;6329.335419780903;6340.492760579143;6355.87288254237;6363.490920726331;5986.790462333797;6047.788327408608;6127.632342059446;6129.7854575090105;6130.601510901777;5573.470520300565;6405.423511883952;6471.5146364022885;6509.609423434515;6511.772087976898;6227.719752611143;6239.844003899848;6243.500519958392;6245;6253.6560489173535;6193.876122477525;6196.721147548371;6243.719032643542;6356.364363563606;6366;5870.207521984477;6223.190985171898;6251.78118765841;6255.030470277115;6257.061440783918;5592.720363981784;6173.332401760676;6252.093446450239;6263.123162757218;6291.370862913764;4911.656184067152;4981.078500477351;4988.127077761377;5038.974805126024;5060.544550990355;3856.2094770571966;4519.683622146418;4554.658400619966;4562.703424277478;4587.564181402761;6103.664298463627;6115.724792384353;6123.908141377883;6162.137300777895;6169.105479705418;6212.502999760099;6248.218972628421;6321.747130114744;6329.367063293726;6360.77737279193;6113.23584551931;6114.510839132859;6117.541184411098;6126.908096378558;6157.538184636171;5486.369067557282;5551.916721249185;5575.080111781511;5583;5602.159676048625;6360.204974378203;6455.7417703292285;6492.545521813522;6533.150690410216;6563.901541476882;6294.339094395205;6310.52671049664;6314.1160237565855;6317.084022816758;6326.33573474797;6349.174607301022;6468.870622587616;6534.444572211415;6542.54202205841;6564.671766411756;5226.320578324946;6208.658523781055;6251.499880009497;6277.435030847246;6292.339304372975;6293.150424692791;6305.306416294296;6315.210598675166;6317.084022816758;6324.841878953063;6100.847478813065;6134.008014331881;6241.438270555672;6241.6879156041105;6250.062490626442;6162.168107305636;6226.283977342664;6228.968855155877;6237.688115594293;6257.092721555258;5724.112762521816;6001.789937352171;6057.394260574084;6189.412005859436;6207.410296021871;4741.715497070187;6063.757449701962;6112.755489780359;6121.112438696453;6148.938510615016;6143.511877689543;6148;6181.660008699565;6235.282942461494;6238.469730072995 14:38:44 INFO - PROCESS | 1662 | |1;ext.html;458.80500787165465;536.6967663270252;580.7357652268217;614.0788816774838;680.965951702415;37510.62489375105;39787.40318895219;39826;39959.40060899085;40067.59932400683;41122.9719257018;41750;41798.79100604493;41839.74480765574;41855.790721046425;9603.32776705631;9786.510674466284;9787.608495660164;9810.607575696964;9818.950905245463;7770.8445831083345;8018.35853131751;8039;8043.798905027392;8078.515289082645;7855.8821617675785;8054.395920305971;8055.395845311625;8109;8157.79605509864;8050.235227653364;8062.815188000765;8069.919300807005;8075.515469071875;8184.2224988625985;9774.364666296668;9878.456684882329;9914.9504252479;9944.602215911355;9967.202623790079;40159.79920100381;40375.59624403748;40420.595794042274;40610.796946015376;40715.98210044743;3319.668033196685;3450.8102054387;3452.3267962747273;3588.3002814451193;3604.333198358312;28229.576556351672;28420.28949276264;28930.98741544036;29109.981150659838;29698;2859.1994241612383;2864.255293623673;2865.2407112115307;2903.216131644444;2941.4117176564773;504707;504735;509349;509504.45247773896;510282.4485877584;48063.519364806605;74444.62777686077;75124;75168.62415687996;75363.62318188374;38324.425133623015;47087.82280442948;47326.5267347329;47378.289325660146;47399.76300118477;17058.658826823394;17336.219870105877;17380.47858564245;17394.65210695779;17402.651946961243;13635.659108522366;13808.964327675465;13821.516246931309;13825.585232443043;13884.166949982831;13682.31588420575;15117.622059448602;15217.010894291836;15487.380504779909;15625.06249625026;6345.3666728307235;6774.559653622598;6777.728890844311;6806.659667016629;6812.365032392289;945.3618807305041;999.7200783780407;1012.5544760305442;1131.671815173607;1196.4257156564897;30864.228394290323;31024.53463198054;31266.749330027;31622.735090596118;32000;1188.928664280146;1247.9188852724544;1252.136026141959;1253.642711827125;1291.5285920639087;14304.856951430353;15644.452444164399;15942.840571594368;16018.67962640764;16381.426650067191;563998;564901;567746;569146;570600;63002;63503.04745428822;63916;63927.68036159789;63990;1529.6252418157624;1564.765285207228;1575.1415478564438;1582.8733701303868;1590.157216675164;25623.6156457657;30457.390852183275;30534;30582.694173057986;31102.377952440373;44797.32804007877;54982.17526737182;54998.90002200014;55064.898702026534;55262;520685;527344;530421;532074;532456;30935.0719478416;34475.31049378948;35607.28785424329;35737.821310893276;36108.63891361053;44639.77680111579;47405.288920666906;48051.75974120107;48240.5175948236;49513;31569;37915.62084379121;38950.026249343995;38954.22091558096;39392.80303598464;38328.717305891194;39164.6083539161;39180.41229381505;39254.6074539251;40171.39742903917;33488.33023339471;38267;39753.40369894396;40287.39568906528;40891.59108408878;31835.840820795747;33700.662993369755;33827.492587610715;34015.65984340125;34021.829890850386;25633.743662563134;25673;25727.228183154537;25801.870990644926;25983.350416239744 14:38:44 INFO - PROCESS | 1662 | |2;jquery.html;367.2618037744135;376.1968197897488;378.2133163020917;378.5495260639838;384.3063270796215;20345.491362715922;21081.894590527045;21095.367138985854;21725.3482395528;21832.345029649117;12240.204386714857;12396.690082747937;12430.689232769186;12516.687082822935;12565.874341256607;4791.520847915198;4899.975500122512;5567.916481252764;5619.5785316101255;5763.423657634224;4792.664513484057;5614.073677843151;5658.066419040853;5707.62900411474;5724.227229324029;5706.885862282752;6350.49196064316;6572.4084832365315;6587.670616469158;6638.834029149261;5953;6071.4535691787505;6161.661108639023;6481;6501.15484986951;5904.261967254093;5942.732577034044;5984.222051133368;5990.670513121777;6051.0923361496125;10464.42445665488;10936.726581835439;13477.258750768704;13519.459221631123;13547.864521354759;2154.91380344786;2282.9200977965857;2348.56551537966;2593.351662084479;2704.019246254645;10485.63300284494;13686.973476989166;14362.994590378677;15232.771508427382;15472.922635386863;1810.9275628974826;1838.8988605626685;1842.7512285841374;1912.2064343297654;1936.893470859102;100171.49742753938;100672;106370.46814765877;107949.46025269823;108067;11575.710607234718;11647;11676.949074583328;11697.2981621103;11792.115591330685;14289.42842286297;14295.07082039664;14304.427822887175;14343.354549045318;14362.640933976525;8510.148985101441;8753.387262891536;8819.735407937773;8828.602712877935;8986.415882967585;9147.0852914708;9173.036831132635;9196.08039196075;9230.676926307548;9276.814463710689;4536.705114167568;4595.977020114878;4616.0767846430845;4622.976885115553;4628;1960.4412742368356;2002.1390801955008;2002.2091273947;2041.7345745053049;2046.8362530997485;766.8312971146339;978.3982850547005;981.4727077774759;1016.9677777056294;1105.701460605632;19094.427167185007;20580.073896674687;21205.045772939946;21516.354509364744;21522.892385537973;1012.099231683802;1013.5287091502339;1039.4023436524028;1049.6431213387484;1056.3450660590483;11275.985161335519;11349.36148678821;11430;11435.371054592077;11436.94281528587;591137;656890;694651;709640;718361;121342;124820;126991;134090.32954835164;143378;1047.8375851742992;1058.4654749351528;1065.2383545764815;1073.1146803886668;1088.755030118233;18749.437516874517;19022;19294.13176407093;19375.128119234385;19646.115924783135;51727.74136129295;52574.737126314125;52637;54381.72809135929;54428.45571544234;57991;72072.47746328854;75315.62342188254;76130.61934690291;77699;6634.635095069818;7181.784546463615;8211.93244878162;8315.417920745489;8444.155584441507;9645.324827262024;12736.554220602235;13409.865901340861;13413.597592072254;13752.449902003807;11554.884451155382;11560.537578496765;12056.457459414172;12137.21108127969;12184.939075304921;11718.765624687288;11722.296662200295;11802.232854864405;11917.940410297893;12121.393930303273;10258.43578603184;11940.223885447418;12292.385380731106;12309.26144431337;12355.62933112008;8290.33677305802;8298.087210406971;8300.335973122257;8330.291925186184;8527.275181609633;11085.445727713743;11975.820362694742;12061.75876482483;12198.817017744563;12241.326727030098 14:38:44 INFO - PROCESS | 1662 | |3;mootools.html;1569.7331453652878;1651.8843680942334;1962.6859702447612;2023.878567285962;2072.8963551822403;7707.30634242918;8292.004959404865;8989.011208767039;9069.365144439884;9175.220106290957;7542.396608271339;8815;8894.110588941103;8988.550572471382;8993.550322483883;2524.899004039836;2561.6285638582394;2563.551378508763;2566.781823545001;2572.2283315005425;2216.833737469688;2564.1153801938394;2603.2320465462735;2633.8156329056974;2647.4308023774884;2542.250036239314;2578.7808036316937;2597.4155814941582;2600.77893379063;2607.1787386973137;2556.6037264224074;2581.7418258174125;2586.831855929368;2589.4432696970243;2598.649182360376;2607.7001144868395;2613.6800915537724;2637.222019504251;2642.075273654225;2646;9047.68333108338;9082.500462474562;9105.908940910573;9118.224950879183;9120.863187052133;5627.887442251132;5651.943480565183;5683.232763576905;5687.459691329358;5749.712514374264;3048.4512787698204;3639.6178401267753;3708.8145592720257;3807.8667246646232;3812.942805857914;1073.0825144501416;1079.7516571188592;1084.72003036417;1104.2546281260118;1105.5688281570194;11879.821802672881;11919.284842909366;11948.342841143734;12103.394830258452;12288.938555307255;4363.345498175236;4976.62675299354;4992.575631071327;5127.6154288428515;5131.307273518102;10489.947550262352;10532.789344213073;10627;10655.094316982988;10661.307015043998;4770.76146192689;5580.665160090408;5592;5719.370869204384;5807.390224026501;4609.746463944515;4989.700617962933;5035.093683137071;5080.77136528857;5095.668781529189;4094.754314741125;4146.357314616239;4160.895977600524;4164.37534369847;4167.645750111214;1180.3154170581215;1371.9519816806564;1386.5632325817335;1394.8047273381735;1421.8909250784197;1407.197897198587;1429.9785503217252;1437.547172640615;1442.5600191941348;1472.9263536823116;7788.299053085249;8235.794105147299;8372.790680233044;8404.537750423664;8440;465.2881091929286;534.1987019470794;545.3973359437844;552.4392741367515;553.1812916883035;6263.123162757218;6288.402601752918;6297;6299.905501417483;6339.492840572743;10663.573457061631;10934.835977460345;10944.23390362667;10988.956049175316;11089.33463992163;10606.522706478227;10852.891471085346;10897.67306980792;10912.181586380895;10915.017648411682;8497.61760720769;8539.018012928469;8585.957070214734;8599.484030958163;8607.35444841652;7952.324052455606;7961.402894782798;8025.799355016171;8077.990251218597;8172.5913704315735;9694.612215511583;9800.068993445611;9854.655087071918;9894.356866803635;9902.158316542886;9455.338126331366;10242.59029638836;10259.640912568024;10266.384016959006;10279.023492768176;7495;7591.3547348475995;7675.692972281046;7692.7692169235015;7707.845843083219;8307.044689860502;8332.16678332162;8462.830743384975;8469.322454203526;8476.576171191538;7331.230220826949;7485.1017877855;7548.207438219128;7593.544387336778;7657;5969.641821490724;7330.890036649348;7374.741884034033;7400.592967386845;7459.850802983801;7738.955241042612;7793.688252469838;7823.530588164728;7857.724979625686;7871.134175240833;6949.861002780017;7082.858342833011;7093.538919970186;7094.326039026284;7104.147502299757;7166.140063192451;7182.497225194186;7219.9892015116875;7250.456215783732;7262.164851042197 14:38:44 INFO - PROCESS | 1662 | |4;prototype.html;344.8517137630819;346.82658670664665;348.6200041954271;349.58050339592495;354.6858887820624;6879.828004299889;6915.204751453591;6931.5841049537;6954.965225173867;6973.267806880281;5751.396103409134;6175.135481032659;6257.468115210213;6880.2431732509385;6905.205901321349;4887.462379138292;5020.071286811952;5084.644074914758;5111.386633603973;5155.922661160085;5080.288759573663;5098.133317336044;5102.132637451642;5102.923456148161;5116.590672746172;4545.590896819285;4739.289106633998;5101.770420331094;5119.897602047957;5138.460461651529;4160.251154792136;5116.079105760961;5118.309028281172;5130.204818253177;5139.460356662553;4314.590113939171;4406.603405693503;4432.778361081933;4436.334549817553;4441.489228738672;4724.244120940633;5448.509634132907;6045.697715114226;6554.868902621968;6583.210014798207;5089.592832573422;5764.423557644244;5887.1463637772285;5955.285365756094;5958.225430693982;6129.417705317987;7058.647067646649;7413.925860741431;7425.962870185668;7436.772932466137;4757.048590281957;4771.1173432914675;4771.188897887368;4789.473157952622;4793.945332026983;7783.404402097556;7829.686812527492;7847.293743563049;7849.136594974549;7856.646450909666;4657.906841863211;4810.5670489656095;4852.951470485321;4860.1008813369635;4864.221724524059;4910.779014944336;4961.42943561495;4963.057019166346;4972.925406118911;4986.501349865057;5918.171455996164;5926.407359264039;5928.762849486058;5937.198478205473;5938.6436813791315;6138.109974053827;7392.55644661322;7429.517081389692;7429.665665044978;7430.219826918095;1706.436875830973;1729.1786401459206;1730.8701847361247;1733.635936453359;1737.1314342828587;1050.5325130317087;1088.0968795899385;1098.1763677242068;1100.3287994323457;1111.5387114347454;7044.330788575077;7044.471664625174;7077.82305442368;7127.002219689248;7144.714211431485;7471.813204669927;7692.884606730903;7702.576358300347;7704.5762483062845;7729.8454030919065;6942.722291108299;7101.502894797314;7172.426205903515;7192.28077192287;7207.495475316782;3307.768456208042;4075.9388609170887;4101.610347017028;4119.032027473541;4134.958650413518;6467.773627923094;8117.188281171835;8123.593820308961;8135.552544609985;8147.79630509242;7708.152103268636;7890.526568405914;8008.239217274349;8022.799430014296;8045.436819422701;8049;8063.395245356622;8080.0707918590115;8086.231807978233;8102.351811855037;7733.535987840747;7737.613119344122;7744.341730952932;7752.18602046777;7757.728479503416;6167.828112658581;7127.893081603676;7561.508501947355;7573.772786816405;7585.886211706718;7727.613619319124;8051.718189863327;8064.9756341371985;8130.381980018835;8153.306968907709;5045.722485263199;5098.668586541863;5118.411382691038;5127.5897928166405;5131.692098474104;7631.732889348847;7653.005109335751;7666.540007599562;7671.619108560512;7673.309402153833;7372.078490188726;7391.889121663072;7398.593077380796;7404.777856664308;7405.370543503863;7104.218535961144;7416.0729908761405;7431.479796414199;7458.291462311072;7464.104307483137;5866.325372582208;7211.8557628848175;7290.453216008715;7293.562386256842;7295.8540829184185;5988.940110599013;7406.44451666138;7424.777256682308;7461.589612571361;7481.88777168332;7000.649967501503;7251.927480725336;7257.709691612276;7279.490435669452;7279.8544029120185 14:38:44 INFO - PROCESS | 1662 | |5;yui.html;692.2005084127834;716.4304378019475;723.9746608868691;786.1666633368629;812.3163383431117;11974.580889668863;15303.15832629205;15589.298481568328;15674.529764107081;15764.921175394122;12389.566365177221;14413.207273599948;14531.636709082279;14560.708785824303;14851.480198193065;829.5520418973747;978.6623614852882;991.2912267728573;1012.5089331674133;1015.1422048369117;967.6613185385094;968.6658102954469;1000.5747557288123;1026.199564339816;1030.8247597908337;1034.5551412892453;1073.2540884085563;1074.317808191796;1081.453865797771;1081.7187531241893;1058.6294796821128;1058.8094143054248;1067.359584249452;1072.3565860483725;1074.9570017199303;784.3960150683998;787.3307688464816;792.675003248671;798.997258440659;801.3028665061375;15627.906046576743;15767.29047192879;15827.52517424479;15850.048997060214;15922;13300.800487992688;13317.467301307935;13328.600141995756;13416.86583134166;13490.595282141552;10188.745281368025;10320.845187322197;10424.16606671472;10442.425666588335;10775.676729698122;3594.0835087052897;3600.279944011208;3631.7457777955556;3651.3245049665898;3866.149447121629;80377;80445.79331310035;80715;80890.38219235641;81502.3699526012;9621.422714637145;9795.608175673036;9856.950715246521;9961.35251208669;9979.401235925867;22916.541669166523;23094.7690523096;23112.075516979134;23155.189568365025;23158.305250842503;7438.070241219848;7489.775306740807;7577.696892124363;7595.354394876497;7686.192949740309;4193.874183774492;4229.133027729308;4253.085586598834;4282.272013757669;4302.075053863372;3673.3204357194004;3762.4544441055896;3785.413260944558;3807.1053302473897;3819.866304679323;690.4752388184916;690.4786885901212;707.0913875669739;709.3084242863167;710.9903936410207;543.8450041738165;597.8624916269282;598.3119412675458;599.8080614203413;613.9877202456015;7947.3642108631175;7978.3218426434405;8111.432199746079;8121.26908578219;8243.2581067703;508.3975489045493;511.8438876142738;527.8733104055076;590.5275779376567;593.2762030322999;3721.5720192177705;3816.1795214029116;3820.84716611338;3883.66988805949;3927.0182454386404;103330.48334758429;103628;104076;104286;105468;84571;86383;86476;87229.56385218033;88717.55641221753;78019.43961120746;78094.82857757139;78401.34698920122;80256.59871700604;80431.19568804237;6414.679266036773;7401.962990185015;7444.851102978018;7613.695452181851;7844.09792873804;46268;47465.57603271907;48506.757466212446;48661;48665.75667121642;63644;66290;67650;68071;68225.29436763922;9698.078682525149;9893.604255829974;10051.648192313527;10068.144207742424;10097.949510252402;10648.680539583514;10654.414007229676;11009.119270458505;11013.449327533432;11292.548298067984;10282.537285822305;10417.687469375931;10427.165826733995;10668.253222274367;10678.946605266923;8875.911240887508;10287.971202879653;10302.948485257826;10380.948095259475;10627.521761520904;7602.619869006417;7896;8507.76637387563;9822.852657210005;10055.748606284902;8812.064573474609;8897.866532001895;9047.366684332033;9077.04691007461;9087.909120908971;8606.838883082077;8781.385303028726;8793.20861122502;8880.333974951775;8991.55042247898 14:38:44 INFO - PROCESS | 1662 | __end_tp_report 14:38:44 INFO - PROCESS | 1662 | __start_cc_report 14:38:44 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,357 14:38:44 INFO - PROCESS | 1662 | __end_cc_report 14:38:44 INFO - PROCESS | 1662 | __startTimestamp1461620324579__endTimestamp 14:38:44 INFO - PROCESS | 1662 | 14:38:44 INFO - PROCESS | 1662 | ------- Summary: start ------- 14:38:44 INFO - PROCESS | 1662 | Number of tests: 6 14:38:44 INFO - PROCESS | 1662 | 14:38:44 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5850.49 Median:6129.79 stddev:647.50 (10.6%) stddev-sans-first:616.45 14:38:44 INFO - PROCESS | 1662 | Values: 3247.8 3656.8 3694.6 3724.1 3727.6 4539.7 5844.7 5938.3 5950.4 5977.6 4768.4 5964.7 5996.2 6006.1 6017.4 5272.2 5367.6 5380.0 5425.6 5428.2 5298.0 5384.9 5391.9 5435.1 5446.8 5265.6 5353.3 5381.7 5400.6 5418.8 5082.9 5425.3 5426.2 5427.7 5429.3 5309.5 5368.3 5384.9 5409.5 5440.9 5541.8 5693.4 5791.0 5874.9 5876.2 6201.2 6256.0 6261.4 6267.9 6284.4 6321.1 6329.3 6340.5 6355.9 6363.5 5986.8 6047.8 6127.6 6129.8 6130.6 5573.5 6405.4 6471.5 6509.6 6511.8 6227.7 6239.8 6243.5 6245.0 6253.7 6193.9 6196.7 6243.7 6356.4 6366.0 5870.2 6223.2 6251.8 6255.0 6257.1 5592.7 6173.3 6252.1 6263.1 6291.4 4911.7 4981.1 4988.1 5039.0 5060.5 3856.2 4519.7 4554.7 4562.7 4587.6 6103.7 6115.7 6123.9 6162.1 6169.1 6212.5 6248.2 6321.7 6329.4 6360.8 6113.2 6114.5 6117.5 6126.9 6157.5 5486.4 5551.9 5575.1 5583.0 5602.2 6360.2 6455.7 6492.5 6533.2 6563.9 6294.3 6310.5 6314.1 6317.1 6326.3 6349.2 6468.9 6534.4 6542.5 6564.7 5226.3 6208.7 6251.5 6277.4 6292.3 6293.2 6305.3 6315.2 6317.1 6324.8 6100.8 6134.0 6241.4 6241.7 6250.1 6162.2 6226.3 6229.0 6237.7 6257.1 5724.1 6001.8 6057.4 6189.4 6207.4 4741.7 6063.8 6112.8 6121.1 6148.9 6143.5 6148.0 6181.7 6235.3 6238.5 14:38:44 INFO - PROCESS | 1662 | 14:38:44 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:67401.82 Median:40113.70 stddev:142615.48 (355.5%) stddev-sans-first:142926.98 14:38:44 INFO - PROCESS | 1662 | Values: 458.8 536.7 580.7 614.1 681.0 37510.6 39787.4 39826.0 39959.4 40067.6 41123.0 41750.0 41798.8 41839.7 41855.8 9603.3 9786.5 9787.6 9810.6 9819.0 7770.8 8018.4 8039.0 8043.8 8078.5 7855.9 8054.4 8055.4 8109.0 8157.8 8050.2 8062.8 8069.9 8075.5 8184.2 9774.4 9878.5 9915.0 9944.6 9967.2 40159.8 40375.6 40420.6 40610.8 40716.0 3319.7 3450.8 3452.3 3588.3 3604.3 28229.6 28420.3 28931.0 29110.0 29698.0 2859.2 2864.3 2865.2 2903.2 2941.4 504707.0 504735.0 509349.0 509504.5 510282.4 48063.5 74444.6 75124.0 75168.6 75363.6 38324.4 47087.8 47326.5 47378.3 47399.8 17058.7 17336.2 17380.5 17394.7 17402.7 13635.7 13809.0 13821.5 13825.6 13884.2 13682.3 15117.6 15217.0 15487.4 15625.1 6345.4 6774.6 6777.7 6806.7 6812.4 945.4 999.7 1012.6 1131.7 1196.4 30864.2 31024.5 31266.7 31622.7 32000.0 1188.9 1247.9 1252.1 1253.6 1291.5 14304.9 15644.5 15942.8 16018.7 16381.4 563998.0 564901.0 567746.0 569146.0 570600.0 63002.0 63503.0 63916.0 63927.7 63990.0 1529.6 1564.8 1575.1 1582.9 1590.2 25623.6 30457.4 30534.0 30582.7 31102.4 44797.3 54982.2 54998.9 55064.9 55262.0 520685.0 527344.0 530421.0 532074.0 532456.0 30935.1 34475.3 35607.3 35737.8 36108.6 44639.8 47405.3 48051.8 48240.5 49513.0 31569.0 37915.6 38950.0 38954.2 39392.8 38328.7 39164.6 39180.4 39254.6 40171.4 33488.3 38267.0 39753.4 40287.4 40891.6 31835.8 33700.7 33827.5 34015.7 34021.8 25633.7 25673.0 25727.2 25801.9 25983.4 14:38:44 INFO - PROCESS | 1662 | 14:38:44 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:36363.82 Median:11193.61 stddev:111925.02 (999.9%) stddev-sans-first:112206.36 14:38:44 INFO - PROCESS | 1662 | Values: 367.3 376.2 378.2 378.5 384.3 20345.5 21081.9 21095.4 21725.3 21832.3 12240.2 12396.7 12430.7 12516.7 12565.9 4791.5 4900.0 5567.9 5619.6 5763.4 4792.7 5614.1 5658.1 5707.6 5724.2 5706.9 6350.5 6572.4 6587.7 6638.8 5953.0 6071.5 6161.7 6481.0 6501.2 5904.3 5942.7 5984.2 5990.7 6051.1 10464.4 10936.7 13477.3 13519.5 13547.9 2154.9 2282.9 2348.6 2593.4 2704.0 10485.6 13687.0 14363.0 15232.8 15472.9 1810.9 1838.9 1842.8 1912.2 1936.9 100171.5 100672.0 106370.5 107949.5 108067.0 11575.7 11647.0 11676.9 11697.3 11792.1 14289.4 14295.1 14304.4 14343.4 14362.6 8510.1 8753.4 8819.7 8828.6 8986.4 9147.1 9173.0 9196.1 9230.7 9276.8 4536.7 4596.0 4616.1 4623.0 4628.0 1960.4 2002.1 2002.2 2041.7 2046.8 766.8 978.4 981.5 1017.0 1105.7 19094.4 20580.1 21205.0 21516.4 21522.9 1012.1 1013.5 1039.4 1049.6 1056.3 11276.0 11349.4 11430.0 11435.4 11436.9 591137.0 656890.0 694651.0 709640.0 718361.0 121342.0 124820.0 126991.0 134090.3 143378.0 1047.8 1058.5 1065.2 1073.1 1088.8 18749.4 19022.0 19294.1 19375.1 19646.1 51727.7 52574.7 52637.0 54381.7 54428.5 57991.0 72072.5 75315.6 76130.6 77699.0 6634.6 7181.8 8211.9 8315.4 8444.2 9645.3 12736.6 13409.9 13413.6 13752.4 11554.9 11560.5 12056.5 12137.2 12184.9 11718.8 11722.3 11802.2 11917.9 12121.4 10258.4 11940.2 12292.4 12309.3 12355.6 8290.3 8298.1 8300.3 8330.3 8527.3 11085.4 11975.8 12061.8 12198.8 12241.3 14:38:44 INFO - PROCESS | 1662 | 14:38:44 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:6182.74 Median:2832.75 stddev:3250.98 (114.8%) stddev-sans-first:3241.61 14:38:44 INFO - PROCESS | 1662 | Values: 1569.7 1651.9 1962.7 2023.9 2072.9 7707.3 8292.0 8989.0 9069.4 9175.2 7542.4 8815.0 8894.1 8988.6 8993.6 2524.9 2561.6 2563.6 2566.8 2572.2 2216.8 2564.1 2603.2 2633.8 2647.4 2542.3 2578.8 2597.4 2600.8 2607.2 2556.6 2581.7 2586.8 2589.4 2598.6 2607.7 2613.7 2637.2 2642.1 2646.0 9047.7 9082.5 9105.9 9118.2 9120.9 5627.9 5651.9 5683.2 5687.5 5749.7 3048.5 3639.6 3708.8 3807.9 3812.9 1073.1 1079.8 1084.7 1104.3 1105.6 11879.8 11919.3 11948.3 12103.4 12288.9 4363.3 4976.6 4992.6 5127.6 5131.3 10489.9 10532.8 10627.0 10655.1 10661.3 4770.8 5580.7 5592.0 5719.4 5807.4 4609.7 4989.7 5035.1 5080.8 5095.7 4094.8 4146.4 4160.9 4164.4 4167.6 1180.3 1372.0 1386.6 1394.8 1421.9 1407.2 1430.0 1437.5 1442.6 1472.9 7788.3 8235.8 8372.8 8404.5 8440.0 465.3 534.2 545.4 552.4 553.2 6263.1 6288.4 6297.0 6299.9 6339.5 10663.6 10934.8 10944.2 10989.0 11089.3 10606.5 10852.9 10897.7 10912.2 10915.0 8497.6 8539.0 8586.0 8599.5 8607.4 7952.3 7961.4 8025.8 8078.0 8172.6 9694.6 9800.1 9854.7 9894.4 9902.2 9455.3 10242.6 10259.6 10266.4 10279.0 7495.0 7591.4 7675.7 7692.8 7707.8 8307.0 8332.2 8462.8 8469.3 8476.6 7331.2 7485.1 7548.2 7593.5 7657.0 5969.6 7330.9 7374.7 7400.6 7459.9 7739.0 7793.7 7823.5 7857.7 7871.1 6949.9 7082.9 7093.5 7094.3 7104.1 7166.1 7182.5 7220.0 7250.5 7262.2 14:38:44 INFO - PROCESS | 1662 | 14:38:44 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:6015.89 Median:6892.72 stddev:1945.22 (28.2%) stddev-sans-first:1903.54 14:38:44 INFO - PROCESS | 1662 | Values: 344.9 346.8 348.6 349.6 354.7 6879.8 6915.2 6931.6 6955.0 6973.3 5751.4 6175.1 6257.5 6880.2 6905.2 4887.5 5020.1 5084.6 5111.4 5155.9 5080.3 5098.1 5102.1 5102.9 5116.6 4545.6 4739.3 5101.8 5119.9 5138.5 4160.3 5116.1 5118.3 5130.2 5139.5 4314.6 4406.6 4432.8 4436.3 4441.5 4724.2 5448.5 6045.7 6554.9 6583.2 5089.6 5764.4 5887.1 5955.3 5958.2 6129.4 7058.6 7413.9 7426.0 7436.8 4757.0 4771.1 4771.2 4789.5 4793.9 7783.4 7829.7 7847.3 7849.1 7856.6 4657.9 4810.6 4853.0 4860.1 4864.2 4910.8 4961.4 4963.1 4972.9 4986.5 5918.2 5926.4 5928.8 5937.2 5938.6 6138.1 7392.6 7429.5 7429.7 7430.2 1706.4 1729.2 1730.9 1733.6 1737.1 1050.5 1088.1 1098.2 1100.3 1111.5 7044.3 7044.5 7077.8 7127.0 7144.7 7471.8 7692.9 7702.6 7704.6 7729.8 6942.7 7101.5 7172.4 7192.3 7207.5 3307.8 4075.9 4101.6 4119.0 4135.0 6467.8 8117.2 8123.6 8135.6 8147.8 7708.2 7890.5 8008.2 8022.8 8045.4 8049.0 8063.4 8080.1 8086.2 8102.4 7733.5 7737.6 7744.3 7752.2 7757.7 6167.8 7127.9 7561.5 7573.8 7585.9 7727.6 8051.7 8065.0 8130.4 8153.3 5045.7 5098.7 5118.4 5127.6 5131.7 7631.7 7653.0 7666.5 7671.6 7673.3 7372.1 7391.9 7398.6 7404.8 7405.4 7104.2 7416.1 7431.5 7458.3 7464.1 5866.3 7211.9 7290.5 7293.6 7295.9 5988.9 7406.4 7424.8 7461.6 7481.9 7000.6 7251.9 7257.7 7279.5 7279.9 14:38:44 INFO - PROCESS | 1662 | 14:38:44 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18914.49 Median:48583.88 stddev:27725.93 (57.1%) stddev-sans-first:27769.95 14:38:44 INFO - PROCESS | 1662 | Values: 692.2 716.4 724.0 786.2 812.3 11974.6 15303.2 15589.3 15674.5 15764.9 12389.6 14413.2 14531.6 14560.7 14851.5 829.6 978.7 991.3 1012.5 1015.1 967.7 968.7 1000.6 1026.2 1030.8 1034.6 1073.3 1074.3 1081.5 1081.7 1058.6 1058.8 1067.4 1072.4 1075.0 784.4 787.3 792.7 799.0 801.3 15627.9 15767.3 15827.5 15850.0 15922.0 13300.8 13317.5 13328.6 13416.9 13490.6 10188.7 10320.8 10424.2 10442.4 10775.7 3594.1 3600.3 3631.7 3651.3 3866.1 80377.0 80445.8 80715.0 80890.4 81502.4 9621.4 9795.6 9857.0 9961.4 9979.4 22916.5 23094.8 23112.1 23155.2 23158.3 7438.1 7489.8 7577.7 7595.4 7686.2 4193.9 4229.1 4253.1 4282.3 4302.1 3673.3 3762.5 3785.4 3807.1 3819.9 690.5 690.5 707.1 709.3 711.0 543.8 597.9 598.3 599.8 614.0 7947.4 7978.3 8111.4 8121.3 8243.3 508.4 511.8 527.9 590.5 593.3 3721.6 3816.2 3820.8 3883.7 3927.0 103330.5 103628.0 104076.0 104286.0 105468.0 84571.0 86383.0 86476.0 87229.6 88717.6 78019.4 78094.8 78401.3 80256.6 80431.2 6414.7 7402.0 7444.9 7613.7 7844.1 46268.0 47465.6 48506.8 48661.0 48665.8 63644.0 66290.0 67650.0 68071.0 68225.3 9698.1 9893.6 10051.6 10068.1 10097.9 10648.7 10654.4 11009.1 11013.4 11292.5 10282.5 10417.7 10427.2 10668.3 10678.9 8875.9 10288.0 10302.9 10380.9 10627.5 7602.6 7896.0 8507.8 9822.9 10055.7 8812.1 8897.9 9047.4 9077.0 9087.9 8606.8 8781.4 8793.2 8880.3 8991.6 14:38:44 INFO - PROCESS | 1662 | -------- Summary: end -------- 14:38:44 INFO - PROCESS | 1662 | 14:38:45 INFO - TEST-INFO | 1662: exit 0 14:38:45 INFO - TEST-OK | dromaeo_css | took 1109846ms 14:38:45 INFO - TEST-START | kraken 14:38:45 INFO - operating with platform_type : mac_ 14:38:45 INFO - Initialising browser for kraken test... 14:38:45 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpMora4b/profile http://localhost:49278/getInfo.html) 14:38:47 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 14:38:47 INFO - PROCESS | 1675 | colorDepth:24 14:38:47 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 14:38:47 INFO - PROCESS | 1675 | __metrics 14:38:47 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:38:48 INFO - TEST-INFO | 1675: exit 0 14:38:48 INFO - Browser initialized. 14:38:48 INFO - Running cycle 1/1 for kraken test... 14:38:48 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpMora4b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:39:00 INFO - PROCESS | 1679 | RSS: Main: 167825408 14:39:00 INFO - PROCESS | 1679 | 14:39:02 INFO - PROCESS | 1679 | 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) 14:39:03 INFO - PROCESS | 1679 | RSS: Main: 179728384 14:39:03 INFO - PROCESS | 1679 | 14:39:06 INFO - PROCESS | 1679 | 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) 14:39:06 INFO - PROCESS | 1679 | RSS: Main: 188784640 14:39:06 INFO - PROCESS | 1679 | 14:39:10 INFO - PROCESS | 1679 | 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) 14:39:10 INFO - PROCESS | 1679 | RSS: Main: 192544768 14:39:10 INFO - PROCESS | 1679 | 14:39:12 INFO - PROCESS | 1679 | 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) 14:39:13 INFO - PROCESS | 1679 | RSS: Main: 193966080 14:39:13 INFO - PROCESS | 1679 | 14:39:15 INFO - PROCESS | 1679 | 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) 14:39:15 INFO - PROCESS | 1679 | RSS: Main: 194523136 14:39:15 INFO - PROCESS | 1679 | 14:39:18 INFO - PROCESS | 1679 | 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) 14:39:19 INFO - PROCESS | 1679 | RSS: Main: 195301376 14:39:19 INFO - PROCESS | 1679 | 14:39:22 INFO - PROCESS | 1679 | 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) 14:39:22 INFO - PROCESS | 1679 | RSS: Main: 195145728 14:39:22 INFO - PROCESS | 1679 | 14:39:25 INFO - PROCESS | 1679 | 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) 14:39:26 INFO - PROCESS | 1679 | RSS: Main: 195276800 14:39:26 INFO - PROCESS | 1679 | 14:39:27 INFO - PROCESS | 1679 | 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) 14:39:28 INFO - PROCESS | 1679 | RSS: Main: 194682880 14:39:28 INFO - PROCESS | 1679 | 14:39:30 INFO - PROCESS | 1679 | 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) 14:39:30 INFO - PROCESS | 1679 | RSS: Main: 194969600 14:39:30 INFO - PROCESS | 1679 | 14:39:32 INFO - PROCESS | 1679 | 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) 14:39:33 INFO - PROCESS | 1679 | RSS: Main: 194412544 14:39:33 INFO - PROCESS | 1679 | 14:39:36 INFO - PROCESS | 1679 | 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) 14:39:36 INFO - PROCESS | 1679 | RSS: Main: 194494464 14:39:36 INFO - PROCESS | 1679 | 14:39:39 INFO - PROCESS | 1679 | 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) 14:39:39 INFO - PROCESS | 1679 | RSS: Main: 194654208 14:39:39 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | 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) 14:39:41 INFO - PROCESS | 1679 | RSS: Main: 196132864 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | __start_tp_report 14:39:41 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 14:39:41 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 14:39:41 INFO - PROCESS | 1679 | |i|pagename|runs| 14:39:41 INFO - PROCESS | 1679 | |0;ai-astar;97;141;167;165;119;129;115;115;114;115 14:39:41 INFO - PROCESS | 1679 | |1;audio-beat-detection;149;121;155;153;123;139;123;151;151;128 14:39:41 INFO - PROCESS | 1679 | |2;audio-dft;195;201;198;285;279;194;194;195;200;194 14:39:41 INFO - PROCESS | 1679 | |3;audio-fft;65;68;74;110;57;57;59;59;117;56 14:39:41 INFO - PROCESS | 1679 | |4;audio-oscillator;82;79;122;80;78;82;113;102;114;138 14:39:41 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;89;88;90;87;97;86;90;87;84;126 14:39:41 INFO - PROCESS | 1679 | |6;imaging-darkroom;94;95;95;95;95;94;122;104;150;150 14:39:41 INFO - PROCESS | 1679 | |7;imaging-desaturate;137;151;92;90;92;91;92;110;119;95 14:39:41 INFO - PROCESS | 1679 | |8;json-parse-financial;56;59;58;58;59;57;56;60;84;80 14:39:41 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;63;64;71;62;60;67;93;78;66;68 14:39:41 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;81;82;84;82;84;82;84;82;82;88 14:39:41 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;147;132;128;129;136;135;134;118;121;142 14:39:41 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;140;138;135;122;122;153;173;172;164;137 14:39:41 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;64;69;68;66;65;65;65;66;67;66 14:39:41 INFO - PROCESS | 1679 | __end_tp_report 14:39:41 INFO - PROCESS | 1679 | __start_cc_report 14:39:41 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,919 14:39:41 INFO - PROCESS | 1679 | __end_cc_report 14:39:41 INFO - PROCESS | 1679 | __startTimestamp1461620381878__endTimestamp 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | ------- Summary: start ------- 14:39:41 INFO - PROCESS | 1679 | Number of tests: 14 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:127.70 Median:135.00 stddev:23.10 (17.1%) stddev-sans-first:21.67 14:39:41 INFO - PROCESS | 1679 | Values: 97.0 141.0 167.0 165.0 119.0 129.0 115.0 115.0 114.0 115.0 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:150.00 stddev:14.13 (9.4%) stddev-sans-first:14.54 14:39:41 INFO - PROCESS | 1679 | Values: 149.0 121.0 155.0 153.0 123.0 139.0 123.0 151.0 151.0 128.0 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:213.50 Median:199.00 stddev:36.22 (18.2%) stddev-sans-first:37.79 14:39:41 INFO - PROCESS | 1679 | Values: 195.0 201.0 198.0 285.0 279.0 194.0 194.0 195.0 200.0 194.0 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:72.20 Median:59.00 stddev:22.56 (38.2%) stddev-sans-first:23.78 14:39:41 INFO - PROCESS | 1679 | Values: 65.0 68.0 74.0 110.0 57.0 57.0 59.0 59.0 117.0 56.0 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:99.00 Median:78.50 stddev:21.76 (27.7%) stddev-sans-first:22.19 14:39:41 INFO - PROCESS | 1679 | Values: 82.0 79.0 122.0 80.0 78.0 82.0 113.0 102.0 114.0 138.0 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:88.50 stddev:12.30 (13.9%) stddev-sans-first:12.99 14:39:41 INFO - PROCESS | 1679 | Values: 89.0 88.0 90.0 87.0 97.0 86.0 90.0 87.0 84.0 126.0 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:109.40 Median:94.50 stddev:23.07 (24.4%) stddev-sans-first:23.78 14:39:41 INFO - PROCESS | 1679 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 122.0 104.0 150.0 150.0 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:106.90 Median:91.50 stddev:21.99 (24.0%) stddev-sans-first:20.45 14:39:41 INFO - PROCESS | 1679 | Values: 137.0 151.0 92.0 90.0 92.0 91.0 92.0 110.0 119.0 95.0 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:59.00 stddev:10.30 (17.5%) stddev-sans-first:10.63 14:39:41 INFO - PROCESS | 1679 | Values: 56.0 59.0 58.0 58.0 59.0 57.0 56.0 60.0 84.0 80.0 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:67.50 stddev:9.81 (14.5%) stddev-sans-first:10.14 14:39:41 INFO - PROCESS | 1679 | Values: 63.0 64.0 71.0 62.0 60.0 67.0 93.0 78.0 66.0 68.0 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:2.02 (2.4%) stddev-sans-first:2.00 14:39:41 INFO - PROCESS | 1679 | Values: 81.0 82.0 84.0 82.0 84.0 82.0 84.0 82.0 82.0 88.0 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:134.50 stddev:8.79 (6.5%) stddev-sans-first:7.52 14:39:41 INFO - PROCESS | 1679 | Values: 147.0 132.0 128.0 129.0 136.0 135.0 134.0 118.0 121.0 142.0 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.60 Median:146.50 stddev:18.95 (12.9%) stddev-sans-first:19.99 14:39:41 INFO - PROCESS | 1679 | Values: 140.0 138.0 135.0 122.0 122.0 153.0 173.0 172.0 164.0 137.0 14:39:41 INFO - PROCESS | 1679 | 14:39:41 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.52 (2.3%) stddev-sans-first:1.41 14:39:41 INFO - PROCESS | 1679 | Values: 64.0 69.0 68.0 66.0 65.0 65.0 65.0 66.0 67.0 66.0 14:39:41 INFO - PROCESS | 1679 | -------- Summary: end -------- 14:39:41 INFO - PROCESS | 1679 | 14:39:42 INFO - TEST-INFO | 1679: exit 0 14:39:42 INFO - TEST-OK | kraken | took 57592ms 14:39:42 INFO - SUITE-END | took 1167s 14:39:43 INFO - Completed test suite (00:19:27) 14:39:43 INFO - javascript benchmark 14:39:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3247.7888937219077, 3656.762310449819, 3694.5935947045805, 3724.0689827543115, 3727.645873642004, 4539.660800063981, 5844.707764611763, 5938.317093534245, 5950.404959504053, 5977.641341519512, 4768.403949506312, 5964.701764911748, 5996.220491336131, 6006.099085137232, 6017.368176341487, 5272.209168624709, 5367.570594352443, 5379.9731001345135, 5425.6202065855405, 5428.240046393508, 5297.973510132444, 5384.892302153955, 5391.948570028826, 5435.10320797068, 5446.782128714846, 5265.552428043621, 5353.277307563488, 5381.730913454312, 5400.621956463049, 5418.834950485645, 5082.898342033176, 5425.321834770653, 5426.186072089179, 5427.674339539621, 5429.294191755086, 5309.548688361494, 5368.30212072432, 5384.946150538483, 5409.486098820606, 5440.945590544123, 5541.806036788734, 5693.430656934315, 5791.0, 5874.882502349929, 5876.177335173079, 6201.224846894138, 6255.968720156416, 6261.436470717612, 6267.874642507124, 6284.402981716729, 6321.146645202884, 6329.335419780903, 6340.492760579143, 6355.87288254237, 6363.490920726331, 5986.790462333797, 6047.788327408608, 6127.632342059446, 6129.7854575090105, 6130.601510901777, 5573.470520300565, 6405.423511883952, 6471.5146364022885, 6509.609423434515, 6511.772087976898, 6227.719752611143, 6239.844003899848, 6243.500519958392, 6245.0, 6253.6560489173535, 6193.876122477525, 6196.721147548371, 6243.719032643542, 6356.364363563606, 6366.0, 5870.207521984477, 6223.190985171898, 6251.78118765841, 6255.030470277115, 6257.061440783918, 5592.720363981784, 6173.332401760676, 6252.093446450239, 6263.123162757218, 6291.370862913764, 4911.656184067152, 4981.078500477351, 4988.127077761377, 5038.974805126024, 5060.544550990355, 3856.2094770571966, 4519.683622146418, 4554.658400619966, 4562.703424277478, 4587.564181402761, 6103.664298463627, 6115.724792384353, 6123.908141377883, 6162.137300777895, 6169.105479705418, 6212.502999760099, 6248.218972628421, 6321.747130114744, 6329.367063293726, 6360.77737279193, 6113.23584551931, 6114.510839132859, 6117.541184411098, 6126.908096378558, 6157.538184636171, 5486.369067557282, 5551.916721249185, 5575.080111781511, 5583.0, 5602.159676048625, 6360.204974378203, 6455.7417703292285, 6492.545521813522, 6533.150690410216, 6563.901541476882, 6294.339094395205, 6310.52671049664, 6314.1160237565855, 6317.084022816758, 6326.33573474797, 6349.174607301022, 6468.870622587616, 6534.444572211415, 6542.54202205841, 6564.671766411756, 5226.320578324946, 6208.658523781055, 6251.499880009497, 6277.435030847246, 6292.339304372975, 6293.150424692791, 6305.306416294296, 6315.210598675166, 6317.084022816758, 6324.841878953063, 6100.847478813065, 6134.008014331881, 6241.438270555672, 6241.6879156041105, 6250.062490626442, 6162.168107305636, 6226.283977342664, 6228.968855155877, 6237.688115594293, 6257.092721555258, 5724.112762521816, 6001.789937352171, 6057.394260574084, 6189.412005859436, 6207.410296021871, 4741.715497070187, 6063.757449701962, 6112.755489780359, 6121.112438696453, 6148.938510615016, 6143.511877689543, 6148.0, 6181.660008699565, 6235.282942461494, 6238.469730072995], "unit": "score", "name": "dojo.html", "value": 5813.05883225684}, {"lowerIsBetter": false, "replicates": [458.80500787165465, 536.6967663270252, 580.7357652268217, 614.0788816774838, 680.965951702415, 37510.62489375105, 39787.40318895219, 39826.0, 39959.40060899085, 40067.59932400683, 41122.9719257018, 41750.0, 41798.79100604493, 41839.74480765574, 41855.790721046425, 9603.32776705631, 9786.510674466284, 9787.608495660164, 9810.607575696964, 9818.950905245463, 7770.8445831083345, 8018.35853131751, 8039.0, 8043.798905027392, 8078.515289082645, 7855.8821617675785, 8054.395920305971, 8055.395845311625, 8109.0, 8157.79605509864, 8050.235227653364, 8062.815188000765, 8069.919300807005, 8075.515469071875, 8184.2224988625985, 9774.364666296668, 9878.456684882329, 9914.9504252479, 9944.602215911355, 9967.202623790079, 40159.79920100381, 40375.59624403748, 40420.595794042274, 40610.796946015376, 40715.98210044743, 3319.668033196685, 3450.8102054387, 3452.3267962747273, 3588.3002814451193, 3604.333198358312, 28229.576556351672, 28420.28949276264, 28930.98741544036, 29109.981150659838, 29698.0, 2859.1994241612383, 2864.255293623673, 2865.2407112115307, 2903.216131644444, 2941.4117176564773, 504707.0, 504735.0, 509349.0, 509504.45247773896, 510282.4485877584, 48063.519364806605, 74444.62777686077, 75124.0, 75168.62415687996, 75363.62318188374, 38324.425133623015, 47087.82280442948, 47326.5267347329, 47378.289325660146, 47399.76300118477, 17058.658826823394, 17336.219870105877, 17380.47858564245, 17394.65210695779, 17402.651946961243, 13635.659108522366, 13808.964327675465, 13821.516246931309, 13825.585232443043, 13884.166949982831, 13682.31588420575, 15117.622059448602, 15217.010894291836, 15487.380504779909, 15625.06249625026, 6345.3666728307235, 6774.559653622598, 6777.728890844311, 6806.659667016629, 6812.365032392289, 945.3618807305041, 999.7200783780407, 1012.5544760305442, 1131.671815173607, 1196.4257156564897, 30864.228394290323, 31024.53463198054, 31266.749330027, 31622.735090596118, 32000.0, 1188.928664280146, 1247.9188852724544, 1252.136026141959, 1253.642711827125, 1291.5285920639087, 14304.856951430353, 15644.452444164399, 15942.840571594368, 16018.67962640764, 16381.426650067191, 563998.0, 564901.0, 567746.0, 569146.0, 570600.0, 63002.0, 63503.04745428822, 63916.0, 63927.68036159789, 63990.0, 1529.6252418157624, 1564.765285207228, 1575.1415478564438, 1582.8733701303868, 1590.157216675164, 25623.6156457657, 30457.390852183275, 30534.0, 30582.694173057986, 31102.377952440373, 44797.32804007877, 54982.17526737182, 54998.90002200014, 55064.898702026534, 55262.0, 520685.0, 527344.0, 530421.0, 532074.0, 532456.0, 30935.0719478416, 34475.31049378948, 35607.28785424329, 35737.821310893276, 36108.63891361053, 44639.77680111579, 47405.288920666906, 48051.75974120107, 48240.5175948236, 49513.0, 31569.0, 37915.62084379121, 38950.026249343995, 38954.22091558096, 39392.80303598464, 38328.717305891194, 39164.6083539161, 39180.41229381505, 39254.6074539251, 40171.39742903917, 33488.33023339471, 38267.0, 39753.40369894396, 40287.39568906528, 40891.59108408878, 31835.840820795747, 33700.662993369755, 33827.492587610715, 34015.65984340125, 34021.829890850386, 25633.743662563134, 25673.0, 25727.228183154537, 25801.870990644926, 25983.350416239744], "unit": "score", "name": "ext.html", "value": 19854.5130994942}, {"lowerIsBetter": false, "replicates": [367.2618037744135, 376.1968197897488, 378.2133163020917, 378.5495260639838, 384.3063270796215, 20345.491362715922, 21081.894590527045, 21095.367138985854, 21725.3482395528, 21832.345029649117, 12240.204386714857, 12396.690082747937, 12430.689232769186, 12516.687082822935, 12565.874341256607, 4791.520847915198, 4899.975500122512, 5567.916481252764, 5619.5785316101255, 5763.423657634224, 4792.664513484057, 5614.073677843151, 5658.066419040853, 5707.62900411474, 5724.227229324029, 5706.885862282752, 6350.49196064316, 6572.4084832365315, 6587.670616469158, 6638.834029149261, 5953.0, 6071.4535691787505, 6161.661108639023, 6481.0, 6501.15484986951, 5904.261967254093, 5942.732577034044, 5984.222051133368, 5990.670513121777, 6051.0923361496125, 10464.42445665488, 10936.726581835439, 13477.258750768704, 13519.459221631123, 13547.864521354759, 2154.91380344786, 2282.9200977965857, 2348.56551537966, 2593.351662084479, 2704.019246254645, 10485.63300284494, 13686.973476989166, 14362.994590378677, 15232.771508427382, 15472.922635386863, 1810.9275628974826, 1838.8988605626685, 1842.7512285841374, 1912.2064343297654, 1936.893470859102, 100171.49742753938, 100672.0, 106370.46814765877, 107949.46025269823, 108067.0, 11575.710607234718, 11647.0, 11676.949074583328, 11697.2981621103, 11792.115591330685, 14289.42842286297, 14295.07082039664, 14304.427822887175, 14343.354549045318, 14362.640933976525, 8510.148985101441, 8753.387262891536, 8819.735407937773, 8828.602712877935, 8986.415882967585, 9147.0852914708, 9173.036831132635, 9196.08039196075, 9230.676926307548, 9276.814463710689, 4536.705114167568, 4595.977020114878, 4616.0767846430845, 4622.976885115553, 4628.0, 1960.4412742368356, 2002.1390801955008, 2002.2091273947, 2041.7345745053049, 2046.8362530997485, 766.8312971146339, 978.3982850547005, 981.4727077774759, 1016.9677777056294, 1105.701460605632, 19094.427167185007, 20580.073896674687, 21205.045772939946, 21516.354509364744, 21522.892385537973, 1012.099231683802, 1013.5287091502339, 1039.4023436524028, 1049.6431213387484, 1056.3450660590483, 11275.985161335519, 11349.36148678821, 11430.0, 11435.371054592077, 11436.94281528587, 591137.0, 656890.0, 694651.0, 709640.0, 718361.0, 121342.0, 124820.0, 126991.0, 134090.32954835164, 143378.0, 1047.8375851742992, 1058.4654749351528, 1065.2383545764815, 1073.1146803886668, 1088.755030118233, 18749.437516874517, 19022.0, 19294.13176407093, 19375.128119234385, 19646.115924783135, 51727.74136129295, 52574.737126314125, 52637.0, 54381.72809135929, 54428.45571544234, 57991.0, 72072.47746328854, 75315.62342188254, 76130.61934690291, 77699.0, 6634.635095069818, 7181.784546463615, 8211.93244878162, 8315.417920745489, 8444.155584441507, 9645.324827262024, 12736.554220602235, 13409.865901340861, 13413.597592072254, 13752.449902003807, 11554.884451155382, 11560.537578496765, 12056.457459414172, 12137.21108127969, 12184.939075304921, 11718.765624687288, 11722.296662200295, 11802.232854864405, 11917.940410297893, 12121.393930303273, 10258.43578603184, 11940.223885447418, 12292.385380731106, 12309.26144431337, 12355.62933112008, 8290.33677305802, 8298.087210406971, 8300.335973122257, 8330.291925186184, 8527.275181609633, 11085.445727713743, 11975.820362694742, 12061.75876482483, 12198.817017744563, 12241.326727030098], "unit": "score", "name": "jquery.html", "value": 9543.750700600085}, {"lowerIsBetter": false, "replicates": [1569.7331453652878, 1651.8843680942334, 1962.6859702447612, 2023.878567285962, 2072.8963551822403, 7707.30634242918, 8292.004959404865, 8989.011208767039, 9069.365144439884, 9175.220106290957, 7542.396608271339, 8815.0, 8894.110588941103, 8988.550572471382, 8993.550322483883, 2524.899004039836, 2561.6285638582394, 2563.551378508763, 2566.781823545001, 2572.2283315005425, 2216.833737469688, 2564.1153801938394, 2603.2320465462735, 2633.8156329056974, 2647.4308023774884, 2542.250036239314, 2578.7808036316937, 2597.4155814941582, 2600.77893379063, 2607.1787386973137, 2556.6037264224074, 2581.7418258174125, 2586.831855929368, 2589.4432696970243, 2598.649182360376, 2607.7001144868395, 2613.6800915537724, 2637.222019504251, 2642.075273654225, 2646.0, 9047.68333108338, 9082.500462474562, 9105.908940910573, 9118.224950879183, 9120.863187052133, 5627.887442251132, 5651.943480565183, 5683.232763576905, 5687.459691329358, 5749.712514374264, 3048.4512787698204, 3639.6178401267753, 3708.8145592720257, 3807.8667246646232, 3812.942805857914, 1073.0825144501416, 1079.7516571188592, 1084.72003036417, 1104.2546281260118, 1105.5688281570194, 11879.821802672881, 11919.284842909366, 11948.342841143734, 12103.394830258452, 12288.938555307255, 4363.345498175236, 4976.62675299354, 4992.575631071327, 5127.6154288428515, 5131.307273518102, 10489.947550262352, 10532.789344213073, 10627.0, 10655.094316982988, 10661.307015043998, 4770.76146192689, 5580.665160090408, 5592.0, 5719.370869204384, 5807.390224026501, 4609.746463944515, 4989.700617962933, 5035.093683137071, 5080.77136528857, 5095.668781529189, 4094.754314741125, 4146.357314616239, 4160.895977600524, 4164.37534369847, 4167.645750111214, 1180.3154170581215, 1371.9519816806564, 1386.5632325817335, 1394.8047273381735, 1421.8909250784197, 1407.197897198587, 1429.9785503217252, 1437.547172640615, 1442.5600191941348, 1472.9263536823116, 7788.299053085249, 8235.794105147299, 8372.790680233044, 8404.537750423664, 8440.0, 465.2881091929286, 534.1987019470794, 545.3973359437844, 552.4392741367515, 553.1812916883035, 6263.123162757218, 6288.402601752918, 6297.0, 6299.905501417483, 6339.492840572743, 10663.573457061631, 10934.835977460345, 10944.23390362667, 10988.956049175316, 11089.33463992163, 10606.522706478227, 10852.891471085346, 10897.67306980792, 10912.181586380895, 10915.017648411682, 8497.61760720769, 8539.018012928469, 8585.957070214734, 8599.484030958163, 8607.35444841652, 7952.324052455606, 7961.402894782798, 8025.799355016171, 8077.990251218597, 8172.5913704315735, 9694.612215511583, 9800.068993445611, 9854.655087071918, 9894.356866803635, 9902.158316542886, 9455.338126331366, 10242.59029638836, 10259.640912568024, 10266.384016959006, 10279.023492768176, 7495.0, 7591.3547348475995, 7675.692972281046, 7692.7692169235015, 7707.845843083219, 8307.044689860502, 8332.16678332162, 8462.830743384975, 8469.322454203526, 8476.576171191538, 7331.230220826949, 7485.1017877855, 7548.207438219128, 7593.544387336778, 7657.0, 5969.641821490724, 7330.890036649348, 7374.741884034033, 7400.592967386845, 7459.850802983801, 7738.955241042612, 7793.688252469838, 7823.530588164728, 7857.724979625686, 7871.134175240833, 6949.861002780017, 7082.858342833011, 7093.538919970186, 7094.326039026284, 7104.147502299757, 7166.140063192451, 7182.497225194186, 7219.9892015116875, 7250.456215783732, 7262.164851042197], "unit": "score", "name": "mootools.html", "value": 4989.313870756301}, {"lowerIsBetter": false, "replicates": [344.8517137630819, 346.82658670664665, 348.6200041954271, 349.58050339592495, 354.6858887820624, 6879.828004299889, 6915.204751453591, 6931.5841049537, 6954.965225173867, 6973.267806880281, 5751.396103409134, 6175.135481032659, 6257.468115210213, 6880.2431732509385, 6905.205901321349, 4887.462379138292, 5020.071286811952, 5084.644074914758, 5111.386633603973, 5155.922661160085, 5080.288759573663, 5098.133317336044, 5102.132637451642, 5102.923456148161, 5116.590672746172, 4545.590896819285, 4739.289106633998, 5101.770420331094, 5119.897602047957, 5138.460461651529, 4160.251154792136, 5116.079105760961, 5118.309028281172, 5130.204818253177, 5139.460356662553, 4314.590113939171, 4406.603405693503, 4432.778361081933, 4436.334549817553, 4441.489228738672, 4724.244120940633, 5448.509634132907, 6045.697715114226, 6554.868902621968, 6583.210014798207, 5089.592832573422, 5764.423557644244, 5887.1463637772285, 5955.285365756094, 5958.225430693982, 6129.417705317987, 7058.647067646649, 7413.925860741431, 7425.962870185668, 7436.772932466137, 4757.048590281957, 4771.1173432914675, 4771.188897887368, 4789.473157952622, 4793.945332026983, 7783.404402097556, 7829.686812527492, 7847.293743563049, 7849.136594974549, 7856.646450909666, 4657.906841863211, 4810.5670489656095, 4852.951470485321, 4860.1008813369635, 4864.221724524059, 4910.779014944336, 4961.42943561495, 4963.057019166346, 4972.925406118911, 4986.501349865057, 5918.171455996164, 5926.407359264039, 5928.762849486058, 5937.198478205473, 5938.6436813791315, 6138.109974053827, 7392.55644661322, 7429.517081389692, 7429.665665044978, 7430.219826918095, 1706.436875830973, 1729.1786401459206, 1730.8701847361247, 1733.635936453359, 1737.1314342828587, 1050.5325130317087, 1088.0968795899385, 1098.1763677242068, 1100.3287994323457, 1111.5387114347454, 7044.330788575077, 7044.471664625174, 7077.82305442368, 7127.002219689248, 7144.714211431485, 7471.813204669927, 7692.884606730903, 7702.576358300347, 7704.5762483062845, 7729.8454030919065, 6942.722291108299, 7101.502894797314, 7172.426205903515, 7192.28077192287, 7207.495475316782, 3307.768456208042, 4075.9388609170887, 4101.610347017028, 4119.032027473541, 4134.958650413518, 6467.773627923094, 8117.188281171835, 8123.593820308961, 8135.552544609985, 8147.79630509242, 7708.152103268636, 7890.526568405914, 8008.239217274349, 8022.799430014296, 8045.436819422701, 8049.0, 8063.395245356622, 8080.0707918590115, 8086.231807978233, 8102.351811855037, 7733.535987840747, 7737.613119344122, 7744.341730952932, 7752.18602046777, 7757.728479503416, 6167.828112658581, 7127.893081603676, 7561.508501947355, 7573.772786816405, 7585.886211706718, 7727.613619319124, 8051.718189863327, 8064.9756341371985, 8130.381980018835, 8153.306968907709, 5045.722485263199, 5098.668586541863, 5118.411382691038, 5127.5897928166405, 5131.692098474104, 7631.732889348847, 7653.005109335751, 7666.540007599562, 7671.619108560512, 7673.309402153833, 7372.078490188726, 7391.889121663072, 7398.593077380796, 7404.777856664308, 7405.370543503863, 7104.218535961144, 7416.0729908761405, 7431.479796414199, 7458.291462311072, 7464.104307483137, 5866.325372582208, 7211.8557628848175, 7290.453216008715, 7293.562386256842, 7295.8540829184185, 5988.940110599013, 7406.44451666138, 7424.777256682308, 7461.589612571361, 7481.88777168332, 7000.649967501503, 7251.927480725336, 7257.709691612276, 7279.490435669452, 7279.8544029120185], "unit": "score", "name": "prototype.html", "value": 5371.13152919991}, {"lowerIsBetter": false, "replicates": [692.2005084127834, 716.4304378019475, 723.9746608868691, 786.1666633368629, 812.3163383431117, 11974.580889668863, 15303.15832629205, 15589.298481568328, 15674.529764107081, 15764.921175394122, 12389.566365177221, 14413.207273599948, 14531.636709082279, 14560.708785824303, 14851.480198193065, 829.5520418973747, 978.6623614852882, 991.2912267728573, 1012.5089331674133, 1015.1422048369117, 967.6613185385094, 968.6658102954469, 1000.5747557288123, 1026.199564339816, 1030.8247597908337, 1034.5551412892453, 1073.2540884085563, 1074.317808191796, 1081.453865797771, 1081.7187531241893, 1058.6294796821128, 1058.8094143054248, 1067.359584249452, 1072.3565860483725, 1074.9570017199303, 784.3960150683998, 787.3307688464816, 792.675003248671, 798.997258440659, 801.3028665061375, 15627.906046576743, 15767.29047192879, 15827.52517424479, 15850.048997060214, 15922.0, 13300.800487992688, 13317.467301307935, 13328.600141995756, 13416.86583134166, 13490.595282141552, 10188.745281368025, 10320.845187322197, 10424.16606671472, 10442.425666588335, 10775.676729698122, 3594.0835087052897, 3600.279944011208, 3631.7457777955556, 3651.3245049665898, 3866.149447121629, 80377.0, 80445.79331310035, 80715.0, 80890.38219235641, 81502.3699526012, 9621.422714637145, 9795.608175673036, 9856.950715246521, 9961.35251208669, 9979.401235925867, 22916.541669166523, 23094.7690523096, 23112.075516979134, 23155.189568365025, 23158.305250842503, 7438.070241219848, 7489.775306740807, 7577.696892124363, 7595.354394876497, 7686.192949740309, 4193.874183774492, 4229.133027729308, 4253.085586598834, 4282.272013757669, 4302.075053863372, 3673.3204357194004, 3762.4544441055896, 3785.413260944558, 3807.1053302473897, 3819.866304679323, 690.4752388184916, 690.4786885901212, 707.0913875669739, 709.3084242863167, 710.9903936410207, 543.8450041738165, 597.8624916269282, 598.3119412675458, 599.8080614203413, 613.9877202456015, 7947.3642108631175, 7978.3218426434405, 8111.432199746079, 8121.26908578219, 8243.2581067703, 508.3975489045493, 511.8438876142738, 527.8733104055076, 590.5275779376567, 593.2762030322999, 3721.5720192177705, 3816.1795214029116, 3820.84716611338, 3883.66988805949, 3927.0182454386404, 103330.48334758429, 103628.0, 104076.0, 104286.0, 105468.0, 84571.0, 86383.0, 86476.0, 87229.56385218033, 88717.55641221753, 78019.43961120746, 78094.82857757139, 78401.34698920122, 80256.59871700604, 80431.19568804237, 6414.679266036773, 7401.962990185015, 7444.851102978018, 7613.695452181851, 7844.09792873804, 46268.0, 47465.57603271907, 48506.757466212446, 48661.0, 48665.75667121642, 63644.0, 66290.0, 67650.0, 68071.0, 68225.29436763922, 9698.078682525149, 9893.604255829974, 10051.648192313527, 10068.144207742424, 10097.949510252402, 10648.680539583514, 10654.414007229676, 11009.119270458505, 11013.449327533432, 11292.548298067984, 10282.537285822305, 10417.687469375931, 10427.165826733995, 10668.253222274367, 10678.946605266923, 8875.911240887508, 10287.971202879653, 10302.948485257826, 10380.948095259475, 10627.521761520904, 7602.619869006417, 7896.0, 8507.76637387563, 9822.852657210005, 10055.748606284902, 8812.064573474609, 8897.866532001895, 9047.366684332033, 9077.04691007461, 9087.909120908971, 8606.838883082077, 8781.385303028726, 8793.20861122502, 8880.333974951775, 8991.55042247898], "unit": "score", "name": "yui.html", "value": 6975.563228904642}], "name": "dromaeo_css", "value": 7684.524770275148}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [97.0, 141.0, 167.0, 165.0, 119.0, 129.0, 115.0, 115.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 127.7}, {"lowerIsBetter": true, "replicates": [149.0, 121.0, 155.0, 153.0, 123.0, 139.0, 123.0, 151.0, 151.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 139.3}, {"lowerIsBetter": true, "replicates": [195.0, 201.0, 198.0, 285.0, 279.0, 194.0, 194.0, 195.0, 200.0, 194.0], "unit": "score", "name": "audio-dft", "value": 213.5}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 74.0, 110.0, 57.0, 57.0, 59.0, 59.0, 117.0, 56.0], "unit": "score", "name": "audio-fft", "value": 72.2}, {"lowerIsBetter": true, "replicates": [82.0, 79.0, 122.0, 80.0, 78.0, 82.0, 113.0, 102.0, 114.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 99.0}, {"lowerIsBetter": true, "replicates": [89.0, 88.0, 90.0, 87.0, 97.0, 86.0, 90.0, 87.0, 84.0, 126.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.4}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 122.0, 104.0, 150.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 109.4}, {"lowerIsBetter": true, "replicates": [137.0, 151.0, 92.0, 90.0, 92.0, 91.0, 92.0, 110.0, 119.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 106.9}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 58.0, 58.0, 59.0, 57.0, 56.0, 60.0, 84.0, 80.0], "unit": "score", "name": "json-parse-financial", "value": 62.7}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 71.0, 62.0, 60.0, 67.0, 93.0, 78.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 84.0, 82.0, 84.0, 82.0, 84.0, 82.0, 82.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [147.0, 132.0, 128.0, 129.0, 136.0, 135.0, 134.0, 118.0, 121.0, 142.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.2}, {"lowerIsBetter": true, "replicates": [140.0, 138.0, 135.0, 122.0, 122.0, 153.0, 173.0, 172.0, 164.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.6}, {"lowerIsBetter": true, "replicates": [64.0, 69.0, 68.0, 66.0, 65.0, 65.0, 65.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1519.2999999999997}]} 14:39:43 INFO - Return code: 0 14:39:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:39:43 ERROR - # TBPL SUCCESS # 14:39:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:39:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:39:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:39:43 INFO - 2016-04-25 14:39:43.225 screenresolution[1684:10432] starting screenresolution argv=screenresolution get 14:39:43 INFO - 2016-04-25 14:39:43.227 screenresolution[1684:10432] Display 0: 1600x1200x32@60 14:39:43 INFO - 2016-04-25 14:39:43.233 screenresolution[1685:10435] starting screenresolution argv=screenresolution list 14:39:43 INFO - Available Modes on Display 0 14:39:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:39:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:39:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:39:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:39:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:39:43 INFO - Intel Iris: 14:39:43 INFO - Chipset Model: Intel Iris 14:39:43 INFO - Type: GPU 14:39:43 INFO - Bus: Built-In 14:39:43 INFO - VRAM (Dynamic, Max): 1536 MB 14:39:43 INFO - Vendor: Intel (0x8086) 14:39:43 INFO - Device ID: 0x0a2e 14:39:43 INFO - Revision ID: 0x0009 14:39:43 INFO - Displays: 14:39:43 INFO - Display: 14:39:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:39:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:39:43 INFO - Display Serial Number: 1600x1200 60 14:39:43 INFO - Main Display: Yes 14:39:43 INFO - Mirror: Off 14:39:43 INFO - Online: Yes 14:39:43 INFO - Rotation: Supported 14:39:43 INFO - Return code: 0 14:39:43 INFO - Running post-action listener: _resource_record_post_action 14:39:43 INFO - Running post-run listener: _resource_record_post_run 14:39:44 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 49162752; Write bytes: 520965120; Read time: 562; Write time: 1874 14:39:44 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 198554112; Write bytes: 196157440; Read time: 17830; Write time: 388 14:39:44 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 47405568; Write bytes: 314014720; Read time: 544; Write time: 1452 14:39:44 INFO - Running post-run listener: _upload_blobber_files 14:39:44 INFO - Blob upload gear active. 14:39:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:39:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:39:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:39:44 INFO - (blobuploader) - INFO - Open directory for files ... 14:39:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:39:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:39:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:45 INFO - (blobuploader) - INFO - Done attempting. 14:39:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:39:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:39:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:46 INFO - (blobuploader) - INFO - Done attempting. 14:39:46 INFO - (blobuploader) - INFO - Iteration through files over. 14:39:46 INFO - Return code: 0 14:39:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:39:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:39:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/60898822a9de5dc8f9528711f219e9d8a13f9e85c23c19843df8ae32062da092c68551a7349039f30872b1af6245746394c7673f723b6ea273fa33555bd5892c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/416c9cca295c71f9d2707803670e597087070428775f89efa72a49a9f06487cd1c65574e6b129c35101f2d3ab6ded80741abe5eeba37b29e40253052d6b863f2"} 14:39:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:39:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:39:46 INFO - Contents: 14:39:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/60898822a9de5dc8f9528711f219e9d8a13f9e85c23c19843df8ae32062da092c68551a7349039f30872b1af6245746394c7673f723b6ea273fa33555bd5892c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/416c9cca295c71f9d2707803670e597087070428775f89efa72a49a9f06487cd1c65574e6b129c35101f2d3ab6ded80741abe5eeba37b29e40253052d6b863f2"} 14:39:46 INFO - Running post-run listener: copy_logs_to_upload_dir 14:39:46 INFO - Copying logs to upload dir... 14:39:46 INFO - mkdir: /builds/slave/test/build/upload/logs 14:39:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.345119 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-25 14:39:47.242644) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-25 14:39:47.249508) ========= 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.y0fdgUQPFU/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.yaAcQw6K9J/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/60898822a9de5dc8f9528711f219e9d8a13f9e85c23c19843df8ae32062da092c68551a7349039f30872b1af6245746394c7673f723b6ea273fa33555bd5892c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/416c9cca295c71f9d2707803670e597087070428775f89efa72a49a9f06487cd1c65574e6b129c35101f2d3ab6ded80741abe5eeba37b29e40253052d6b863f2"} build_url:https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010973 build_url: 'https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/60898822a9de5dc8f9528711f219e9d8a13f9e85c23c19843df8ae32062da092c68551a7349039f30872b1af6245746394c7673f723b6ea273fa33555bd5892c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/416c9cca295c71f9d2707803670e597087070428775f89efa72a49a9f06487cd1c65574e6b129c35101f2d3ab6ded80741abe5eeba37b29e40253052d6b863f2"}' ========= master_lag: 2.23 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-25 14:39:49.485870) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 14:39:49.486204) ========= 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.y0fdgUQPFU/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.yaAcQw6K9J/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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.005200 ========= master_lag: 1.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 14:39:50.560956) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:39:50.561294) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:39:51.224934) ========= ========= Total master_lag: 3.58 =========