builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0040 starttime: 1461152243.65 results: success (0) buildid: 20160420024742 builduid: 8df05eb3aeee4b2bba7799e3f25fde79 revision: 973dfa15822126c39ea2d98d34ac16643b040243 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 04:37:23.652272) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 04:37:23.652796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 04:37:23.653118) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 04:37:23.674093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:37:23.674505) ========= 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.MSipSu3pk2/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.8zAvwKHD4B/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-20 04:37:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 152M=0s 2016-04-20 04:37:23 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142201 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:37:23.834206) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:37:23.834522) ========= 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.MSipSu3pk2/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.8zAvwKHD4B/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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.028769 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:37:23.882423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-20 04:37:23.882844) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 973dfa15822126c39ea2d98d34ac16643b040243 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 973dfa15822126c39ea2d98d34ac16643b040243 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MSipSu3pk2/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.8zAvwKHD4B/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-20 04:37:23,999 truncating revision to first 12 chars 2016-04-20 04:37:24,000 Setting DEBUG logging. 2016-04-20 04:37:24,000 attempt 1/10 2016-04-20 04:37:24,000 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/973dfa158221?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 04:37:25,276 unpacking tar archive at: mozilla-central-973dfa158221/testing/mozharness/ program finished with exit code 0 elapsedTime=1.527057 ========= master_lag: 2.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-20 04:37:27.430423) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 04:37:27.436583) ========= script_repo_revision: 973dfa15822126c39ea2d98d34ac16643b040243 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 04:37:27.437047) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 04:37:27.437420) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 04:37:27.469553) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-20 04:37:27.469882) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MSipSu3pk2/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.8zAvwKHD4B/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:37:27 INFO - MultiFileLogger online at 20160420 04:37:27 in /builds/slave/test 04:37:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:37:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:37:27 INFO - {'append_to_log': False, 04:37:27 INFO - 'base_work_dir': '/builds/slave/test', 04:37:27 INFO - 'blob_upload_branch': 'Firefox', 04:37:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:37:27 INFO - 'branch': 'Firefox', 04:37:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:37:27 INFO - 'config_files': ('talos/mac_config.py',), 04:37:27 INFO - 'default_actions': ('clobber', 04:37:27 INFO - 'read-buildbot-config', 04:37:27 INFO - 'download-and-extract', 04:37:27 INFO - 'populate-webroot', 04:37:27 INFO - 'create-virtualenv', 04:37:27 INFO - 'install', 04:37:27 INFO - 'run-tests'), 04:37:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:37:27 INFO - 'download_minidump_stackwalk': True, 04:37:27 INFO - 'download_symbols': 'ondemand', 04:37:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:37:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:37:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:37:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:37:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:37:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:37:27 INFO - 'installer_path': 'installer.exe', 04:37:27 INFO - 'log_level': 'info', 04:37:27 INFO - 'log_name': 'talos', 04:37:27 INFO - 'log_to_console': True, 04:37:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:37:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:37:27 INFO - 'opt_config_files': (), 04:37:27 INFO - 'pip_index': False, 04:37:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:37:27 INFO - 'cmd': ('bash', 04:37:27 INFO - '-c', 04:37:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:37:27 INFO - 'enabled': True, 04:37:27 INFO - 'halt_on_failure': False, 04:37:27 INFO - 'name': 'check_screen_resolution'},), 04:37:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:37:27 INFO - 'cmd': ('bash', 04:37:27 INFO - '-c', 04:37:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:37:27 INFO - 'enabled': True, 04:37:27 INFO - 'halt_on_failure': False, 04:37:27 INFO - 'name': 'check_screen_resolution'},), 04:37:27 INFO - 'run_cmd_checks_enabled': True, 04:37:27 INFO - 'sps_profile': False, 04:37:27 INFO - 'sps_profile_interval': 0, 04:37:27 INFO - 'suite': 'dromaeojs-e10s', 04:37:27 INFO - 'system_bits': '32', 04:37:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:37:27 INFO - 'title': 't-yosemite-r7-0040', 04:37:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:37:27 INFO - 'use_talos_json': True, 04:37:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:37:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:37:27 INFO - 'work_dir': 'build'} 04:37:27 INFO - ##### 04:37:27 INFO - ##### Running clobber step. 04:37:27 INFO - ##### 04:37:27 INFO - Running pre-action listener: _resource_record_pre_action 04:37:27 INFO - Running main action method: clobber 04:37:27 INFO - rmtree: /builds/slave/test/build 04:37:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:37:29 INFO - Running post-action listener: _resource_record_post_action 04:37:29 INFO - ##### 04:37:29 INFO - ##### Running read-buildbot-config step. 04:37:29 INFO - ##### 04:37:29 INFO - Running pre-action listener: _resource_record_pre_action 04:37:29 INFO - Running main action method: read_buildbot_config 04:37:29 INFO - Using buildbot properties: 04:37:29 INFO - { 04:37:29 INFO - "project": "", 04:37:29 INFO - "product": "firefox", 04:37:29 INFO - "script_repo_revision": "production", 04:37:29 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:37:29 INFO - "repository": "", 04:37:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:37:29 INFO - "buildid": "20160420024742", 04:37:29 INFO - "pgo_build": "False", 04:37:29 INFO - "basedir": "/builds/slave/test", 04:37:29 INFO - "buildnumber": 245, 04:37:29 INFO - "slavename": "t-yosemite-r7-0040", 04:37:29 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:37:29 INFO - "platform": "yosemite_r7", 04:37:29 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:37:29 INFO - "branch": "mozilla-central", 04:37:29 INFO - "repo_path": "mozilla-central", 04:37:29 INFO - "revision": "973dfa15822126c39ea2d98d34ac16643b040243", 04:37:29 INFO - "stage_platform": "macosx64", 04:37:29 INFO - "builduid": "8df05eb3aeee4b2bba7799e3f25fde79", 04:37:29 INFO - "slavebuilddir": "test" 04:37:29 INFO - } 04:37:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:37:29 INFO - Running post-action listener: _resource_record_post_action 04:37:29 INFO - ##### 04:37:29 INFO - ##### Running download-and-extract step. 04:37:29 INFO - ##### 04:37:29 INFO - Running pre-action listener: _resource_record_pre_action 04:37:29 INFO - Running main action method: download_and_extract 04:37:29 INFO - mkdir: /builds/slave/test/build/tests 04:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:29 INFO - https://queue.taskcluster.net/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:37:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:37:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:37:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:37:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 04:37:30 INFO - Downloaded 1199 bytes. 04:37:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:37:30 INFO - Using the following test package requirements: 04:37:30 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:37:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:30 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:37:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:30 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:37:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:30 INFO - u'jsshell-mac.zip'], 04:37:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:30 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:37:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:37:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:30 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:37:30 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:30 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:37:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:30 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:37:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:30 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:37:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:30 INFO - https://queue.taskcluster.net/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:37:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:37:31 INFO - Downloaded 18095450 bytes. 04:37:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:37:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:37:35 INFO - Return code: 0 04:37:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:35 INFO - https://queue.taskcluster.net/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:37:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:37:36 INFO - Downloaded 18095450 bytes. 04:37:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:37:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:37:40 INFO - Return code: 0 04:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:40 INFO - https://queue.taskcluster.net/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:37:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:37:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:37:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:37:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:37:41 INFO - Downloaded 10845952 bytes. 04:37:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:37:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:37:41 INFO - Return code: 0 04:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:41 INFO - https://queue.taskcluster.net/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:37:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:37:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:37:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:37:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 04:37:44 INFO - Downloaded 110060395 bytes. 04:37:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:37:44 INFO - mkdir: /builds/slave/test/properties 04:37:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:37:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:37:44 INFO - Contents: 04:37:44 INFO - build_url:https://queue.taskcluster.net/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:37:45 INFO - Running post-action listener: _resource_record_post_action 04:37:45 INFO - Running post-action listener: set_extra_try_arguments 04:37:45 INFO - ##### 04:37:45 INFO - ##### Running populate-webroot step. 04:37:45 INFO - ##### 04:37:45 INFO - Running pre-action listener: _resource_record_pre_action 04:37:45 INFO - Running main action method: populate_webroot 04:37:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:37:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:37:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:37:45 INFO - '--tppagecycles', 04:37:45 INFO - '7'], 04:37:45 INFO - 'tests': ['tsvgm']}}, 04:37:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:37:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:37:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:37:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:37:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['damp', 'tps']}, 04:37:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'tests': ['damp', 'tps']}, 04:37:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['dromaeo_dom']}, 04:37:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:37:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other-e10s': {'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tsvgx', 04:37:45 INFO - 'tsvgr_opacity', 04:37:45 INFO - 'tart', 04:37:45 INFO - 'tscrollx', 04:37:45 INFO - 'cart']}, 04:37:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:37:45 INFO - 'tsvgr_opacity', 04:37:45 INFO - 'tart', 04:37:45 INFO - 'tscrollx', 04:37:45 INFO - 'cart']}, 04:37:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tp5o']}, 04:37:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'tests': ['tp5o']}, 04:37:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s', 04:37:45 INFO - '--xperf_path', 04:37:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:45 INFO - 'tests': ['tp5n']}, 04:37:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--xperf_path', 04:37:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:45 INFO - 'tests': ['tp5n']}}, 04:37:45 INFO - 'talos.zip': {'path': '', 04:37:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:37:45 INFO - Running post-action listener: _resource_record_post_action 04:37:45 INFO - ##### 04:37:45 INFO - ##### Running create-virtualenv step. 04:37:45 INFO - ##### 04:37:45 INFO - Running pre-action listener: _resource_record_pre_action 04:37:45 INFO - Running main action method: create_virtualenv 04:37:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:37:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:37:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:37:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:37:45 INFO - Using real prefix '/tools/python27' 04:37:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:37:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:37:49 INFO - Installing pip.................done. 04:37:49 INFO - Return code: 0 04:37:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:49 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 0x1064dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc7b4a2760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ee00>, '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 0x1061e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106379b20>, '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.MSipSu3pk2/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.8zAvwKHD4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MSipSu3pk2/Render', 04:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:49 INFO - 'HOME': '/Users/cltbld', 04:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:49 INFO - 'LOGNAME': 'cltbld', 04:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:49 INFO - 'MOZ_NO_REMOTE': '1', 04:37:49 INFO - 'NO_EM_RESTART': '1', 04:37:49 INFO - 'PAGER': '/bin/cat', 04:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:49 INFO - 'PWD': '/builds/slave/test', 04:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:49 INFO - 'SHELL': '/bin/bash', 04:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8zAvwKHD4B/Listeners', 04:37:49 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 04:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:49 INFO - 'USER': 'cltbld', 04:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:49 INFO - 'XPC_FLAGS': '0x0', 04:37:49 INFO - 'XPC_SERVICE_NAME': '0', 04:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:37:49 INFO - Cleaning up... 04:37:49 INFO - Return code: 0 04:37:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:49 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 0x1064dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc7b4a2760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ee00>, '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 0x1061e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106379b20>, '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.MSipSu3pk2/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.8zAvwKHD4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MSipSu3pk2/Render', 04:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:49 INFO - 'HOME': '/Users/cltbld', 04:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:49 INFO - 'LOGNAME': 'cltbld', 04:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:49 INFO - 'MOZ_NO_REMOTE': '1', 04:37:49 INFO - 'NO_EM_RESTART': '1', 04:37:49 INFO - 'PAGER': '/bin/cat', 04:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:49 INFO - 'PWD': '/builds/slave/test', 04:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:49 INFO - 'SHELL': '/bin/bash', 04:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8zAvwKHD4B/Listeners', 04:37:49 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 04:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:49 INFO - 'USER': 'cltbld', 04:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:49 INFO - 'XPC_FLAGS': '0x0', 04:37:49 INFO - 'XPC_SERVICE_NAME': '0', 04:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:50 INFO - Downloading/unpacking psutil>=0.7.1 04:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:37:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:52 INFO - Installing collected packages: psutil 04:37:52 INFO - Running setup.py install for psutil 04:37:52 INFO - building 'psutil._psutil_osx' extension 04:37:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:37:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:37:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:37:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:37:53 INFO - building 'psutil._psutil_posix' extension 04:37:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:37:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:37:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:37:53 INFO - ^ 04:37:53 INFO - 1 warning generated. 04:37:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:37:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:53 INFO - Successfully installed psutil 04:37:53 INFO - Cleaning up... 04:37:53 INFO - Return code: 0 04:37:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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', '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 0x1064dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc7b4a2760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ee00>, '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 0x1061e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106379b20>, '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.MSipSu3pk2/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.8zAvwKHD4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:37: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:37: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 mozsystemmonitor==0.0.0 04:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MSipSu3pk2/Render', 04:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:53 INFO - 'HOME': '/Users/cltbld', 04:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:53 INFO - 'LOGNAME': 'cltbld', 04:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:53 INFO - 'MOZ_NO_REMOTE': '1', 04:37:53 INFO - 'NO_EM_RESTART': '1', 04:37:53 INFO - 'PAGER': '/bin/cat', 04:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:53 INFO - 'PWD': '/builds/slave/test', 04:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:53 INFO - 'SHELL': '/bin/bash', 04:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8zAvwKHD4B/Listeners', 04:37:53 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 04:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:53 INFO - 'USER': 'cltbld', 04:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:53 INFO - 'XPC_FLAGS': '0x0', 04:37:53 INFO - 'XPC_SERVICE_NAME': '0', 04:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:37:56 INFO - Installing collected packages: mozsystemmonitor 04:37:56 INFO - Running setup.py install for mozsystemmonitor 04:37:56 INFO - Successfully installed mozsystemmonitor 04:37:56 INFO - Cleaning up... 04:37:56 INFO - Return code: 0 04:37:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:56 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 0x1064dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc7b4a2760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ee00>, '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 0x1061e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106379b20>, '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.MSipSu3pk2/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.8zAvwKHD4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:37:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MSipSu3pk2/Render', 04:37:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:56 INFO - 'HOME': '/Users/cltbld', 04:37:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:56 INFO - 'LOGNAME': 'cltbld', 04:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:56 INFO - 'MOZ_NO_REMOTE': '1', 04:37:56 INFO - 'NO_EM_RESTART': '1', 04:37:56 INFO - 'PAGER': '/bin/cat', 04:37:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:56 INFO - 'PWD': '/builds/slave/test', 04:37:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:56 INFO - 'SHELL': '/bin/bash', 04:37:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8zAvwKHD4B/Listeners', 04:37:56 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 04:37:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:56 INFO - 'USER': 'cltbld', 04:37:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:56 INFO - 'XPC_FLAGS': '0x0', 04:37:56 INFO - 'XPC_SERVICE_NAME': '0', 04:37:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:57 INFO - Downloading/unpacking blobuploader==1.2.4 04:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:59 INFO - Downloading blobuploader-1.2.4.tar.gz 04:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:37:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:38:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:00 INFO - Downloading docopt-0.6.1.tar.gz 04:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:38:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:38:00 INFO - Running setup.py install for blobuploader 04:38:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:38:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:38:01 INFO - Running setup.py install for requests 04:38:01 INFO - Running setup.py install for docopt 04:38:01 INFO - Successfully installed blobuploader requests docopt 04:38:01 INFO - Cleaning up... 04:38:01 INFO - Return code: 0 04:38:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:01 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 0x1064dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc7b4a2760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ee00>, '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 0x1061e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106379b20>, '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.MSipSu3pk2/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.8zAvwKHD4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:38:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MSipSu3pk2/Render', 04:38:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:01 INFO - 'HOME': '/Users/cltbld', 04:38:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:01 INFO - 'LOGNAME': 'cltbld', 04:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:01 INFO - 'MOZ_NO_REMOTE': '1', 04:38:01 INFO - 'NO_EM_RESTART': '1', 04:38:01 INFO - 'PAGER': '/bin/cat', 04:38:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:01 INFO - 'PWD': '/builds/slave/test', 04:38:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:01 INFO - 'SHELL': '/bin/bash', 04:38:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8zAvwKHD4B/Listeners', 04:38:01 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 04:38:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:01 INFO - 'USER': 'cltbld', 04:38:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:01 INFO - 'XPC_FLAGS': '0x0', 04:38:01 INFO - 'XPC_SERVICE_NAME': '0', 04:38:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:02 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-Yt4euk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:02 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-7D4df5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:02 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-_4Y3yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:02 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-AscODa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:02 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-GVwqmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:02 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-h_tWz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:02 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-pPsQ1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:02 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-wxO0X0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:02 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-i3GO9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:02 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-14DdZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:03 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-yVPMjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:03 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-LHv02y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:03 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-0VPqVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:03 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-YS_owC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:03 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-enJ8qV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:03 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-Cdv9aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:03 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-iJ5DTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:38:03 INFO - Running setup.py install for manifestparser 04:38:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:38:03 INFO - Running setup.py install for mozcrash 04:38:04 INFO - Running setup.py install for mozdebug 04:38:04 INFO - Running setup.py install for mozdevice 04:38:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:38:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:38:04 INFO - Running setup.py install for mozfile 04:38:04 INFO - Running setup.py install for mozhttpd 04:38:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:38:04 INFO - Running setup.py install for mozinfo 04:38:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:38:04 INFO - Running setup.py install for mozInstall 04:38:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:38:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:38:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:38:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:38:04 INFO - Running setup.py install for mozleak 04:38:05 INFO - Running setup.py install for mozlog 04:38:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Running setup.py install for moznetwork 04:38:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Running setup.py install for mozprocess 04:38:05 INFO - Running setup.py install for mozprofile 04:38:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Running setup.py install for mozrunner 04:38:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Running setup.py install for mozscreenshot 04:38:05 INFO - Running setup.py install for moztest 04:38:06 INFO - Running setup.py install for mozversion 04:38:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:38:06 INFO - Cleaning up... 04:38:06 INFO - Return code: 0 04:38:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:06 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 0x1064dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc7b4a2760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ee00>, '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 0x1061e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106379b20>, '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.MSipSu3pk2/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.8zAvwKHD4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:38:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MSipSu3pk2/Render', 04:38:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:06 INFO - 'HOME': '/Users/cltbld', 04:38:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:06 INFO - 'LOGNAME': 'cltbld', 04:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:06 INFO - 'MOZ_NO_REMOTE': '1', 04:38:06 INFO - 'NO_EM_RESTART': '1', 04:38:06 INFO - 'PAGER': '/bin/cat', 04:38:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:06 INFO - 'PWD': '/builds/slave/test', 04:38:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:06 INFO - 'SHELL': '/bin/bash', 04:38:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8zAvwKHD4B/Listeners', 04:38:06 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 04:38:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:06 INFO - 'USER': 'cltbld', 04:38:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:06 INFO - 'XPC_FLAGS': '0x0', 04:38:06 INFO - 'XPC_SERVICE_NAME': '0', 04:38:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:06 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-Eq9RdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:06 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-jfTrEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:06 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-huCA3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:06 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-SBlkJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:07 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-YBg52A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:07 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-Rsb_ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:07 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-YwXEzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:07 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-90TUSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:07 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-x2RrJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:07 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-0kzQVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:07 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-u44O1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:07 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-Yxv9rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:07 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-mlSIRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:07 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-OCnSiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:08 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-vkkpI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:08 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-qaoFO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:08 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-vsN31X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:38:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:10 INFO - Downloading blessings-1.6.tar.gz 04:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:38:10 INFO - Installing collected packages: blessings 04:38:10 INFO - Running setup.py install for blessings 04:38:10 INFO - Successfully installed blessings 04:38:10 INFO - Cleaning up... 04:38:11 INFO - Return code: 0 04:38:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:11 INFO - Reading from file tmpfile_stdout 04:38:11 INFO - Current package versions: 04:38:11 INFO - blessings == 1.6 04:38:11 INFO - blobuploader == 1.2.4 04:38:11 INFO - docopt == 0.6.1 04:38:11 INFO - manifestparser == 1.1 04:38:11 INFO - mozInstall == 1.12 04:38:11 INFO - mozcrash == 0.17 04:38:11 INFO - mozdebug == 0.1 04:38:11 INFO - mozdevice == 0.48 04:38:11 INFO - mozfile == 1.2 04:38:11 INFO - mozhttpd == 0.7 04:38:11 INFO - mozinfo == 0.9 04:38:11 INFO - mozleak == 0.1 04:38:11 INFO - mozlog == 3.1 04:38:11 INFO - moznetwork == 0.27 04:38:11 INFO - mozprocess == 0.22 04:38:11 INFO - mozprofile == 0.28 04:38:11 INFO - mozrunner == 6.11 04:38:11 INFO - mozscreenshot == 0.1 04:38:11 INFO - mozsystemmonitor == 0.0 04:38:11 INFO - moztest == 0.7 04:38:11 INFO - mozversion == 1.4 04:38:11 INFO - psutil == 3.1.1 04:38:11 INFO - requests == 1.2.3 04:38:11 INFO - wsgiref == 0.1.2 04:38:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:11 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 0x1064dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc7b4a2760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ee00>, '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 0x1061e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106379b20>, '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.MSipSu3pk2/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.8zAvwKHD4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:38:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MSipSu3pk2/Render', 04:38:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:11 INFO - 'HOME': '/Users/cltbld', 04:38:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:11 INFO - 'LOGNAME': 'cltbld', 04:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:11 INFO - 'MOZ_NO_REMOTE': '1', 04:38:11 INFO - 'NO_EM_RESTART': '1', 04:38:11 INFO - 'PAGER': '/bin/cat', 04:38:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:11 INFO - 'PWD': '/builds/slave/test', 04:38:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:11 INFO - 'SHELL': '/bin/bash', 04:38:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8zAvwKHD4B/Listeners', 04:38:11 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 04:38:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:11 INFO - 'USER': 'cltbld', 04:38:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:11 INFO - 'XPC_FLAGS': '0x0', 04:38:11 INFO - 'XPC_SERVICE_NAME': '0', 04:38:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:38:11 INFO - Cleaning up... 04:38:11 INFO - Return code: 0 04:38:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc7b4a2760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ee00>, '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 0x1061e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106379b20>, '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.MSipSu3pk2/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.8zAvwKHD4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38: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', 'jsonschema'] in /builds/slave/test/build 04:38: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 jsonschema 04:38:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MSipSu3pk2/Render', 04:38:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:12 INFO - 'HOME': '/Users/cltbld', 04:38:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:12 INFO - 'LOGNAME': 'cltbld', 04:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:12 INFO - 'MOZ_NO_REMOTE': '1', 04:38:12 INFO - 'NO_EM_RESTART': '1', 04:38:12 INFO - 'PAGER': '/bin/cat', 04:38:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:12 INFO - 'PWD': '/builds/slave/test', 04:38:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:12 INFO - 'SHELL': '/bin/bash', 04:38:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8zAvwKHD4B/Listeners', 04:38:12 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 04:38:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:12 INFO - 'USER': 'cltbld', 04:38:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:12 INFO - 'XPC_FLAGS': '0x0', 04:38:12 INFO - 'XPC_SERVICE_NAME': '0', 04:38:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:12 INFO - Downloading/unpacking jsonschema 04:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:38:15 INFO - Downloading/unpacking functools32 (from jsonschema) 04:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:15 INFO - Downloading functools32-3.2.3-2.tar.gz 04:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:38:15 INFO - warning: no files found matching '*.txt' 04:38:15 INFO - no previously-included directories found matching 'build' 04:38:15 INFO - no previously-included directories found matching 'dist' 04:38:15 INFO - no previously-included directories found matching '.git*' 04:38:15 INFO - Installing collected packages: jsonschema, functools32 04:38:15 INFO - Running setup.py install for functools32 04:38:16 INFO - warning: no files found matching '*.txt' 04:38:16 INFO - no previously-included directories found matching 'build' 04:38:16 INFO - no previously-included directories found matching 'dist' 04:38:16 INFO - no previously-included directories found matching '.git*' 04:38:16 INFO - Successfully installed jsonschema functools32 04:38:16 INFO - Cleaning up... 04:38:16 INFO - Return code: 0 04:38:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:16 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 0x1064dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc7b4a2760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ee00>, '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 0x1061e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106379b20>, '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.MSipSu3pk2/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.8zAvwKHD4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:38:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MSipSu3pk2/Render', 04:38:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:16 INFO - 'HOME': '/Users/cltbld', 04:38:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:16 INFO - 'LOGNAME': 'cltbld', 04:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:16 INFO - 'MOZ_NO_REMOTE': '1', 04:38:16 INFO - 'NO_EM_RESTART': '1', 04:38:16 INFO - 'PAGER': '/bin/cat', 04:38:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:16 INFO - 'PWD': '/builds/slave/test', 04:38:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:16 INFO - 'SHELL': '/bin/bash', 04:38:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8zAvwKHD4B/Listeners', 04:38:16 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 04:38:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:16 INFO - 'USER': 'cltbld', 04:38:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:16 INFO - 'XPC_FLAGS': '0x0', 04:38:16 INFO - 'XPC_SERVICE_NAME': '0', 04:38:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:16 INFO - Downloading/unpacking flake8 04:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:38:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:38:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:38:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:20 INFO - no previously-included directories found matching 'docs/_build' 04:38:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:38:20 INFO - Running setup.py install for pep8 04:38:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:20 INFO - no previously-included directories found matching 'docs/_build' 04:38:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:38:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:38:20 INFO - Cleaning up... 04:38:20 INFO - Return code: 0 04:38:20 INFO - Running post-action listener: _resource_record_post_action 04:38:20 INFO - Running post-action listener: _start_resource_monitoring 04:38:20 INFO - Starting resource monitoring. 04:38:20 INFO - ##### 04:38:20 INFO - ##### Running install step. 04:38:20 INFO - ##### 04:38:20 INFO - Running pre-action listener: _resource_record_pre_action 04:38:20 INFO - Running main action method: install 04:38:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:20 INFO - Reading from file tmpfile_stdout 04:38:20 INFO - Detecting whether we're running mozinstall >=1.0... 04:38:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:38:20 INFO - Reading from file tmpfile_stdout 04:38:20 INFO - Output received: 04:38:20 INFO - Usage: mozinstall [options] installer 04:38:20 INFO - Options: 04:38:20 INFO - -h, --help show this help message and exit 04:38:20 INFO - -d DEST, --destination=DEST 04:38:20 INFO - Directory to install application into. [default: 04:38:20 INFO - "/builds/slave/test"] 04:38:20 INFO - --app=APP Application being installed. [default: firefox] 04:38:20 INFO - mkdir: /builds/slave/test/build/application 04:38:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:38:54 INFO - Reading from file tmpfile_stdout 04:38:54 INFO - Output received: 04:38:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:38:54 INFO - Running post-action listener: _resource_record_post_action 04:38:54 INFO - ##### 04:38:54 INFO - ##### Running run-tests step. 04:38:54 INFO - ##### 04:38:54 INFO - Running pre-action listener: _resource_record_pre_action 04:38:54 INFO - Running main action method: run_tests 04:38:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:38:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:38:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:38:54 INFO - 2016-04-20 04:38:54.386 screenresolution[1648:7562] starting screenresolution argv=screenresolution get 04:38:54 INFO - 2016-04-20 04:38:54.389 screenresolution[1648:7562] Display 0: 1600x1200x32@60 04:38:54 INFO - 2016-04-20 04:38:54.394 screenresolution[1649:7564] starting screenresolution argv=screenresolution list 04:38:54 INFO - Available Modes on Display 0 04:38:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:38:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:38:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:38:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:38:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:38:54 INFO - Intel Iris: 04:38:54 INFO - Chipset Model: Intel Iris 04:38:54 INFO - Type: GPU 04:38:54 INFO - Bus: Built-In 04:38:54 INFO - VRAM (Dynamic, Max): 1536 MB 04:38:54 INFO - Vendor: Intel (0x8086) 04:38:54 INFO - Device ID: 0x0a2e 04:38:54 INFO - Revision ID: 0x0009 04:38:54 INFO - Displays: 04:38:54 INFO - Display: 04:38:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:38:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:38:54 INFO - Display Serial Number: 1600x1200 60 04:38:54 INFO - Main Display: Yes 04:38:54 INFO - Mirror: Off 04:38:54 INFO - Online: Yes 04:38:54 INFO - Rotation: Supported 04:38:54 INFO - Return code: 0 04:38:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:38:54 INFO - Python 2.7.3 04:38:54 INFO - Return code: 0 04:38:54 INFO - grabbing minidump binary from tooltool 04:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:54 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 0x10637ee00>, '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 0x1061e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106379b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:38:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:38:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:38:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:38:54 INFO - Return code: 0 04:38:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:38:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:38:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:38:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:38:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:38:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:38:55 INFO - Return code: 0 04:38:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:38:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MSipSu3pk2/Render', 04:38:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:55 INFO - 'HOME': '/Users/cltbld', 04:38:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:55 INFO - 'LOGNAME': 'cltbld', 04:38:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:38:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:55 INFO - 'MOZ_NO_REMOTE': '1', 04:38:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:38:55 INFO - 'NO_EM_RESTART': '1', 04:38:55 INFO - 'PAGER': '/bin/cat', 04:38:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:55 INFO - 'PWD': '/builds/slave/test', 04:38:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:38:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:55 INFO - 'SHELL': '/bin/bash', 04:38:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8zAvwKHD4B/Listeners', 04:38:55 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 04:38:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:55 INFO - 'USER': 'cltbld', 04:38:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:55 INFO - 'XPC_FLAGS': '0x0', 04:38:55 INFO - 'XPC_SERVICE_NAME': '0', 04:38:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:38:56 INFO - mozversion application_buildid: 20160420024742 04:38:56 INFO - mozversion application_changeset: 973dfa15822126c39ea2d98d34ac16643b040243 04:38:56 INFO - mozversion application_display_name: Nightly 04:38:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:38:56 INFO - mozversion application_name: Firefox 04:38:56 INFO - mozversion application_remotingname: firefox 04:38:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:38:56 INFO - mozversion application_vendor: Mozilla 04:38:56 INFO - mozversion application_version: 48.0a1 04:38:56 INFO - mozversion platform_buildid: 20160420024742 04:38:56 INFO - mozversion platform_changeset: 973dfa15822126c39ea2d98d34ac16643b040243 04:38:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:38:56 INFO - mozversion platform_version: 48.0a1 04:38:56 INFO - using testdate: 1461152336 04:38:56 INFO - actual date: 1461152336 04:38:56 INFO - starting webserver on 'localhost:49271' 04:38:56 INFO - SUITE-START | Running 2 tests 04:38:56 INFO - TEST-START | dromaeo_css 04:38:56 INFO - operating with platform_type : mac_ 04:38:56 INFO - Initialising browser for dromaeo_css test... 04:38:56 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmp4uWzGF/profile http://localhost:49271/getInfo.html) 04:38:59 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 04:38:59 INFO - PROCESS | 1667 | colorDepth:24 04:38:59 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 04:38:59 INFO - PROCESS | 1667 | __metrics 04:38:59 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:38:59 INFO - TEST-INFO | 1667: exit 0 04:38:59 INFO - Browser initialized. 04:38:59 INFO - Running cycle 1/1 for dromaeo_css test... 04:38:59 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmp4uWzGF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:11 INFO - PROCESS | 1670 | RSS: Main: 247779328 04:39:11 INFO - PROCESS | 1670 | 04:40:01 INFO - PROCESS | 1670 | 1461152401296 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:42:12 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 04:42:13 INFO - PROCESS | 1670 | RSS: Main: 259702784 04:42:13 INFO - PROCESS | 1670 | 04:45:16 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 04:45:16 INFO - PROCESS | 1670 | RSS: Main: 271634432 04:45:16 INFO - PROCESS | 1670 | 04:48:18 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 04:48:19 INFO - PROCESS | 1670 | RSS: Main: 273723392 04:48:19 INFO - PROCESS | 1670 | 04:51:20 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 04:51:21 INFO - PROCESS | 1670 | RSS: Main: 275226624 04:51:21 INFO - PROCESS | 1670 | 04:54:24 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 04:54:24 INFO - PROCESS | 1670 | RSS: Main: 278151168 04:54:24 INFO - PROCESS | 1670 | 04:57:27 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 04:57:27 INFO - PROCESS | 1670 | RSS: Main: 279400448 04:57:27 INFO - PROCESS | 1670 | 04:57:27 INFO - PROCESS | 1670 | __start_tp_report 04:57:27 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 04:57:27 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 04:57:27 INFO - PROCESS | 1670 | |i|pagename|runs| 04:57:27 INFO - PROCESS | 1670 | |0;dojo.html;2667.599860020997;3440.8967730968066;3449.8447569859354;3500.264944361684;3524.8942531724056;4951.282064100703;5174.990876779025;5741.16753070805;5751.079827227644;5793.2179155814;5635.830925072254;5757.625754325976;5761.279840019997;5799.18811366409;5881.85295367616;5096.796128154888;5112.590992720592;5197.636165468419;5206.21906713994;5236.162214045753;4283.764392958386;5228.973855130719;5242.501962313574;5244.895102097956;5313.1764576490705;5090.854557724501;5189.896202075937;5198.454162312978;5205.505476979681;5216.426193118754;5157.329547158883;5158.896822063575;5185.092608793484;5189.2475591039465;5241.344831896013;5016.799328026875;5148.897022059537;5164.690118592896;5167.992241512907;5206.427292997805;5502.58730595207;5533.391326954032;5576.386597474275;5626.831195064114;5647.689377084259;6158.538109641795;6187.690615469253;6213.627182369072;6223.844403889893;6229.1590635264565;6144.341027922436;6172.9074063889075;6209.285932117819;6213.751449941997;6240.063990401431;5867.618604790675;5877.617954832922;5877.970610146965;5903;5910.34986151523;6238.563300569007;6296.779612713624;6304.211973503312;6308.211473565804;6318.494520438354;6068.817935461855;6099.400579572073;6147.170132032208;6151.569390142647;6164.599301045418;6119.694015299217;6168.383161683885;6170.382961703794;6188;6200.3799620038535;6067.150598916155;6108.068892179526;6131.96934015336;6188.1027251049245;6190.969045154746;6098.613770999311;6120.355709576858;6155.169052177988;6163.1679723237685;6174.5060395168275;4934.827281045146;4943.110240156806;4954.603631709455;4969.726665033386;4986.4514903360605;4424.535423780457;4439.778011099432;4460.888477788081;4493.910121797611;4518.88702782433;5731.598788084877;5804.332501762267;5928.962431574457;5978.55160862937;6001.399860013964;5116.258142569381;5432.348118225838;6028.608140470856;6164.6917654117115;6219.129321894939;5736.311642602831;5895.4399332063385;5906.379830117776;5950.345461999176;5953.166556682068;4628;5378.435264297271;5430.728463576806;5478.096114141202;5489.149181876815;6378.52161087911;6416.165898433173;6426.646534440557;6431.903521447182;6445.097686324012;5340.2256672783005;6171.321154672893;6186.443220110212;6227.377262273918;6263.78076767311;5243.737813109406;6227.906581401373;6314.273858506147;6400.135981642418;6426.132472116205;6093.634381937098;6149.926310793524;6155.846103847261;6170.660613666291;6184.6598437086395;6203.131561581473;6211.2857021441305;6237.251529816451;6268;6270.310265870659;5085.5931525477135;5947.137665038459;6001.099835024781;6062.575619706755;6099.359567245553;6117;6170.012797952306;6200.627962322275;6208.2239720034995;6216.968915155395;5897.970510147422;5956.5532585055425;6021.488173505126;6083.391660833881;6114.082887566723;6072.939270607238;6115.480184184395;6125.632272693401;6169.2288463942;6223.066540019034;6035.486983606443;6075.28108842996;6085.513158947185;6096.1465394845645;6099.634021958696 04:57:27 INFO - PROCESS | 1670 | |1;ext.html;498.5836826250081;517.9611529135315;541.3503795445466;569.0667305618784;585.1486087742335;30589.541156882664;39671;39771.602283977154;39788.60211397885;39841.203175936535;40700.389494157615;41018.38472422909;41094;41765.79117104418;42065;9365.250779937624;9584.137427631511;9591.808163836718;9599.712008639752;9639.566219520104;9410.294227932898;9529.332946693734;9549.665761698341;9563.378380405285;9577.042295770401;9540.427574345562;9621.230301575857;9621.422714637145;9646.035396460367;9652;9535.71392858212;9574.425534467884;9576.186024187882;9577.616895324214;9607.759806004837;9337.71986840396;9453.196478299353;9468.905310946871;9495.05049495052;9534.761630959212;38373.80813095945;38772.80613596914;38796;38806.61193388058;38809.61190388088;2551.889927881359;2722.3466368071718;3159.225989632555;3594.982025089884;3958.039799459303;22621.77378226213;26917.461650766876;27649.585256221173;28154.436911261866;28249.293767655767;2603.2971097803675;2654.4027593791434;2663.4806212788512;2744.794140439475;2748.2991837081418;366695;372451;372546;373083;374827.12586437166;33587;33801.8169364076;34229.315413691584;34828;35743.28513429717;34720;34898;35014.47478287828;35074.82462587722;35088;14588.197649129399;14820.481283155037;14832.184229867245;14833.035852669542;14852;9945.15466185368;10796.730081747863;11815.468303926344;12176.695582610506;12607.432665530074;7891.368690504861;8015.839683206304;8025.117237103914;8077.838443231102;8176.305014073751;3356.043527594624;3391.1352605085544;3403.2172600301574;3407.3526030054704;3471.6181220065773;918.150710592699;970.5147426286857;971.5288085278635;1054.3779170289565;1132.4111462039693;28221.871125154765;29583.26041848971;29704;29877;30743.692563074084;1072.780080083581;1140.156284349592;1145.438735019851;1151.4933429291252;1162.2793867801847;15336;15340.309686064154;15706.293216805272;15841.603959901095;15977.440789572309;635343;662853;788491;789961;791911;52244.95510089777;56274.43725562692;58694.11958820621;59468;60697.99999999912;1258.150748244931;1300.7593595184921;1482.7034593081428;1489.106536078366;1498.8126484189477;24501.039916806258;28371.43257134887;29522.81908723627;30219.546706799854;30656.693433065382;40095;41657.95855103646;51991;53005.46994530005;55679;595482;597926;598358;599328;600196;27313.590296145972;27616;27714.722852771214;27726.168214953585;41723;42701.78649106859;43141.352879707454;43424.91437713956;43944.78027609841;44442.111262767816;35949.28101437904;36981.81509092437;37079.814600926824;37789.05527361838;38015;36574.074074074546;36650.26699466049;36670.8166459166;37330;37814.810925945196;30998.070057898298;37410.81294593619;37501;37798.677046303244;39348.80325598468;30005;31154.532682009336;31379.05862824119;31718.04845854628;31777.68222317747;19309;24622.935478411473;24675.629865551673;24757.381065473506;24809.751902480744 04:57:27 INFO - PROCESS | 1670 | |2;jquery.html;391.74928046050525;394.1820722001845;395.9148783011653;397.334464771508;399.9460072890159;13537.323133843292;19467.513312167186;20120.69818952715;20234;20242.291519796792;18042.729359059624;19986.70019949702;20172.798272017277;21619.810910399923;21691;5881.8823623527505;5937.346891841894;6114.480269177103;6127.111568822518;6141.14024036633;6003.0695242237525;6028.4574388305045;6058.787942422016;6059.909101363483;6072.149899014142;5721.971390143043;5978.2228310319815;6055.848603784896;6060.454559089681;6067.877442673098;5860.736266868002;5934.614250073774;6033.185519954815;6038.788642397517;6047.42549457803;5195.896082078375;5229.712365819878;5261.105612045923;5269.341332333458;5273.1035723927025;20599.176032958665;25153.119640812485;25764.969401223927;25800.74199258021;26627.934882604673;2116.7552383466464;2138.689889965962;2338.941526461835;2454.914078007261;2489.7759201671756;14823.18472484013;15086.24568771568;15100.848991510054;15332.926695131346;15472;1551.4880089570415;1724.9137543122793;1744.3371518822894;1753.465193116099;1788.3919467381022;114706;118530;118710;119235.4038229812;120042;10929.56281748721;11055.11559075272;11134;11202.159838012181;11206.719832004264;13909.304534773422;14003;14153.575392738234;14160.221187834562;14177.78733319001;8656.826863462822;8693.391462597683;8707.346948978851;8710.346723995726;8717.607707653044;8696.478211307342;8698.869516957251;8796.384253102222;8812.07473215316;8821.161989610977;6677.432418244406;6727.428168605723;6800.727970881109;6807.319268073153;6816.352446517573;1851.6574433729802;1878.8402985746366;1883.6138591588692;1884.0956340956143;1889.0649128681391;976.6386437018349;979.118793086228;995.9651412200539;1036.3729943384144;1092.82514797632;21296.467588310417;21758.02088906003;21818.89090554569;21843.890780545997;22025.779742202372;859.7420773767844;963.1668606655193;973.2360097323567;984.9310548261697;996.3573495095623;9471.242300616072;11468.667069812576;11506.827397589042;11526.020288275422;11570.247933884271;563711;567310;572124;589355;601402;114365;115145;116716.41641791737;118042.40978795051;123345.76654233343;1016.4612755239734;1043.838205078214;1051.4322265976286;1066.8506409102731;1066.898644628759;13974.720505589628;15026.774598381251;19043.809561904203;19152.61694766125;19171;48985.265221021;50138.997220056124;50838.491615083374;50867.74566127294;51621;64953.35046649473;66959;67338;67811.66094169498;71460;6483.902741458787;7785.532868027936;7826.2173782621285;8160.939077919832;8234.547099909563;11261.211715180187;12449.93775031119;12743.323901980688;12777.16948398351;12826.935865320615;5370.650907690988;9222.40054396462;9360.578773955325;10753.341131380566;10943.83584246253;8996.422218224743;10665.786684266426;11030.393328366696;11190.048845848194;11198.44007799623;10912.96326848948;10970.945145274223;11199.72000699989;11457.140714446616;11465.828012579985;7893.407994400328;7900.68397264103;7978.720744773905;8014.639341229542;8252.546109963769;6688.464922806261;9415.85876211871;10485.423301718174;10677.14582833387;10701.090407315465 04:57:27 INFO - PROCESS | 1670 | |3;mootools.html;1398.8391334996475;1578.0689393257976;1800.7568978187949;1940.6700860853662;1948.8733232339905;7679.616019199046;7862.135165131831;8417.242448179662;8638.956805215965;8643.524606146659;7078.858422831553;8455.154484551542;8570.871436928435;8582.656693732244;8596.570171491416;2384.8211384146216;2398.712154541449;2398.95202095958;2403.3631087761755;2404.483036147228;2396.8442051266697;2414.3722632115687;2440.731519532859;2444.9022039118504;2452.705675318964;2420.7337192908767;2423.3456966619;2423.9272821815284;2440;2440.9633855492184;1874.4564076417823;2207.6357401028813;2221.7889300516426;2236.3402796175087;2239.395363251913;2018.414659748671;2056.187805816694;2282.372347604422;2288.805451536605;2300.033985725999;8605.096464871162;8608.053114157437;8660.956695216484;8678.435901666435;8680.045195028542;5053.545180933696;5253.448387919251;5262;5267.209918512215;5294.867628309285;2900.8152173913004;3414.095264754842;3518.3491054155065;3555.4489054196642;3582.946255806165;1043.4417586591137;1044.9529771160317;1057.5611121384616;1058.1006144776954;1060.2790102730141;11263.831042534368;11272;11289.830652540219;11329.490172942238;11334.43327833605;3725.869594564177;4607.193741095295;4753.239481682983;4767.189577771787;4775.594074503706;9632.75918102053;9642.662506812228;9651.034896510433;9693.273004524688;9695.90304096964;4250.681198910094;5150.330457040561;5214.765335559909;5248.7900483980975;5264.289320941624;4330.437043184366;4690.718556886598;4802.759862006886;4832.589229915427;4880.633952453509;3877.515310586177;3967.2263908538134;4000.299947509174;4011.538673052578;4096.569860164699;1125.4429057616533;1324.708564115893;1328.548293580168;1334.1794796200268;1354.593621913422;751.9398448124136;833.3416600885233;887.9644814207488;904.8687940248759;922.9492377919145;5023.447420783711;5477.808276710376;5500.972495137578;5613.887722245532;5685.829425117253;934.8550974598948;941.4325148627458;963.2342287881012;970.8883478399933;977.9584742249482;3405.1997780521556;3622.1487950331652;3650.1239702471216;3702.9444558331647;3738.43923411485;10323.380597164194;10577.995090466393;10716;10745.892541074645;10785.62250321235;8940.642374304955;10627.415492147851;10713.35719856811;10735.463226838783;10764.40795756241;6516.511261655395;7549.773506794805;8261.008678958444;8297.294729948022;8300.875486867702;5576.052071147834;5615.129654903497;5702.743376548148;5736.110902810071;5752.798652047159;9597.040295970348;9618.903810961801;9737.610495580097;9739.902600974183;9820.950895245478;8443.95778021106;9551.856722149034;9707.805843883225;10049.894511603863;10156.949215253877;6778.017187507882;7058;7199.568025918462;7353.411727061929;7363.374113200223;7960.681572737026;7977.282044616012;7980.201979802206;8067.515949043076;8077.798055048671;7061.929380706127;7189.317014883578;7210.351068403869;7303.196648368781;7323.194448610755;7013.368796808311;7028.332308430691;7096.53872498286;7206.351428371472;7206.927930720625;6686.699098540675;6835.384815366641;6900.206476255295;6930.48021398387;6930.8613827724175;4456.732596044248;4632.397788287636;4648.907021859612;4677.602403795716;4717.57541821224;4655.674102812906;4719.268513380432;4722.976385118052;4724.055188962153;4789.018251258414 04:57:27 INFO - PROCESS | 1670 | |4;prototype.html;325.33469055780927;326.4238618837752;333.43482796659674;335.0952428443204;337.33713253456955;6271.1847459830215;6376.713047912844;6398.744050237997;6448.258450278219;6450.258220304672;5217.947820521794;5674.943250567503;6033.7284822183;6127.816165515031;6258.812235632927;3773.490578771858;3961.227560625679;4571.542845715435;4644.744539050351;4661.394018777554;3916.4321173429835;4250.61744443;4581.862544123682;4657.464391594959;4664.463586687541;4545.681802273825;4588.334691469735;4598.356230127785;4628.675992680513;4631.189541830183;4054.9999999999854;4423.955760442386;4635.281531362644;4646.094011667727;4667.836625718083;3981.3430783920617;3999.440078389028;4007.338789099795;4014.7992600369867;4018.7990600470152;5525.867197224599;5736.7665951820145;5764;6001.639901605918;6019.608725432833;4975.41769925653;5170.767315470813;5491.697956612385;5514.696691681956;5517.779288828442;6644.468442524587;6674.866502669919;6677.465802735769;6678.198616166092;6698.210779292829;4188.560201178862;4350.8042138103865;4475.2168370535355;4494.460664720222;4515.977420112911;6110.725017374229;6616.842052640769;7014.281501032228;7031.7538886139255;7050.753223637199;3434.10713214566;3898.473706049647;4178.603032711888;4331.566843315643;4591.127685739699;4066.369712694537;4221.944513871532;4677.158111539956;4692.859214223578;4706.599939005223;4700.224462963641;4712.929306060412;4838.443578988391;4897.583705385082;5007.823161557031;6729.932700673028;6743;6765.188177418741;6793.320667933167;6839.179298484214;1200.9399530023463;1265.7531781302741;1508;1529.243024702757;1539.6458814472735;820.3806126374549;984.867042949207;996.3225006995312;1009.8939611340851;1011.716719318592;6160.1375807387;6232.594881332699;6252.374762523802;6268.247810262797;6316.526260530479;5806.44838740319;6645.472462390245;6896.344847239504;6899.310068993161;6948.235694073648;5461.890762184734;6153.29237137726;6222.191115155001;6234.2830574484515;6259.186305780219;2973.9553906691417;3378.6687185841693;3651.8174091295327;3663.4321680139087;3684.428913518409;5862.2447449698575;6318.684065796691;7323.974643549907;7350.595717235603;7371.520851144658;6064.48451881595;7175.46184036189;7185.712571497186;7211.350978411968;7270.200277969419;7054.964725176341;7340.632968351561;7344.200670835679;7368.594727289836;7424.703011879465;5603.831885043455;6168.537359697951;6984.917337812647;7016.403605693573;7044.823879403056;5637.43625637433;6580.374864387875;6710.429613482714;6875.862482750217;6910.928806035073;7270.382017528569;7320.377767889789;7321.63391830417;7328.2305357938785;7336.303051210127;4357.520672726061;4461.553844615512;4461.843835465743;4473.686841921034;4473.888152796076;5729.28383952006;6398.904016439664;6864.24493305746;6961.79114626562;6970.756023539152;5406.486383793534;6181.567290289637;6683.532152749261;6724.159480064992;6776.017477465642;6401.327860574759;6670.9332906670315;6718.529702920749;6730.226024007302;6736.932630673827;5718.340971448297;6435.710393032231;6561.081448597105;6582.3746744059235;6634.701438435185;5295.637270333443;5768.278965129359;5968.671723055274;6666.766663166766;6814.488913331619;5251.474852514718;6154.692265386802;6598.3731545505025;6610.661615883948;6638.734450621921 04:57:27 INFO - PROCESS | 1670 | |5;yui.html;663.7610460234316;733.6472321490783;735.1105162753068;750.9624518774064;751.6354568034506;14808.519148085186;14842.925785371071;14894.553163405102;15075.170865602387;15100.320485578148;9557.904420955805;12382.876171238286;12396.442160102795;12427.192232504882;12890.613281601543;848.2154007543029;850.6597361055597;958.606971141832;960.5965494492295;961.9470929098896;737.1301863800713;923.8013827027188;955.856621506776;957.5978089202551;958.3579002068595;985.1527686189871;989.678354534779;996.0587245053428;998.9800203995916;999.535216124502;979.5934687104879;979.8285300072458;986.1814693804162;987.9555420006117;994.9303548751591;731.9121705395387;741.280957471252;741.7885902517811;743.6727839750492;746.3544034410196;14937.17845518496;14984.850151498455;14990.250487475583;15026.549203523911;15046.022008569407;13010.609681709564;13022.934885325512;13024.609261722164;13072.346382680827;13242.073054886161;10004.649837255734;10145.34055286404;10176.338537995007;10355;10570.312929659625;3530.593981692087;3604.2070744436446;3635.1275693833554;3719.5536535615897;3738.4018557030745;69013.65493172502;87166.56416717876;87514;87782;89911.55044224738;9173.954130229306;9496.952515237379;9521.523923803783;9731.951340243253;10526.684199474028;20561;20602.793972060386;21035.263765768126;21374.465638359165;21464.57070858574;7290.453216008715;7373.5575865448245;7608.125065617525;7668.961655191688;7734.5359278443475;4045.7572545647354;4063.065494936181;4063.4108054331955;4068.2270368629866;4069.5726948670554;2937.5593660951026;3382.9323413531592;3484.6341134181052;3491.354099491602;3494.685478306965;613.9416755408229;618.9412005859436;624.0545573456218;632.6330728177738;633.9936600633935;572;590.8463799412098;597.0924195223323;609.6433586351945;628.5348841856993;7105.609191494414;7556.508826926232;7764.301212890867;7961.363090952826;8267.454232670028;459.8321612611373;567.6508946997567;594.8869714754182;602.208096353294;625.7121724006917;3736.1220113273357;3798.810059497014;3852.460655508231;3873.0511024799102;3875.8255878485534;96323;97227;98537.50731246299;98963.50518247363;99715;81952.59023704844;82548.99999999879;82895.7565636516;83940.58029709812;84232.57883710542;72811.63594181996;74531;74601.62699186578;74863;75460.62269688727;7481.177070522347;7507;7703.576303303372;7769.7669069928;7814.097537248958;45472.09055818931;45477.54522454733;45949.31076033929;46002.53997459982;46004.7699761499;66840.3315966834;67794.30514237184;67817.66091169513;68274.65862670654;68423.3157668417;9694.5152742364;9714.271429642946;9831.803363932539;9848.852267216142;10163.186945044527;9341.346105772802;10722;11285.492152853305;11451.14116441287;11495.482703278205;7987.457382475315;10171.898281017095;10214.693559193236;10505.68482945513;10604.840927385942;8588.484690918565;10364.948175259377;10438.425886576311;11527.481263343001;11533.365664888512;11137.220394572627;11155.609553665583;11439.42802859837;11613.0644476099;11703.590374336858;9270.397424167408;9401.529923503935;9464.716058518256;9468.763280917756;9874.703758887244;9413.81172376535;9711.36876103051;9839.655612053544;9877.654282100091;9982.60069597237 04:57:27 INFO - PROCESS | 1670 | __end_tp_report 04:57:27 INFO - PROCESS | 1670 | __start_cc_report 04:57:27 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,406 04:57:27 INFO - PROCESS | 1670 | __end_cc_report 04:57:27 INFO - PROCESS | 1670 | __startTimestamp1461153447599__endTimestamp 04:57:27 INFO - PROCESS | 1670 | 04:57:27 INFO - PROCESS | 1670 | ------- Summary: start ------- 04:57:27 INFO - PROCESS | 1670 | Number of tests: 6 04:57:27 INFO - PROCESS | 1670 | 04:57:27 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5713.30 Median:6001.10 stddev:664.28 (11.1%) stddev-sans-first:621.87 04:57:27 INFO - PROCESS | 1670 | Values: 2667.6 3440.9 3449.8 3500.3 3524.9 4951.3 5175.0 5741.2 5751.1 5793.2 5635.8 5757.6 5761.3 5799.2 5881.9 5096.8 5112.6 5197.6 5206.2 5236.2 4283.8 5229.0 5242.5 5244.9 5313.2 5090.9 5189.9 5198.5 5205.5 5216.4 5157.3 5158.9 5185.1 5189.2 5241.3 5016.8 5148.9 5164.7 5168.0 5206.4 5502.6 5533.4 5576.4 5626.8 5647.7 6158.5 6187.7 6213.6 6223.8 6229.2 6144.3 6172.9 6209.3 6213.8 6240.1 5867.6 5877.6 5878.0 5903.0 5910.3 6238.6 6296.8 6304.2 6308.2 6318.5 6068.8 6099.4 6147.2 6151.6 6164.6 6119.7 6168.4 6170.4 6188.0 6200.4 6067.2 6108.1 6132.0 6188.1 6191.0 6098.6 6120.4 6155.2 6163.2 6174.5 4934.8 4943.1 4954.6 4969.7 4986.5 4424.5 4439.8 4460.9 4493.9 4518.9 5731.6 5804.3 5929.0 5978.6 6001.4 5116.3 5432.3 6028.6 6164.7 6219.1 5736.3 5895.4 5906.4 5950.3 5953.2 4628.0 5378.4 5430.7 5478.1 5489.1 6378.5 6416.2 6426.6 6431.9 6445.1 5340.2 6171.3 6186.4 6227.4 6263.8 5243.7 6227.9 6314.3 6400.1 6426.1 6093.6 6149.9 6155.8 6170.7 6184.7 6203.1 6211.3 6237.3 6268.0 6270.3 5085.6 5947.1 6001.1 6062.6 6099.4 6117.0 6170.0 6200.6 6208.2 6217.0 5898.0 5956.6 6021.5 6083.4 6114.1 6072.9 6115.5 6125.6 6169.2 6223.1 6035.5 6075.3 6085.5 6096.1 6099.6 04:57:27 INFO - PROCESS | 1670 | 04:57:27 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:67578.73 Median:205206.50 stddev:158542.34 (77.3%) stddev-sans-first:158907.09 04:57:27 INFO - PROCESS | 1670 | Values: 498.6 518.0 541.4 569.1 585.1 30589.5 39671.0 39771.6 39788.6 39841.2 40700.4 41018.4 41094.0 41765.8 42065.0 9365.3 9584.1 9591.8 9599.7 9639.6 9410.3 9529.3 9549.7 9563.4 9577.0 9540.4 9621.2 9621.4 9646.0 9652.0 9535.7 9574.4 9576.2 9577.6 9607.8 9337.7 9453.2 9468.9 9495.1 9534.8 38373.8 38772.8 38796.0 38806.6 38809.6 2551.9 2722.3 3159.2 3595.0 3958.0 22621.8 26917.5 27649.6 28154.4 28249.3 2603.3 2654.4 2663.5 2744.8 2748.3 366695.0 372451.0 372546.0 373083.0 374827.1 33587.0 33801.8 34229.3 34828.0 35743.3 34720.0 34898.0 35014.5 35074.8 35088.0 14588.2 14820.5 14832.2 14833.0 14852.0 9945.2 10796.7 11815.5 12176.7 12607.4 7891.4 8015.8 8025.1 8077.8 8176.3 3356.0 3391.1 3403.2 3407.4 3471.6 918.2 970.5 971.5 1054.4 1132.4 28221.9 29583.3 29704.0 29877.0 30743.7 1072.8 1140.2 1145.4 1151.5 1162.3 15336.0 15340.3 15706.3 15841.6 15977.4 635343.0 662853.0 788491.0 789961.0 791911.0 52245.0 56274.4 58694.1 59468.0 60698.0 1258.2 1300.8 1482.7 1489.1 1498.8 24501.0 28371.4 29522.8 30219.5 30656.7 40095.0 41658.0 51991.0 53005.5 55679.0 595482.0 597926.0 598358.0 599328.0 600196.0 27313.6 27616.0 27714.7 27726.2 41723.0 42701.8 43141.4 43424.9 43944.8 44442.1 35949.3 36981.8 37079.8 37789.1 38015.0 36574.1 36650.3 36670.8 37330.0 37814.8 30998.1 37410.8 37501.0 37798.7 39348.8 30005.0 31154.5 31379.1 31718.0 31777.7 19309.0 24622.9 24675.6 24757.4 24809.8 04:57:27 INFO - PROCESS | 1670 | 04:57:27 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:33847.98 Median:13821.45 stddev:96419.08 (697.6%) stddev-sans-first:96656.83 04:57:27 INFO - PROCESS | 1670 | Values: 391.7 394.2 395.9 397.3 399.9 13537.3 19467.5 20120.7 20234.0 20242.3 18042.7 19986.7 20172.8 21619.8 21691.0 5881.9 5937.3 6114.5 6127.1 6141.1 6003.1 6028.5 6058.8 6059.9 6072.1 5722.0 5978.2 6055.8 6060.5 6067.9 5860.7 5934.6 6033.2 6038.8 6047.4 5195.9 5229.7 5261.1 5269.3 5273.1 20599.2 25153.1 25765.0 25800.7 26627.9 2116.8 2138.7 2338.9 2454.9 2489.8 14823.2 15086.2 15100.8 15332.9 15472.0 1551.5 1724.9 1744.3 1753.5 1788.4 114706.0 118530.0 118710.0 119235.4 120042.0 10929.6 11055.1 11134.0 11202.2 11206.7 13909.3 14003.0 14153.6 14160.2 14177.8 8656.8 8693.4 8707.3 8710.3 8717.6 8696.5 8698.9 8796.4 8812.1 8821.2 6677.4 6727.4 6800.7 6807.3 6816.4 1851.7 1878.8 1883.6 1884.1 1889.1 976.6 979.1 996.0 1036.4 1092.8 21296.5 21758.0 21818.9 21843.9 22025.8 859.7 963.2 973.2 984.9 996.4 9471.2 11468.7 11506.8 11526.0 11570.2 563711.0 567310.0 572124.0 589355.0 601402.0 114365.0 115145.0 116716.4 118042.4 123345.8 1016.5 1043.8 1051.4 1066.9 1066.9 13974.7 15026.8 19043.8 19152.6 19171.0 48985.3 50139.0 50838.5 50867.7 51621.0 64953.4 66959.0 67338.0 67811.7 71460.0 6483.9 7785.5 7826.2 8160.9 8234.5 11261.2 12449.9 12743.3 12777.2 12826.9 5370.7 9222.4 9360.6 10753.3 10943.8 8996.4 10665.8 11030.4 11190.0 11198.4 10913.0 10970.9 11199.7 11457.1 11465.8 7893.4 7900.7 7978.7 8014.6 8252.5 6688.5 9415.9 10485.4 10677.1 10701.1 04:57:27 INFO - PROCESS | 1670 | 04:57:27 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5527.69 Median:4856.61 stddev:3092.51 (63.7%) stddev-sans-first:3085.62 04:57:27 INFO - PROCESS | 1670 | Values: 1398.8 1578.1 1800.8 1940.7 1948.9 7679.6 7862.1 8417.2 8639.0 8643.5 7078.9 8455.2 8570.9 8582.7 8596.6 2384.8 2398.7 2399.0 2403.4 2404.5 2396.8 2414.4 2440.7 2444.9 2452.7 2420.7 2423.3 2423.9 2440.0 2441.0 1874.5 2207.6 2221.8 2236.3 2239.4 2018.4 2056.2 2282.4 2288.8 2300.0 8605.1 8608.1 8661.0 8678.4 8680.0 5053.5 5253.4 5262.0 5267.2 5294.9 2900.8 3414.1 3518.3 3555.4 3582.9 1043.4 1045.0 1057.6 1058.1 1060.3 11263.8 11272.0 11289.8 11329.5 11334.4 3725.9 4607.2 4753.2 4767.2 4775.6 9632.8 9642.7 9651.0 9693.3 9695.9 4250.7 5150.3 5214.8 5248.8 5264.3 4330.4 4690.7 4802.8 4832.6 4880.6 3877.5 3967.2 4000.3 4011.5 4096.6 1125.4 1324.7 1328.5 1334.2 1354.6 751.9 833.3 888.0 904.9 922.9 5023.4 5477.8 5501.0 5613.9 5685.8 934.9 941.4 963.2 970.9 978.0 3405.2 3622.1 3650.1 3702.9 3738.4 10323.4 10578.0 10716.0 10745.9 10785.6 8940.6 10627.4 10713.4 10735.5 10764.4 6516.5 7549.8 8261.0 8297.3 8300.9 5576.1 5615.1 5702.7 5736.1 5752.8 9597.0 9618.9 9737.6 9739.9 9821.0 8444.0 9551.9 9707.8 10049.9 10156.9 6778.0 7058.0 7199.6 7353.4 7363.4 7960.7 7977.3 7980.2 8067.5 8077.8 7061.9 7189.3 7210.4 7303.2 7323.2 7013.4 7028.3 7096.5 7206.4 7206.9 6686.7 6835.4 6900.2 6930.5 6930.9 4456.7 4632.4 4648.9 4677.6 4717.6 4655.7 4719.3 4723.0 4724.1 4789.0 04:57:27 INFO - PROCESS | 1670 | 04:57:27 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5352.47 Median:6026.67 stddev:1745.47 (29.0%) stddev-sans-first:1709.10 04:57:27 INFO - PROCESS | 1670 | Values: 325.3 326.4 333.4 335.1 337.3 6271.2 6376.7 6398.7 6448.3 6450.3 5217.9 5674.9 6033.7 6127.8 6258.8 3773.5 3961.2 4571.5 4644.7 4661.4 3916.4 4250.6 4581.9 4657.5 4664.5 4545.7 4588.3 4598.4 4628.7 4631.2 4055.0 4424.0 4635.3 4646.1 4667.8 3981.3 3999.4 4007.3 4014.8 4018.8 5525.9 5736.8 5764.0 6001.6 6019.6 4975.4 5170.8 5491.7 5514.7 5517.8 6644.5 6674.9 6677.5 6678.2 6698.2 4188.6 4350.8 4475.2 4494.5 4516.0 6110.7 6616.8 7014.3 7031.8 7050.8 3434.1 3898.5 4178.6 4331.6 4591.1 4066.4 4221.9 4677.2 4692.9 4706.6 4700.2 4712.9 4838.4 4897.6 5007.8 6729.9 6743.0 6765.2 6793.3 6839.2 1200.9 1265.8 1508.0 1529.2 1539.6 820.4 984.9 996.3 1009.9 1011.7 6160.1 6232.6 6252.4 6268.2 6316.5 5806.4 6645.5 6896.3 6899.3 6948.2 5461.9 6153.3 6222.2 6234.3 6259.2 2974.0 3378.7 3651.8 3663.4 3684.4 5862.2 6318.7 7324.0 7350.6 7371.5 6064.5 7175.5 7185.7 7211.4 7270.2 7055.0 7340.6 7344.2 7368.6 7424.7 5603.8 6168.5 6984.9 7016.4 7044.8 5637.4 6580.4 6710.4 6875.9 6910.9 7270.4 7320.4 7321.6 7328.2 7336.3 4357.5 4461.6 4461.8 4473.7 4473.9 5729.3 6398.9 6864.2 6961.8 6970.8 5406.5 6181.6 6683.5 6724.2 6776.0 6401.3 6670.9 6718.5 6730.2 6736.9 5718.3 6435.7 6561.1 6582.4 6634.7 5295.6 5768.3 5968.7 6666.8 6814.5 5251.5 6154.7 6598.4 6610.7 6638.7 04:57:27 INFO - PROCESS | 1670 | 04:57:27 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:18504.21 Median:67805.98 stddev:26950.70 (39.7%) stddev-sans-first:26993.01 04:57:27 INFO - PROCESS | 1670 | Values: 663.8 733.6 735.1 751.0 751.6 14808.5 14842.9 14894.6 15075.2 15100.3 9557.9 12382.9 12396.4 12427.2 12890.6 848.2 850.7 958.6 960.6 961.9 737.1 923.8 955.9 957.6 958.4 985.2 989.7 996.1 999.0 999.5 979.6 979.8 986.2 988.0 994.9 731.9 741.3 741.8 743.7 746.4 14937.2 14984.9 14990.3 15026.5 15046.0 13010.6 13022.9 13024.6 13072.3 13242.1 10004.6 10145.3 10176.3 10355.0 10570.3 3530.6 3604.2 3635.1 3719.6 3738.4 69013.7 87166.6 87514.0 87782.0 89911.6 9174.0 9497.0 9521.5 9732.0 10526.7 20561.0 20602.8 21035.3 21374.5 21464.6 7290.5 7373.6 7608.1 7669.0 7734.5 4045.8 4063.1 4063.4 4068.2 4069.6 2937.6 3382.9 3484.6 3491.4 3494.7 613.9 618.9 624.1 632.6 634.0 572.0 590.8 597.1 609.6 628.5 7105.6 7556.5 7764.3 7961.4 8267.5 459.8 567.7 594.9 602.2 625.7 3736.1 3798.8 3852.5 3873.1 3875.8 96323.0 97227.0 98537.5 98963.5 99715.0 81952.6 82549.0 82895.8 83940.6 84232.6 72811.6 74531.0 74601.6 74863.0 75460.6 7481.2 7507.0 7703.6 7769.8 7814.1 45472.1 45477.5 45949.3 46002.5 46004.8 66840.3 67794.3 67817.7 68274.7 68423.3 9694.5 9714.3 9831.8 9848.9 10163.2 9341.3 10722.0 11285.5 11451.1 11495.5 7987.5 10171.9 10214.7 10505.7 10604.8 8588.5 10364.9 10438.4 11527.5 11533.4 11137.2 11155.6 11439.4 11613.1 11703.6 9270.4 9401.5 9464.7 9468.8 9874.7 9413.8 9711.4 9839.7 9877.7 9982.6 04:57:27 INFO - PROCESS | 1670 | -------- Summary: end -------- 04:57:27 INFO - PROCESS | 1670 | 04:57:28 INFO - TEST-INFO | 1670: exit 0 04:57:28 INFO - TEST-OK | dromaeo_css | took 1112055ms 04:57:28 INFO - TEST-START | kraken 04:57:28 INFO - operating with platform_type : mac_ 04:57:28 INFO - Initialising browser for kraken test... 04:57:28 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmp2wOdJ3/profile http://localhost:49271/getInfo.html) 04:57:31 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 04:57:31 INFO - PROCESS | 1682 | colorDepth:24 04:57:31 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 04:57:31 INFO - PROCESS | 1682 | __metrics 04:57:31 ERROR - PROCESS | 1682 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:57:31 INFO - TEST-INFO | 1682: exit 0 04:57:31 INFO - Browser initialized. 04:57:31 INFO - Running cycle 1/1 for kraken test... 04:57:31 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmp2wOdJ3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:43 INFO - PROCESS | 1685 | RSS: Main: 248164352 04:57:43 INFO - PROCESS | 1685 | 04:57:46 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 04:57:47 INFO - PROCESS | 1685 | RSS: Main: 259985408 04:57:47 INFO - PROCESS | 1685 | 04:57:50 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 04:57:50 INFO - PROCESS | 1685 | RSS: Main: 268767232 04:57:50 INFO - PROCESS | 1685 | 04:57:54 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 04:57:54 INFO - PROCESS | 1685 | RSS: Main: 271818752 04:57:54 INFO - PROCESS | 1685 | 04:57:56 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 04:57:57 INFO - PROCESS | 1685 | RSS: Main: 273776640 04:57:57 INFO - PROCESS | 1685 | 04:57:59 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:58:00 INFO - PROCESS | 1685 | RSS: Main: 274214912 04:58:00 INFO - PROCESS | 1685 | 04:58:03 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 04:58:03 INFO - PROCESS | 1685 | RSS: Main: 274694144 04:58:03 INFO - PROCESS | 1685 | 04:58:06 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 04:58:07 INFO - PROCESS | 1685 | RSS: Main: 274722816 04:58:07 INFO - PROCESS | 1685 | 04:58:10 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 04:58:11 INFO - PROCESS | 1685 | RSS: Main: 274984960 04:58:11 INFO - PROCESS | 1685 | 04:58:12 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:58:13 INFO - PROCESS | 1685 | RSS: Main: 274857984 04:58:13 INFO - PROCESS | 1685 | 04:58:15 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:58:15 INFO - PROCESS | 1685 | RSS: Main: 274853888 04:58:15 INFO - PROCESS | 1685 | 04:58:17 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:58:18 INFO - PROCESS | 1685 | RSS: Main: 275120128 04:58:18 INFO - PROCESS | 1685 | 04:58:21 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:58:22 INFO - PROCESS | 1685 | RSS: Main: 275009536 04:58:22 INFO - PROCESS | 1685 | 04:58:25 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:58:25 INFO - PROCESS | 1685 | RSS: Main: 274903040 04:58:25 INFO - PROCESS | 1685 | 04:58:27 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 04:58:28 INFO - PROCESS | 1685 | RSS: Main: 276279296 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | __start_tp_report 04:58:28 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 04:58:28 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 04:58:28 INFO - PROCESS | 1685 | |i|pagename|runs| 04:58:28 INFO - PROCESS | 1685 | |0;ai-astar;116;111;117;116;116;128;115;118;117;117 04:58:28 INFO - PROCESS | 1685 | |1;audio-beat-detection;158;133;138;190;159;147;164;158;171;147 04:58:28 INFO - PROCESS | 1685 | |2;audio-dft;195;203;212;265;284;254;204;256;273;199 04:58:28 INFO - PROCESS | 1685 | |3;audio-fft;71;83;75;135;56;57;61;61;79;75 04:58:28 INFO - PROCESS | 1685 | |4;audio-oscillator;86;68;168;115;122;127;134;81;82;123 04:58:28 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;88;86;88;86;89;85;93;98;135;112 04:58:28 INFO - PROCESS | 1685 | |6;imaging-darkroom;95;94;94;95;100;89;152;152;94;96 04:58:28 INFO - PROCESS | 1685 | |7;imaging-desaturate;100;130;99;94;95;94;100;96;109;145 04:58:28 INFO - PROCESS | 1685 | |8;json-parse-financial;56;66;58;56;52;52;73;101;101;97 04:58:28 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;63;65;74;62;74;72;64;66;65;65 04:58:28 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;84;82;86;81;86;83;85;81;85;85 04:58:28 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;164;140;159;163;160;157;161;170;179;173 04:58:28 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;176;181;173;173;177;175;170;167;172;172 04:58:28 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;68;83;89;92;101;99;103;61;84;102 04:58:28 INFO - PROCESS | 1685 | __end_tp_report 04:58:28 INFO - PROCESS | 1685 | __start_cc_report 04:58:28 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,1039 04:58:28 INFO - PROCESS | 1685 | __end_cc_report 04:58:28 INFO - PROCESS | 1685 | __startTimestamp1461153508035__endTimestamp 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | ------- Summary: start ------- 04:58:28 INFO - PROCESS | 1685 | Number of tests: 14 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:117.10 Median:117.00 stddev:4.28 (3.7%) stddev-sans-first:4.52 04:58:28 INFO - PROCESS | 1685 | Values: 116.0 111.0 117.0 116.0 116.0 128.0 115.0 118.0 117.0 117.0 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:156.50 Median:158.50 stddev:16.58 (10.5%) stddev-sans-first:17.58 04:58:28 INFO - PROCESS | 1685 | Values: 158.0 133.0 138.0 190.0 159.0 147.0 164.0 158.0 171.0 147.0 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:234.50 Median:255.00 stddev:34.89 (13.7%) stddev-sans-first:33.95 04:58:28 INFO - PROCESS | 1685 | Values: 195.0 203.0 212.0 265.0 284.0 254.0 204.0 256.0 273.0 199.0 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:75.30 Median:73.00 stddev:23.03 (31.5%) stddev-sans-first:24.37 04:58:28 INFO - PROCESS | 1685 | Values: 71.0 83.0 75.0 135.0 56.0 57.0 61.0 61.0 79.0 75.0 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:118.00 stddev:30.78 (26.1%) stddev-sans-first:31.34 04:58:28 INFO - PROCESS | 1685 | Values: 86.0 68.0 168.0 115.0 122.0 127.0 134.0 81.0 82.0 123.0 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:96.00 Median:88.00 stddev:15.94 (18.1%) stddev-sans-first:16.65 04:58:28 INFO - PROCESS | 1685 | Values: 88.0 86.0 88.0 86.0 89.0 85.0 93.0 98.0 135.0 112.0 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:106.10 Median:94.00 stddev:24.34 (25.9%) stddev-sans-first:25.48 04:58:28 INFO - PROCESS | 1685 | Values: 95.0 94.0 94.0 95.0 100.0 89.0 152.0 152.0 94.0 96.0 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:106.20 Median:94.00 stddev:17.43 (18.5%) stddev-sans-first:18.35 04:58:28 INFO - PROCESS | 1685 | Values: 100.0 130.0 99.0 94.0 95.0 94.0 100.0 96.0 109.0 145.0 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:71.20 Median:57.00 stddev:20.67 (36.3%) stddev-sans-first:21.18 04:58:28 INFO - PROCESS | 1685 | Values: 56.0 66.0 58.0 56.0 52.0 52.0 73.0 101.0 101.0 97.0 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:65.50 stddev:4.55 (6.9%) stddev-sans-first:4.59 04:58:28 INFO - PROCESS | 1685 | Values: 63.0 65.0 74.0 62.0 74.0 72.0 64.0 66.0 65.0 65.0 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:85.00 stddev:1.93 (2.3%) stddev-sans-first:2.05 04:58:28 INFO - PROCESS | 1685 | Values: 84.0 82.0 86.0 81.0 86.0 83.0 85.0 81.0 85.0 85.0 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:162.60 Median:163.50 stddev:10.53 (6.4%) stddev-sans-first:11.16 04:58:28 INFO - PROCESS | 1685 | Values: 164.0 140.0 159.0 163.0 160.0 157.0 161.0 170.0 179.0 173.0 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:174.00 stddev:3.89 (2.2%) stddev-sans-first:4.03 04:58:28 INFO - PROCESS | 1685 | Values: 176.0 181.0 173.0 173.0 177.0 175.0 170.0 167.0 172.0 172.0 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:88.20 Median:83.50 stddev:14.52 (17.4%) stddev-sans-first:13.44 04:58:28 INFO - PROCESS | 1685 | Values: 68.0 83.0 89.0 92.0 101.0 99.0 103.0 61.0 84.0 102.0 04:58:28 INFO - PROCESS | 1685 | -------- Summary: end -------- 04:58:28 INFO - PROCESS | 1685 | 04:58:28 INFO - TEST-INFO | 1685: exit 0 04:58:28 INFO - TEST-OK | kraken | took 60683ms 04:58:28 INFO - SUITE-END | took 1172s 04:58:29 INFO - Completed test suite (00:19:33) 04:58:29 INFO - javascript benchmark 04:58:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2667.599860020997, 3440.8967730968066, 3449.8447569859354, 3500.264944361684, 3524.8942531724056, 4951.282064100703, 5174.990876779025, 5741.16753070805, 5751.079827227644, 5793.2179155814, 5635.830925072254, 5757.625754325976, 5761.279840019997, 5799.18811366409, 5881.85295367616, 5096.796128154888, 5112.590992720592, 5197.636165468419, 5206.21906713994, 5236.162214045753, 4283.764392958386, 5228.973855130719, 5242.501962313574, 5244.895102097956, 5313.1764576490705, 5090.854557724501, 5189.896202075937, 5198.454162312978, 5205.505476979681, 5216.426193118754, 5157.329547158883, 5158.896822063575, 5185.092608793484, 5189.2475591039465, 5241.344831896013, 5016.799328026875, 5148.897022059537, 5164.690118592896, 5167.992241512907, 5206.427292997805, 5502.58730595207, 5533.391326954032, 5576.386597474275, 5626.831195064114, 5647.689377084259, 6158.538109641795, 6187.690615469253, 6213.627182369072, 6223.844403889893, 6229.1590635264565, 6144.341027922436, 6172.9074063889075, 6209.285932117819, 6213.751449941997, 6240.063990401431, 5867.618604790675, 5877.617954832922, 5877.970610146965, 5903.0, 5910.34986151523, 6238.563300569007, 6296.779612713624, 6304.211973503312, 6308.211473565804, 6318.494520438354, 6068.817935461855, 6099.400579572073, 6147.170132032208, 6151.569390142647, 6164.599301045418, 6119.694015299217, 6168.383161683885, 6170.382961703794, 6188.0, 6200.3799620038535, 6067.150598916155, 6108.068892179526, 6131.96934015336, 6188.1027251049245, 6190.969045154746, 6098.613770999311, 6120.355709576858, 6155.169052177988, 6163.1679723237685, 6174.5060395168275, 4934.827281045146, 4943.110240156806, 4954.603631709455, 4969.726665033386, 4986.4514903360605, 4424.535423780457, 4439.778011099432, 4460.888477788081, 4493.910121797611, 4518.88702782433, 5731.598788084877, 5804.332501762267, 5928.962431574457, 5978.55160862937, 6001.399860013964, 5116.258142569381, 5432.348118225838, 6028.608140470856, 6164.6917654117115, 6219.129321894939, 5736.311642602831, 5895.4399332063385, 5906.379830117776, 5950.345461999176, 5953.166556682068, 4628.0, 5378.435264297271, 5430.728463576806, 5478.096114141202, 5489.149181876815, 6378.52161087911, 6416.165898433173, 6426.646534440557, 6431.903521447182, 6445.097686324012, 5340.2256672783005, 6171.321154672893, 6186.443220110212, 6227.377262273918, 6263.78076767311, 5243.737813109406, 6227.906581401373, 6314.273858506147, 6400.135981642418, 6426.132472116205, 6093.634381937098, 6149.926310793524, 6155.846103847261, 6170.660613666291, 6184.6598437086395, 6203.131561581473, 6211.2857021441305, 6237.251529816451, 6268.0, 6270.310265870659, 5085.5931525477135, 5947.137665038459, 6001.099835024781, 6062.575619706755, 6099.359567245553, 6117.0, 6170.012797952306, 6200.627962322275, 6208.2239720034995, 6216.968915155395, 5897.970510147422, 5956.5532585055425, 6021.488173505126, 6083.391660833881, 6114.082887566723, 6072.939270607238, 6115.480184184395, 6125.632272693401, 6169.2288463942, 6223.066540019034, 6035.486983606443, 6075.28108842996, 6085.513158947185, 6096.1465394845645, 6099.634021958696], "value": 5671.273551241735, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.5836826250081, 517.9611529135315, 541.3503795445466, 569.0667305618784, 585.1486087742335, 30589.541156882664, 39671.0, 39771.602283977154, 39788.60211397885, 39841.203175936535, 40700.389494157615, 41018.38472422909, 41094.0, 41765.79117104418, 42065.0, 9365.250779937624, 9584.137427631511, 9591.808163836718, 9599.712008639752, 9639.566219520104, 9410.294227932898, 9529.332946693734, 9549.665761698341, 9563.378380405285, 9577.042295770401, 9540.427574345562, 9621.230301575857, 9621.422714637145, 9646.035396460367, 9652.0, 9535.71392858212, 9574.425534467884, 9576.186024187882, 9577.616895324214, 9607.759806004837, 9337.71986840396, 9453.196478299353, 9468.905310946871, 9495.05049495052, 9534.761630959212, 38373.80813095945, 38772.80613596914, 38796.0, 38806.61193388058, 38809.61190388088, 2551.889927881359, 2722.3466368071718, 3159.225989632555, 3594.982025089884, 3958.039799459303, 22621.77378226213, 26917.461650766876, 27649.585256221173, 28154.436911261866, 28249.293767655767, 2603.2971097803675, 2654.4027593791434, 2663.4806212788512, 2744.794140439475, 2748.2991837081418, 366695.0, 372451.0, 372546.0, 373083.0, 374827.12586437166, 33587.0, 33801.8169364076, 34229.315413691584, 34828.0, 35743.28513429717, 34720.0, 34898.0, 35014.47478287828, 35074.82462587722, 35088.0, 14588.197649129399, 14820.481283155037, 14832.184229867245, 14833.035852669542, 14852.0, 9945.15466185368, 10796.730081747863, 11815.468303926344, 12176.695582610506, 12607.432665530074, 7891.368690504861, 8015.839683206304, 8025.117237103914, 8077.838443231102, 8176.305014073751, 3356.043527594624, 3391.1352605085544, 3403.2172600301574, 3407.3526030054704, 3471.6181220065773, 918.150710592699, 970.5147426286857, 971.5288085278635, 1054.3779170289565, 1132.4111462039693, 28221.871125154765, 29583.26041848971, 29704.0, 29877.0, 30743.692563074084, 1072.780080083581, 1140.156284349592, 1145.438735019851, 1151.4933429291252, 1162.2793867801847, 15336.0, 15340.309686064154, 15706.293216805272, 15841.603959901095, 15977.440789572309, 635343.0, 662853.0, 788491.0, 789961.0, 791911.0, 52244.95510089777, 56274.43725562692, 58694.11958820621, 59468.0, 60697.99999999912, 1258.150748244931, 1300.7593595184921, 1482.7034593081428, 1489.106536078366, 1498.8126484189477, 24501.039916806258, 28371.43257134887, 29522.81908723627, 30219.546706799854, 30656.693433065382, 40095.0, 41657.95855103646, 51991.0, 53005.46994530005, 55679.0, 595482.0, 597926.0, 598358.0, 599328.0, 600196.0, 27313.590296145972, 27616.0, 27714.722852771214, 27726.168214953585, 41723.0, 42701.78649106859, 43141.352879707454, 43424.91437713956, 43944.78027609841, 44442.111262767816, 35949.28101437904, 36981.81509092437, 37079.814600926824, 37789.05527361838, 38015.0, 36574.074074074546, 36650.26699466049, 36670.8166459166, 37330.0, 37814.810925945196, 30998.070057898298, 37410.81294593619, 37501.0, 37798.677046303244, 39348.80325598468, 30005.0, 31154.532682009336, 31379.05862824119, 31718.04845854628, 31777.68222317747, 19309.0, 24622.935478411473, 24675.629865551673, 24757.381065473506, 24809.751902480744], "value": 18018.300697906623, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.74928046050525, 394.1820722001845, 395.9148783011653, 397.334464771508, 399.9460072890159, 13537.323133843292, 19467.513312167186, 20120.69818952715, 20234.0, 20242.291519796792, 18042.729359059624, 19986.70019949702, 20172.798272017277, 21619.810910399923, 21691.0, 5881.8823623527505, 5937.346891841894, 6114.480269177103, 6127.111568822518, 6141.14024036633, 6003.0695242237525, 6028.4574388305045, 6058.787942422016, 6059.909101363483, 6072.149899014142, 5721.971390143043, 5978.2228310319815, 6055.848603784896, 6060.454559089681, 6067.877442673098, 5860.736266868002, 5934.614250073774, 6033.185519954815, 6038.788642397517, 6047.42549457803, 5195.896082078375, 5229.712365819878, 5261.105612045923, 5269.341332333458, 5273.1035723927025, 20599.176032958665, 25153.119640812485, 25764.969401223927, 25800.74199258021, 26627.934882604673, 2116.7552383466464, 2138.689889965962, 2338.941526461835, 2454.914078007261, 2489.7759201671756, 14823.18472484013, 15086.24568771568, 15100.848991510054, 15332.926695131346, 15472.0, 1551.4880089570415, 1724.9137543122793, 1744.3371518822894, 1753.465193116099, 1788.3919467381022, 114706.0, 118530.0, 118710.0, 119235.4038229812, 120042.0, 10929.56281748721, 11055.11559075272, 11134.0, 11202.159838012181, 11206.719832004264, 13909.304534773422, 14003.0, 14153.575392738234, 14160.221187834562, 14177.78733319001, 8656.826863462822, 8693.391462597683, 8707.346948978851, 8710.346723995726, 8717.607707653044, 8696.478211307342, 8698.869516957251, 8796.384253102222, 8812.07473215316, 8821.161989610977, 6677.432418244406, 6727.428168605723, 6800.727970881109, 6807.319268073153, 6816.352446517573, 1851.6574433729802, 1878.8402985746366, 1883.6138591588692, 1884.0956340956143, 1889.0649128681391, 976.6386437018349, 979.118793086228, 995.9651412200539, 1036.3729943384144, 1092.82514797632, 21296.467588310417, 21758.02088906003, 21818.89090554569, 21843.890780545997, 22025.779742202372, 859.7420773767844, 963.1668606655193, 973.2360097323567, 984.9310548261697, 996.3573495095623, 9471.242300616072, 11468.667069812576, 11506.827397589042, 11526.020288275422, 11570.247933884271, 563711.0, 567310.0, 572124.0, 589355.0, 601402.0, 114365.0, 115145.0, 116716.41641791737, 118042.40978795051, 123345.76654233343, 1016.4612755239734, 1043.838205078214, 1051.4322265976286, 1066.8506409102731, 1066.898644628759, 13974.720505589628, 15026.774598381251, 19043.809561904203, 19152.61694766125, 19171.0, 48985.265221021, 50138.997220056124, 50838.491615083374, 50867.74566127294, 51621.0, 64953.35046649473, 66959.0, 67338.0, 67811.66094169498, 71460.0, 6483.902741458787, 7785.532868027936, 7826.2173782621285, 8160.939077919832, 8234.547099909563, 11261.211715180187, 12449.93775031119, 12743.323901980688, 12777.16948398351, 12826.935865320615, 5370.650907690988, 9222.40054396462, 9360.578773955325, 10753.341131380566, 10943.83584246253, 8996.422218224743, 10665.786684266426, 11030.393328366696, 11190.048845848194, 11198.44007799623, 10912.96326848948, 10970.945145274223, 11199.72000699989, 11457.140714446616, 11465.828012579985, 7893.407994400328, 7900.68397264103, 7978.720744773905, 8014.639341229542, 8252.546109963769, 6688.464922806261, 9415.85876211871, 10485.423301718174, 10677.14582833387, 10701.090407315465], "value": 9584.683185742888, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.8391334996475, 1578.0689393257976, 1800.7568978187949, 1940.6700860853662, 1948.8733232339905, 7679.616019199046, 7862.135165131831, 8417.242448179662, 8638.956805215965, 8643.524606146659, 7078.858422831553, 8455.154484551542, 8570.871436928435, 8582.656693732244, 8596.570171491416, 2384.8211384146216, 2398.712154541449, 2398.95202095958, 2403.3631087761755, 2404.483036147228, 2396.8442051266697, 2414.3722632115687, 2440.731519532859, 2444.9022039118504, 2452.705675318964, 2420.7337192908767, 2423.3456966619, 2423.9272821815284, 2440.0, 2440.9633855492184, 1874.4564076417823, 2207.6357401028813, 2221.7889300516426, 2236.3402796175087, 2239.395363251913, 2018.414659748671, 2056.187805816694, 2282.372347604422, 2288.805451536605, 2300.033985725999, 8605.096464871162, 8608.053114157437, 8660.956695216484, 8678.435901666435, 8680.045195028542, 5053.545180933696, 5253.448387919251, 5262.0, 5267.209918512215, 5294.867628309285, 2900.8152173913004, 3414.095264754842, 3518.3491054155065, 3555.4489054196642, 3582.946255806165, 1043.4417586591137, 1044.9529771160317, 1057.5611121384616, 1058.1006144776954, 1060.2790102730141, 11263.831042534368, 11272.0, 11289.830652540219, 11329.490172942238, 11334.43327833605, 3725.869594564177, 4607.193741095295, 4753.239481682983, 4767.189577771787, 4775.594074503706, 9632.75918102053, 9642.662506812228, 9651.034896510433, 9693.273004524688, 9695.90304096964, 4250.681198910094, 5150.330457040561, 5214.765335559909, 5248.7900483980975, 5264.289320941624, 4330.437043184366, 4690.718556886598, 4802.759862006886, 4832.589229915427, 4880.633952453509, 3877.515310586177, 3967.2263908538134, 4000.299947509174, 4011.538673052578, 4096.569860164699, 1125.4429057616533, 1324.708564115893, 1328.548293580168, 1334.1794796200268, 1354.593621913422, 751.9398448124136, 833.3416600885233, 887.9644814207488, 904.8687940248759, 922.9492377919145, 5023.447420783711, 5477.808276710376, 5500.972495137578, 5613.887722245532, 5685.829425117253, 934.8550974598948, 941.4325148627458, 963.2342287881012, 970.8883478399933, 977.9584742249482, 3405.1997780521556, 3622.1487950331652, 3650.1239702471216, 3702.9444558331647, 3738.43923411485, 10323.380597164194, 10577.995090466393, 10716.0, 10745.892541074645, 10785.62250321235, 8940.642374304955, 10627.415492147851, 10713.35719856811, 10735.463226838783, 10764.40795756241, 6516.511261655395, 7549.773506794805, 8261.008678958444, 8297.294729948022, 8300.875486867702, 5576.052071147834, 5615.129654903497, 5702.743376548148, 5736.110902810071, 5752.798652047159, 9597.040295970348, 9618.903810961801, 9737.610495580097, 9739.902600974183, 9820.950895245478, 8443.95778021106, 9551.856722149034, 9707.805843883225, 10049.894511603863, 10156.949215253877, 6778.017187507882, 7058.0, 7199.568025918462, 7353.411727061929, 7363.374113200223, 7960.681572737026, 7977.282044616012, 7980.201979802206, 8067.515949043076, 8077.798055048671, 7061.929380706127, 7189.317014883578, 7210.351068403869, 7303.196648368781, 7323.194448610755, 7013.368796808311, 7028.332308430691, 7096.53872498286, 7206.351428371472, 7206.927930720625, 6686.699098540675, 6835.384815366641, 6900.206476255295, 6930.48021398387, 6930.8613827724175, 4456.732596044248, 4632.397788287636, 4648.907021859612, 4677.602403795716, 4717.57541821224, 4655.674102812906, 4719.268513380432, 4722.976385118052, 4724.055188962153, 4789.018251258414], "value": 4466.425907722108, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.33469055780927, 326.4238618837752, 333.43482796659674, 335.0952428443204, 337.33713253456955, 6271.1847459830215, 6376.713047912844, 6398.744050237997, 6448.258450278219, 6450.258220304672, 5217.947820521794, 5674.943250567503, 6033.7284822183, 6127.816165515031, 6258.812235632927, 3773.490578771858, 3961.227560625679, 4571.542845715435, 4644.744539050351, 4661.394018777554, 3916.4321173429835, 4250.61744443, 4581.862544123682, 4657.464391594959, 4664.463586687541, 4545.681802273825, 4588.334691469735, 4598.356230127785, 4628.675992680513, 4631.189541830183, 4054.9999999999854, 4423.955760442386, 4635.281531362644, 4646.094011667727, 4667.836625718083, 3981.3430783920617, 3999.440078389028, 4007.338789099795, 4014.7992600369867, 4018.7990600470152, 5525.867197224599, 5736.7665951820145, 5764.0, 6001.639901605918, 6019.608725432833, 4975.41769925653, 5170.767315470813, 5491.697956612385, 5514.696691681956, 5517.779288828442, 6644.468442524587, 6674.866502669919, 6677.465802735769, 6678.198616166092, 6698.210779292829, 4188.560201178862, 4350.8042138103865, 4475.2168370535355, 4494.460664720222, 4515.977420112911, 6110.725017374229, 6616.842052640769, 7014.281501032228, 7031.7538886139255, 7050.753223637199, 3434.10713214566, 3898.473706049647, 4178.603032711888, 4331.566843315643, 4591.127685739699, 4066.369712694537, 4221.944513871532, 4677.158111539956, 4692.859214223578, 4706.599939005223, 4700.224462963641, 4712.929306060412, 4838.443578988391, 4897.583705385082, 5007.823161557031, 6729.932700673028, 6743.0, 6765.188177418741, 6793.320667933167, 6839.179298484214, 1200.9399530023463, 1265.7531781302741, 1508.0, 1529.243024702757, 1539.6458814472735, 820.3806126374549, 984.867042949207, 996.3225006995312, 1009.8939611340851, 1011.716719318592, 6160.1375807387, 6232.594881332699, 6252.374762523802, 6268.247810262797, 6316.526260530479, 5806.44838740319, 6645.472462390245, 6896.344847239504, 6899.310068993161, 6948.235694073648, 5461.890762184734, 6153.29237137726, 6222.191115155001, 6234.2830574484515, 6259.186305780219, 2973.9553906691417, 3378.6687185841693, 3651.8174091295327, 3663.4321680139087, 3684.428913518409, 5862.2447449698575, 6318.684065796691, 7323.974643549907, 7350.595717235603, 7371.520851144658, 6064.48451881595, 7175.46184036189, 7185.712571497186, 7211.350978411968, 7270.200277969419, 7054.964725176341, 7340.632968351561, 7344.200670835679, 7368.594727289836, 7424.703011879465, 5603.831885043455, 6168.537359697951, 6984.917337812647, 7016.403605693573, 7044.823879403056, 5637.43625637433, 6580.374864387875, 6710.429613482714, 6875.862482750217, 6910.928806035073, 7270.382017528569, 7320.377767889789, 7321.63391830417, 7328.2305357938785, 7336.303051210127, 4357.520672726061, 4461.553844615512, 4461.843835465743, 4473.686841921034, 4473.888152796076, 5729.28383952006, 6398.904016439664, 6864.24493305746, 6961.79114626562, 6970.756023539152, 5406.486383793534, 6181.567290289637, 6683.532152749261, 6724.159480064992, 6776.017477465642, 6401.327860574759, 6670.9332906670315, 6718.529702920749, 6730.226024007302, 6736.932630673827, 5718.340971448297, 6435.710393032231, 6561.081448597105, 6582.3746744059235, 6634.701438435185, 5295.637270333443, 5768.278965129359, 5968.671723055274, 6666.766663166766, 6814.488913331619, 5251.474852514718, 6154.692265386802, 6598.3731545505025, 6610.661615883948, 6638.734450621921], "value": 4778.154150646346, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.7610460234316, 733.6472321490783, 735.1105162753068, 750.9624518774064, 751.6354568034506, 14808.519148085186, 14842.925785371071, 14894.553163405102, 15075.170865602387, 15100.320485578148, 9557.904420955805, 12382.876171238286, 12396.442160102795, 12427.192232504882, 12890.613281601543, 848.2154007543029, 850.6597361055597, 958.606971141832, 960.5965494492295, 961.9470929098896, 737.1301863800713, 923.8013827027188, 955.856621506776, 957.5978089202551, 958.3579002068595, 985.1527686189871, 989.678354534779, 996.0587245053428, 998.9800203995916, 999.535216124502, 979.5934687104879, 979.8285300072458, 986.1814693804162, 987.9555420006117, 994.9303548751591, 731.9121705395387, 741.280957471252, 741.7885902517811, 743.6727839750492, 746.3544034410196, 14937.17845518496, 14984.850151498455, 14990.250487475583, 15026.549203523911, 15046.022008569407, 13010.609681709564, 13022.934885325512, 13024.609261722164, 13072.346382680827, 13242.073054886161, 10004.649837255734, 10145.34055286404, 10176.338537995007, 10355.0, 10570.312929659625, 3530.593981692087, 3604.2070744436446, 3635.1275693833554, 3719.5536535615897, 3738.4018557030745, 69013.65493172502, 87166.56416717876, 87514.0, 87782.0, 89911.55044224738, 9173.954130229306, 9496.952515237379, 9521.523923803783, 9731.951340243253, 10526.684199474028, 20561.0, 20602.793972060386, 21035.263765768126, 21374.465638359165, 21464.57070858574, 7290.453216008715, 7373.5575865448245, 7608.125065617525, 7668.961655191688, 7734.5359278443475, 4045.7572545647354, 4063.065494936181, 4063.4108054331955, 4068.2270368629866, 4069.5726948670554, 2937.5593660951026, 3382.9323413531592, 3484.6341134181052, 3491.354099491602, 3494.685478306965, 613.9416755408229, 618.9412005859436, 624.0545573456218, 632.6330728177738, 633.9936600633935, 572.0, 590.8463799412098, 597.0924195223323, 609.6433586351945, 628.5348841856993, 7105.609191494414, 7556.508826926232, 7764.301212890867, 7961.363090952826, 8267.454232670028, 459.8321612611373, 567.6508946997567, 594.8869714754182, 602.208096353294, 625.7121724006917, 3736.1220113273357, 3798.810059497014, 3852.460655508231, 3873.0511024799102, 3875.8255878485534, 96323.0, 97227.0, 98537.50731246299, 98963.50518247363, 99715.0, 81952.59023704844, 82548.99999999879, 82895.7565636516, 83940.58029709812, 84232.57883710542, 72811.63594181996, 74531.0, 74601.62699186578, 74863.0, 75460.62269688727, 7481.177070522347, 7507.0, 7703.576303303372, 7769.7669069928, 7814.097537248958, 45472.09055818931, 45477.54522454733, 45949.31076033929, 46002.53997459982, 46004.7699761499, 66840.3315966834, 67794.30514237184, 67817.66091169513, 68274.65862670654, 68423.3157668417, 9694.5152742364, 9714.271429642946, 9831.803363932539, 9848.852267216142, 10163.186945044527, 9341.346105772802, 10722.0, 11285.492152853305, 11451.14116441287, 11495.482703278205, 7987.457382475315, 10171.898281017095, 10214.693559193236, 10505.68482945513, 10604.840927385942, 8588.484690918565, 10364.948175259377, 10438.425886576311, 11527.481263343001, 11533.365664888512, 11137.220394572627, 11155.609553665583, 11439.42802859837, 11613.0644476099, 11703.590374336858, 9270.397424167408, 9401.529923503935, 9464.716058518256, 9468.763280917756, 9874.703758887244, 9413.81172376535, 9711.36876103051, 9839.655612053544, 9877.654282100091, 9982.60069597237], "value": 6829.70491710264, "unit": "score"}], "name": "dromaeo_css", "value": 7229.450358241437, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 117.0, 116.0, 116.0, 128.0, 115.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 133.0, 138.0, 190.0, 159.0, 147.0, 164.0, 158.0, 171.0, 147.0], "value": 156.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 203.0, 212.0, 265.0, 284.0, 254.0, 204.0, 256.0, 273.0, 199.0], "value": 234.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 83.0, 75.0, 135.0, 56.0, 57.0, 61.0, 61.0, 79.0, 75.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 68.0, 168.0, 115.0, 122.0, 127.0, 134.0, 81.0, 82.0, 123.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 89.0, 85.0, 93.0, 98.0, 135.0, 112.0], "value": 96.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 100.0, 89.0, 152.0, 152.0, 94.0, 96.0], "value": 106.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 130.0, 99.0, 94.0, 95.0, 94.0, 100.0, 96.0, 109.0, 145.0], "value": 106.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 66.0, 58.0, 56.0, 52.0, 52.0, 73.0, 101.0, 101.0, 97.0], "value": 71.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 74.0, 62.0, 74.0, 72.0, 64.0, 66.0, 65.0, 65.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 86.0, 81.0, 86.0, 83.0, 85.0, 81.0, 85.0, 85.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 140.0, 159.0, 163.0, 160.0, 157.0, 161.0, 170.0, 179.0, 173.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 181.0, 173.0, 173.0, 177.0, 175.0, 170.0, 167.0, 172.0, 172.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 83.0, 89.0, 92.0, 101.0, 99.0, 103.0, 61.0, 84.0, 102.0], "value": 88.2, "unit": "score"}], "name": "kraken", "value": 1648.6999999999998, "alertThreshold": 2.0}]} 04:58:29 INFO - Return code: 0 04:58:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:58:29 ERROR - # TBPL SUCCESS # 04:58:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:58:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:58:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:58:29 INFO - 2016-04-20 04:58:29.291 screenresolution[1690:10638] starting screenresolution argv=screenresolution get 04:58:29 INFO - 2016-04-20 04:58:29.294 screenresolution[1690:10638] Display 0: 1600x1200x32@60 04:58:29 INFO - 2016-04-20 04:58:29.300 screenresolution[1691:10641] starting screenresolution argv=screenresolution list 04:58:29 INFO - Available Modes on Display 0 04:58:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:58:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:58:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:58:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:58:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:58:29 INFO - Intel Iris: 04:58:29 INFO - Chipset Model: Intel Iris 04:58:29 INFO - Type: GPU 04:58:29 INFO - Bus: Built-In 04:58:29 INFO - VRAM (Dynamic, Max): 1536 MB 04:58:29 INFO - Vendor: Intel (0x8086) 04:58:29 INFO - Device ID: 0x0a2e 04:58:29 INFO - Revision ID: 0x0009 04:58:29 INFO - Displays: 04:58:29 INFO - Display: 04:58:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:58:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:58:29 INFO - Display Serial Number: 1600x1200 60 04:58:29 INFO - Main Display: Yes 04:58:29 INFO - Mirror: Off 04:58:29 INFO - Online: Yes 04:58:29 INFO - Rotation: Supported 04:58:29 INFO - Return code: 0 04:58:29 INFO - Running post-action listener: _resource_record_post_action 04:58:29 INFO - Running post-run listener: _resource_record_post_run 04:58:30 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37971456; Write bytes: 696737280; Read time: 393; Write time: 2063 04:58:30 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 375654912; Write bytes: 369161728; Read time: 27969; Write time: 717 04:58:30 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 37017088; Write bytes: 300283904; Read time: 379; Write time: 1292 04:58:30 INFO - Running post-run listener: _upload_blobber_files 04:58:30 INFO - Blob upload gear active. 04:58:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:58:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:58:30 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:58:30 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:58:31 INFO - (blobuploader) - INFO - Open directory for files ... 04:58:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:58:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:58:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:32 INFO - (blobuploader) - INFO - Done attempting. 04:58:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:58:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:58:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:33 INFO - (blobuploader) - INFO - Done attempting. 04:58:33 INFO - (blobuploader) - INFO - Iteration through files over. 04:58:33 INFO - Return code: 0 04:58:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:58:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:58:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8b51cd0dd0e9b1e7eda663a9d7d3df5e0bc738bd2510974e5a9120043e4e8a753124248c4c3c1b1b14bc128572d1e4d104af0d96fdbb8c6507a3d98bceb91b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1047edd34958df07ac51a69bf0ae3ee46250973f8aab55587b35c8542d8164e362bc07899636472ee2a12841b2a426499a1d9be08bf31cc0d03aa67ad2ef68c"} 04:58:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:58:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:58:33 INFO - Contents: 04:58:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8b51cd0dd0e9b1e7eda663a9d7d3df5e0bc738bd2510974e5a9120043e4e8a753124248c4c3c1b1b14bc128572d1e4d104af0d96fdbb8c6507a3d98bceb91b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1047edd34958df07ac51a69bf0ae3ee46250973f8aab55587b35c8542d8164e362bc07899636472ee2a12841b2a426499a1d9be08bf31cc0d03aa67ad2ef68c"} 04:58:33 INFO - Running post-run listener: copy_logs_to_upload_dir 04:58:33 INFO - Copying logs to upload dir... 04:58:33 INFO - mkdir: /builds/slave/test/build/upload/logs 04:58:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.777049 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-20 04:58:33.310564) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 04:58:33.318195) ========= 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.MSipSu3pk2/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.8zAvwKHD4B/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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/Firefox/sha512/b8b51cd0dd0e9b1e7eda663a9d7d3df5e0bc738bd2510974e5a9120043e4e8a753124248c4c3c1b1b14bc128572d1e4d104af0d96fdbb8c6507a3d98bceb91b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1047edd34958df07ac51a69bf0ae3ee46250973f8aab55587b35c8542d8164e362bc07899636472ee2a12841b2a426499a1d9be08bf31cc0d03aa67ad2ef68c"} build_url:https://queue.taskcluster.net/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011086 build_url: 'https://queue.taskcluster.net/v1/task/SBg3ZURYTO6KfxlT0jvnLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8b51cd0dd0e9b1e7eda663a9d7d3df5e0bc738bd2510974e5a9120043e4e8a753124248c4c3c1b1b14bc128572d1e4d104af0d96fdbb8c6507a3d98bceb91b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1047edd34958df07ac51a69bf0ae3ee46250973f8aab55587b35c8542d8164e362bc07899636472ee2a12841b2a426499a1d9be08bf31cc0d03aa67ad2ef68c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 04:58:33.351783) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:58:33.352118) ========= 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.MSipSu3pk2/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.8zAvwKHD4B/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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.005036 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:58:33.404567) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 04:58:33.407923) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 04:58:33.408582) ========= ========= Total master_lag: 2.19 =========