builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0305 starttime: 1468475776.48 results: success (0) buildid: 20160713154642 builduid: 0219f93640ac4a39933847396c8d0f21 revision: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:16.489190) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:16.489898) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:16.490232) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:16.518651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:16.519162) ========= 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.ydIw0HTYoO/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.x72627Ar3P/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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-07-13 22:56:16-- 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% 56.8M=0s 2016-07-13 22:56:16 (56.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.414120 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:16.956373) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:16.956799) ========= 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.ydIw0HTYoO/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.x72627Ar3P/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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.025738 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:17.007289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 22:56:17.007770) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 --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 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ydIw0HTYoO/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.x72627Ar3P/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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-07-13 22:56:17,081 truncating revision to first 12 chars 2016-07-13 22:56:17,081 Setting DEBUG logging. 2016-07-13 22:56:17,081 attempt 1/10 2016-07-13 22:56:17,081 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/84c59d136a9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 22:56:18,091 unpacking tar archive at: mozilla-beta-84c59d136a9e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.272319 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 22:56:18.302626) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:18.303009) ========= script_repo_revision: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:18.303508) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:18.303847) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:18.322154) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-13 22:56:18.322510) ========= /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.ydIw0HTYoO/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.x72627Ar3P/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 22:56:18 INFO - MultiFileLogger online at 20160713 22:56:18 in /builds/slave/test 22:56:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 22:56:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:56:18 INFO - {'append_to_log': False, 22:56:18 INFO - 'base_work_dir': '/builds/slave/test', 22:56:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:56:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:56:18 INFO - 'branch': 'Mozilla-Beta', 22:56:18 INFO - 'buildbot_json_path': 'buildprops.json', 22:56:18 INFO - 'config_files': ('talos/mac_config.py',), 22:56:18 INFO - 'default_actions': ('clobber', 22:56:18 INFO - 'read-buildbot-config', 22:56:18 INFO - 'download-and-extract', 22:56:18 INFO - 'populate-webroot', 22:56:18 INFO - 'create-virtualenv', 22:56:18 INFO - 'install', 22:56:18 INFO - 'run-tests'), 22:56:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:56:18 INFO - 'download_minidump_stackwalk': True, 22:56:18 INFO - 'download_symbols': 'ondemand', 22:56:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:56:18 INFO - 'tooltool.py': '/tools/tooltool.py', 22:56:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:56:18 INFO - '/tools/misc-python/virtualenv.py')}, 22:56:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:56:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:56:18 INFO - 'installer_path': 'installer.exe', 22:56:18 INFO - 'log_level': 'info', 22:56:18 INFO - 'log_name': 'talos', 22:56:18 INFO - 'log_to_console': True, 22:56:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:56:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:56:18 INFO - 'opt_config_files': (), 22:56:18 INFO - 'pip_index': False, 22:56:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:56:18 INFO - 'cmd': ('bash', 22:56:18 INFO - '-c', 22:56:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:56:18 INFO - 'enabled': True, 22:56:18 INFO - 'halt_on_failure': False, 22:56:18 INFO - 'name': 'check_screen_resolution'},), 22:56:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:56:18 INFO - 'cmd': ('bash', 22:56:18 INFO - '-c', 22:56:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:56:18 INFO - 'enabled': True, 22:56:18 INFO - 'halt_on_failure': False, 22:56:18 INFO - 'name': 'check_screen_resolution'},), 22:56:18 INFO - 'run_cmd_checks_enabled': True, 22:56:18 INFO - 'sps_profile': False, 22:56:18 INFO - 'sps_profile_interval': 0, 22:56:18 INFO - 'suite': 'dromaeojs-e10s', 22:56:18 INFO - 'system_bits': '32', 22:56:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:56:18 INFO - 'title': 't-yosemite-r7-0305', 22:56:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:56:18 INFO - 'use_talos_json': True, 22:56:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:56:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:56:18 INFO - 'work_dir': 'build'} 22:56:18 INFO - ##### 22:56:18 INFO - ##### Running clobber step. 22:56:18 INFO - ##### 22:56:18 INFO - Running pre-action listener: _resource_record_pre_action 22:56:18 INFO - Running main action method: clobber 22:56:18 INFO - rmtree: /builds/slave/test/build 22:56:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:56:20 INFO - Running post-action listener: _resource_record_post_action 22:56:20 INFO - ##### 22:56:20 INFO - ##### Running read-buildbot-config step. 22:56:20 INFO - ##### 22:56:20 INFO - Running pre-action listener: _resource_record_pre_action 22:56:20 INFO - Running main action method: read_buildbot_config 22:56:20 INFO - Using buildbot properties: 22:56:20 INFO - { 22:56:20 INFO - "project": "", 22:56:20 INFO - "product": "firefox", 22:56:20 INFO - "script_repo_revision": "production", 22:56:20 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 22:56:20 INFO - "repository": "", 22:56:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 22:56:20 INFO - "buildid": "20160713154642", 22:56:20 INFO - "pgo_build": "False", 22:56:20 INFO - "basedir": "/builds/slave/test", 22:56:20 INFO - "buildnumber": 26, 22:56:20 INFO - "slavename": "t-yosemite-r7-0305", 22:56:20 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 22:56:20 INFO - "platform": "yosemite_r7", 22:56:20 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 22:56:20 INFO - "branch": "mozilla-beta", 22:56:20 INFO - "repo_path": "releases/mozilla-beta", 22:56:20 INFO - "revision": "84c59d136a9e54be69571b75a19e8a8ccff7b8a1", 22:56:20 INFO - "stage_platform": "macosx64", 22:56:20 INFO - "builduid": "0219f93640ac4a39933847396c8d0f21", 22:56:20 INFO - "slavebuilddir": "test" 22:56:20 INFO - } 22:56:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 22:56:20 INFO - Running post-action listener: _resource_record_post_action 22:56:20 INFO - ##### 22:56:20 INFO - ##### Running download-and-extract step. 22:56:20 INFO - ##### 22:56:20 INFO - Running pre-action listener: _resource_record_pre_action 22:56:20 INFO - Running main action method: download_and_extract 22:56:20 INFO - mkdir: /builds/slave/test/build/tests 22:56: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')]} 22:56:20 INFO - https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 22:56:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 22:56:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 22:56:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 22:56:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 22:56:27 INFO - Downloaded 1165 bytes. 22:56:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 22:56:27 INFO - Using the following test package requirements: 22:56:27 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 22:56:27 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 22:56:27 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 22:56:27 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 22:56:27 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 22:56:27 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 22:56:27 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 22:56:27 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 22:56:27 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 22:56:27 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 22:56:27 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 22:56:27 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 22:56:27 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 22:56:27 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 22:56:27 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 22:56:27 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 22:56:27 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 22:56:27 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 22:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:27 INFO - https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:56:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 22:56:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 22:56:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 22:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 22:56:30 INFO - Downloaded 18314911 bytes. 22:56:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:56:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:56:33 INFO - Return code: 0 22:56:33 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 22:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:33 INFO - https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:56:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 22:56:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 22:56:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 22:56:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 22:56:34 INFO - Downloaded 18314911 bytes. 22:56:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:56:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:56:38 INFO - Return code: 0 22:56:38 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')]} 22:56:38 INFO - https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 22:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 22:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 22:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 22:56:39 INFO - Downloaded 10840145 bytes. 22:56:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:56:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 22:56:39 INFO - Return code: 0 22:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:39 INFO - https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 22:56:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 22:56:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 22:56:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 22:56:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 22:56:41 INFO - Downloaded 86190055 bytes. 22:56:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 22:56:41 INFO - mkdir: /builds/slave/test/properties 22:56:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:56:41 INFO - Writing to file /builds/slave/test/properties/build_url 22:56:41 INFO - Contents: 22:56:41 INFO - build_url:https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 22:56:42 INFO - Running post-action listener: _resource_record_post_action 22:56:42 INFO - Running post-action listener: set_extra_try_arguments 22:56:42 INFO - ##### 22:56:42 INFO - ##### Running populate-webroot step. 22:56:42 INFO - ##### 22:56:42 INFO - Running pre-action listener: _resource_record_pre_action 22:56:42 INFO - Running main action method: populate_webroot 22:56:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:56:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:56:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:56:42 INFO - '--tppagecycles', 22:56:42 INFO - '7'], 22:56:42 INFO - 'tests': ['tsvgm']}}, 22:56:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:56:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:56:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:56:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:56:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:56:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:56:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:42 INFO - 'talos_options': ['--disable-e10s'], 22:56:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:56:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:56:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:42 INFO - 'talos_options': ['--disable-e10s'], 22:56:42 INFO - 'tests': ['damp', 'tps']}, 22:56:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:42 INFO - 'tests': ['damp', 'tps']}, 22:56:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:56:42 INFO - 'tests': ['dromaeo_dom']}, 22:56:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:56:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:56:42 INFO - 'tests': ['a11yr', 22:56:42 INFO - 'ts_paint', 22:56:42 INFO - 'tpaint', 22:56:42 INFO - 'sessionrestore', 22:56:42 INFO - 'sessionrestore_no_auto_restore', 22:56:42 INFO - 'tabpaint']}, 22:56:42 INFO - 'other-e10s': {'tests': ['a11yr', 22:56:42 INFO - 'ts_paint', 22:56:42 INFO - 'tpaint', 22:56:42 INFO - 'sessionrestore', 22:56:42 INFO - 'sessionrestore_no_auto_restore', 22:56:42 INFO - 'tabpaint']}, 22:56:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:56:42 INFO - 'ts_paint', 22:56:42 INFO - 'tpaint', 22:56:42 INFO - 'sessionrestore', 22:56:42 INFO - 'sessionrestore_no_auto_restore', 22:56:42 INFO - 'tabpaint']}, 22:56:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:56:42 INFO - 'ts_paint', 22:56:42 INFO - 'tpaint', 22:56:42 INFO - 'sessionrestore', 22:56:42 INFO - 'sessionrestore_no_auto_restore', 22:56:42 INFO - 'tabpaint']}, 22:56:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:56:42 INFO - 'tests': ['a11yr', 22:56:42 INFO - 'ts_paint', 22:56:42 INFO - 'tpaint', 22:56:42 INFO - 'sessionrestore', 22:56:42 INFO - 'sessionrestore_no_auto_restore', 22:56:42 INFO - 'tabpaint']}, 22:56:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:56:42 INFO - 'tests': ['a11yr', 22:56:42 INFO - 'ts_paint', 22:56:42 INFO - 'tpaint', 22:56:42 INFO - 'sessionrestore', 22:56:42 INFO - 'sessionrestore_no_auto_restore', 22:56:42 INFO - 'tabpaint']}, 22:56:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:56:42 INFO - 'tests': ['tsvgx', 22:56:42 INFO - 'tsvgr_opacity', 22:56:42 INFO - 'tart', 22:56:42 INFO - 'tscrollx', 22:56:42 INFO - 'cart']}, 22:56:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:56:42 INFO - 'tsvgr_opacity', 22:56:42 INFO - 'tart', 22:56:42 INFO - 'tscrollx', 22:56:42 INFO - 'cart']}, 22:56:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:42 INFO - 'talos_options': ['--disable-e10s'], 22:56:42 INFO - 'tests': ['tp5o']}, 22:56:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:42 INFO - 'tests': ['tp5o']}, 22:56:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:42 INFO - 'talos_options': ['--disable-e10s', 22:56:42 INFO - '--xperf_path', 22:56:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:56:42 INFO - 'tests': ['tp5n']}, 22:56:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:42 INFO - 'talos_options': ['--xperf_path', 22:56:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:56:42 INFO - 'tests': ['tp5n']}}, 22:56:42 INFO - 'talos.zip': {'path': '', 22:56:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:56:42 INFO - Running post-action listener: _resource_record_post_action 22:56:42 INFO - ##### 22:56:42 INFO - ##### Running create-virtualenv step. 22:56:42 INFO - ##### 22:56:42 INFO - Running pre-action listener: _resource_record_pre_action 22:56:42 INFO - Running main action method: create_virtualenv 22:56:42 INFO - Creating virtualenv /builds/slave/test/build/venv 22:56:42 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 22:56:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:56:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:56:42 INFO - Using real prefix '/tools/python27' 22:56:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:56:43 INFO - Installing distribute.............................................................................................................................................................................................done. 22:56:46 INFO - Installing pip.................done. 22:56:46 INFO - Return code: 0 22:56:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:56: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')]} 22:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56: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')]} 22:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f183a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f193420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f8d95ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f022e00>, '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 0x10ee8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f01db20>, '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.ydIw0HTYoO/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.x72627Ar3P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 22:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:56:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ydIw0HTYoO/Render', 22:56:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:56:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:56:46 INFO - 'HOME': '/Users/cltbld', 22:56:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:56:46 INFO - 'LOGNAME': 'cltbld', 22:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:46 INFO - 'MOZ_NO_REMOTE': '1', 22:56:46 INFO - 'NO_EM_RESTART': '1', 22:56:46 INFO - 'PAGER': '/bin/cat', 22:56:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:46 INFO - 'PWD': '/builds/slave/test', 22:56:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:56:46 INFO - 'SHELL': '/bin/bash', 22:56:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x72627Ar3P/Listeners', 22:56:46 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 22:56:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:56:46 INFO - 'USER': 'cltbld', 22:56:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:56:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:46 INFO - 'XPC_FLAGS': '0x0', 22:56:46 INFO - 'XPC_SERVICE_NAME': '0', 22:56:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:46 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 22:56:46 INFO - Cleaning up... 22:56:46 INFO - Return code: 0 22:56:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:56: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')]} 22:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56: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')]} 22:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56: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', '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 0x10f183a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f193420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f8d95ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f022e00>, '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 0x10ee8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f01db20>, '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.ydIw0HTYoO/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.x72627Ar3P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 22:56: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', 'psutil>=0.7.1'] in /builds/slave/test/build 22:56: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 psutil>=0.7.1 22:56:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ydIw0HTYoO/Render', 22:56:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:56:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:56:46 INFO - 'HOME': '/Users/cltbld', 22:56:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:56:46 INFO - 'LOGNAME': 'cltbld', 22:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:46 INFO - 'MOZ_NO_REMOTE': '1', 22:56:46 INFO - 'NO_EM_RESTART': '1', 22:56:46 INFO - 'PAGER': '/bin/cat', 22:56:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:46 INFO - 'PWD': '/builds/slave/test', 22:56:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:56:46 INFO - 'SHELL': '/bin/bash', 22:56:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x72627Ar3P/Listeners', 22:56:46 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 22:56:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:56:46 INFO - 'USER': 'cltbld', 22:56:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:56:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:46 INFO - 'XPC_FLAGS': '0x0', 22:56:46 INFO - 'XPC_SERVICE_NAME': '0', 22:56:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:46 INFO - Downloading/unpacking psutil>=0.7.1 22:56: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 22:56: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 22:56: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 22:56: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 22:56: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 22:56: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 22:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:56:49 INFO - Installing collected packages: psutil 22:56:49 INFO - Running setup.py install for psutil 22:56:49 INFO - building 'psutil._psutil_osx' extension 22:56:49 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 22:56:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 22:56:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 22:56:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 22:56:50 INFO - building 'psutil._psutil_posix' extension 22:56:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 22:56:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:56:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:56:50 INFO - ^ 22:56:50 INFO - 1 warning generated. 22:56:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 22:56:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:56:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:56:50 INFO - Successfully installed psutil 22:56:50 INFO - Cleaning up... 22:56:50 INFO - Return code: 0 22:56:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f183a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f193420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f8d95ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f022e00>, '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 0x10ee8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f01db20>, '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.ydIw0HTYoO/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.x72627Ar3P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 22:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:56:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ydIw0HTYoO/Render', 22:56:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:56:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:56:50 INFO - 'HOME': '/Users/cltbld', 22:56:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:56:50 INFO - 'LOGNAME': 'cltbld', 22:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:50 INFO - 'MOZ_NO_REMOTE': '1', 22:56:50 INFO - 'NO_EM_RESTART': '1', 22:56:50 INFO - 'PAGER': '/bin/cat', 22:56:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:50 INFO - 'PWD': '/builds/slave/test', 22:56:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:56:50 INFO - 'SHELL': '/bin/bash', 22:56:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x72627Ar3P/Listeners', 22:56:50 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 22:56:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:56:50 INFO - 'USER': 'cltbld', 22:56:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:56:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:50 INFO - 'XPC_FLAGS': '0x0', 22:56:50 INFO - 'XPC_SERVICE_NAME': '0', 22:56:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:56:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:56:53 INFO - Installing collected packages: mozsystemmonitor 22:56:53 INFO - Running setup.py install for mozsystemmonitor 22:56:53 INFO - Successfully installed mozsystemmonitor 22:56:53 INFO - Cleaning up... 22:56:53 INFO - Return code: 0 22:56:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f183a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f193420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f8d95ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f022e00>, '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 0x10ee8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f01db20>, '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.ydIw0HTYoO/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.x72627Ar3P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 22:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:56:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ydIw0HTYoO/Render', 22:56:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:56:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:56:53 INFO - 'HOME': '/Users/cltbld', 22:56:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:56:53 INFO - 'LOGNAME': 'cltbld', 22:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:53 INFO - 'MOZ_NO_REMOTE': '1', 22:56:53 INFO - 'NO_EM_RESTART': '1', 22:56:53 INFO - 'PAGER': '/bin/cat', 22:56:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:53 INFO - 'PWD': '/builds/slave/test', 22:56:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:56:53 INFO - 'SHELL': '/bin/bash', 22:56:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x72627Ar3P/Listeners', 22:56:53 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 22:56:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:56:53 INFO - 'USER': 'cltbld', 22:56:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:56:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:53 INFO - 'XPC_FLAGS': '0x0', 22:56:53 INFO - 'XPC_SERVICE_NAME': '0', 22:56:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:54 INFO - Downloading/unpacking blobuploader==1.2.4 22:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:56 INFO - Downloading blobuploader-1.2.4.tar.gz 22:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:56:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:56:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:57 INFO - Downloading docopt-0.6.1.tar.gz 22:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:56:57 INFO - Installing collected packages: blobuploader, requests, docopt 22:56:57 INFO - Running setup.py install for blobuploader 22:56:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:56:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:56:57 INFO - Running setup.py install for requests 22:56:58 INFO - Running setup.py install for docopt 22:56:58 INFO - Successfully installed blobuploader requests docopt 22:56:58 INFO - Cleaning up... 22:56:58 INFO - Return code: 0 22:56:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f183a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f193420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f8d95ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f022e00>, '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 0x10ee8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f01db20>, '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.ydIw0HTYoO/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.x72627Ar3P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 22:56:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:56:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ydIw0HTYoO/Render', 22:56:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:56:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:56:58 INFO - 'HOME': '/Users/cltbld', 22:56:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:56:58 INFO - 'LOGNAME': 'cltbld', 22:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:58 INFO - 'MOZ_NO_REMOTE': '1', 22:56:58 INFO - 'NO_EM_RESTART': '1', 22:56:58 INFO - 'PAGER': '/bin/cat', 22:56:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:58 INFO - 'PWD': '/builds/slave/test', 22:56:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:56:58 INFO - 'SHELL': '/bin/bash', 22:56:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x72627Ar3P/Listeners', 22:56:58 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 22:56:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:56:58 INFO - 'USER': 'cltbld', 22:56:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:56:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:58 INFO - 'XPC_FLAGS': '0x0', 22:56:58 INFO - 'XPC_SERVICE_NAME': '0', 22:56:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:56:59 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-RZ_frx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:56:59 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-X06HCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:56:59 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-no9LtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:56:59 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-fdai31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:56:59 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-0WEb1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:56:59 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Bsgqjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:56:59 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-n2n_07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:56:59 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-rdUVS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:56:59 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-DpjCeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:56:59 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-P_87Mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:57:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-IeU1fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:57:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-6aKCAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:57:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-ZHhRec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:57:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-XgRR9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-0tVaZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:57:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-v82Pc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:57:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-UFA_E8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:57:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:57:00 INFO - Running setup.py install for manifestparser 22:57:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:57:00 INFO - Running setup.py install for mozcrash 22:57:01 INFO - Running setup.py install for mozdebug 22:57:01 INFO - Running setup.py install for mozdevice 22:57:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:57:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:57:01 INFO - Running setup.py install for mozfile 22:57:01 INFO - Running setup.py install for mozhttpd 22:57:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:57:01 INFO - Running setup.py install for mozinfo 22:57:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:57:01 INFO - Running setup.py install for mozInstall 22:57:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:57:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:57:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:57:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:57:01 INFO - Running setup.py install for mozleak 22:57:02 INFO - Running setup.py install for mozlog 22:57:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:57:02 INFO - Running setup.py install for moznetwork 22:57:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:57:02 INFO - Running setup.py install for mozprocess 22:57:02 INFO - Running setup.py install for mozprofile 22:57:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:57:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:57:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:57:02 INFO - Running setup.py install for mozrunner 22:57:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:57:02 INFO - Running setup.py install for mozscreenshot 22:57:02 INFO - Running setup.py install for moztest 22:57:03 INFO - Running setup.py install for mozversion 22:57:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:57:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:57:03 INFO - Cleaning up... 22:57:03 INFO - Return code: 0 22:57:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f183a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f193420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f8d95ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f022e00>, '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 0x10ee8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f01db20>, '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.ydIw0HTYoO/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.x72627Ar3P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 22:57:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:57:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ydIw0HTYoO/Render', 22:57:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:03 INFO - 'HOME': '/Users/cltbld', 22:57:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:03 INFO - 'LOGNAME': 'cltbld', 22:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:03 INFO - 'MOZ_NO_REMOTE': '1', 22:57:03 INFO - 'NO_EM_RESTART': '1', 22:57:03 INFO - 'PAGER': '/bin/cat', 22:57:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:03 INFO - 'PWD': '/builds/slave/test', 22:57:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:03 INFO - 'SHELL': '/bin/bash', 22:57:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x72627Ar3P/Listeners', 22:57:03 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 22:57:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:03 INFO - 'USER': 'cltbld', 22:57:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:03 INFO - 'XPC_FLAGS': '0x0', 22:57:03 INFO - 'XPC_SERVICE_NAME': '0', 22:57:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:57:03 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-RbwA_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:57:03 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-ZPzhmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:57:03 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-ZBF104-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:57:03 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)) 22:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:57:03 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-76L6M6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:57:03 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)) 22:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:57:03 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-848Rdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:57:04 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-r529_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:57:04 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-lXXYpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:57:04 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-d9ylzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:57:04 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-k2Kwul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:57:04 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-J7UMYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:57:04 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-9QnZ02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:57:04 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-jbjdLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:57:04 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-etV0W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:57:04 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)) 22:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:57:04 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-RyF1Xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:05 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-W7CpBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:57:05 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-PYGCBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:57:05 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-3kdR2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:57:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:07 INFO - Downloading blessings-1.6.tar.gz 22:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:57:07 INFO - Installing collected packages: blessings 22:57:07 INFO - Running setup.py install for blessings 22:57:08 INFO - Successfully installed blessings 22:57:08 INFO - Cleaning up... 22:57:08 INFO - Return code: 0 22:57:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:57:08 INFO - Reading from file tmpfile_stdout 22:57:08 INFO - Current package versions: 22:57:08 INFO - blessings == 1.6 22:57:08 INFO - blobuploader == 1.2.4 22:57:08 INFO - docopt == 0.6.1 22:57:08 INFO - manifestparser == 1.1 22:57:08 INFO - mozInstall == 1.12 22:57:08 INFO - mozcrash == 0.17 22:57:08 INFO - mozdebug == 0.1 22:57:08 INFO - mozdevice == 0.48 22:57:08 INFO - mozfile == 1.2 22:57:08 INFO - mozhttpd == 0.7 22:57:08 INFO - mozinfo == 0.9 22:57:08 INFO - mozleak == 0.1 22:57:08 INFO - mozlog == 3.1 22:57:08 INFO - moznetwork == 0.27 22:57:08 INFO - mozprocess == 0.22 22:57:08 INFO - mozprofile == 0.28 22:57:08 INFO - mozrunner == 6.11 22:57:08 INFO - mozscreenshot == 0.1 22:57:08 INFO - mozsystemmonitor == 0.0 22:57:08 INFO - moztest == 0.7 22:57:08 INFO - mozversion == 1.4 22:57:08 INFO - psutil == 3.1.1 22:57:08 INFO - requests == 1.2.3 22:57:08 INFO - wsgiref == 0.1.2 22:57:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f183a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f193420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f8d95ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f022e00>, '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 0x10ee8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f01db20>, '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.ydIw0HTYoO/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.x72627Ar3P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 22:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ydIw0HTYoO/Render', 22:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:08 INFO - 'HOME': '/Users/cltbld', 22:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:08 INFO - 'LOGNAME': 'cltbld', 22:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:08 INFO - 'MOZ_NO_REMOTE': '1', 22:57:08 INFO - 'NO_EM_RESTART': '1', 22:57:08 INFO - 'PAGER': '/bin/cat', 22:57:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:08 INFO - 'PWD': '/builds/slave/test', 22:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:08 INFO - 'SHELL': '/bin/bash', 22:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x72627Ar3P/Listeners', 22:57:08 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 22:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:08 INFO - 'USER': 'cltbld', 22:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:08 INFO - 'XPC_FLAGS': '0x0', 22:57:08 INFO - 'XPC_SERVICE_NAME': '0', 22:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:57:08 INFO - Cleaning up... 22:57:08 INFO - Return code: 0 22:57:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f183a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f193420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f8d95ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f022e00>, '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 0x10ee8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f01db20>, '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.ydIw0HTYoO/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.x72627Ar3P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 22:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ydIw0HTYoO/Render', 22:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:08 INFO - 'HOME': '/Users/cltbld', 22:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:08 INFO - 'LOGNAME': 'cltbld', 22:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:08 INFO - 'MOZ_NO_REMOTE': '1', 22:57:08 INFO - 'NO_EM_RESTART': '1', 22:57:08 INFO - 'PAGER': '/bin/cat', 22:57:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:08 INFO - 'PWD': '/builds/slave/test', 22:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:08 INFO - 'SHELL': '/bin/bash', 22:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x72627Ar3P/Listeners', 22:57:08 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 22:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:08 INFO - 'USER': 'cltbld', 22:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:08 INFO - 'XPC_FLAGS': '0x0', 22:57:08 INFO - 'XPC_SERVICE_NAME': '0', 22:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:08 INFO - Downloading/unpacking jsonschema 22:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:57:11 INFO - Downloading/unpacking functools32 (from jsonschema) 22:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:11 INFO - Downloading functools32-3.2.3-2.tar.gz 22:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:57:11 INFO - warning: no files found matching '*.txt' 22:57:11 INFO - no previously-included directories found matching 'build' 22:57:11 INFO - no previously-included directories found matching 'dist' 22:57:11 INFO - no previously-included directories found matching '.git*' 22:57:11 INFO - Installing collected packages: jsonschema, functools32 22:57:11 INFO - Running setup.py install for functools32 22:57:12 INFO - warning: no files found matching '*.txt' 22:57:12 INFO - no previously-included directories found matching 'build' 22:57:12 INFO - no previously-included directories found matching 'dist' 22:57:12 INFO - no previously-included directories found matching '.git*' 22:57:12 INFO - Successfully installed jsonschema functools32 22:57:12 INFO - Cleaning up... 22:57:12 INFO - Return code: 0 22:57:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f183a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f193420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f8d95ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f022e00>, '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 0x10ee8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f01db20>, '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.ydIw0HTYoO/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.x72627Ar3P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 22:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ydIw0HTYoO/Render', 22:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:12 INFO - 'HOME': '/Users/cltbld', 22:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:12 INFO - 'LOGNAME': 'cltbld', 22:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:12 INFO - 'MOZ_NO_REMOTE': '1', 22:57:12 INFO - 'NO_EM_RESTART': '1', 22:57:12 INFO - 'PAGER': '/bin/cat', 22:57:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:12 INFO - 'PWD': '/builds/slave/test', 22:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:12 INFO - 'SHELL': '/bin/bash', 22:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x72627Ar3P/Listeners', 22:57:12 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 22:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:12 INFO - 'USER': 'cltbld', 22:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:12 INFO - 'XPC_FLAGS': '0x0', 22:57:12 INFO - 'XPC_SERVICE_NAME': '0', 22:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:12 INFO - Downloading/unpacking flake8 22:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:57:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:57:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:57:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:57:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:57:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:57:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:57:16 INFO - no previously-included directories found matching 'docs/_build' 22:57:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:57:16 INFO - Running setup.py install for pep8 22:57:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:57:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:57:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:57:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:57:16 INFO - no previously-included directories found matching 'docs/_build' 22:57:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:57:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:57:16 INFO - Cleaning up... 22:57:16 INFO - Return code: 0 22:57:16 INFO - Running post-action listener: _resource_record_post_action 22:57:16 INFO - Running post-action listener: _start_resource_monitoring 22:57:16 INFO - Starting resource monitoring. 22:57:16 INFO - ##### 22:57:16 INFO - ##### Running install step. 22:57:16 INFO - ##### 22:57:16 INFO - Running pre-action listener: _resource_record_pre_action 22:57:16 INFO - Running main action method: install 22:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:57:16 INFO - Reading from file tmpfile_stdout 22:57:16 INFO - Detecting whether we're running mozinstall >=1.0... 22:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:57:16 INFO - Reading from file tmpfile_stdout 22:57:16 INFO - Output received: 22:57:16 INFO - Usage: mozinstall [options] installer 22:57:16 INFO - Options: 22:57:16 INFO - -h, --help show this help message and exit 22:57:16 INFO - -d DEST, --destination=DEST 22:57:16 INFO - Directory to install application into. [default: 22:57:16 INFO - "/builds/slave/test"] 22:57:16 INFO - --app=APP Application being installed. [default: firefox] 22:57:16 INFO - mkdir: /builds/slave/test/build/application 22:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 22:57:38 INFO - Reading from file tmpfile_stdout 22:57:38 INFO - Output received: 22:57:38 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 22:57:38 INFO - Running post-action listener: _resource_record_post_action 22:57:38 INFO - ##### 22:57:38 INFO - ##### Running run-tests step. 22:57:38 INFO - ##### 22:57:38 INFO - Running pre-action listener: _resource_record_pre_action 22:57:38 INFO - Running main action method: run_tests 22:57:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:57:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:57:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:57:38 INFO - 2016-07-13 22:57:38.664 screenresolution[1644:8270] starting screenresolution argv=screenresolution get 22:57:38 INFO - 2016-07-13 22:57:38.666 screenresolution[1644:8270] Display 0: 1600x1200x32@60 22:57:38 INFO - 2016-07-13 22:57:38.672 screenresolution[1645:8273] starting screenresolution argv=screenresolution list 22:57:38 INFO - Available Modes on Display 0 22:57:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:57:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:57:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:57:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:57:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:57:38 INFO - Intel Iris: 22:57:38 INFO - Chipset Model: Intel Iris 22:57:38 INFO - Type: GPU 22:57:38 INFO - Bus: Built-In 22:57:38 INFO - VRAM (Dynamic, Max): 1536 MB 22:57:38 INFO - Vendor: Intel (0x8086) 22:57:38 INFO - Device ID: 0x0a2e 22:57:38 INFO - Revision ID: 0x0009 22:57:38 INFO - Displays: 22:57:38 INFO - Display: 22:57:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:57:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:57:38 INFO - Display Serial Number: 1600x1200 60 22:57:38 INFO - Main Display: Yes 22:57:38 INFO - Mirror: Off 22:57:38 INFO - Online: Yes 22:57:38 INFO - Rotation: Supported 22:57:38 INFO - Return code: 0 22:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:57:38 INFO - Python 2.7.3 22:57:38 INFO - Return code: 0 22:57:38 INFO - grabbing minidump binary from tooltool 22:57:38 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')]} 22:57:38 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 0x10f022e00>, '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 0x10ee8bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f01db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:57:38 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 22:57:38 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 22:57:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:57:38 INFO - Return code: 0 22:57:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:57:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:57:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:57:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:57:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:57:40 INFO - Return code: 0 22:57:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0305', '--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 22:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0305 --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 22:57:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ydIw0HTYoO/Render', 22:57:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:40 INFO - 'HOME': '/Users/cltbld', 22:57:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:40 INFO - 'LOGNAME': 'cltbld', 22:57:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:57:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:40 INFO - 'MOZ_NO_REMOTE': '1', 22:57:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:57:40 INFO - 'NO_EM_RESTART': '1', 22:57:40 INFO - 'PAGER': '/bin/cat', 22:57:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:40 INFO - 'PWD': '/builds/slave/test', 22:57:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:57:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:40 INFO - 'SHELL': '/bin/bash', 22:57:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x72627Ar3P/Listeners', 22:57:40 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 22:57:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:40 INFO - 'USER': 'cltbld', 22:57:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:40 INFO - 'XPC_FLAGS': '0x0', 22:57:40 INFO - 'XPC_SERVICE_NAME': '0', 22:57:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0305', '--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 22:57:40 INFO - mozversion application_buildid: 20160713154642 22:57:40 INFO - mozversion application_changeset: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 22:57:40 INFO - mozversion application_display_name: Firefox 22:57:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:57:40 INFO - mozversion application_name: Firefox 22:57:40 INFO - mozversion application_remotingname: firefox 22:57:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:57:40 INFO - mozversion application_vendor: Mozilla 22:57:40 INFO - mozversion application_version: 48.0 22:57:40 INFO - mozversion platform_buildid: 20160713154642 22:57:40 INFO - mozversion platform_changeset: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 22:57:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:57:40 INFO - mozversion platform_version: 48.0 22:57:40 INFO - using testdate: 1468475860 22:57:40 INFO - actual date: 1468475860 22:57:40 INFO - starting webserver on 'localhost:49275' 22:57:40 INFO - SUITE-START | Running 2 tests 22:57:40 INFO - TEST-START | dromaeo_css 22:57:40 INFO - operating with platform_type : mac_ 22:57:40 INFO - Initialising browser for dromaeo_css test... 22:57:40 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpbCv2q3/profile http://localhost:49275/getInfo.html) 22:57:43 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 22:57:43 INFO - PROCESS | 1663 | colorDepth:24 22:57:43 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 22:57:43 INFO - PROCESS | 1663 | __metrics 22:57:43 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 22:57:43 INFO - TEST-INFO | 1663: exit 0 22:57:43 INFO - Browser initialized. 22:57:43 INFO - Running cycle 1/1 for dromaeo_css test... 22:57:43 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpbCv2q3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:57:55 INFO - PROCESS | 1668 | RSS: Main: 171257856 22:57:55 INFO - PROCESS | 1668 | 22:58:45 INFO - PROCESS | 1668 | 1468475925448 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] 23:00:55 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 23:00:57 INFO - PROCESS | 1668 | RSS: Main: 185167872 23:00:57 INFO - PROCESS | 1668 | 23:03:59 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 23:03:59 INFO - PROCESS | 1668 | RSS: Main: 195817472 23:03:59 INFO - PROCESS | 1668 | 23:07:01 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 23:07:01 INFO - PROCESS | 1668 | RSS: Main: 197779456 23:07:01 INFO - PROCESS | 1668 | 23:10:03 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 23:10:04 INFO - PROCESS | 1668 | RSS: Main: 201678848 23:10:04 INFO - PROCESS | 1668 | 23:13:06 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 23:13:07 INFO - PROCESS | 1668 | RSS: Main: 200560640 23:13:07 INFO - PROCESS | 1668 | 23:16:09 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 23:16:10 INFO - PROCESS | 1668 | RSS: Main: 205414400 23:16:10 INFO - PROCESS | 1668 | 23:16:10 INFO - PROCESS | 1668 | __start_tp_report 23:16:10 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 23:16:10 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 23:16:10 INFO - PROCESS | 1668 | |i|pagename|runs| 23:16:10 INFO - PROCESS | 1668 | |0;dojo.html;3665.578458477275;3686.096906257967;3718;3738.1962877981227;3738.756980796248;6074.210352654154;6075.362086980869;6086.7869624563145;6107.60300580462;6110.077186750025;6030.728617212225;6092.66490343031;6107.328193898667;6129.38706129388;6132.509399248061;5405.594580406475;5440.782368705247;5479.369872464657;5519.641223320491;5557.777688892439;4695.7886895089805;5027.572656324199;5516.448355164472;5519.751611177487;5529.612927095105;4004.6996475264327;5438.184272359138;5476.863078423032;5502.752376143083;5643.943560564403;5474.151506516497;5495.6153069285165;5516.503514683678;5540.86147846303;5579.302587176603;5358.089124848785;5481.75332110056;5488.4785945335125;5488.91766623501;5505.724713764296;5769.653820770725;5819.603295209162;5924.200232968537;6042.879142417171;6106.419890110433;6242.968785156045;6312.684365781693;6313.368663133696;6319.3680631936895;6325.652089135096;6372.808815735535;6396.200474940632;6404.231492220963;6410.102585638015;6443.065755465478;6046.758129674764;6119.2350956130485;6155.784547540904;6198.969005154991;6225.346338634468;6468.450181734511;6541.443977261891;6580.5064620152725;6584.209894812653;6595.043718660767;5221.947780522146;6295.685215739195;6303.747850086037;6317.147185129948;6326.841828954313;5355.196720491957;6373.171487706569;6419.197600299963;6461.935380646228;6470.870582588416;6247.468965137923;6306.274778400542;6310.1796766420075;6312.242530896322;6327.050942358591;6238.1266622672865;6330.430261276507;6335.366463353628;6339.0808332791485;6368.936310636927;4770.332153498513;5149.0474262261605;5166;5180.948190518122;5202.297689811827;4624.514425985223;4647.140279048387;4687.648426367968;4695.037517308943;4700.459447163552;5104.9744751276;6100.664463454464;6130.111133885562;6132.540059495555;6213.440790328892;6238.968805155945;6389.6805159741825;6411.4229719325485;6465.741370345134;6500.3499650035565;6154.323024467305;6171.166892469549;6228.532860035425;6242.875142497124;6258.906116408258;5577.498025177753;5656.095024796013;5699.116636921284;5705.372409035002;5736.713164341766;6010.677650916791;6340.968295158587;6679.565828221247;6685;6700.798976030727;5518.089515229942;6289.433950944437;6459.483241340776;6477.676116194078;6479.838004049937;5540.335159780852;6537;6667.933320666732;6687.832804179934;6725.260221375547;6317.494600432046;6347.936520634735;6360.395762402564;6364.459020983269;6365.331640177715;6072.210612620331;6416.967915160394;6426.325235850169;6448.935510644834;6458.321876203119;6220.222472190976;6221.688915554295;6264.185655864709;6278.717457714322;6292.622442653455;6226.564140510302;6293.37066293367;6293.96853015732;6304.905426418516;6308.621482711052;6029.939700603113;6201;6293.307736149111;6330.778422755366;6330.905036424365;6208.161898143693;6226.066090086342;6267.2479302484;6277.466415354746;6303.086052522267;5201.375834899836;5218.086834803818;6243.063540468966;6283.057541368648;6304.810855674337 23:16:10 INFO - PROCESS | 1668 | |1;ext.html;551.884104338089;555.4445554445555;556.4769117029989;592.4312659846547;600.663628368114;38503.80748096259;39451.60548394515;39531.604683953155;39661.20677586446;39673.80978570644;40922.386164207484;41399.793001035025;41725.58274417255;41915.37126943098;41993;9568.37805542641;9695.36980096295;9789;9811.067948544876;9832.508374581279;9683.661071862487;9804.803903921917;9808.558614862348;9848;9890.15933645641;9868.45723485208;9875.95062024689;9884.308098433112;9914.504274786268;9974.251931105196;8535.359848011392;9893.901060989407;9923.1069203772;9953.502324883762;9977.201823854075;9726.17327527161;9784.315097943147;9853.26100542455;9885.25860560461;9894.406335619886;39530.40704389437;39787.80636580907;39988.00029999244;40275.79172624826;40572.59427405718;3365.1923538350866;3465.2722928185112;3507.8772242971627;3861;3923.372260438316;28887;28900.855495722597;29040.709592904223;29389.94270401073;29423.70576294231;2745.6018877262886;2770.293575138347;2813.8733756980987;2818.873150708223;2849.2591926099362;401978;466137;480096;480272.59863700805;481023;37248;61561.69219153876;61879;61888.381116189164;62083.379166208666;36469.817650912104;36520.904372868856;36560.45159322612;36576.45135322972;36662;16393.754093688603;16501.58746031359;16589.50231493057;16766;16788.664226715642;14160.00879938415;14257.073290236309;14274.286285685674;14321.64195895111;14377.065490743069;7106.680199391039;7128.536645118051;8357.331413486907;8444.071152173256;8648.697295594624;3224.290656055664;3475.687188153028;3546.131197856542;3558.982205088958;3604.2070744436182;990.821652102614;1045.4057562217527;1114.7603265298;1148.8736239013701;1195.384377045822;30219.848900755795;30233.244168895955;30737.69262307393;30839;30917.690823091933;1165.9941700291445;1190.2323001663879;1225;1234.7592219517107;1298.0653929170983;15507;15672;15694.215289235493;15794.9210253948;15939.681206375808;526813;627304;631312;634436;640760;60659;61758;62450.68774656098;62642.0603690945;62902;1337.505123104438;1540.5147378575937;1547.0562956596243;1564.9217539123;1566.6396728752222;25819.354516137246;29918.25204369908;30302.393952121274;30508.389832203677;30575.598434919597;43591.34612980745;51574.74212628913;52029.95940081253;52599.47400525946;52753.20870186874;572009;583837;585539;587698.0615096897;588454;27207.183784486497;27391.17826465209;27547.86226068937;27820.88716451319;28075.157745267676;40262.79868600638;45907.85230369268;46160.8459788508;46257.84355391142;47555;38999.6100038996;39093;39393.80303098466;39446.40830387604;40736.981575459664;36221.27557448784;36364.81817590895;36550.817245914666;36879.63120368762;37255.25489490141;36601.26797464089;38517.651882183985;39500.80249598734;39885.40171897482;40151.59848401479;22219.555608887407;26168;26672.59991100096;29657.5551366734;30195.547066793577;24817.759112044685;24954.251372458857;25433.491330173663;26135.477290454466;26660.466790664464 23:16:10 INFO - PROCESS | 1668 | |2;jquery.html;413.5946772163278;416.62920001198955;418.82200064972386;422.5077784381195;425.9574042595741;20940.790592094076;21385;21629.91850407479;21765.99999999996;22524.549509009852;19408.417747467563;20998.530102892804;21575.24486642964;21612.8919355403;21767;5804.390538993398;6187.907181392283;6217.751289948419;6224.253089629251;6363.077353783722;6112.480439162677;6259.655718935457;6267.686615669221;6270.623762574237;6280.811575652715;5832.737526811283;6114.602550834204;6150.477209437203;6159.8768024639485;6169.722362493676;5892.823215303548;6139.7851075212375;6857.622830744307;6934.445244380463;6948.722051117949;6165.414285642857;6173.536984726164;6179.783707570258;6191.4118158774845;6220.720067596969;14191.716165676731;14406.135631862122;14614.634634134125;14619.488317908928;14624.122552646875;2320.7641831376955;2354.8587084774967;2391.792144966798;2624.9868750656315;2635.6705411823523;10145.391276523358;10597.523111460003;10650.520726567323;11358;15087.170205638686;1421.6161636358124;1593.745000799878;1819.5542092187366;1836.02690573996;1852.1017306606286;86208.56895715544;115463;116844.41577792141;117026;119581.60836783303;12031.518739250332;12176.512939482498;12191.817122743167;12241.20432171906;12402.81395779064;15463.072215667096;15736.055836649837;15772.92113539448;15832.68334633301;15839.287232074585;7605.353544948631;9026.503542305236;9410.38832475887;9486.09882061217;9499.810003799885;9309.53452327381;9319.673811416704;9459.148676619137;9497.857532137023;9521;4920.704757714477;4936.284238785428;4938.8765280868265;4993.750312484434;5108.565771909355;1706.257777866632;1949.6783030800043;1968.9507762306057;2021.181421524285;2098.8320934325216;938.558877327655;1004.492731170754;1058.3544038136731;1060.5810704771727;1081.259337353915;16484.25820838041;18887.338943136925;19665.186469904962;20965.475863103544;21892.562148756937;951.5955718819474;1042.5517027678172;1051.3954476176077;1058.9523471443804;1118.4351902289454;11224.943875280735;11571.710707232218;11600;11618.709532261591;11656.650300491;536979;643464;670326;689404;693105;132094;133636;134998;135504.32247838896;135680;1037.227265687068;1066.7599790047177;1073.0503504398664;1073.4954571351452;1099.8460215569826;18470.353537626117;18959.90520047391;18996.335128270443;19006.714899276245;19363.515912101746;53552.73223633857;54747.45252547583;54912;56929.430705692415;57984.130238047306;80903.59548202221;82758;82808;83244;83385.74921376306;8305.709300174465;8432.620532076195;8440.95779521123;8597.226249637562;8734.170253825876;8152.796180095545;12215.389230538616;12558.937205313914;12617.179883307555;12899.355032248537;5328.333958255218;8866.492696241783;11080.889191107986;11233.932776386231;11315;10637.9468102659;11062.723431913944;11211.860679009891;11396.886031139915;11583.594574189863;11331.150163737588;11593.304401735923;11603.419829008684;11727.706807329885;11950.760984780429;8384.077751447458;8455.32357411418;8505.82988340242;8556.871646925176;8625.008124065813;8498.107698691549;10719.624813131502;11042.834357484484;11195.160362972973;11345.149113816662 23:16:10 INFO - PROCESS | 1668 | |3;mootools.html;1632.3920937876194;1644.4984279794662;1953.9609207815845;2022.9958511610266;2052.3124753207676;7629.2752188542;9010.008899021102;9113.362064655461;9177.678781242657;9261.53692315384;9126.041765614615;9171.77070573236;9198.81602367954;9254.30592705548;9299.674511392102;2465.617829236462;2470.3700556358103;2472.7898128659085;2490.5392502387117;2493.6882889638796;2423.200343886522;2587.081586036958;2589.4821035792825;2590.883410246534;2595.6236345729953;2561.3596600849787;2574.034736973635;2604.192700262915;2606.804489663273;2613.398918248804;2520.773130418262;2561.9487610247784;2563.1541591274927;2610.0864697355773;2618.9214323570322;2555.9168978926064;2594.5718956372366;2594.7664710176173;2601.1026195962363;2606.374470127175;9401.811963760754;9441.90558094417;9441.90558094424;9460.810783784354;9483.952580237124;5655.37790843011;5690.146478028288;5783.942160578383;5822.912656310159;5855.975204339266;3025.243689077731;3743.8128093595483;3803.2773772983046;3807.1243613968663;3813.2945405100145;1052.1425038593522;1079.02348374721;1079.6707004363666;1079.7138758229075;1086.3427626286061;11655.009324207453;12660.366981650881;12694.365281735969;12703.618891433272;12704.174228675107;4713.457952335457;5094.133997220481;5116.206987916805;5166.870828229249;5174.301469301596;10631.149508039338;10713.92860713938;10734.194935379877;10823.67528974132;10887.673369798918;5786.363500014995;5830.4461076197695;5872.911906321408;5890.793822216202;5898.764049437975;4694.906101878011;5136.691798492027;5167.9224811627855;5271.947280527223;5292.311999440125;3613.9277214455565;4251.6386107180615;4275.679324050709;4364.75993820343;4383.802728877208;1399.7410479061407;1427.514645020677;1428.7356838984613;1435.2608406670572;1437.8418373978855;961.8893827209961;977.6969139566758;980.7597138701063;982.832918403873;985.3545927417553;6230.59501132434;6233.532485063638;6317.925952588071;6339.270983836917;6346.11154438379;420.0716416719024;477.43900916423064;487.72931023282416;491.5084915084915;498.0835263115812;3446.6208717041104;3852.287326844543;4126.690498212646;4150.833966641361;4180.979095104566;9611.663591774255;11241.044511216638;11439.256448330998;11549.422528873523;11553.653390398302;10915.836262456069;11197.66407007791;11251.043661288719;11288.153388495895;11351.432428378548;6113;7903.841923161504;8711.738647840575;8767.912320876709;8827.646894124164;5947.881042379215;6040.879182416239;6042.728077236623;6111.54541335351;6161.44546990773;9534.713958581253;9673.613055477703;9696.0788725071;9746.902530974883;9860.359076659994;9482.004389539276;9925.305228633926;9953;9958.651447199314;10119.443430611387;7240.1311842579225;7740.729074482591;7909.9209007909185;7919.564423956737;8031.879521807061;7308.780736577911;8660.17728315809;8684.609192586475;8699.608517616849;8757.168069033432;7646.388288936761;7812.57030863308;7820.84358312842;7908.960455197687;7910.7231246906085;7604.2395760423515;7635.770926872203;7651.693932242648;7732.574708391093;7742.535447873146;7172.677229524579;7230.783076507713;7246.528975616779;7264.455165862476;7300.634968251672;5053.7473126344275;5082.085224659597;5162.354705661793;5212.530872221519;5219.295395121761;5202.24567437727;5231.215317702375;5275.155975043975;5423.996560636295;5482.890342193214 23:16:10 INFO - PROCESS | 1668 | |4;prototype.html;282.5577970476205;324.2251020062051;338.35543290032496;344.8172468591646;346.2071855451017;6788.253292137861;6916.7579134730295;6986;7012.983117447973;7026.1217347831525;6946.895796563055;6976.441884649229;6979.546329488579;6982.720691172347;7032.085828842243;4631.513691062441;4713.457952335491;5161.303224064741;5168.353955755521;5198.298229738974;5163.793448262065;5165.173572228444;5177.663451875616;5183.714895680736;5184.1705327147665;4792.448868380128;5101.464346243647;5112.054269960069;5129.563987061104;5144.331236939192;4195.790210489463;4719.032598317337;5088.821891233808;5105.157648987913;5155;3649.59854416014;4334.566543345672;4428.136513379892;4443.2224360736745;4454.420925279693;6691.866162676768;6764.8308792280095;6767.120274364351;6772.72909083636;6781.22015968165;6048.667323297217;6054.636721796706;6070.484008859252;6070.96964515179;6089.147519347295;7471.066116735408;7472.0286362772495;7483;7485.513441626277;7504.5872477013745;4805.927911081337;4953.2074868020945;4979.751012449363;5000.549950504435;5016;6445.613263204176;7799.8440031199625;7873.015873015873;7873.173316801711;7879.606019698992;4603.378543896598;4640.816591769078;5041.445441001487;5049.798008079636;5056.216286475602;5119.206522988943;5127.102757017507;5135.897282054413;5147.794088236504;5153.433122356538;4990.5508504234795;5966.433188847052;6028.347527088067;6056.06131049688;6071.696415179224;6005.819825405245;6200.224971878515;7093.964530177316;7233.602151881697;7248.528845625017;1787.5084351803357;1804.7834259888634;1806.9006204658608;1808.692522271217;1816.9454916352531;1077.8437126616755;1141.2353723005606;1141.84585081013;1144.4449442020614;1166.8833116688434;5712.314522257356;7044.15470143586;7063.6821343038655;7066.328698773608;7080.114985626797;7727.806804829812;7729.458937874295;7766.766996989986;7769;7775.028121484815;7040.6479676016;7057.929420705727;7063;7083.6458177090935;7090.75182368625;3218.4206842768526;4094.28350038742;4104.958950410458;4118.402831589403;4121.505419349637;8064.919350806417;8082.7171049013;8086.636101375335;8097.595120243965;8118.985126859143;7942.404319676048;7946.7615971520945;7973.043234811744;7981.40139489529;8001.759947201477;6529.444997175198;8056.556889371141;8061.879071813927;8083.878741818878;8101.6354264058255;7417.443691723251;7711.9614401929875;7715.768526944201;7722.652480638497;7730.149683534919;7508.812279693051;7529.4729368943645;7536.7362142324755;7547.28300811422;7592.924070759443;6664.700088496126;7115.82210444743;7413.147488038944;7873.606319684108;8080.232377924088;4430.734155950653;5128.256402821645;5132.897342053213;5136.845894623168;5144.331236939174;5761.81882714051;6925.580256047398;7407.222241664763;7676.462647614837;7724.150343462103;7259.894630557079;7402.1857595665515;7404.333609975128;7414.258574142758;7458.627068646438;7381;7391.482596218429;7397.889031664422;7401.592912389655;7403.51877127985;6983.8254043647285;7242.420606351374;7244.963775181091;7245.311695388929;7263.16473605521;7365.337119659256;7435.7025718970635;7437.293457121565;7477.177510473734;7502.887456688263;5650.547956163415;7167.462440317101;7286.96356518214;7311.720448921524;7382.3724983377015 23:16:10 INFO - PROCESS | 1668 | |5;yui.html;716.2944499667827;781.1485480825899;787.6219414680953;793.8690116130839;802.2018091998463;15144.167070811101;15379.077255364658;15482.690346193069;15497.690046199083;15503.61240968975;13506.392212350444;13744.312784360793;14099.78850317246;14650.633734156625;14679.119252844837;946.2713710442955;953.0993211415215;966.632679581758;975.3513913247682;982.997342710435;912.2018234045211;923.1368670293264;938.6104766521885;947.3747326764337;948.9525523723821;976.4434272464663;999.8200323941687;1004.8542961270612;1009.4044513736894;1009.4448053570544;964.7154089543601;984.2224642532391;993.2401712689798;997.4912794474834;999.2505620784411;694.1843334082433;733.2081352139676;743.7657138001513;747.2714103748856;759.3128218961848;13550.525731599446;13614.591562253148;13623;13628.454861805516;13670.248136352497;11623.07015438763;11722.296662200295;11878.762424751543;12196.451159697835;12308.75382492354;9798.314118011742;11367.545298188063;11388.772224555545;11409.087273018138;11454.48454819535;3512.3326567952263;3525.7884526928465;3547.9113022174392;3578.6063533011347;3637.9636203638156;66027.66986165039;71770.56458870793;80123.5993820033;81026.59486702588;87618.5619071907;9918.851217231748;9928.354656947275;9960.352577082467;10186;10212.948935255276;21864.344069677936;22049.779502204772;22063.33809985703;22078.88960555187;22079.668804967616;6642.63465509392;7739.806504837424;7853.842923141505;7879.487833290817;8067.273945344947;4266.040140968319;4325.480942286883;4327.285997810326;4356.956430435655;4507.549245075532;3738.065483629093;3741.4387841823946;3764.3412402829395;3802.8859134225463;3887.5918028607157;695.474916438086;697.8429853282971;702.1854648607692;704.2851505721696;706.5336877660719;529.9231611416322;566.5439321346273;584.8537865533617;586.4135864135864;594.576351941562;8117.269445749911;8193.262606365337;8203.8359232815;8249.958750206331;8496.362772791941;536.5761048771427;584.7456356484943;593.4095574902913;601.711178634258;614.9631022138686;3651.598324184338;3796.563395209531;3804.8478060877255;3825.7513261637905;3832.9425058624142;84968;92472.53763731138;95108.0489195113;96787.03212967921;97052.51473742587;64966;73395.1651208724;77964.6101769499;83951.16048839556;84471;67285.32714672889;67656.323436765;68940.6552967232;71033.24168957761;73721.26278737144;8295;8327.20891515305;8374.87437688423;8548.487090774574;8679.349048821237;46530;51008.48991510038;51232;51550.74224628853;52923.47076529185;63571.68214159085;70184;70341.64829176026;72246.63876680793;73358.63320683362;10770.461476926279;10844.728881777703;11115.777684446104;11134.888651113386;11252.324860508395;11903.40482975865;12069.094817888517;12167.330796805907;12206.02351811835;12506.499740010298;10992.780144396907;11008.724781880517;11195.552177912792;11410.372429516456;12066.577669781516;10768.300060496043;11059.944700276446;11131.833022504507;11289.548418063185;12122.333271670142;11085.50115244832;11119;11145.275557088764;11371.601993930173;11880.34658093813;9503.477308748084;9519.238460923249;9600.423974561549;9611;9793.167580755715;9189.908100918905;9423.38747981379;9431.481268530297;9528.858588210636;9543.76140596463 23:16:10 INFO - PROCESS | 1668 | __end_tp_report 23:16:10 INFO - PROCESS | 1668 | __start_cc_report 23:16:10 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,396 23:16:10 INFO - PROCESS | 1668 | __end_cc_report 23:16:10 INFO - PROCESS | 1668 | __startTimestamp1468476970032__endTimestamp 23:16:10 INFO - PROCESS | 1668 | 23:16:10 INFO - PROCESS | 1668 | ------- Summary: start ------- 23:16:10 INFO - PROCESS | 1668 | Number of tests: 6 23:16:10 INFO - PROCESS | 1668 | 23:16:10 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5935.18 Median:6220.22 stddev:646.04 (10.4%) stddev-sans-first:623.00 23:16:10 INFO - PROCESS | 1668 | Values: 3665.6 3686.1 3718.0 3738.2 3738.8 6074.2 6075.4 6086.8 6107.6 6110.1 6030.7 6092.7 6107.3 6129.4 6132.5 5405.6 5440.8 5479.4 5519.6 5557.8 4695.8 5027.6 5516.4 5519.8 5529.6 4004.7 5438.2 5476.9 5502.8 5643.9 5474.2 5495.6 5516.5 5540.9 5579.3 5358.1 5481.8 5488.5 5488.9 5505.7 5769.7 5819.6 5924.2 6042.9 6106.4 6243.0 6312.7 6313.4 6319.4 6325.7 6372.8 6396.2 6404.2 6410.1 6443.1 6046.8 6119.2 6155.8 6199.0 6225.3 6468.5 6541.4 6580.5 6584.2 6595.0 5221.9 6295.7 6303.7 6317.1 6326.8 5355.2 6373.2 6419.2 6461.9 6470.9 6247.5 6306.3 6310.2 6312.2 6327.1 6238.1 6330.4 6335.4 6339.1 6368.9 4770.3 5149.0 5166.0 5180.9 5202.3 4624.5 4647.1 4687.6 4695.0 4700.5 5105.0 6100.7 6130.1 6132.5 6213.4 6239.0 6389.7 6411.4 6465.7 6500.3 6154.3 6171.2 6228.5 6242.9 6258.9 5577.5 5656.1 5699.1 5705.4 5736.7 6010.7 6341.0 6679.6 6685.0 6700.8 5518.1 6289.4 6459.5 6477.7 6479.8 5540.3 6537.0 6667.9 6687.8 6725.3 6317.5 6347.9 6360.4 6364.5 6365.3 6072.2 6417.0 6426.3 6448.9 6458.3 6220.2 6221.7 6264.2 6278.7 6292.6 6226.6 6293.4 6294.0 6304.9 6308.6 6029.9 6201.0 6293.3 6330.8 6330.9 6208.2 6226.1 6267.2 6277.5 6303.1 5201.4 5218.1 6243.1 6283.1 6304.8 23:16:10 INFO - PROCESS | 1668 | 23:16:10 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:67557.65 Median:39420.11 stddev:149075.02 (378.2%) stddev-sans-first:149408.33 23:16:10 INFO - PROCESS | 1668 | Values: 551.9 555.4 556.5 592.4 600.7 38503.8 39451.6 39531.6 39661.2 39673.8 40922.4 41399.8 41725.6 41915.4 41993.0 9568.4 9695.4 9789.0 9811.1 9832.5 9683.7 9804.8 9808.6 9848.0 9890.2 9868.5 9876.0 9884.3 9914.5 9974.3 8535.4 9893.9 9923.1 9953.5 9977.2 9726.2 9784.3 9853.3 9885.3 9894.4 39530.4 39787.8 39988.0 40275.8 40572.6 3365.2 3465.3 3507.9 3861.0 3923.4 28887.0 28900.9 29040.7 29389.9 29423.7 2745.6 2770.3 2813.9 2818.9 2849.3 401978.0 466137.0 480096.0 480272.6 481023.0 37248.0 61561.7 61879.0 61888.4 62083.4 36469.8 36520.9 36560.5 36576.5 36662.0 16393.8 16501.6 16589.5 16766.0 16788.7 14160.0 14257.1 14274.3 14321.6 14377.1 7106.7 7128.5 8357.3 8444.1 8648.7 3224.3 3475.7 3546.1 3559.0 3604.2 990.8 1045.4 1114.8 1148.9 1195.4 30219.8 30233.2 30737.7 30839.0 30917.7 1166.0 1190.2 1225.0 1234.8 1298.1 15507.0 15672.0 15694.2 15794.9 15939.7 526813.0 627304.0 631312.0 634436.0 640760.0 60659.0 61758.0 62450.7 62642.1 62902.0 1337.5 1540.5 1547.1 1564.9 1566.6 25819.4 29918.3 30302.4 30508.4 30575.6 43591.3 51574.7 52030.0 52599.5 52753.2 572009.0 583837.0 585539.0 587698.1 588454.0 27207.2 27391.2 27547.9 27820.9 28075.2 40262.8 45907.9 46160.8 46257.8 47555.0 38999.6 39093.0 39393.8 39446.4 40737.0 36221.3 36364.8 36550.8 36879.6 37255.3 36601.3 38517.7 39500.8 39885.4 40151.6 22219.6 26168.0 26672.6 29657.6 30195.5 24817.8 24954.3 25433.5 26135.5 26660.5 23:16:10 INFO - PROCESS | 1668 | 23:16:10 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:36473.69 Median:21480.12 stddev:108023.49 (502.9%) stddev-sans-first:108292.59 23:16:10 INFO - PROCESS | 1668 | Values: 413.6 416.6 418.8 422.5 426.0 20940.8 21385.0 21629.9 21766.0 22524.5 19408.4 20998.5 21575.2 21612.9 21767.0 5804.4 6187.9 6217.8 6224.3 6363.1 6112.5 6259.7 6267.7 6270.6 6280.8 5832.7 6114.6 6150.5 6159.9 6169.7 5892.8 6139.8 6857.6 6934.4 6948.7 6165.4 6173.5 6179.8 6191.4 6220.7 14191.7 14406.1 14614.6 14619.5 14624.1 2320.8 2354.9 2391.8 2625.0 2635.7 10145.4 10597.5 10650.5 11358.0 15087.2 1421.6 1593.7 1819.6 1836.0 1852.1 86208.6 115463.0 116844.4 117026.0 119581.6 12031.5 12176.5 12191.8 12241.2 12402.8 15463.1 15736.1 15772.9 15832.7 15839.3 7605.4 9026.5 9410.4 9486.1 9499.8 9309.5 9319.7 9459.1 9497.9 9521.0 4920.7 4936.3 4938.9 4993.8 5108.6 1706.3 1949.7 1969.0 2021.2 2098.8 938.6 1004.5 1058.4 1060.6 1081.3 16484.3 18887.3 19665.2 20965.5 21892.6 951.6 1042.6 1051.4 1059.0 1118.4 11224.9 11571.7 11600.0 11618.7 11656.7 536979.0 643464.0 670326.0 689404.0 693105.0 132094.0 133636.0 134998.0 135504.3 135680.0 1037.2 1066.8 1073.1 1073.5 1099.8 18470.4 18959.9 18996.3 19006.7 19363.5 53552.7 54747.5 54912.0 56929.4 57984.1 80903.6 82758.0 82808.0 83244.0 83385.7 8305.7 8432.6 8441.0 8597.2 8734.2 8152.8 12215.4 12558.9 12617.2 12899.4 5328.3 8866.5 11080.9 11233.9 11315.0 10637.9 11062.7 11211.9 11396.9 11583.6 11331.2 11593.3 11603.4 11727.7 11950.8 8384.1 8455.3 8505.8 8556.9 8625.0 8498.1 10719.6 11042.8 11195.2 11345.1 23:16:10 INFO - PROCESS | 1668 | 23:16:10 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5960.58 Median:5188.27 stddev:3317.08 (63.9%) stddev-sans-first:3310.44 23:16:10 INFO - PROCESS | 1668 | Values: 1632.4 1644.5 1954.0 2023.0 2052.3 7629.3 9010.0 9113.4 9177.7 9261.5 9126.0 9171.8 9198.8 9254.3 9299.7 2465.6 2470.4 2472.8 2490.5 2493.7 2423.2 2587.1 2589.5 2590.9 2595.6 2561.4 2574.0 2604.2 2606.8 2613.4 2520.8 2561.9 2563.2 2610.1 2618.9 2555.9 2594.6 2594.8 2601.1 2606.4 9401.8 9441.9 9441.9 9460.8 9484.0 5655.4 5690.1 5783.9 5822.9 5856.0 3025.2 3743.8 3803.3 3807.1 3813.3 1052.1 1079.0 1079.7 1079.7 1086.3 11655.0 12660.4 12694.4 12703.6 12704.2 4713.5 5094.1 5116.2 5166.9 5174.3 10631.1 10713.9 10734.2 10823.7 10887.7 5786.4 5830.4 5872.9 5890.8 5898.8 4694.9 5136.7 5167.9 5271.9 5292.3 3613.9 4251.6 4275.7 4364.8 4383.8 1399.7 1427.5 1428.7 1435.3 1437.8 961.9 977.7 980.8 982.8 985.4 6230.6 6233.5 6317.9 6339.3 6346.1 420.1 477.4 487.7 491.5 498.1 3446.6 3852.3 4126.7 4150.8 4181.0 9611.7 11241.0 11439.3 11549.4 11553.7 10915.8 11197.7 11251.0 11288.2 11351.4 6113.0 7903.8 8711.7 8767.9 8827.6 5947.9 6040.9 6042.7 6111.5 6161.4 9534.7 9673.6 9696.1 9746.9 9860.4 9482.0 9925.3 9953.0 9958.7 10119.4 7240.1 7740.7 7909.9 7919.6 8031.9 7308.8 8660.2 8684.6 8699.6 8757.2 7646.4 7812.6 7820.8 7909.0 7910.7 7604.2 7635.8 7651.7 7732.6 7742.5 7172.7 7230.8 7246.5 7264.5 7300.6 5053.7 5082.1 5162.4 5212.5 5219.3 5202.2 5231.2 5275.2 5424.0 5482.9 23:16:10 INFO - PROCESS | 1668 | 23:16:10 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:6039.48 Median:6936.24 stddev:1925.04 (27.8%) stddev-sans-first:1881.32 23:16:10 INFO - PROCESS | 1668 | Values: 282.6 324.2 338.4 344.8 346.2 6788.3 6916.8 6986.0 7013.0 7026.1 6946.9 6976.4 6979.5 6982.7 7032.1 4631.5 4713.5 5161.3 5168.4 5198.3 5163.8 5165.2 5177.7 5183.7 5184.2 4792.4 5101.5 5112.1 5129.6 5144.3 4195.8 4719.0 5088.8 5105.2 5155.0 3649.6 4334.6 4428.1 4443.2 4454.4 6691.9 6764.8 6767.1 6772.7 6781.2 6048.7 6054.6 6070.5 6071.0 6089.1 7471.1 7472.0 7483.0 7485.5 7504.6 4805.9 4953.2 4979.8 5000.5 5016.0 6445.6 7799.8 7873.0 7873.2 7879.6 4603.4 4640.8 5041.4 5049.8 5056.2 5119.2 5127.1 5135.9 5147.8 5153.4 4990.6 5966.4 6028.3 6056.1 6071.7 6005.8 6200.2 7094.0 7233.6 7248.5 1787.5 1804.8 1806.9 1808.7 1816.9 1077.8 1141.2 1141.8 1144.4 1166.9 5712.3 7044.2 7063.7 7066.3 7080.1 7727.8 7729.5 7766.8 7769.0 7775.0 7040.6 7057.9 7063.0 7083.6 7090.8 3218.4 4094.3 4105.0 4118.4 4121.5 8064.9 8082.7 8086.6 8097.6 8119.0 7942.4 7946.8 7973.0 7981.4 8001.8 6529.4 8056.6 8061.9 8083.9 8101.6 7417.4 7712.0 7715.8 7722.7 7730.1 7508.8 7529.5 7536.7 7547.3 7592.9 6664.7 7115.8 7413.1 7873.6 8080.2 4430.7 5128.3 5132.9 5136.8 5144.3 5761.8 6925.6 7407.2 7676.5 7724.2 7259.9 7402.2 7404.3 7414.3 7458.6 7381.0 7391.5 7397.9 7401.6 7403.5 6983.8 7242.4 7245.0 7245.3 7263.2 7365.3 7435.7 7437.3 7477.2 7502.9 5650.5 7167.5 7287.0 7311.7 7382.4 23:16:10 INFO - PROCESS | 1668 | 23:16:10 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18315.04 Median:593.99 stddev:25657.94 (4319.6%) stddev-sans-first:25695.89 23:16:10 INFO - PROCESS | 1668 | Values: 716.3 781.1 787.6 793.9 802.2 15144.2 15379.1 15482.7 15497.7 15503.6 13506.4 13744.3 14099.8 14650.6 14679.1 946.3 953.1 966.6 975.4 983.0 912.2 923.1 938.6 947.4 949.0 976.4 999.8 1004.9 1009.4 1009.4 964.7 984.2 993.2 997.5 999.3 694.2 733.2 743.8 747.3 759.3 13550.5 13614.6 13623.0 13628.5 13670.2 11623.1 11722.3 11878.8 12196.5 12308.8 9798.3 11367.5 11388.8 11409.1 11454.5 3512.3 3525.8 3547.9 3578.6 3638.0 66027.7 71770.6 80123.6 81026.6 87618.6 9918.9 9928.4 9960.4 10186.0 10212.9 21864.3 22049.8 22063.3 22078.9 22079.7 6642.6 7739.8 7853.8 7879.5 8067.3 4266.0 4325.5 4327.3 4357.0 4507.5 3738.1 3741.4 3764.3 3802.9 3887.6 695.5 697.8 702.2 704.3 706.5 529.9 566.5 584.9 586.4 594.6 8117.3 8193.3 8203.8 8250.0 8496.4 536.6 584.7 593.4 601.7 615.0 3651.6 3796.6 3804.8 3825.8 3832.9 84968.0 92472.5 95108.0 96787.0 97052.5 64966.0 73395.2 77964.6 83951.2 84471.0 67285.3 67656.3 68940.7 71033.2 73721.3 8295.0 8327.2 8374.9 8548.5 8679.3 46530.0 51008.5 51232.0 51550.7 52923.5 63571.7 70184.0 70341.6 72246.6 73358.6 10770.5 10844.7 11115.8 11134.9 11252.3 11903.4 12069.1 12167.3 12206.0 12506.5 10992.8 11008.7 11195.6 11410.4 12066.6 10768.3 11059.9 11131.8 11289.5 12122.3 11085.5 11119.0 11145.3 11371.6 11880.3 9503.5 9519.2 9600.4 9611.0 9793.2 9189.9 9423.4 9431.5 9528.9 9543.8 23:16:10 INFO - PROCESS | 1668 | -------- Summary: end -------- 23:16:10 INFO - PROCESS | 1668 | 23:16:10 INFO - TEST-INFO | 1668: exit 0 23:16:10 INFO - TEST-OK | dromaeo_css | took 1110246ms 23:16:10 INFO - TEST-START | kraken 23:16:10 INFO - operating with platform_type : mac_ 23:16:10 INFO - Initialising browser for kraken test... 23:16:10 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpRqUNEG/profile http://localhost:49275/getInfo.html) 23:16:13 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 23:16:13 INFO - PROCESS | 1676 | colorDepth:24 23:16:13 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 23:16:13 INFO - PROCESS | 1676 | __metrics 23:16:13 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 23:16:13 INFO - TEST-INFO | 1676: exit 0 23:16:13 INFO - Browser initialized. 23:16:13 INFO - Running cycle 1/1 for kraken test... 23:16:13 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpRqUNEG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:16:25 INFO - PROCESS | 1680 | RSS: Main: 171020288 23:16:25 INFO - PROCESS | 1680 | 23:16:28 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 23:16:29 INFO - PROCESS | 1680 | RSS: Main: 183754752 23:16:29 INFO - PROCESS | 1680 | 23:16:32 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 23:16:32 INFO - PROCESS | 1680 | RSS: Main: 192995328 23:16:32 INFO - PROCESS | 1680 | 23:16:35 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 23:16:36 INFO - PROCESS | 1680 | RSS: Main: 196186112 23:16:36 INFO - PROCESS | 1680 | 23:16:38 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 23:16:39 INFO - PROCESS | 1680 | RSS: Main: 196808704 23:16:39 INFO - PROCESS | 1680 | 23:16:41 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:16:41 INFO - PROCESS | 1680 | RSS: Main: 197042176 23:16:41 INFO - PROCESS | 1680 | 23:16:44 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 23:16:45 INFO - PROCESS | 1680 | RSS: Main: 197599232 23:16:45 INFO - PROCESS | 1680 | 23:16:48 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 23:16:48 INFO - PROCESS | 1680 | RSS: Main: 198729728 23:16:48 INFO - PROCESS | 1680 | 23:16:51 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 23:16:52 INFO - PROCESS | 1680 | RSS: Main: 198758400 23:16:52 INFO - PROCESS | 1680 | 23:16:53 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:16:54 INFO - PROCESS | 1680 | RSS: Main: 197795840 23:16:54 INFO - PROCESS | 1680 | 23:16:56 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:16:56 INFO - PROCESS | 1680 | RSS: Main: 198197248 23:16:56 INFO - PROCESS | 1680 | 23:16:58 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:16:59 INFO - PROCESS | 1680 | RSS: Main: 198373376 23:16:59 INFO - PROCESS | 1680 | 23:17:02 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:17:03 INFO - PROCESS | 1680 | RSS: Main: 198373376 23:17:03 INFO - PROCESS | 1680 | 23:17:06 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:17:06 INFO - PROCESS | 1680 | RSS: Main: 198250496 23:17:06 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 23:17:08 INFO - PROCESS | 1680 | RSS: Main: 200089600 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | __start_tp_report 23:17:08 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 23:17:08 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 23:17:08 INFO - PROCESS | 1680 | |i|pagename|runs| 23:17:08 INFO - PROCESS | 1680 | |0;ai-astar;117;112;116;116;117;132;115;117;131;167 23:17:08 INFO - PROCESS | 1680 | |1;audio-beat-detection;152;127;140;157;121;139;140;127;200;149 23:17:08 INFO - PROCESS | 1680 | |2;audio-dft;183;199;194;196;198;193;194;192;199;191 23:17:08 INFO - PROCESS | 1680 | |3;audio-fft;66;80;73;148;69;83;91;98;139;59 23:17:08 INFO - PROCESS | 1680 | |4;audio-oscillator;97;122;166;115;80;80;119;77;79;120 23:17:08 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;90;88;89;86;90;86;91;87;90;88 23:17:08 INFO - PROCESS | 1680 | |6;imaging-darkroom;95;115;116;96;96;95;96;95;95;94 23:17:08 INFO - PROCESS | 1680 | |7;imaging-desaturate;89;90;89;89;88;94;101;93;129;145 23:17:08 INFO - PROCESS | 1680 | |8;json-parse-financial;52;59;62;63;63;67;64;78;64;59 23:17:08 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;65;85;78;76;71;72;69;62;70;75 23:17:08 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;83;78;80;82;82;80;79;80;80;81 23:17:08 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;127;126;125;130;147;163;141;154;143;139 23:17:08 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;168;163;176;203;165;168;163;153;216;217 23:17:08 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;66;67;66;66;63;94;67;67;67;68 23:17:08 INFO - PROCESS | 1680 | __end_tp_report 23:17:08 INFO - PROCESS | 1680 | __start_cc_report 23:17:08 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1052 23:17:08 INFO - PROCESS | 1680 | __end_cc_report 23:17:08 INFO - PROCESS | 1680 | __startTimestamp1468477028601__endTimestamp 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | ------- Summary: start ------- 23:17:08 INFO - PROCESS | 1680 | Number of tests: 14 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:124.00 Median:117.00 stddev:16.54 (14.1%) stddev-sans-first:17.35 23:17:08 INFO - PROCESS | 1680 | Values: 117.0 112.0 116.0 116.0 117.0 132.0 115.0 117.0 131.0 167.0 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:144.50 stddev:22.47 (15.5%) stddev-sans-first:23.70 23:17:08 INFO - PROCESS | 1680 | Values: 152.0 127.0 140.0 157.0 121.0 139.0 140.0 127.0 200.0 149.0 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:193.90 Median:195.00 stddev:4.77 (2.4%) stddev-sans-first:3.02 23:17:08 INFO - PROCESS | 1680 | Values: 183.0 199.0 194.0 196.0 198.0 193.0 194.0 192.0 199.0 191.0 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:90.60 Median:76.50 stddev:30.26 (39.6%) stddev-sans-first:30.76 23:17:08 INFO - PROCESS | 1680 | Values: 66.0 80.0 73.0 148.0 69.0 83.0 91.0 98.0 139.0 59.0 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:78.00 stddev:28.48 (36.5%) stddev-sans-first:30.05 23:17:08 INFO - PROCESS | 1680 | Values: 97.0 122.0 166.0 115.0 80.0 80.0 119.0 77.0 79.0 120.0 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:89.50 stddev:1.78 (2.0%) stddev-sans-first:1.80 23:17:08 INFO - PROCESS | 1680 | Values: 90.0 88.0 89.0 86.0 90.0 86.0 91.0 87.0 90.0 88.0 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:99.30 Median:95.00 stddev:8.56 (9.0%) stddev-sans-first:8.94 23:17:08 INFO - PROCESS | 1680 | Values: 95.0 115.0 116.0 96.0 96.0 95.0 96.0 95.0 95.0 94.0 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:100.70 Median:89.00 stddev:19.87 (22.3%) stddev-sans-first:20.62 23:17:08 INFO - PROCESS | 1680 | Values: 89.0 90.0 89.0 89.0 88.0 94.0 101.0 93.0 129.0 145.0 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.50 stddev:6.64 (10.5%) stddev-sans-first:5.70 23:17:08 INFO - PROCESS | 1680 | Values: 52.0 59.0 62.0 63.0 63.0 67.0 64.0 78.0 64.0 59.0 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:73.50 stddev:6.60 (9.0%) stddev-sans-first:6.45 23:17:08 INFO - PROCESS | 1680 | Values: 65.0 85.0 78.0 76.0 71.0 72.0 69.0 62.0 70.0 75.0 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.50 stddev:1.51 (1.9%) stddev-sans-first:1.30 23:17:08 INFO - PROCESS | 1680 | Values: 83.0 78.0 80.0 82.0 82.0 80.0 79.0 80.0 80.0 81.0 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:142.00 stddev:12.79 (9.0%) stddev-sans-first:12.74 23:17:08 INFO - PROCESS | 1680 | Values: 127.0 126.0 125.0 130.0 147.0 163.0 141.0 154.0 143.0 139.0 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:172.00 stddev:23.63 (13.7%) stddev-sans-first:24.71 23:17:08 INFO - PROCESS | 1680 | Values: 168.0 163.0 176.0 203.0 165.0 168.0 163.0 153.0 216.0 217.0 23:17:08 INFO - PROCESS | 1680 | 23:17:08 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:67.00 stddev:8.85 (13.2%) stddev-sans-first:9.32 23:17:08 INFO - PROCESS | 1680 | Values: 66.0 67.0 66.0 66.0 63.0 94.0 67.0 67.0 67.0 68.0 23:17:08 INFO - PROCESS | 1680 | -------- Summary: end -------- 23:17:08 INFO - PROCESS | 1680 | 23:17:09 INFO - TEST-INFO | 1680: exit 0 23:17:09 INFO - TEST-OK | kraken | took 58988ms 23:17:09 INFO - SUITE-END | took 1169s 23:17:09 INFO - Completed test suite (00:19:29) 23:17:09 INFO - javascript benchmark 23:17:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3665.578458477275, 3686.096906257967, 3718.0, 3738.1962877981227, 3738.756980796248, 6074.210352654154, 6075.362086980869, 6086.7869624563145, 6107.60300580462, 6110.077186750025, 6030.728617212225, 6092.66490343031, 6107.328193898667, 6129.38706129388, 6132.509399248061, 5405.594580406475, 5440.782368705247, 5479.369872464657, 5519.641223320491, 5557.777688892439, 4695.7886895089805, 5027.572656324199, 5516.448355164472, 5519.751611177487, 5529.612927095105, 4004.6996475264327, 5438.184272359138, 5476.863078423032, 5502.752376143083, 5643.943560564403, 5474.151506516497, 5495.6153069285165, 5516.503514683678, 5540.86147846303, 5579.302587176603, 5358.089124848785, 5481.75332110056, 5488.4785945335125, 5488.91766623501, 5505.724713764296, 5769.653820770725, 5819.603295209162, 5924.200232968537, 6042.879142417171, 6106.419890110433, 6242.968785156045, 6312.684365781693, 6313.368663133696, 6319.3680631936895, 6325.652089135096, 6372.808815735535, 6396.200474940632, 6404.231492220963, 6410.102585638015, 6443.065755465478, 6046.758129674764, 6119.2350956130485, 6155.784547540904, 6198.969005154991, 6225.346338634468, 6468.450181734511, 6541.443977261891, 6580.5064620152725, 6584.209894812653, 6595.043718660767, 5221.947780522146, 6295.685215739195, 6303.747850086037, 6317.147185129948, 6326.841828954313, 5355.196720491957, 6373.171487706569, 6419.197600299963, 6461.935380646228, 6470.870582588416, 6247.468965137923, 6306.274778400542, 6310.1796766420075, 6312.242530896322, 6327.050942358591, 6238.1266622672865, 6330.430261276507, 6335.366463353628, 6339.0808332791485, 6368.936310636927, 4770.332153498513, 5149.0474262261605, 5166.0, 5180.948190518122, 5202.297689811827, 4624.514425985223, 4647.140279048387, 4687.648426367968, 4695.037517308943, 4700.459447163552, 5104.9744751276, 6100.664463454464, 6130.111133885562, 6132.540059495555, 6213.440790328892, 6238.968805155945, 6389.6805159741825, 6411.4229719325485, 6465.741370345134, 6500.3499650035565, 6154.323024467305, 6171.166892469549, 6228.532860035425, 6242.875142497124, 6258.906116408258, 5577.498025177753, 5656.095024796013, 5699.116636921284, 5705.372409035002, 5736.713164341766, 6010.677650916791, 6340.968295158587, 6679.565828221247, 6685.0, 6700.798976030727, 5518.089515229942, 6289.433950944437, 6459.483241340776, 6477.676116194078, 6479.838004049937, 5540.335159780852, 6537.0, 6667.933320666732, 6687.832804179934, 6725.260221375547, 6317.494600432046, 6347.936520634735, 6360.395762402564, 6364.459020983269, 6365.331640177715, 6072.210612620331, 6416.967915160394, 6426.325235850169, 6448.935510644834, 6458.321876203119, 6220.222472190976, 6221.688915554295, 6264.185655864709, 6278.717457714322, 6292.622442653455, 6226.564140510302, 6293.37066293367, 6293.96853015732, 6304.905426418516, 6308.621482711052, 6029.939700603113, 6201.0, 6293.307736149111, 6330.778422755366, 6330.905036424365, 6208.161898143693, 6226.066090086342, 6267.2479302484, 6277.466415354746, 6303.086052522267, 5201.375834899836, 5218.086834803818, 6243.063540468966, 6283.057541368648, 6304.810855674337], "value": 5899.7546052768885, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.884104338089, 555.4445554445555, 556.4769117029989, 592.4312659846547, 600.663628368114, 38503.80748096259, 39451.60548394515, 39531.604683953155, 39661.20677586446, 39673.80978570644, 40922.386164207484, 41399.793001035025, 41725.58274417255, 41915.37126943098, 41993.0, 9568.37805542641, 9695.36980096295, 9789.0, 9811.067948544876, 9832.508374581279, 9683.661071862487, 9804.803903921917, 9808.558614862348, 9848.0, 9890.15933645641, 9868.45723485208, 9875.95062024689, 9884.308098433112, 9914.504274786268, 9974.251931105196, 8535.359848011392, 9893.901060989407, 9923.1069203772, 9953.502324883762, 9977.201823854075, 9726.17327527161, 9784.315097943147, 9853.26100542455, 9885.25860560461, 9894.406335619886, 39530.40704389437, 39787.80636580907, 39988.00029999244, 40275.79172624826, 40572.59427405718, 3365.1923538350866, 3465.2722928185112, 3507.8772242971627, 3861.0, 3923.372260438316, 28887.0, 28900.855495722597, 29040.709592904223, 29389.94270401073, 29423.70576294231, 2745.6018877262886, 2770.293575138347, 2813.8733756980987, 2818.873150708223, 2849.2591926099362, 401978.0, 466137.0, 480096.0, 480272.59863700805, 481023.0, 37248.0, 61561.69219153876, 61879.0, 61888.381116189164, 62083.379166208666, 36469.817650912104, 36520.904372868856, 36560.45159322612, 36576.45135322972, 36662.0, 16393.754093688603, 16501.58746031359, 16589.50231493057, 16766.0, 16788.664226715642, 14160.00879938415, 14257.073290236309, 14274.286285685674, 14321.64195895111, 14377.065490743069, 7106.680199391039, 7128.536645118051, 8357.331413486907, 8444.071152173256, 8648.697295594624, 3224.290656055664, 3475.687188153028, 3546.131197856542, 3558.982205088958, 3604.2070744436182, 990.821652102614, 1045.4057562217527, 1114.7603265298, 1148.8736239013701, 1195.384377045822, 30219.848900755795, 30233.244168895955, 30737.69262307393, 30839.0, 30917.690823091933, 1165.9941700291445, 1190.2323001663879, 1225.0, 1234.7592219517107, 1298.0653929170983, 15507.0, 15672.0, 15694.215289235493, 15794.9210253948, 15939.681206375808, 526813.0, 627304.0, 631312.0, 634436.0, 640760.0, 60659.0, 61758.0, 62450.68774656098, 62642.0603690945, 62902.0, 1337.505123104438, 1540.5147378575937, 1547.0562956596243, 1564.9217539123, 1566.6396728752222, 25819.354516137246, 29918.25204369908, 30302.393952121274, 30508.389832203677, 30575.598434919597, 43591.34612980745, 51574.74212628913, 52029.95940081253, 52599.47400525946, 52753.20870186874, 572009.0, 583837.0, 585539.0, 587698.0615096897, 588454.0, 27207.183784486497, 27391.17826465209, 27547.86226068937, 27820.88716451319, 28075.157745267676, 40262.79868600638, 45907.85230369268, 46160.8459788508, 46257.84355391142, 47555.0, 38999.6100038996, 39093.0, 39393.80303098466, 39446.40830387604, 40736.981575459664, 36221.27557448784, 36364.81817590895, 36550.817245914666, 36879.63120368762, 37255.25489490141, 36601.26797464089, 38517.651882183985, 39500.80249598734, 39885.40171897482, 40151.59848401479, 22219.555608887407, 26168.0, 26672.59991100096, 29657.5551366734, 30195.547066793577, 24817.759112044685, 24954.251372458857, 25433.491330173663, 26135.477290454466, 26660.466790664464], "value": 18949.44115056779, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.5946772163278, 416.62920001198955, 418.82200064972386, 422.5077784381195, 425.9574042595741, 20940.790592094076, 21385.0, 21629.91850407479, 21765.99999999996, 22524.549509009852, 19408.417747467563, 20998.530102892804, 21575.24486642964, 21612.8919355403, 21767.0, 5804.390538993398, 6187.907181392283, 6217.751289948419, 6224.253089629251, 6363.077353783722, 6112.480439162677, 6259.655718935457, 6267.686615669221, 6270.623762574237, 6280.811575652715, 5832.737526811283, 6114.602550834204, 6150.477209437203, 6159.8768024639485, 6169.722362493676, 5892.823215303548, 6139.7851075212375, 6857.622830744307, 6934.445244380463, 6948.722051117949, 6165.414285642857, 6173.536984726164, 6179.783707570258, 6191.4118158774845, 6220.720067596969, 14191.716165676731, 14406.135631862122, 14614.634634134125, 14619.488317908928, 14624.122552646875, 2320.7641831376955, 2354.8587084774967, 2391.792144966798, 2624.9868750656315, 2635.6705411823523, 10145.391276523358, 10597.523111460003, 10650.520726567323, 11358.0, 15087.170205638686, 1421.6161636358124, 1593.745000799878, 1819.5542092187366, 1836.02690573996, 1852.1017306606286, 86208.56895715544, 115463.0, 116844.41577792141, 117026.0, 119581.60836783303, 12031.518739250332, 12176.512939482498, 12191.817122743167, 12241.20432171906, 12402.81395779064, 15463.072215667096, 15736.055836649837, 15772.92113539448, 15832.68334633301, 15839.287232074585, 7605.353544948631, 9026.503542305236, 9410.38832475887, 9486.09882061217, 9499.810003799885, 9309.53452327381, 9319.673811416704, 9459.148676619137, 9497.857532137023, 9521.0, 4920.704757714477, 4936.284238785428, 4938.8765280868265, 4993.750312484434, 5108.565771909355, 1706.257777866632, 1949.6783030800043, 1968.9507762306057, 2021.181421524285, 2098.8320934325216, 938.558877327655, 1004.492731170754, 1058.3544038136731, 1060.5810704771727, 1081.259337353915, 16484.25820838041, 18887.338943136925, 19665.186469904962, 20965.475863103544, 21892.562148756937, 951.5955718819474, 1042.5517027678172, 1051.3954476176077, 1058.9523471443804, 1118.4351902289454, 11224.943875280735, 11571.710707232218, 11600.0, 11618.709532261591, 11656.650300491, 536979.0, 643464.0, 670326.0, 689404.0, 693105.0, 132094.0, 133636.0, 134998.0, 135504.32247838896, 135680.0, 1037.227265687068, 1066.7599790047177, 1073.0503504398664, 1073.4954571351452, 1099.8460215569826, 18470.353537626117, 18959.90520047391, 18996.335128270443, 19006.714899276245, 19363.515912101746, 53552.73223633857, 54747.45252547583, 54912.0, 56929.430705692415, 57984.130238047306, 80903.59548202221, 82758.0, 82808.0, 83244.0, 83385.74921376306, 8305.709300174465, 8432.620532076195, 8440.95779521123, 8597.226249637562, 8734.170253825876, 8152.796180095545, 12215.389230538616, 12558.937205313914, 12617.179883307555, 12899.355032248537, 5328.333958255218, 8866.492696241783, 11080.889191107986, 11233.932776386231, 11315.0, 10637.9468102659, 11062.723431913944, 11211.860679009891, 11396.886031139915, 11583.594574189863, 11331.150163737588, 11593.304401735923, 11603.419829008684, 11727.706807329885, 11950.760984780429, 8384.077751447458, 8455.32357411418, 8505.82988340242, 8556.871646925176, 8625.008124065813, 8498.107698691549, 10719.624813131502, 11042.834357484484, 11195.160362972973, 11345.149113816662], "value": 9805.477160082895, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1632.3920937876194, 1644.4984279794662, 1953.9609207815845, 2022.9958511610266, 2052.3124753207676, 7629.2752188542, 9010.008899021102, 9113.362064655461, 9177.678781242657, 9261.53692315384, 9126.041765614615, 9171.77070573236, 9198.81602367954, 9254.30592705548, 9299.674511392102, 2465.617829236462, 2470.3700556358103, 2472.7898128659085, 2490.5392502387117, 2493.6882889638796, 2423.200343886522, 2587.081586036958, 2589.4821035792825, 2590.883410246534, 2595.6236345729953, 2561.3596600849787, 2574.034736973635, 2604.192700262915, 2606.804489663273, 2613.398918248804, 2520.773130418262, 2561.9487610247784, 2563.1541591274927, 2610.0864697355773, 2618.9214323570322, 2555.9168978926064, 2594.5718956372366, 2594.7664710176173, 2601.1026195962363, 2606.374470127175, 9401.811963760754, 9441.90558094417, 9441.90558094424, 9460.810783784354, 9483.952580237124, 5655.37790843011, 5690.146478028288, 5783.942160578383, 5822.912656310159, 5855.975204339266, 3025.243689077731, 3743.8128093595483, 3803.2773772983046, 3807.1243613968663, 3813.2945405100145, 1052.1425038593522, 1079.02348374721, 1079.6707004363666, 1079.7138758229075, 1086.3427626286061, 11655.009324207453, 12660.366981650881, 12694.365281735969, 12703.618891433272, 12704.174228675107, 4713.457952335457, 5094.133997220481, 5116.206987916805, 5166.870828229249, 5174.301469301596, 10631.149508039338, 10713.92860713938, 10734.194935379877, 10823.67528974132, 10887.673369798918, 5786.363500014995, 5830.4461076197695, 5872.911906321408, 5890.793822216202, 5898.764049437975, 4694.906101878011, 5136.691798492027, 5167.9224811627855, 5271.947280527223, 5292.311999440125, 3613.9277214455565, 4251.6386107180615, 4275.679324050709, 4364.75993820343, 4383.802728877208, 1399.7410479061407, 1427.514645020677, 1428.7356838984613, 1435.2608406670572, 1437.8418373978855, 961.8893827209961, 977.6969139566758, 980.7597138701063, 982.832918403873, 985.3545927417553, 6230.59501132434, 6233.532485063638, 6317.925952588071, 6339.270983836917, 6346.11154438379, 420.0716416719024, 477.43900916423064, 487.72931023282416, 491.5084915084915, 498.0835263115812, 3446.6208717041104, 3852.287326844543, 4126.690498212646, 4150.833966641361, 4180.979095104566, 9611.663591774255, 11241.044511216638, 11439.256448330998, 11549.422528873523, 11553.653390398302, 10915.836262456069, 11197.66407007791, 11251.043661288719, 11288.153388495895, 11351.432428378548, 6113.0, 7903.841923161504, 8711.738647840575, 8767.912320876709, 8827.646894124164, 5947.881042379215, 6040.879182416239, 6042.728077236623, 6111.54541335351, 6161.44546990773, 9534.713958581253, 9673.613055477703, 9696.0788725071, 9746.902530974883, 9860.359076659994, 9482.004389539276, 9925.305228633926, 9953.0, 9958.651447199314, 10119.443430611387, 7240.1311842579225, 7740.729074482591, 7909.9209007909185, 7919.564423956737, 8031.879521807061, 7308.780736577911, 8660.17728315809, 8684.609192586475, 8699.608517616849, 8757.168069033432, 7646.388288936761, 7812.57030863308, 7820.84358312842, 7908.960455197687, 7910.7231246906085, 7604.2395760423515, 7635.770926872203, 7651.693932242648, 7732.574708391093, 7742.535447873146, 7172.677229524579, 7230.783076507713, 7246.528975616779, 7264.455165862476, 7300.634968251672, 5053.7473126344275, 5082.085224659597, 5162.354705661793, 5212.530872221519, 5219.295395121761, 5202.24567437727, 5231.215317702375, 5275.155975043975, 5423.996560636295, 5482.890342193214], "value": 4747.214756057602, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.5577970476205, 324.2251020062051, 338.35543290032496, 344.8172468591646, 346.2071855451017, 6788.253292137861, 6916.7579134730295, 6986.0, 7012.983117447973, 7026.1217347831525, 6946.895796563055, 6976.441884649229, 6979.546329488579, 6982.720691172347, 7032.085828842243, 4631.513691062441, 4713.457952335491, 5161.303224064741, 5168.353955755521, 5198.298229738974, 5163.793448262065, 5165.173572228444, 5177.663451875616, 5183.714895680736, 5184.1705327147665, 4792.448868380128, 5101.464346243647, 5112.054269960069, 5129.563987061104, 5144.331236939192, 4195.790210489463, 4719.032598317337, 5088.821891233808, 5105.157648987913, 5155.0, 3649.59854416014, 4334.566543345672, 4428.136513379892, 4443.2224360736745, 4454.420925279693, 6691.866162676768, 6764.8308792280095, 6767.120274364351, 6772.72909083636, 6781.22015968165, 6048.667323297217, 6054.636721796706, 6070.484008859252, 6070.96964515179, 6089.147519347295, 7471.066116735408, 7472.0286362772495, 7483.0, 7485.513441626277, 7504.5872477013745, 4805.927911081337, 4953.2074868020945, 4979.751012449363, 5000.549950504435, 5016.0, 6445.613263204176, 7799.8440031199625, 7873.015873015873, 7873.173316801711, 7879.606019698992, 4603.378543896598, 4640.816591769078, 5041.445441001487, 5049.798008079636, 5056.216286475602, 5119.206522988943, 5127.102757017507, 5135.897282054413, 5147.794088236504, 5153.433122356538, 4990.5508504234795, 5966.433188847052, 6028.347527088067, 6056.06131049688, 6071.696415179224, 6005.819825405245, 6200.224971878515, 7093.964530177316, 7233.602151881697, 7248.528845625017, 1787.5084351803357, 1804.7834259888634, 1806.9006204658608, 1808.692522271217, 1816.9454916352531, 1077.8437126616755, 1141.2353723005606, 1141.84585081013, 1144.4449442020614, 1166.8833116688434, 5712.314522257356, 7044.15470143586, 7063.6821343038655, 7066.328698773608, 7080.114985626797, 7727.806804829812, 7729.458937874295, 7766.766996989986, 7769.0, 7775.028121484815, 7040.6479676016, 7057.929420705727, 7063.0, 7083.6458177090935, 7090.75182368625, 3218.4206842768526, 4094.28350038742, 4104.958950410458, 4118.402831589403, 4121.505419349637, 8064.919350806417, 8082.7171049013, 8086.636101375335, 8097.595120243965, 8118.985126859143, 7942.404319676048, 7946.7615971520945, 7973.043234811744, 7981.40139489529, 8001.759947201477, 6529.444997175198, 8056.556889371141, 8061.879071813927, 8083.878741818878, 8101.6354264058255, 7417.443691723251, 7711.9614401929875, 7715.768526944201, 7722.652480638497, 7730.149683534919, 7508.812279693051, 7529.4729368943645, 7536.7362142324755, 7547.28300811422, 7592.924070759443, 6664.700088496126, 7115.82210444743, 7413.147488038944, 7873.606319684108, 8080.232377924088, 4430.734155950653, 5128.256402821645, 5132.897342053213, 5136.845894623168, 5144.331236939174, 5761.81882714051, 6925.580256047398, 7407.222241664763, 7676.462647614837, 7724.150343462103, 7259.894630557079, 7402.1857595665515, 7404.333609975128, 7414.258574142758, 7458.627068646438, 7381.0, 7391.482596218429, 7397.889031664422, 7401.592912389655, 7403.51877127985, 6983.8254043647285, 7242.420606351374, 7244.963775181091, 7245.311695388929, 7263.16473605521, 7365.337119659256, 7435.7025718970635, 7437.293457121565, 7477.177510473734, 7502.887456688263, 5650.547956163415, 7167.462440317101, 7286.96356518214, 7311.720448921524, 7382.3724983377015], "value": 5395.872675352047, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.2944499667827, 781.1485480825899, 787.6219414680953, 793.8690116130839, 802.2018091998463, 15144.167070811101, 15379.077255364658, 15482.690346193069, 15497.690046199083, 15503.61240968975, 13506.392212350444, 13744.312784360793, 14099.78850317246, 14650.633734156625, 14679.119252844837, 946.2713710442955, 953.0993211415215, 966.632679581758, 975.3513913247682, 982.997342710435, 912.2018234045211, 923.1368670293264, 938.6104766521885, 947.3747326764337, 948.9525523723821, 976.4434272464663, 999.8200323941687, 1004.8542961270612, 1009.4044513736894, 1009.4448053570544, 964.7154089543601, 984.2224642532391, 993.2401712689798, 997.4912794474834, 999.2505620784411, 694.1843334082433, 733.2081352139676, 743.7657138001513, 747.2714103748856, 759.3128218961848, 13550.525731599446, 13614.591562253148, 13623.0, 13628.454861805516, 13670.248136352497, 11623.07015438763, 11722.296662200295, 11878.762424751543, 12196.451159697835, 12308.75382492354, 9798.314118011742, 11367.545298188063, 11388.772224555545, 11409.087273018138, 11454.48454819535, 3512.3326567952263, 3525.7884526928465, 3547.9113022174392, 3578.6063533011347, 3637.9636203638156, 66027.66986165039, 71770.56458870793, 80123.5993820033, 81026.59486702588, 87618.5619071907, 9918.851217231748, 9928.354656947275, 9960.352577082467, 10186.0, 10212.948935255276, 21864.344069677936, 22049.779502204772, 22063.33809985703, 22078.88960555187, 22079.668804967616, 6642.63465509392, 7739.806504837424, 7853.842923141505, 7879.487833290817, 8067.273945344947, 4266.040140968319, 4325.480942286883, 4327.285997810326, 4356.956430435655, 4507.549245075532, 3738.065483629093, 3741.4387841823946, 3764.3412402829395, 3802.8859134225463, 3887.5918028607157, 695.474916438086, 697.8429853282971, 702.1854648607692, 704.2851505721696, 706.5336877660719, 529.9231611416322, 566.5439321346273, 584.8537865533617, 586.4135864135864, 594.576351941562, 8117.269445749911, 8193.262606365337, 8203.8359232815, 8249.958750206331, 8496.362772791941, 536.5761048771427, 584.7456356484943, 593.4095574902913, 601.711178634258, 614.9631022138686, 3651.598324184338, 3796.563395209531, 3804.8478060877255, 3825.7513261637905, 3832.9425058624142, 84968.0, 92472.53763731138, 95108.0489195113, 96787.03212967921, 97052.51473742587, 64966.0, 73395.1651208724, 77964.6101769499, 83951.16048839556, 84471.0, 67285.32714672889, 67656.323436765, 68940.6552967232, 71033.24168957761, 73721.26278737144, 8295.0, 8327.20891515305, 8374.87437688423, 8548.487090774574, 8679.349048821237, 46530.0, 51008.48991510038, 51232.0, 51550.74224628853, 52923.47076529185, 63571.68214159085, 70184.0, 70341.64829176026, 72246.63876680793, 73358.63320683362, 10770.461476926279, 10844.728881777703, 11115.777684446104, 11134.888651113386, 11252.324860508395, 11903.40482975865, 12069.094817888517, 12167.330796805907, 12206.02351811835, 12506.499740010298, 10992.780144396907, 11008.724781880517, 11195.552177912792, 11410.372429516456, 12066.577669781516, 10768.300060496043, 11059.944700276446, 11131.833022504507, 11289.548418063185, 12122.333271670142, 11085.50115244832, 11119.0, 11145.275557088764, 11371.601993930173, 11880.34658093813, 9503.477308748084, 9519.238460923249, 9600.423974561549, 9611.0, 9793.167580755715, 9189.908100918905, 9423.38747981379, 9431.481268530297, 9528.858588210636, 9543.76140596463], "value": 7023.037116643964, "unit": "score"}], "name": "dromaeo_css", "value": 7629.445073355242, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 116.0, 116.0, 117.0, 132.0, 115.0, 117.0, 131.0, 167.0], "value": 124.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 140.0, 157.0, 121.0, 139.0, 140.0, 127.0, 200.0, 149.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 199.0, 194.0, 196.0, 198.0, 193.0, 194.0, 192.0, 199.0, 191.0], "value": 193.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 80.0, 73.0, 148.0, 69.0, 83.0, 91.0, 98.0, 139.0, 59.0], "value": 90.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 122.0, 166.0, 115.0, 80.0, 80.0, 119.0, 77.0, 79.0, 120.0], "value": 105.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 89.0, 86.0, 90.0, 86.0, 91.0, 87.0, 90.0, 88.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 115.0, 116.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 94.0], "value": 99.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 89.0, 89.0, 88.0, 94.0, 101.0, 93.0, 129.0, 145.0], "value": 100.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 59.0, 62.0, 63.0, 63.0, 67.0, 64.0, 78.0, 64.0, 59.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 85.0, 78.0, 76.0, 71.0, 72.0, 69.0, 62.0, 70.0, 75.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 80.0, 82.0, 82.0, 80.0, 79.0, 80.0, 80.0, 81.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 125.0, 130.0, 147.0, 163.0, 141.0, 154.0, 143.0, 139.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 176.0, 203.0, 165.0, 168.0, 163.0, 153.0, 216.0, 217.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 63.0, 94.0, 67.0, 67.0, 67.0, 68.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1551.4, "alertThreshold": 2.0}]} 23:17:09 INFO - Return code: 0 23:17:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:17:09 ERROR - # TBPL SUCCESS # 23:17:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:17:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:17:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:17:09 INFO - 2016-07-13 23:17:09.956 screenresolution[1685:11191] starting screenresolution argv=screenresolution get 23:17:09 INFO - 2016-07-13 23:17:09.958 screenresolution[1685:11191] Display 0: 1600x1200x32@60 23:17:09 INFO - 2016-07-13 23:17:09.965 screenresolution[1686:11194] starting screenresolution argv=screenresolution list 23:17:09 INFO - Available Modes on Display 0 23:17:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:17:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:17:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:17:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:17:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:17:10 INFO - Intel Iris: 23:17:10 INFO - Chipset Model: Intel Iris 23:17:10 INFO - Type: GPU 23:17:10 INFO - Bus: Built-In 23:17:10 INFO - VRAM (Dynamic, Max): 1536 MB 23:17:10 INFO - Vendor: Intel (0x8086) 23:17:10 INFO - Device ID: 0x0a2e 23:17:10 INFO - Revision ID: 0x0009 23:17:10 INFO - Displays: 23:17:10 INFO - Display: 23:17:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:17:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:17:10 INFO - Display Serial Number: 1600x1200 60 23:17:10 INFO - Main Display: Yes 23:17:10 INFO - Mirror: Off 23:17:10 INFO - Online: Yes 23:17:10 INFO - Rotation: Supported 23:17:10 INFO - Return code: 0 23:17:10 INFO - Running post-action listener: _resource_record_post_action 23:17:10 INFO - Running post-run listener: _resource_record_post_run 23:17:11 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 31706624; Write bytes: 497412608; Read time: 226; Write time: 1575 23:17:11 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193434112; Write bytes: 186889728; Read time: 17585; Write time: 399 23:17:11 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 29920768; Write bytes: 300778496; Read time: 211; Write time: 1143 23:17:11 INFO - Running post-run listener: _upload_blobber_files 23:17:11 INFO - Blob upload gear active. 23:17:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:17:11 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 23:17:11 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'] 23:17:11 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 23:17:11 INFO - (blobuploader) - INFO - Open directory for files ... 23:17:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:17:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:17:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:17:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:17:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:17:12 INFO - (blobuploader) - INFO - Done attempting. 23:17:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:17:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:17:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:17:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:17:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:17:13 INFO - (blobuploader) - INFO - Done attempting. 23:17:13 INFO - (blobuploader) - INFO - Iteration through files over. 23:17:13 INFO - Return code: 0 23:17:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:17:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:17:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bea24826391ca8f623cc72740ab16a61a4400013e7c61e6738f56abd7620f658bcf94554e88b0f3da67b41c98f91fd4ca8dbd95cb7bebcd66ed4660c0a31760a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a8797d49f4fdc6c2d2e2d6b368e1235efd78cb333984235b43dc24eb8017d34ab4133da6a3d140dd6f09c5093989f88bd43d69e595b04b60bf74b21f9586486"} 23:17:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:17:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:17:13 INFO - Contents: 23:17:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bea24826391ca8f623cc72740ab16a61a4400013e7c61e6738f56abd7620f658bcf94554e88b0f3da67b41c98f91fd4ca8dbd95cb7bebcd66ed4660c0a31760a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a8797d49f4fdc6c2d2e2d6b368e1235efd78cb333984235b43dc24eb8017d34ab4133da6a3d140dd6f09c5093989f88bd43d69e595b04b60bf74b21f9586486"} 23:17:13 INFO - Running post-run listener: copy_logs_to_upload_dir 23:17:13 INFO - Copying logs to upload dir... 23:17:13 INFO - mkdir: /builds/slave/test/build/upload/logs 23:17:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.102012 ========= master_lag: 3.36 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-13 23:17:16.787419) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:17:16.791152) ========= 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.ydIw0HTYoO/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.x72627Ar3P/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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/bea24826391ca8f623cc72740ab16a61a4400013e7c61e6738f56abd7620f658bcf94554e88b0f3da67b41c98f91fd4ca8dbd95cb7bebcd66ed4660c0a31760a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a8797d49f4fdc6c2d2e2d6b368e1235efd78cb333984235b43dc24eb8017d34ab4133da6a3d140dd6f09c5093989f88bd43d69e595b04b60bf74b21f9586486"} build_url:https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011634 build_url: 'https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bea24826391ca8f623cc72740ab16a61a4400013e7c61e6738f56abd7620f658bcf94554e88b0f3da67b41c98f91fd4ca8dbd95cb7bebcd66ed4660c0a31760a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a8797d49f4fdc6c2d2e2d6b368e1235efd78cb333984235b43dc24eb8017d34ab4133da6a3d140dd6f09c5093989f88bd43d69e595b04b60bf74b21f9586486"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:17:16.831419) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:17:16.831758) ========= 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.ydIw0HTYoO/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.x72627Ar3P/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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.005247 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:17:16.881657) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:17:16.881981) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:17:16.882298) ========= ========= Total master_lag: 3.51 =========