builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0193 starttime: 1461649922.29 results: success (0) buildid: 20160425205003 builduid: 68a02e46d6d349f3b74437b25b685305 revision: 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 22:52:02.291702) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 22:52:02.292172) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 22:52:02.292447) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 22:52:02.319281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 22:52:02.319680) ========= 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.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-25 22:52:02-- 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% 193M=0s 2016-04-25 22:52:02 (193 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085429 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 22:52:02.427368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 22:52:02.427773) ========= 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.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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.027094 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 22:52:02.475976) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-25 22:52:02.476381) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-25 22:52:02,566 truncating revision to first 12 chars 2016-04-25 22:52:02,566 Setting DEBUG logging. 2016-04-25 22:52:02,566 attempt 1/10 2016-04-25 22:52:02,566 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5bbf2e7c2fc6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 22:52:04,725 unpacking tar archive at: mozilla-beta-5bbf2e7c2fc6/testing/mozharness/ program finished with exit code 0 elapsedTime=2.407700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-25 22:52:04.904182) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 22:52:04.904558) ========= script_repo_revision: 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 22:52:04.904969) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 22:52:04.911447) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 22:52:04.935172) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-25 22:52:04.935573) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 22:52:05 INFO - MultiFileLogger online at 20160425 22:52:05 in /builds/slave/test 22:52:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 22:52:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:52:05 INFO - {'append_to_log': False, 22:52:05 INFO - 'base_work_dir': '/builds/slave/test', 22:52:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:52:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:52:05 INFO - 'branch': 'Mozilla-Beta', 22:52:05 INFO - 'buildbot_json_path': 'buildprops.json', 22:52:05 INFO - 'config_files': ('talos/mac_config.py',), 22:52:05 INFO - 'default_actions': ('clobber', 22:52:05 INFO - 'read-buildbot-config', 22:52:05 INFO - 'download-and-extract', 22:52:05 INFO - 'populate-webroot', 22:52:05 INFO - 'create-virtualenv', 22:52:05 INFO - 'install', 22:52:05 INFO - 'run-tests'), 22:52:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:52:05 INFO - 'download_minidump_stackwalk': True, 22:52:05 INFO - 'download_symbols': 'ondemand', 22:52:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:52:05 INFO - 'tooltool.py': '/tools/tooltool.py', 22:52:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:52:05 INFO - '/tools/misc-python/virtualenv.py')}, 22:52:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:52:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:52:05 INFO - 'installer_path': 'installer.exe', 22:52:05 INFO - 'log_level': 'info', 22:52:05 INFO - 'log_name': 'talos', 22:52:05 INFO - 'log_to_console': True, 22:52:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:52:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:52:05 INFO - 'opt_config_files': (), 22:52:05 INFO - 'pip_index': False, 22:52:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:52:05 INFO - 'cmd': ('bash', 22:52:05 INFO - '-c', 22:52:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:52:05 INFO - 'enabled': True, 22:52:05 INFO - 'halt_on_failure': False, 22:52:05 INFO - 'name': 'check_screen_resolution'},), 22:52:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:52:05 INFO - 'cmd': ('bash', 22:52:05 INFO - '-c', 22:52:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:52:05 INFO - 'enabled': True, 22:52:05 INFO - 'halt_on_failure': False, 22:52:05 INFO - 'name': 'check_screen_resolution'},), 22:52:05 INFO - 'run_cmd_checks_enabled': True, 22:52:05 INFO - 'sps_profile': False, 22:52:05 INFO - 'sps_profile_interval': 0, 22:52:05 INFO - 'suite': 'dromaeojs-e10s', 22:52:05 INFO - 'system_bits': '32', 22:52:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:52:05 INFO - 'title': 't-yosemite-r7-0193', 22:52:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:52:05 INFO - 'use_talos_json': True, 22:52:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:52:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:52:05 INFO - 'work_dir': 'build'} 22:52:05 INFO - ##### 22:52:05 INFO - ##### Running clobber step. 22:52:05 INFO - ##### 22:52:05 INFO - Running pre-action listener: _resource_record_pre_action 22:52:05 INFO - Running main action method: clobber 22:52:05 INFO - rmtree: /builds/slave/test/build 22:52:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:52:06 INFO - Running post-action listener: _resource_record_post_action 22:52:06 INFO - ##### 22:52:06 INFO - ##### Running read-buildbot-config step. 22:52:06 INFO - ##### 22:52:06 INFO - Running pre-action listener: _resource_record_pre_action 22:52:06 INFO - Running main action method: read_buildbot_config 22:52:06 INFO - Using buildbot properties: 22:52:06 INFO - { 22:52:06 INFO - "project": "", 22:52:06 INFO - "product": "firefox", 22:52:06 INFO - "script_repo_revision": "production", 22:52:06 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 22:52:06 INFO - "repository": "", 22:52:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 22:52:06 INFO - "buildid": "20160425205003", 22:52:06 INFO - "pgo_build": "False", 22:52:06 INFO - "basedir": "/builds/slave/test", 22:52:06 INFO - "buildnumber": 5, 22:52:06 INFO - "slavename": "t-yosemite-r7-0193", 22:52:06 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 22:52:06 INFO - "platform": "yosemite_r7", 22:52:06 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 22:52:06 INFO - "branch": "mozilla-beta", 22:52:06 INFO - "repo_path": "releases/mozilla-beta", 22:52:06 INFO - "revision": "5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2", 22:52:06 INFO - "stage_platform": "macosx64", 22:52:06 INFO - "builduid": "68a02e46d6d349f3b74437b25b685305", 22:52:06 INFO - "slavebuilddir": "test" 22:52:06 INFO - } 22:52:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 22:52:06 INFO - Running post-action listener: _resource_record_post_action 22:52:06 INFO - ##### 22:52:06 INFO - ##### Running download-and-extract step. 22:52:06 INFO - ##### 22:52:06 INFO - Running pre-action listener: _resource_record_pre_action 22:52:06 INFO - Running main action method: download_and_extract 22:52:06 INFO - mkdir: /builds/slave/test/build/tests 22:52: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')]} 22:52:06 INFO - https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 22:52:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 22:52:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 22:52:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 22:52:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 22:52:08 INFO - Downloaded 1241 bytes. 22:52:08 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 22:52:08 INFO - Using the following test package requirements: 22:52:08 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 22:52:08 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 22:52:08 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 22:52:08 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 22:52:08 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 22:52:08 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 22:52:08 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 22:52:08 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 22:52:08 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 22:52:08 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 22:52:08 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 22:52:08 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 22:52:08 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 22:52:08 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 22:52:08 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 22:52:08 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 22:52:08 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 22:52:08 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 22:52:08 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 22:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:08 INFO - https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:52:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 22:52:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 22:52:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 22:52:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 22:52:10 INFO - Downloaded 17745664 bytes. 22:52:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:52:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:52:13 INFO - Return code: 0 22:52:13 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 22:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:13 INFO - https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:52:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 22:52:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 22:52:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 22:52:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 22:52:14 INFO - Downloaded 17745664 bytes. 22:52:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:52:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:52:17 INFO - Return code: 0 22:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:17 INFO - https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:52:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 22:52:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 22:52:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 22:52:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 22:52:18 INFO - Downloaded 10845194 bytes. 22:52:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:52:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 22:52:19 INFO - Return code: 0 22:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:19 INFO - https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 22:52:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 22:52:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 22:52:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 22:52:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 22:52:21 INFO - Downloaded 88299541 bytes. 22:52:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 22:52:21 INFO - mkdir: /builds/slave/test/properties 22:52:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:52:21 INFO - Writing to file /builds/slave/test/properties/build_url 22:52:21 INFO - Contents: 22:52:21 INFO - build_url:https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 22:52:22 INFO - Running post-action listener: _resource_record_post_action 22:52:22 INFO - Running post-action listener: set_extra_try_arguments 22:52:22 INFO - ##### 22:52:22 INFO - ##### Running populate-webroot step. 22:52:22 INFO - ##### 22:52:22 INFO - Running pre-action listener: _resource_record_pre_action 22:52:22 INFO - Running main action method: populate_webroot 22:52:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:52:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:52:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:52:22 INFO - '--tppagecycles', 22:52:22 INFO - '7'], 22:52:22 INFO - 'tests': ['tsvgm']}}, 22:52:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:52:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:52:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:52:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:52:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:52:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:52:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:52:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:22 INFO - 'talos_options': ['--e10s'], 22:52:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:52:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:22 INFO - 'tests': ['damp', 'tps']}, 22:52:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:22 INFO - 'talos_options': ['--e10s'], 22:52:22 INFO - 'tests': ['damp', 'tps']}, 22:52:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:52:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:52:22 INFO - 'other': {'tests': ['a11yr', 22:52:22 INFO - 'ts_paint', 22:52:22 INFO - 'tpaint', 22:52:22 INFO - 'sessionrestore', 22:52:22 INFO - 'sessionrestore_no_auto_restore', 22:52:22 INFO - 'tabpaint']}, 22:52:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:52:22 INFO - 'tests': ['a11yr', 22:52:22 INFO - 'ts_paint', 22:52:22 INFO - 'tpaint', 22:52:22 INFO - 'sessionrestore', 22:52:22 INFO - 'sessionrestore_no_auto_restore', 22:52:22 INFO - 'tabpaint']}, 22:52:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:52:22 INFO - 'tests': ['a11yr', 22:52:22 INFO - 'ts_paint', 22:52:22 INFO - 'tpaint', 22:52:22 INFO - 'sessionrestore', 22:52:22 INFO - 'sessionrestore_no_auto_restore', 22:52:22 INFO - 'tabpaint']}, 22:52:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:52:22 INFO - 'tests': ['a11yr', 22:52:22 INFO - 'ts_paint', 22:52:22 INFO - 'tpaint', 22:52:22 INFO - 'sessionrestore', 22:52:22 INFO - 'sessionrestore_no_auto_restore', 22:52:22 INFO - 'tabpaint']}, 22:52:22 INFO - 'other_l64': {'tests': ['a11yr', 22:52:22 INFO - 'ts_paint', 22:52:22 INFO - 'tpaint', 22:52:22 INFO - 'sessionrestore', 22:52:22 INFO - 'sessionrestore_no_auto_restore', 22:52:22 INFO - 'tabpaint']}, 22:52:22 INFO - 'other_nol64': {'tests': ['a11yr', 22:52:22 INFO - 'ts_paint', 22:52:22 INFO - 'tpaint', 22:52:22 INFO - 'sessionrestore', 22:52:22 INFO - 'sessionrestore_no_auto_restore', 22:52:22 INFO - 'tabpaint']}, 22:52:22 INFO - 'svgr': {'tests': ['tsvgx', 22:52:22 INFO - 'tsvgr_opacity', 22:52:22 INFO - 'tart', 22:52:22 INFO - 'tscrollx', 22:52:22 INFO - 'cart']}, 22:52:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:52:22 INFO - 'tests': ['tsvgx', 22:52:22 INFO - 'tsvgr_opacity', 22:52:22 INFO - 'tart', 22:52:22 INFO - 'tscrollx', 22:52:22 INFO - 'cart']}, 22:52:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:22 INFO - 'tests': ['tp5o']}, 22:52:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:22 INFO - 'talos_options': ['--e10s'], 22:52:22 INFO - 'tests': ['tp5o']}, 22:52:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:22 INFO - 'talos_options': ['--xperf_path', 22:52:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:52:22 INFO - 'tests': ['tp5n']}, 22:52:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:22 INFO - 'talos_options': ['--e10s', 22:52:22 INFO - '--xperf_path', 22:52:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:52:22 INFO - 'tests': ['tp5n']}}, 22:52:22 INFO - 'talos.zip': {'path': '', 22:52:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:52:22 INFO - Running post-action listener: _resource_record_post_action 22:52:22 INFO - ##### 22:52:22 INFO - ##### Running create-virtualenv step. 22:52:22 INFO - ##### 22:52:22 INFO - Running pre-action listener: _resource_record_pre_action 22:52:22 INFO - Running main action method: create_virtualenv 22:52:22 INFO - Creating virtualenv /builds/slave/test/build/venv 22:52:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:52:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:52:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:52:22 INFO - Using real prefix '/tools/python27' 22:52:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:52:23 INFO - Installing distribute.............................................................................................................................................................................................done. 22:52:26 INFO - Installing pip.................done. 22:52:26 INFO - Return code: 0 22:52:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:26 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 0x106caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cb24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadca5de160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b4fd30>, '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 0x1069b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b46b20>, '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.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:52:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hhKEjvSz4/Render', 22:52:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:52:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:52:26 INFO - 'HOME': '/Users/cltbld', 22:52:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:52:26 INFO - 'LOGNAME': 'cltbld', 22:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:26 INFO - 'MOZ_NO_REMOTE': '1', 22:52:26 INFO - 'NO_EM_RESTART': '1', 22:52:26 INFO - 'PAGER': '/bin/cat', 22:52:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:26 INFO - 'PWD': '/builds/slave/test', 22:52:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:52:26 INFO - 'SHELL': '/bin/bash', 22:52:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7jvX0O0Vs8/Listeners', 22:52:26 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 22:52:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:52:26 INFO - 'USER': 'cltbld', 22:52:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:52:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:26 INFO - 'XPC_FLAGS': '0x0', 22:52:26 INFO - 'XPC_SERVICE_NAME': '0', 22:52:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:52:26 INFO - Cleaning up... 22:52:26 INFO - Return code: 0 22:52:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:26 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 0x106caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cb24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadca5de160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b4fd30>, '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 0x1069b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b46b20>, '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.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:52:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hhKEjvSz4/Render', 22:52:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:52:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:52:26 INFO - 'HOME': '/Users/cltbld', 22:52:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:52:26 INFO - 'LOGNAME': 'cltbld', 22:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:26 INFO - 'MOZ_NO_REMOTE': '1', 22:52:26 INFO - 'NO_EM_RESTART': '1', 22:52:26 INFO - 'PAGER': '/bin/cat', 22:52:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:26 INFO - 'PWD': '/builds/slave/test', 22:52:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:52:26 INFO - 'SHELL': '/bin/bash', 22:52:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7jvX0O0Vs8/Listeners', 22:52:26 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 22:52:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:52:26 INFO - 'USER': 'cltbld', 22:52:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:52:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:26 INFO - 'XPC_FLAGS': '0x0', 22:52:26 INFO - 'XPC_SERVICE_NAME': '0', 22:52:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:26 INFO - Downloading/unpacking psutil>=0.7.1 22:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:52:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:52:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:52:29 INFO - Installing collected packages: psutil 22:52:29 INFO - Running setup.py install for psutil 22:52:29 INFO - building 'psutil._psutil_osx' extension 22:52:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 22:52:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 22:52:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 22:52:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 22:52:30 INFO - building 'psutil._psutil_posix' extension 22:52:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 22:52:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:52:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:52:30 INFO - ^ 22:52:30 INFO - 1 warning generated. 22:52:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 22:52:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:52:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:52:30 INFO - Successfully installed psutil 22:52:30 INFO - Cleaning up... 22:52:30 INFO - Return code: 0 22:52:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:52: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')]} 22:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52: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')]} 22:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:30 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 0x106caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cb24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadca5de160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b4fd30>, '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 0x1069b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b46b20>, '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.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:52:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hhKEjvSz4/Render', 22:52:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:52:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:52:30 INFO - 'HOME': '/Users/cltbld', 22:52:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:52:30 INFO - 'LOGNAME': 'cltbld', 22:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:30 INFO - 'MOZ_NO_REMOTE': '1', 22:52:30 INFO - 'NO_EM_RESTART': '1', 22:52:30 INFO - 'PAGER': '/bin/cat', 22:52:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:30 INFO - 'PWD': '/builds/slave/test', 22:52:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:52:30 INFO - 'SHELL': '/bin/bash', 22:52:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7jvX0O0Vs8/Listeners', 22:52:30 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 22:52:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:52:30 INFO - 'USER': 'cltbld', 22:52:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:52:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:30 INFO - 'XPC_FLAGS': '0x0', 22:52:30 INFO - 'XPC_SERVICE_NAME': '0', 22:52:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:52:33 INFO - Installing collected packages: mozsystemmonitor 22:52:33 INFO - Running setup.py install for mozsystemmonitor 22:52:33 INFO - Successfully installed mozsystemmonitor 22:52:33 INFO - Cleaning up... 22:52:33 INFO - Return code: 0 22:52:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:33 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 0x106caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cb24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadca5de160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b4fd30>, '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 0x1069b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b46b20>, '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.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:52:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:52:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hhKEjvSz4/Render', 22:52:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:52:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:52:33 INFO - 'HOME': '/Users/cltbld', 22:52:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:52:33 INFO - 'LOGNAME': 'cltbld', 22:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:33 INFO - 'MOZ_NO_REMOTE': '1', 22:52:33 INFO - 'NO_EM_RESTART': '1', 22:52:33 INFO - 'PAGER': '/bin/cat', 22:52:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:33 INFO - 'PWD': '/builds/slave/test', 22:52:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:52:33 INFO - 'SHELL': '/bin/bash', 22:52:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7jvX0O0Vs8/Listeners', 22:52:33 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 22:52:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:52:33 INFO - 'USER': 'cltbld', 22:52:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:52:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:33 INFO - 'XPC_FLAGS': '0x0', 22:52:33 INFO - 'XPC_SERVICE_NAME': '0', 22:52:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:33 INFO - Downloading/unpacking blobuploader==1.2.4 22:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:36 INFO - Downloading blobuploader-1.2.4.tar.gz 22:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:52:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:52:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:37 INFO - Downloading docopt-0.6.1.tar.gz 22:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:52:37 INFO - Installing collected packages: blobuploader, requests, docopt 22:52:37 INFO - Running setup.py install for blobuploader 22:52:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:52:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:52:37 INFO - Running setup.py install for requests 22:52:38 INFO - Running setup.py install for docopt 22:52:38 INFO - Successfully installed blobuploader requests docopt 22:52:38 INFO - Cleaning up... 22:52:38 INFO - Return code: 0 22:52:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:38 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 0x106caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cb24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadca5de160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b4fd30>, '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 0x1069b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b46b20>, '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.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:52:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hhKEjvSz4/Render', 22:52:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:52:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:52:38 INFO - 'HOME': '/Users/cltbld', 22:52:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:52:38 INFO - 'LOGNAME': 'cltbld', 22:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:38 INFO - 'MOZ_NO_REMOTE': '1', 22:52:38 INFO - 'NO_EM_RESTART': '1', 22:52:38 INFO - 'PAGER': '/bin/cat', 22:52:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:38 INFO - 'PWD': '/builds/slave/test', 22:52:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:52:38 INFO - 'SHELL': '/bin/bash', 22:52:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7jvX0O0Vs8/Listeners', 22:52:38 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 22:52:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:52:38 INFO - 'USER': 'cltbld', 22:52:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:52:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:38 INFO - 'XPC_FLAGS': '0x0', 22:52:38 INFO - 'XPC_SERVICE_NAME': '0', 22:52:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:52:38 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-ZccaSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:52:38 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-bnGuOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:52:39 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-IvnZVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:52:39 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-QWnlKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:52:39 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-rXTCbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:52:39 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-83KMHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:52:39 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-XLT5GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:52:39 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-UashA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:52:39 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-TnGLKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:52:39 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-F7IZBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:52:39 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-jjvtX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:52:39 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-kUIGVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:52:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-ETuXcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:52:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-crrZEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:52:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-LMl8xO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:52:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-MweEcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:52:40 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-r7sX2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:52:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:52:40 INFO - Running setup.py install for manifestparser 22:52:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:52:40 INFO - Running setup.py install for mozcrash 22:52:40 INFO - Running setup.py install for mozdebug 22:52:41 INFO - Running setup.py install for mozdevice 22:52:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:52:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:52:41 INFO - Running setup.py install for mozfile 22:52:41 INFO - Running setup.py install for mozhttpd 22:52:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:52:41 INFO - Running setup.py install for mozinfo 22:52:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:52:41 INFO - Running setup.py install for mozInstall 22:52:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:52:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:52:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:52:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:52:41 INFO - Running setup.py install for mozleak 22:52:41 INFO - Running setup.py install for mozlog 22:52:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:52:42 INFO - Running setup.py install for moznetwork 22:52:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:52:42 INFO - Running setup.py install for mozprocess 22:52:42 INFO - Running setup.py install for mozprofile 22:52:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:52:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:52:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:52:42 INFO - Running setup.py install for mozrunner 22:52:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:52:42 INFO - Running setup.py install for mozscreenshot 22:52:42 INFO - Running setup.py install for moztest 22:52:43 INFO - Running setup.py install for mozversion 22:52:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:52:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:52:43 INFO - Cleaning up... 22:52:43 INFO - Return code: 0 22:52:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:43 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 0x106caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cb24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadca5de160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b4fd30>, '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 0x1069b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b46b20>, '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.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:52:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hhKEjvSz4/Render', 22:52:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:52:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:52:43 INFO - 'HOME': '/Users/cltbld', 22:52:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:52:43 INFO - 'LOGNAME': 'cltbld', 22:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:43 INFO - 'MOZ_NO_REMOTE': '1', 22:52:43 INFO - 'NO_EM_RESTART': '1', 22:52:43 INFO - 'PAGER': '/bin/cat', 22:52:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:43 INFO - 'PWD': '/builds/slave/test', 22:52:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:52:43 INFO - 'SHELL': '/bin/bash', 22:52:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7jvX0O0Vs8/Listeners', 22:52:43 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 22:52:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:52:43 INFO - 'USER': 'cltbld', 22:52:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:52:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:43 INFO - 'XPC_FLAGS': '0x0', 22:52:43 INFO - 'XPC_SERVICE_NAME': '0', 22:52:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:52:43 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-EAtEKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:52:43 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-uF8OY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:52:43 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-yOF6yM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:52:43 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-FwF2FW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:52:43 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-XXEVTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:52:43 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-XMuS0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:52:44 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-7Fd54L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:52:44 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-bE7DXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:52:44 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-I9xJMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:52:44 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-ZlRJN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:52:44 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-DD4jLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:52:44 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-WIn95G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:52:44 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-8xH2Ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:52:44 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-lcOiCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:52:44 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-5ul2el-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:52:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:52:45 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-Y86XxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:52:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:52:45 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-jxgpyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:52:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:52:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:52:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:52:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:52:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:52:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:52:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:47 INFO - Downloading blessings-1.6.tar.gz 22:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:52:47 INFO - Installing collected packages: blessings 22:52:47 INFO - Running setup.py install for blessings 22:52:47 INFO - Successfully installed blessings 22:52:47 INFO - Cleaning up... 22:52:48 INFO - Return code: 0 22:52:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:52:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:52:48 INFO - Reading from file tmpfile_stdout 22:52:48 INFO - Current package versions: 22:52:48 INFO - blessings == 1.6 22:52:48 INFO - blobuploader == 1.2.4 22:52:48 INFO - docopt == 0.6.1 22:52:48 INFO - manifestparser == 1.1 22:52:48 INFO - mozInstall == 1.12 22:52:48 INFO - mozcrash == 0.17 22:52:48 INFO - mozdebug == 0.1 22:52:48 INFO - mozdevice == 0.48 22:52:48 INFO - mozfile == 1.2 22:52:48 INFO - mozhttpd == 0.7 22:52:48 INFO - mozinfo == 0.9 22:52:48 INFO - mozleak == 0.1 22:52:48 INFO - mozlog == 3.1 22:52:48 INFO - moznetwork == 0.27 22:52:48 INFO - mozprocess == 0.22 22:52:48 INFO - mozprofile == 0.28 22:52:48 INFO - mozrunner == 6.11 22:52:48 INFO - mozscreenshot == 0.1 22:52:48 INFO - mozsystemmonitor == 0.0 22:52:48 INFO - moztest == 0.7 22:52:48 INFO - mozversion == 1.4 22:52:48 INFO - psutil == 3.1.1 22:52:48 INFO - requests == 1.2.3 22:52:48 INFO - wsgiref == 0.1.2 22:52:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:48 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 0x106caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cb24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadca5de160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b4fd30>, '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 0x1069b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b46b20>, '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.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:52:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:52:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hhKEjvSz4/Render', 22:52:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:52:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:52:48 INFO - 'HOME': '/Users/cltbld', 22:52:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:52:48 INFO - 'LOGNAME': 'cltbld', 22:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:48 INFO - 'MOZ_NO_REMOTE': '1', 22:52:48 INFO - 'NO_EM_RESTART': '1', 22:52:48 INFO - 'PAGER': '/bin/cat', 22:52:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:48 INFO - 'PWD': '/builds/slave/test', 22:52:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:52:48 INFO - 'SHELL': '/bin/bash', 22:52:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7jvX0O0Vs8/Listeners', 22:52:48 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 22:52:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:52:48 INFO - 'USER': 'cltbld', 22:52:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:52:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:48 INFO - 'XPC_FLAGS': '0x0', 22:52:48 INFO - 'XPC_SERVICE_NAME': '0', 22:52:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:52:48 INFO - Cleaning up... 22:52:48 INFO - Return code: 0 22:52:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cb24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadca5de160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b4fd30>, '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 0x1069b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b46b20>, '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.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:52:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:52:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hhKEjvSz4/Render', 22:52:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:52:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:52:48 INFO - 'HOME': '/Users/cltbld', 22:52:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:52:48 INFO - 'LOGNAME': 'cltbld', 22:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:48 INFO - 'MOZ_NO_REMOTE': '1', 22:52:48 INFO - 'NO_EM_RESTART': '1', 22:52:48 INFO - 'PAGER': '/bin/cat', 22:52:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:48 INFO - 'PWD': '/builds/slave/test', 22:52:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:52:48 INFO - 'SHELL': '/bin/bash', 22:52:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7jvX0O0Vs8/Listeners', 22:52:48 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 22:52:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:52:48 INFO - 'USER': 'cltbld', 22:52:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:52:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:48 INFO - 'XPC_FLAGS': '0x0', 22:52:48 INFO - 'XPC_SERVICE_NAME': '0', 22:52:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:48 INFO - Downloading/unpacking jsonschema 22:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:52:51 INFO - Downloading/unpacking functools32 (from jsonschema) 22:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:51 INFO - Downloading functools32-3.2.3-2.tar.gz 22:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:52:51 INFO - warning: no files found matching '*.txt' 22:52:51 INFO - no previously-included directories found matching 'build' 22:52:51 INFO - no previously-included directories found matching 'dist' 22:52:51 INFO - no previously-included directories found matching '.git*' 22:52:51 INFO - Installing collected packages: jsonschema, functools32 22:52:51 INFO - Running setup.py install for functools32 22:52:51 INFO - warning: no files found matching '*.txt' 22:52:51 INFO - no previously-included directories found matching 'build' 22:52:51 INFO - no previously-included directories found matching 'dist' 22:52:51 INFO - no previously-included directories found matching '.git*' 22:52:51 INFO - Successfully installed jsonschema functools32 22:52:51 INFO - Cleaning up... 22:52:52 INFO - Return code: 0 22:52:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:52 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 0x106caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cb24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadca5de160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b4fd30>, '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 0x1069b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b46b20>, '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.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:52:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hhKEjvSz4/Render', 22:52:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:52:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:52:52 INFO - 'HOME': '/Users/cltbld', 22:52:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:52:52 INFO - 'LOGNAME': 'cltbld', 22:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:52 INFO - 'MOZ_NO_REMOTE': '1', 22:52:52 INFO - 'NO_EM_RESTART': '1', 22:52:52 INFO - 'PAGER': '/bin/cat', 22:52:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:52 INFO - 'PWD': '/builds/slave/test', 22:52:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:52:52 INFO - 'SHELL': '/bin/bash', 22:52:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7jvX0O0Vs8/Listeners', 22:52:52 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 22:52:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:52:52 INFO - 'USER': 'cltbld', 22:52:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:52:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:52 INFO - 'XPC_FLAGS': '0x0', 22:52:52 INFO - 'XPC_SERVICE_NAME': '0', 22:52:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:52 INFO - Downloading/unpacking flake8 22:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:52:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:52:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:52:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:52:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:52:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:52:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:52:55 INFO - no previously-included directories found matching 'docs/_build' 22:52:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:52:56 INFO - Running setup.py install for pep8 22:52:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:52:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:52:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:52:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:52:56 INFO - no previously-included directories found matching 'docs/_build' 22:52:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:52:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:52:56 INFO - Cleaning up... 22:52:56 INFO - Return code: 0 22:52:56 INFO - Running post-action listener: _resource_record_post_action 22:52:56 INFO - Running post-action listener: _start_resource_monitoring 22:52:56 INFO - Starting resource monitoring. 22:52:56 INFO - ##### 22:52:56 INFO - ##### Running install step. 22:52:56 INFO - ##### 22:52:56 INFO - Running pre-action listener: _resource_record_pre_action 22:52:56 INFO - Running main action method: install 22:52:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:52:56 INFO - Reading from file tmpfile_stdout 22:52:56 INFO - Detecting whether we're running mozinstall >=1.0... 22:52:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:52:56 INFO - Reading from file tmpfile_stdout 22:52:56 INFO - Output received: 22:52:56 INFO - Usage: mozinstall [options] installer 22:52:56 INFO - Options: 22:52:56 INFO - -h, --help show this help message and exit 22:52:56 INFO - -d DEST, --destination=DEST 22:52:56 INFO - Directory to install application into. [default: 22:52:56 INFO - "/builds/slave/test"] 22:52:56 INFO - --app=APP Application being installed. [default: firefox] 22:52:56 INFO - mkdir: /builds/slave/test/build/application 22:52:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 22:53:19 INFO - Reading from file tmpfile_stdout 22:53:19 INFO - Output received: 22:53:19 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 22:53:19 INFO - Running post-action listener: _resource_record_post_action 22:53:19 INFO - ##### 22:53:19 INFO - ##### Running run-tests step. 22:53:19 INFO - ##### 22:53:19 INFO - Running pre-action listener: _resource_record_pre_action 22:53:19 INFO - Running main action method: run_tests 22:53:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:53:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:53:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:53:19 INFO - 2016-04-25 22:53:19.607 screenresolution[1644:7515] starting screenresolution argv=screenresolution get 22:53:19 INFO - 2016-04-25 22:53:19.610 screenresolution[1644:7515] Display 0: 1600x1200x32@60 22:53:19 INFO - 2016-04-25 22:53:19.616 screenresolution[1645:7517] starting screenresolution argv=screenresolution list 22:53:19 INFO - Available Modes on Display 0 22:53:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:53:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:53:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:53:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:53:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:53:19 INFO - Intel Iris: 22:53:19 INFO - Chipset Model: Intel Iris 22:53:19 INFO - Type: GPU 22:53:19 INFO - Bus: Built-In 22:53:19 INFO - VRAM (Dynamic, Max): 1536 MB 22:53:19 INFO - Vendor: Intel (0x8086) 22:53:19 INFO - Device ID: 0x0a2e 22:53:19 INFO - Revision ID: 0x0009 22:53:19 INFO - Displays: 22:53:19 INFO - Display: 22:53:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:53:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:53:19 INFO - Display Serial Number: 1600x1200 60 22:53:19 INFO - Main Display: Yes 22:53:19 INFO - Mirror: Off 22:53:19 INFO - Online: Yes 22:53:19 INFO - Rotation: Supported 22:53:19 INFO - Return code: 0 22:53:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:53:19 INFO - Python 2.7.3 22:53:19 INFO - Return code: 0 22:53:19 INFO - grabbing minidump binary from tooltool 22:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:19 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 0x106b4fd30>, '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 0x1069b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b46b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:53:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:53:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 22:53:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:53:19 INFO - Return code: 0 22:53:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:53:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:53:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:53:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:53:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:53:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:53:21 INFO - Return code: 0 22:53:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0193', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0193 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:53:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hhKEjvSz4/Render', 22:53:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:53:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:53:21 INFO - 'HOME': '/Users/cltbld', 22:53:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:53:21 INFO - 'LOGNAME': 'cltbld', 22:53:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:53:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:21 INFO - 'MOZ_NO_REMOTE': '1', 22:53:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:53:21 INFO - 'NO_EM_RESTART': '1', 22:53:21 INFO - 'PAGER': '/bin/cat', 22:53:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:21 INFO - 'PWD': '/builds/slave/test', 22:53:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:53:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:53:21 INFO - 'SHELL': '/bin/bash', 22:53:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7jvX0O0Vs8/Listeners', 22:53:21 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 22:53:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:53:21 INFO - 'USER': 'cltbld', 22:53:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:53:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:21 INFO - 'XPC_FLAGS': '0x0', 22:53:21 INFO - 'XPC_SERVICE_NAME': '0', 22:53:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:53:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0193', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:53:21 INFO - mozversion application_buildid: 20160425205003 22:53:21 INFO - mozversion application_changeset: 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 22:53:21 INFO - mozversion application_display_name: Firefox 22:53:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:53:21 INFO - mozversion application_name: Firefox 22:53:21 INFO - mozversion application_remotingname: firefox 22:53:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:53:21 INFO - mozversion application_vendor: Mozilla 22:53:21 INFO - mozversion application_version: 47.0 22:53:21 INFO - mozversion platform_buildid: 20160425205003 22:53:21 INFO - mozversion platform_changeset: 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 22:53:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:53:21 INFO - mozversion platform_version: 47.0 22:53:21 INFO - using testdate: 1461650001 22:53:21 INFO - actual date: 1461650001 22:53:21 INFO - starting webserver on 'localhost:49279' 22:53:21 INFO - SUITE-START | Running 2 tests 22:53:21 INFO - TEST-START | dromaeo_css 22:53:21 INFO - operating with platform_type : mac_ 22:53:21 INFO - Initialising browser for dromaeo_css test... 22:53:21 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpnNO83Q/profile http://localhost:49279/getInfo.html) 22:53:24 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 22:53:24 INFO - PROCESS | 1663 | colorDepth:24 22:53:24 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 22:53:24 INFO - PROCESS | 1663 | __metrics 22:53:24 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 22:53:24 INFO - TEST-INFO | 1663: exit 0 22:53:24 INFO - Browser initialized. 22:53:24 INFO - Running cycle 1/1 for dromaeo_css test... 22:53:24 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpnNO83Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:53:36 INFO - PROCESS | 1667 | RSS: Main: 168218624 22:53:36 INFO - PROCESS | 1667 | 22:54:26 INFO - PROCESS | 1667 | 1461650066236 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] 22:56:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 22:56:37 INFO - PROCESS | 1667 | RSS: Main: 178225152 22:56:37 INFO - PROCESS | 1667 | 22:59:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 22:59:40 INFO - PROCESS | 1667 | RSS: Main: 190136320 22:59:40 INFO - PROCESS | 1667 | 23:02:42 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 23:02:42 INFO - PROCESS | 1667 | RSS: Main: 192528384 23:02:42 INFO - PROCESS | 1667 | 23:05:44 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 23:05:44 INFO - PROCESS | 1667 | RSS: Main: 195899392 23:05:44 INFO - PROCESS | 1667 | 23:08:47 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 23:08:48 INFO - PROCESS | 1667 | RSS: Main: 195063808 23:08:48 INFO - PROCESS | 1667 | 23:11:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 23:11:50 INFO - PROCESS | 1667 | RSS: Main: 199905280 23:11:50 INFO - PROCESS | 1667 | 23:11:50 INFO - PROCESS | 1667 | __start_tp_report 23:11:50 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 23:11:50 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 23:11:50 INFO - PROCESS | 1667 | |i|pagename|runs| 23:11:50 INFO - PROCESS | 1667 | |0;dojo.html;3564.9821750891247;3674.0814796300942;3694.6120657331;3722.7766334019943;3723.9627603723957;4610.492845786961;5750.511206547449;5940.851478713029;5961.970190149049;5965.224520812294;5881.088431293146;5930.822075337746;5937.317208521022;5969.671668058255;5993.071073983529;4456.79944402501;5359.330083739543;5407.242985981966;5414.972925135369;5436.429174936634;5328.8401347959625;5408.107662235727;5427.782888684448;5444.91832622511;5449.073657478219;5328.49379308965;5408.864778380533;5458.344998600153;5459.290292262001;5472.5621950243885;5382.327209098863;5411.864703382407;5418.783248670068;5425.213344065108;5431.21247419122;4582.427196600425;5080.704420372818;5200.557952573998;5288.074586947308;5297.099493086146;5696.857578560528;5768.3654797972185;5809.157672137559;5830.183774271605;5900.380460051719;6190.628562286232;6246.750129994794;6265.530085243625;6267.279262884781;6354.269259035178;5431.456854314576;6160.6611636359985;6170.321264660884;6299.212598425197;6327.905081423783;5055.51972562606;6077.6353418795015;6083.726232319512;6094.939050609526;6110.052941794029;6405.551611387252;6452.257990331078;6462.579932304385;6472.288048314682;6476.125723027331;6135.04893764628;6153.384661533811;6195.783147589903;6249.312575616678;6264.812055638338;6278.434940855253;6283.497320214372;6283.905741413882;6284.151639528696;6310.305866354697;6140.074827791203;6166.81499555014;6210.813675589739;6229.4393504583895;6251.9687401563615;6180.783672571439;6222.471089957314;6223.37766223374;6252.280987686383;6254.437100660963;4981.950180498221;5008.624353173526;5031.169856973558;5031.169856973558;5041.647084704109;4380.145871555016;4466;4539.500654927955;4565.20108980927;4570.977145114253;5965.6718880461995;6068.4841788448475;6069.3627169147485;6167.537434692416;6188.81433556994;6251.874962500725;6314.810555683337;6325.272593651697;6334.588251763621;6336.556441049082;5270.226737702887;5960.731767070492;6146.770645870754;6167.814965551041;6179.81460556184;5543.2793736814765;5562.360328562187;5576.442355764391;5586.720663966786;5626.971865140648;6553.770618028441;6577.375149360803;6599.109120268702;6606.504512161607;6634.767783127568;6146.0473626587955;6250.9062364065485;6284.151639528605;6325.177726895474;6329.90505142414;6511.3163117871945;6534.934650653623;6542.084108224757;6546.967265163834;6591.670416479253;6263.749450021948;6265.122882796321;6266.686665666607;6267.6866156692895;6283.937160628335;6180.598261113013;6243.656598887105;6278.497720182466;6287;6293.748250070129;6197.03945888388;6203.782867599793;6222.937770622417;6232.283287421823;6264.749410023548;5999.370066143167;6226.968865155645;6232.688365581794;6236;6241.96879015602;4969.503049695001;5563.9150365679925;6137.570370074052;6138.1713468681155;6156.322804491592;5715.971420143039;6170.629762214281;6194.4115309045565;6196.845078873064;6198.504119670506;4931.334269873664;6196.566240363131;6228.408301211378;6235.688215589294;6239.875202496016 23:11:50 INFO - PROCESS | 1667 | |1;ext.html;482.65972489394983;546.61463668114;584.7018020809386;678.5521555773189;683.4464084091886;27727.445451090967;39534.80232598836;39910;39966;40155.99610009751;38458.80770596143;38811.223775524544;42093.78953105238;42453;42456.57543424565;9722.902770972289;9905.356151850106;9907.157891579225;9925.950370248138;9934.105930466256;9655.903440965605;9975.800483990351;9975.90024099757;9989.100980911717;9996.650117245897;9958.751031224241;10059.34614250075;10061.044200800912;10061.849072263922;10069.345492542998;9908.900910990906;10009.399436033862;10016.849747253797;10026.097651211354;10043.19654427644;9764.218862490983;9914.702558923243;9917;9930.957249488843;9957;35249.94250172499;41603.7919810402;41656.58343416557;41740;42143.36784948228;3212.678732126792;3548.946765798515;3562.6437356264423;3955.2287303975736;4065.146319272956;24231.7884105794;27895.023674171305;28404.431911361862;28417.85791071052;29110.708892911225;2747.986260068687;2789.1493094606135;2791.4277573097465;2802.14534566957;2838.0634390651035;321445;321817;322433.3878330617;322434;323585.76414236025;49338.75330623324;50057.24914126291;71407;71563;71704;47736.761316193195;47902.760486197345;47906.520934790904;47946.80132996633;48008;17226;17322.874013189103;17385.956842589487;17407.82592174062;17476.300947962194;13999.650008749659;14073.2963351832;14139.434422623186;14145.717085658434;14161.150330980174;15252.313645885963;15311.846881531264;15610.531684049496;15762.684746305009;15882;6658.667066646648;6773.424258938046;6823.089534930227;6829;6834.350736680008;929.1869614087539;929.972100836976;1038.958441662325;1073.5974009746344;1217.829503869459;30329;30686.846565767028;30694.870692671364;30963.91626293069;31178.532322015188;1136.5169802833764;1145.8796826333114;1152.8674202466657;1186.9436201780422;1196.1447564991074;15660.646151087478;15720.60698482547;16087.276072576762;16123.596910077107;16332.428365007405;551516;556145;560132;560602;561595;63323.36676633267;64384.678076609314;64451.03323450152;64754.67622661857;64861.35138648647;1553.8989965652197;1571.3871590079877;1576.9211539422984;1592.7053495103444;1595.5612206643266;25309.74690253074;30964.380712386075;31109.533357000117;31294;31782.68217317797;55543.33369998907;55650;55813.72093139508;56024;56043.71978140083;443601;443966;445568;524191;524393.3780331074;34295.485567717005;35753.1061723459;36115.277694446486;46181.30728039149;46899.765501172275;44569.55430445784;45477;46198.769006154755;46671.29993050039;47098.82252943567;30997.225069373446;35941.46128073274;36912.44631330478;37898.810505947295;38687.806560967016;31457.370852583277;37456.625433746405;37491;37574;38030;34329.48505772366;34515.96452106441;39057.6094239054;39475.60524394719;39866;31372.843135784176;32766.67233327636;32786.508202376506;32875.835620821745;33150.5027424584;25567.87216063908;25725;25790.45874482367;26241.868790655924;26250.081247156257 23:11:50 INFO - PROCESS | 1667 | |2;jquery.html;365.9103519637689;371.1111887030561;373.10082700691333;377.658219311523;381.21089345055714;20366.389008329737;21443.785562144374;22050.33848984533;22612.54774904501;22620.43448913776;22018.88990555049;22052.007659655315;22162.556748865012;22205.333839984785;22384.55230895381;5847.473727364558;5850.268716410459;6027.793174439783;6099;6113.23584551931;5871;5933.288005439354;5944.702764861761;5966.582339236255;5976.2230909981645;5691.260136182291;5944.9108263375865;5948.167256584082;5987.161797348374;5994.730237139339;5937.435943585352;5963.642181469126;5984.820455386367;5987.820365389045;6009.5192384609345;5080.847574572768;5205.7397130143345;5217.034848553029;5220.138677118309;5249.527542521191;22068.448288792748;26867.46265074707;27127.593086103723;27488;27612.309692257655;2176.379731776436;2199.164317559333;2200.8899555022185;2473.7155227148746;2977.568252603382;15308.311125999357;15331.923340383339;15477.845221547754;15604.531864044096;15935;1839.45736007878;1851.046710943865;1905.5998240369538;1906.3708976037874;1931.9227230910747;83940.06209782629;91978;100763.48854767258;105620.1849958856;110796.4460177702;10772.138228941665;11065.375905233588;11082.501287442085;11117.499712512956;11145.944270278758;13434.865651343556;13521.391537380645;13666;13692.726145477034;13705.314734263247;9056.36605437613;9150.130737579919;9217.63129474827;9218.953905230432;9267.44395336282;7936;9520.381175223589;9635.13283804461;9636.662716804878;9686.418814870989;6306.369363063657;6329.113924050636;6336.778212762531;6354.523410744213;6363.936360636427;1625.9349626015064;1887.8395336396286;1907.628012537542;1911.550785565391;1918.5299601597699;954.665866946577;998.4957596413765;1056.0548309263168;1096.0354887698775;1158.6204148319366;18122.637547249244;21395.358139255848;22087.116515339207;22226;22373.216937407113;1053.994730026345;1082.9458527073614;1086.3481910853582;1095.6986828622194;1113.432149603708;11535.711607209887;11693.048726865813;11758.706032349088;11851.525938962344;11902.523899044114;647485;650326;656297;717980;730406;70942.58114837675;106795;110810;110821;111279.44360278147;1110.189561620022;1111.2110401614782;1118.72031992002;1125.4147843121532;1128.0580715102817;16380.590485237964;18581.25674972986;19007.239710411428;19356.90321548383;19547.902260488605;47875;48793;49861.501384985684;50345.99308013746;51311;71943;72057;72385.27614723785;73911.2608873926;78074;8117.553534555656;8216.83566328682;8239.299659529008;8435.746927592181;8477.491350518989;11150.832737508781;12471.750564988468;13613.727725445238;13803.964702647141;14141.858581414053;10256.948715256376;11679.591214307458;11759.647210583697;11796.882031179579;12107.818382724443;11525.769484610428;11735.530578777094;11924.523019079139;11932.403379830801;11972.940135299268;10931.18016148776;11305;11848.70378240551;12180.512779488721;12287.87712122903;8353.498790072616;8362.832743344978;8372.581370931552;8445.662173513236;8534.957325213583;10471.842922356018;12054.578089766816;12150.270983740651;12219.51121955112;12333.753324933272 23:11:50 INFO - PROCESS | 1667 | |3;mootools.html;1641.0563925742692;1647.5057482755174;1989.6915978023403;2054.4144918698166;2105.1895020417137;8400;9044.8643270351;9110.590023448944;9377.953110234457;9419.905800941988;9080.36437449377;9092.136247056518;9165.725028249164;9199;9211.263098952084;2575.3432874616947;2587.4954383895147;2590.0675756727564;2595.948081038378;2606.6220398042274;2517.0561039610147;2580.2904201344686;2582.7546383093577;2594.2865711929276;2607.70011448683;2558.6162075688703;2589.365605426673;2590.93522661934;2592.896284148632;2599.1812579037637;2563.51293254282;2578.9871050644815;2579.432524844531;2600.1289567994554;2605.59613259945;2076.5431605046865;2378.607529757588;2577.4716183182404;2606.426586151044;2630.3818602628367;9312.8603070954;9337.71986840396;9346.626134954662;9352.812943741086;9405.106514881076;5741.511971482387;5938.673372964486;5940.316863560703;5965.731542080617;5994.07091900756;3194.2014496375905;3747.138158223624;3824.9808750956067;3880.7671539707426;3897.902552436183;1020.1838529176629;1069.6630561373142;1098.730810951314;1099.8185299425586;1102.5644870276196;12519.74960500794;12533.937330313382;12541.498340066386;12556.874431255661;12584.748305033849;5092.2361645753435;5132.178851383761;5229.738513074331;5229.973850130725;5259.868503287448;10858.891411085946;10864.293820901616;10930.56277748881;10965.56137754481;10997.175211859143;5916.3787802281;5946.375630558816;5960.046392577254;5983.551233657493;6009.128676341906;4725.314829349725;5126.871828204325;5250.606204534675;5251.868703282372;5377.435369286247;3564.4831499432958;4132.504099508018;4155.688323375759;4162.646175075152;4176.352665336817;1386.5563019833558;1391.6520869782555;1396.287893174468;1398.8531204223614;1402.5091218073796;1379.9103058301177;1396.6578188343922;1400.5728252882766;1420.6764278440642;1439.1075735408115;8593.742187734379;8609.397342186112;8627.43921645091;8630.697925572575;8653.783655408664;531.6216429077763;538.1121150102363;540.6701911833778;543.6086018066985;546.1943633141085;5374.4625537445945;6435.51733619971;6451.29035806061;6464.159659244362;6562.606243625398;11041.558337666404;11367.09063274936;11519.02088322502;11543.422828858691;11546.018588420078;10902.291351062315;11121.443927803577;11145.275557088764;11317;11326.093912487146;7540.434467414966;8678.262347700516;8709.259712924346;8755.255803256794;8879.24526415249;7987.281144697005;8193.139720329518;8243.464174828858;8292.543910085004;8355.95822020886;9855.605775768889;10044.949775251076;10192.439415832201;10274.589016439259;10305.021023002802;9935.65225217114;10296.588136474456;10313.432761197906;10422.583096676048;10495.580176793148;7674.577898215652;7804.882926756217;7881.960590197013;7890.250426209501;7962.7213047543055;8531.146885311418;8577.142285771373;8600.612972416131;8608.698695545625;8616.913830861611;7537.170911199873;7706.691732330644;7805.687772489036;7857.528548287121;7858.960705196438;7579.166291707797;7651.961740191264;7723.845523089619;7855.135935047026;7876.527408355517;8077.1115177329275;8177.509349439053;8251.216134467217;8257.05043919957;8323.625436855476;7339.229380915141;7398.889016664647;7412.740554080581;7415.555066696015;7502.849943001001;7372.889406659012;7412.481126321321;7498.925010750041;7512.060992375953;7529 23:11:50 INFO - PROCESS | 1667 | |4;prototype.html;336.20319841974526;337.5965720963448;337.6876389339861;343.8762045663561;344.78278684428807;6915.066466027085;6926.238113807477;6952.235254122049;6956.478264130185;6977.825554361143;6867.622280774555;6869.622170780605;6900.861982760354;6902.102726645529;6940.410065144456;4932.186189278774;4996.300517927493;5125.256837758523;5126.359205099363;5127.974360128194;5089.607884294394;5142.280080788692;5146.893417915147;5148.124818780816;5163.948360516403;5054.21659642756;5055.216441451563;5063.240513922922;5100.795968161269;5117.1556693145585;4206.72656277341;5075.314832497603;5101.54086132248;5103.438621751604;5154.613403994716;4419.977900110511;4449.26587113126;4451.599356057938;4452;4466.888327791831;5390.97304513475;5393.4336894626285;6712.362325579111;6763;6787.2534021257625;5306.2571240026045;5715.142728590745;6067.18093057436;6067.7269522871575;6088.086786981944;7531.774046778551;7539.849203015909;7545.584992825392;7558.622068896533;7566.1298950620285;4134.834606615732;4999.500049995007;5001.17480615698;5002;5020.046191223656;7487.513311634726;7565.319121279056;7829.29536341732;7909.209079092045;7931.643076061591;4572.0627271409285;4625.820415793951;4911.140550403737;5002.099622068063;5005.199168133081;5099.847004589868;5102.770375333119;5106.872328191825;5107.233914912793;5118.846434606968;5942.405759424109;5961.225040744762;5972.58191926561;5978.192943952511;5987.491063259585;6090.299615544181;7441.441891858132;7498.962505187439;7543.886841697379;7553.848923021619;1703.872209584286;1746.0396781769975;1749.5101371615967;1785.5625371783735;1787.865910056725;1142.1719253541282;1146.6674664347413;1157.1841851494676;1161.0943464098018;1161.3206274329443;5750.88498230033;6299.5275354348605;6929;7022.859542809218;7082.043924070287;7654.4259180561685;7709.653065612061;7712.460127791001;7715.30562249389;7745.961270193613;7000.194977577542;7014.053102831154;7040.331168539083;7052.0479735235085;7075.115610548682;3886.550959934295;3974.2846287667917;4062.959370406258;4088.1414902870138;4094.8125043737577;6783.626900520519;8170.3872209584515;8247.134050924567;8288.088310285864;8325.708600198965;6574.441172500296;8118.553479558681;8145.737410701351;8155.184481551797;8165.183481651788;6674.766383176566;8174.223448772357;8226.05400378952;8230.09468958414;8299.211574900375;7444.888326674996;7774.844503110019;7831.921680783119;7855.410844186595;7873.803154921173;7623.123340815877;7657.085728567858;7658.195889431529;7660.923390766021;7671.041119860018;8131.430799844191;8134.471259368122;8154.551499667576;8155.673773049011;8164.42849000588;4848.466668666514;4889.119958407521;4892.730899800546;4897.485763994871;4910.091633047898;7543.924560754323;7790.4546681734;7808.57052862098;7826.452148349561;7828.45200835936;7466.216047314953;7478.850422991619;7509.774706758806;7510.211427800003;7532.924670753441;6075.1191077294425;7414.925850741423;7480.3641690456925;7492.737754178577;7496.700131994659;5881.735321910439;7075.186353569406;7275.854482910418;7309;7398.445116616168;7503.812404689927;7519.924800752141;7521.548707077593;7532.7740167795055;7535.058117735283;5985.191999080243;7322.157951835394;7340.192578816219;7341.229170936975;7369.889451658337 23:11:50 INFO - PROCESS | 1667 | |5;yui.html;683.8974153876918;748.7903387051625;762.7330434347975;782.1044903585398;790.0558832195527;15300.923495382536;15553.144577048259;15924.601884952883;15956.122413267265;15967.441139560118;14744.778828317583;14755.40978360867;14795.852041479582;14824.036437631547;14826;795.5743677132735;944.8015916657511;962.9422234665925;990.6037584966035;996.1482932093065;974.0357046523961;978.7748817771917;984.0749695286407;984.1388784813288;984.4929861121492;1011;1036.2124785163255;1040.4433628009017;1041.6770801051698;1042.7862288230933;995.5221493683036;1021;1025.3335332034162;1029.4543891737353;1032.4321623107262;743.4758495260883;751.943604229685;766.0118447203101;769.315309374657;775.84011902206;15217.239138043164;15288.082715037133;15349.923250383788;15405.537833865003;15492.5352239433;13381.598552043357;13438.664033399244;13477.595672129852;13504.662383440394;13566.389512471864;8764.693235736782;10235.539400726986;10305.587776489007;10439.94780026095;10587.523561439753;3543.5917243565013;3577.4454959481322;3635.909102272438;3644.726645501598;3705.814709264553;81735.59132204301;82900;83120.50638480794;83203.16796832075;85542.57228713878;9619;9748.707538773848;9842.803143937224;9960.452175130438;10085.344452610558;21512.569748605252;21518;21583;21601.891990539945;21608.459788505414;7644.273793989562;7662.731804386931;7675.117361503499;7840.13758486566;8037.799055023671;3637.618050104754;4225.915481690349;4253.085586598896;4266.893327666833;4279.379489973936;3665.6884164845756;3707.8516859325864;3715.015520886967;3719.200371919996;3763.8494460221286;701.2987012987013;725.4812808841704;746.4252525555293;751.5227830327672;754.2871985973203;563.650536667269;565.592773203293;605.6396444115744;607.6597105620866;623.2240860129077;8130.796730081795;8527.275181609633;8530.019047809581;8547.529885856213;8752.21230089295;609.2080295615771;610.8533951851524;614.2966303582373;614.8862460444832;629.2386212682613;3935.5670876204167;3967.305721498726;4017.9397309040387;4061.735987160884;4222.81408726823;100174;100366.49816750869;100847.99152008533;101440.49279753702;101627.49186254169;85753;88821;88954;89846.55076724706;90655;76349;77843.44313113706;77972.61013694895;78459;78970.21029789743;7903.446758727064;8089.2315230053055;8125.674973001013;8175.7138500152205;8291.931637519921;47481.28778068263;48308.75845620749;49382.506174939226;49763.75118124386;50039.749801250764;41288.793556032026;62284.377156227856;69195.96206056813;72265;76965;11162.888371116185;11191.552337906718;11361.715957101138;11651.067914566984;11802.468888900192;12372;12375.504979800708;12500.562480313145;12629.81055284153;12768.74462510763;11804.3507607079;11866.584669536525;11949.402529873298;12048.277103373475;12656.17734847232;9782.41305521671;11627.895349941742;12037.75924481523;12314.322712250554;12468.750624987268;11538.653840384803;11588.536458541565;11613.070954323464;11749.588764393206;11906.880931190924;8619.310455163697;8643.394962352575;9336.159745622926;9870.26201984229;10103.00437743651;9739.220862331138;10109.747256318651;10204.336718113298;10252.948735256574;10285.125764310118 23:11:50 INFO - PROCESS | 1667 | __end_tp_report 23:11:50 INFO - PROCESS | 1667 | __start_cc_report 23:11:50 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,358 23:11:50 INFO - PROCESS | 1667 | __end_cc_report 23:11:50 INFO - PROCESS | 1667 | __startTimestamp1461651110597__endTimestamp 23:11:50 INFO - PROCESS | 1667 | 23:11:50 INFO - PROCESS | 1667 | ------- Summary: start ------- 23:11:50 INFO - PROCESS | 1667 | Number of tests: 6 23:11:50 INFO - PROCESS | 1667 | 23:11:50 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5844.48 Median:6153.38 stddev:646.24 (10.5%) stddev-sans-first:622.99 23:11:50 INFO - PROCESS | 1667 | Values: 3565.0 3674.1 3694.6 3722.8 3724.0 4610.5 5750.5 5940.9 5962.0 5965.2 5881.1 5930.8 5937.3 5969.7 5993.1 4456.8 5359.3 5407.2 5415.0 5436.4 5328.8 5408.1 5427.8 5444.9 5449.1 5328.5 5408.9 5458.3 5459.3 5472.6 5382.3 5411.9 5418.8 5425.2 5431.2 4582.4 5080.7 5200.6 5288.1 5297.1 5696.9 5768.4 5809.2 5830.2 5900.4 6190.6 6246.8 6265.5 6267.3 6354.3 5431.5 6160.7 6170.3 6299.2 6327.9 5055.5 6077.6 6083.7 6094.9 6110.1 6405.6 6452.3 6462.6 6472.3 6476.1 6135.0 6153.4 6195.8 6249.3 6264.8 6278.4 6283.5 6283.9 6284.2 6310.3 6140.1 6166.8 6210.8 6229.4 6252.0 6180.8 6222.5 6223.4 6252.3 6254.4 4982.0 5008.6 5031.2 5031.2 5041.6 4380.1 4466.0 4539.5 4565.2 4571.0 5965.7 6068.5 6069.4 6167.5 6188.8 6251.9 6314.8 6325.3 6334.6 6336.6 5270.2 5960.7 6146.8 6167.8 6179.8 5543.3 5562.4 5576.4 5586.7 5627.0 6553.8 6577.4 6599.1 6606.5 6634.8 6146.0 6250.9 6284.2 6325.2 6329.9 6511.3 6534.9 6542.1 6547.0 6591.7 6263.7 6265.1 6266.7 6267.7 6283.9 6180.6 6243.7 6278.5 6287.0 6293.7 6197.0 6203.8 6222.9 6232.3 6264.7 5999.4 6227.0 6232.7 6236.0 6242.0 4969.5 5563.9 6137.6 6138.2 6156.3 5716.0 6170.6 6194.4 6196.8 6198.5 4931.3 6196.6 6228.4 6235.7 6239.9 23:11:50 INFO - PROCESS | 1667 | 23:11:50 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:60541.86 Median:37473.81 stddev:123251.08 (328.9%) stddev-sans-first:123514.34 23:11:50 INFO - PROCESS | 1667 | Values: 482.7 546.6 584.7 678.6 683.4 27727.4 39534.8 39910.0 39966.0 40156.0 38458.8 38811.2 42093.8 42453.0 42456.6 9722.9 9905.4 9907.2 9926.0 9934.1 9655.9 9975.8 9975.9 9989.1 9996.7 9958.8 10059.3 10061.0 10061.8 10069.3 9908.9 10009.4 10016.8 10026.1 10043.2 9764.2 9914.7 9917.0 9931.0 9957.0 35249.9 41603.8 41656.6 41740.0 42143.4 3212.7 3548.9 3562.6 3955.2 4065.1 24231.8 27895.0 28404.4 28417.9 29110.7 2748.0 2789.1 2791.4 2802.1 2838.1 321445.0 321817.0 322433.4 322434.0 323585.8 49338.8 50057.2 71407.0 71563.0 71704.0 47736.8 47902.8 47906.5 47946.8 48008.0 17226.0 17322.9 17386.0 17407.8 17476.3 13999.7 14073.3 14139.4 14145.7 14161.2 15252.3 15311.8 15610.5 15762.7 15882.0 6658.7 6773.4 6823.1 6829.0 6834.4 929.2 930.0 1039.0 1073.6 1217.8 30329.0 30686.8 30694.9 30963.9 31178.5 1136.5 1145.9 1152.9 1186.9 1196.1 15660.6 15720.6 16087.3 16123.6 16332.4 551516.0 556145.0 560132.0 560602.0 561595.0 63323.4 64384.7 64451.0 64754.7 64861.4 1553.9 1571.4 1576.9 1592.7 1595.6 25309.7 30964.4 31109.5 31294.0 31782.7 55543.3 55650.0 55813.7 56024.0 56043.7 443601.0 443966.0 445568.0 524191.0 524393.4 34295.5 35753.1 36115.3 46181.3 46899.8 44569.6 45477.0 46198.8 46671.3 47098.8 30997.2 35941.5 36912.4 37898.8 38687.8 31457.4 37456.6 37491.0 37574.0 38030.0 34329.5 34516.0 39057.6 39475.6 39866.0 31372.8 32766.7 32786.5 32875.8 33150.5 25567.9 25725.0 25790.5 26241.9 26250.1 23:11:50 INFO - PROCESS | 1667 | 23:11:50 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:36298.41 Median:22077.78 stddev:112082.92 (507.7%) stddev-sans-first:112364.87 23:11:50 INFO - PROCESS | 1667 | Values: 365.9 371.1 373.1 377.7 381.2 20366.4 21443.8 22050.3 22612.5 22620.4 22018.9 22052.0 22162.6 22205.3 22384.6 5847.5 5850.3 6027.8 6099.0 6113.2 5871.0 5933.3 5944.7 5966.6 5976.2 5691.3 5944.9 5948.2 5987.2 5994.7 5937.4 5963.6 5984.8 5987.8 6009.5 5080.8 5205.7 5217.0 5220.1 5249.5 22068.4 26867.5 27127.6 27488.0 27612.3 2176.4 2199.2 2200.9 2473.7 2977.6 15308.3 15331.9 15477.8 15604.5 15935.0 1839.5 1851.0 1905.6 1906.4 1931.9 83940.1 91978.0 100763.5 105620.2 110796.4 10772.1 11065.4 11082.5 11117.5 11145.9 13434.9 13521.4 13666.0 13692.7 13705.3 9056.4 9150.1 9217.6 9219.0 9267.4 7936.0 9520.4 9635.1 9636.7 9686.4 6306.4 6329.1 6336.8 6354.5 6363.9 1625.9 1887.8 1907.6 1911.6 1918.5 954.7 998.5 1056.1 1096.0 1158.6 18122.6 21395.4 22087.1 22226.0 22373.2 1054.0 1082.9 1086.3 1095.7 1113.4 11535.7 11693.0 11758.7 11851.5 11902.5 647485.0 650326.0 656297.0 717980.0 730406.0 70942.6 106795.0 110810.0 110821.0 111279.4 1110.2 1111.2 1118.7 1125.4 1128.1 16380.6 18581.3 19007.2 19356.9 19547.9 47875.0 48793.0 49861.5 50346.0 51311.0 71943.0 72057.0 72385.3 73911.3 78074.0 8117.6 8216.8 8239.3 8435.7 8477.5 11150.8 12471.8 13613.7 13804.0 14141.9 10256.9 11679.6 11759.6 11796.9 12107.8 11525.8 11735.5 11924.5 11932.4 11972.9 10931.2 11305.0 11848.7 12180.5 12287.9 8353.5 8362.8 8372.6 8445.7 8535.0 10471.8 12054.6 12150.3 12219.5 12333.8 23:11:50 INFO - PROCESS | 1667 | 23:11:50 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:6381.18 Median:5255.87 stddev:3389.29 (64.5%) stddev-sans-first:3380.07 23:11:50 INFO - PROCESS | 1667 | Values: 1641.1 1647.5 1989.7 2054.4 2105.2 8400.0 9044.9 9110.6 9378.0 9419.9 9080.4 9092.1 9165.7 9199.0 9211.3 2575.3 2587.5 2590.1 2595.9 2606.6 2517.1 2580.3 2582.8 2594.3 2607.7 2558.6 2589.4 2590.9 2592.9 2599.2 2563.5 2579.0 2579.4 2600.1 2605.6 2076.5 2378.6 2577.5 2606.4 2630.4 9312.9 9337.7 9346.6 9352.8 9405.1 5741.5 5938.7 5940.3 5965.7 5994.1 3194.2 3747.1 3825.0 3880.8 3897.9 1020.2 1069.7 1098.7 1099.8 1102.6 12519.7 12533.9 12541.5 12556.9 12584.7 5092.2 5132.2 5229.7 5230.0 5259.9 10858.9 10864.3 10930.6 10965.6 10997.2 5916.4 5946.4 5960.0 5983.6 6009.1 4725.3 5126.9 5250.6 5251.9 5377.4 3564.5 4132.5 4155.7 4162.6 4176.4 1386.6 1391.7 1396.3 1398.9 1402.5 1379.9 1396.7 1400.6 1420.7 1439.1 8593.7 8609.4 8627.4 8630.7 8653.8 531.6 538.1 540.7 543.6 546.2 5374.5 6435.5 6451.3 6464.2 6562.6 11041.6 11367.1 11519.0 11543.4 11546.0 10902.3 11121.4 11145.3 11317.0 11326.1 7540.4 8678.3 8709.3 8755.3 8879.2 7987.3 8193.1 8243.5 8292.5 8356.0 9855.6 10044.9 10192.4 10274.6 10305.0 9935.7 10296.6 10313.4 10422.6 10495.6 7674.6 7804.9 7882.0 7890.3 7962.7 8531.1 8577.1 8600.6 8608.7 8616.9 7537.2 7706.7 7805.7 7857.5 7859.0 7579.2 7652.0 7723.8 7855.1 7876.5 8077.1 8177.5 8251.2 8257.1 8323.6 7339.2 7398.9 7412.7 7415.6 7502.8 7372.9 7412.5 7498.9 7512.1 7529.0 23:11:50 INFO - PROCESS | 1667 | 23:11:50 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:6073.02 Median:6885.24 stddev:1958.17 (28.4%) stddev-sans-first:1915.74 23:11:50 INFO - PROCESS | 1667 | Values: 336.2 337.6 337.7 343.9 344.8 6915.1 6926.2 6952.2 6956.5 6977.8 6867.6 6869.6 6900.9 6902.1 6940.4 4932.2 4996.3 5125.3 5126.4 5128.0 5089.6 5142.3 5146.9 5148.1 5163.9 5054.2 5055.2 5063.2 5100.8 5117.2 4206.7 5075.3 5101.5 5103.4 5154.6 4420.0 4449.3 4451.6 4452.0 4466.9 5391.0 5393.4 6712.4 6763.0 6787.3 5306.3 5715.1 6067.2 6067.7 6088.1 7531.8 7539.8 7545.6 7558.6 7566.1 4134.8 4999.5 5001.2 5002.0 5020.0 7487.5 7565.3 7829.3 7909.2 7931.6 4572.1 4625.8 4911.1 5002.1 5005.2 5099.8 5102.8 5106.9 5107.2 5118.8 5942.4 5961.2 5972.6 5978.2 5987.5 6090.3 7441.4 7499.0 7543.9 7553.8 1703.9 1746.0 1749.5 1785.6 1787.9 1142.2 1146.7 1157.2 1161.1 1161.3 5750.9 6299.5 6929.0 7022.9 7082.0 7654.4 7709.7 7712.5 7715.3 7746.0 7000.2 7014.1 7040.3 7052.0 7075.1 3886.6 3974.3 4063.0 4088.1 4094.8 6783.6 8170.4 8247.1 8288.1 8325.7 6574.4 8118.6 8145.7 8155.2 8165.2 6674.8 8174.2 8226.1 8230.1 8299.2 7444.9 7774.8 7831.9 7855.4 7873.8 7623.1 7657.1 7658.2 7660.9 7671.0 8131.4 8134.5 8154.6 8155.7 8164.4 4848.5 4889.1 4892.7 4897.5 4910.1 7543.9 7790.5 7808.6 7826.5 7828.5 7466.2 7478.9 7509.8 7510.2 7532.9 6075.1 7414.9 7480.4 7492.7 7496.7 5881.7 7075.2 7275.9 7309.0 7398.4 7503.8 7519.9 7521.5 7532.8 7535.1 5985.2 7322.2 7340.2 7341.2 7369.9 23:11:50 INFO - PROCESS | 1667 | 23:11:50 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:19201.80 Median:4239.50 stddev:27575.09 (650.4%) stddev-sans-first:27617.39 23:11:50 INFO - PROCESS | 1667 | Values: 683.9 748.8 762.7 782.1 790.1 15300.9 15553.1 15924.6 15956.1 15967.4 14744.8 14755.4 14795.9 14824.0 14826.0 795.6 944.8 962.9 990.6 996.1 974.0 978.8 984.1 984.1 984.5 1011.0 1036.2 1040.4 1041.7 1042.8 995.5 1021.0 1025.3 1029.5 1032.4 743.5 751.9 766.0 769.3 775.8 15217.2 15288.1 15349.9 15405.5 15492.5 13381.6 13438.7 13477.6 13504.7 13566.4 8764.7 10235.5 10305.6 10439.9 10587.5 3543.6 3577.4 3635.9 3644.7 3705.8 81735.6 82900.0 83120.5 83203.2 85542.6 9619.0 9748.7 9842.8 9960.5 10085.3 21512.6 21518.0 21583.0 21601.9 21608.5 7644.3 7662.7 7675.1 7840.1 8037.8 3637.6 4225.9 4253.1 4266.9 4279.4 3665.7 3707.9 3715.0 3719.2 3763.8 701.3 725.5 746.4 751.5 754.3 563.7 565.6 605.6 607.7 623.2 8130.8 8527.3 8530.0 8547.5 8752.2 609.2 610.9 614.3 614.9 629.2 3935.6 3967.3 4017.9 4061.7 4222.8 100174.0 100366.5 100848.0 101440.5 101627.5 85753.0 88821.0 88954.0 89846.6 90655.0 76349.0 77843.4 77972.6 78459.0 78970.2 7903.4 8089.2 8125.7 8175.7 8291.9 47481.3 48308.8 49382.5 49763.8 50039.7 41288.8 62284.4 69196.0 72265.0 76965.0 11162.9 11191.6 11361.7 11651.1 11802.5 12372.0 12375.5 12500.6 12629.8 12768.7 11804.4 11866.6 11949.4 12048.3 12656.2 9782.4 11627.9 12037.8 12314.3 12468.8 11538.7 11588.5 11613.1 11749.6 11906.9 8619.3 8643.4 9336.2 9870.3 10103.0 9739.2 10109.7 10204.3 10252.9 10285.1 23:11:50 INFO - PROCESS | 1667 | -------- Summary: end -------- 23:11:50 INFO - PROCESS | 1667 | 23:11:51 INFO - TEST-INFO | 1667: exit 0 23:11:51 INFO - TEST-OK | dromaeo_css | took 1109729ms 23:11:51 INFO - TEST-START | kraken 23:11:51 INFO - operating with platform_type : mac_ 23:11:51 INFO - Initialising browser for kraken test... 23:11:51 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpQhMtmv/profile http://localhost:49279/getInfo.html) 23:11:53 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 23:11:53 INFO - PROCESS | 1679 | colorDepth:24 23:11:53 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 23:11:53 INFO - PROCESS | 1679 | __metrics 23:11:53 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 23:11:54 INFO - TEST-INFO | 1679: exit 0 23:11:54 INFO - Browser initialized. 23:11:54 INFO - Running cycle 1/1 for kraken test... 23:11:54 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpQhMtmv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:12:06 INFO - PROCESS | 1683 | RSS: Main: 168083456 23:12:06 INFO - PROCESS | 1683 | 23:12:08 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 23:12:09 INFO - PROCESS | 1683 | RSS: Main: 179486720 23:12:09 INFO - PROCESS | 1683 | 23:12:11 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 23:12:12 INFO - PROCESS | 1683 | RSS: Main: 188526592 23:12:12 INFO - PROCESS | 1683 | 23:12:15 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 23:12:16 INFO - PROCESS | 1683 | RSS: Main: 192155648 23:12:16 INFO - PROCESS | 1683 | 23:12:18 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 23:12:18 INFO - PROCESS | 1683 | RSS: Main: 192540672 23:12:18 INFO - PROCESS | 1683 | 23:12:21 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:12:21 INFO - PROCESS | 1683 | RSS: Main: 194093056 23:12:21 INFO - PROCESS | 1683 | 23:12:24 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 23:12:24 INFO - PROCESS | 1683 | RSS: Main: 194621440 23:12:24 INFO - PROCESS | 1683 | 23:12:27 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 23:12:28 INFO - PROCESS | 1683 | RSS: Main: 194637824 23:12:28 INFO - PROCESS | 1683 | 23:12:31 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 23:12:32 INFO - PROCESS | 1683 | RSS: Main: 194650112 23:12:32 INFO - PROCESS | 1683 | 23:12:33 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:12:34 INFO - PROCESS | 1683 | RSS: Main: 194097152 23:12:34 INFO - PROCESS | 1683 | 23:12:36 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:12:36 INFO - PROCESS | 1683 | RSS: Main: 194121728 23:12:36 INFO - PROCESS | 1683 | 23:12:39 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:12:39 INFO - PROCESS | 1683 | RSS: Main: 194129920 23:12:39 INFO - PROCESS | 1683 | 23:12:42 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:12:42 INFO - PROCESS | 1683 | RSS: Main: 194244608 23:12:42 INFO - PROCESS | 1683 | 23:12:45 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:12:45 INFO - PROCESS | 1683 | RSS: Main: 194334720 23:12:45 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 23:12:47 INFO - PROCESS | 1683 | RSS: Main: 195842048 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | __start_tp_report 23:12:47 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 23:12:47 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 23:12:47 INFO - PROCESS | 1683 | |i|pagename|runs| 23:12:47 INFO - PROCESS | 1683 | |0;ai-astar;114;111;115;107;117;128;115;116;116;118 23:12:47 INFO - PROCESS | 1683 | |1;audio-beat-detection;148;124;149;185;120;146;126;181;187;149 23:12:47 INFO - PROCESS | 1683 | |2;audio-dft;193;197;198;196;196;194;202;196;195;195 23:12:47 INFO - PROCESS | 1683 | |3;audio-fft;67;70;71;114;58;57;58;74;144;58 23:12:47 INFO - PROCESS | 1683 | |4;audio-oscillator;87;80;121;86;115;115;137;81;81;116 23:12:47 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;93;89;91;90;93;89;92;89;92;88 23:12:47 INFO - PROCESS | 1683 | |6;imaging-darkroom;96;97;99;97;98;97;97;98;97;97 23:12:47 INFO - PROCESS | 1683 | |7;imaging-desaturate;121;143;148;96;147;122;97;120;151;92 23:12:47 INFO - PROCESS | 1683 | |8;json-parse-financial;58;60;60;53;54;83;89;100;49;46 23:12:47 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;62;88;67;86;104;105;89;67;67;65 23:12:47 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;83;85;81;87;98;106;107;108;80;116 23:12:47 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;127;119;128;111;131;137;119;117;120;121 23:12:47 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;128;137;140;145;137;128;135;131;162;141 23:12:47 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;69;69;66;65;68;65;67;66;67;68 23:12:47 INFO - PROCESS | 1683 | __end_tp_report 23:12:47 INFO - PROCESS | 1683 | __start_cc_report 23:12:47 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,905 23:12:47 INFO - PROCESS | 1683 | __end_cc_report 23:12:47 INFO - PROCESS | 1683 | __startTimestamp1461651167821__endTimestamp 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | ------- Summary: start ------- 23:12:47 INFO - PROCESS | 1683 | Number of tests: 14 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:115.70 Median:116.00 stddev:5.38 (4.6%) stddev-sans-first:5.67 23:12:47 INFO - PROCESS | 1683 | Values: 114.0 111.0 115.0 107.0 117.0 128.0 115.0 116.0 116.0 118.0 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:149.00 stddev:25.18 (16.9%) stddev-sans-first:26.68 23:12:47 INFO - PROCESS | 1683 | Values: 148.0 124.0 149.0 185.0 120.0 146.0 126.0 181.0 187.0 149.0 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:196.20 Median:196.00 stddev:2.49 (1.3%) stddev-sans-first:2.35 23:12:47 INFO - PROCESS | 1683 | Values: 193.0 197.0 198.0 196.0 196.0 194.0 202.0 196.0 195.0 195.0 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:77.10 Median:62.50 stddev:28.93 (46.3%) stddev-sans-first:30.46 23:12:47 INFO - PROCESS | 1683 | Values: 67.0 70.0 71.0 114.0 58.0 57.0 58.0 74.0 144.0 58.0 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:80.50 stddev:20.99 (26.1%) stddev-sans-first:21.56 23:12:47 INFO - PROCESS | 1683 | Values: 87.0 80.0 121.0 86.0 115.0 115.0 137.0 81.0 81.0 116.0 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:91.50 stddev:1.84 (2.0%) stddev-sans-first:1.73 23:12:47 INFO - PROCESS | 1683 | Values: 93.0 89.0 91.0 90.0 93.0 89.0 92.0 89.0 92.0 88.0 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.73 23:12:47 INFO - PROCESS | 1683 | Values: 96.0 97.0 99.0 97.0 98.0 97.0 97.0 98.0 97.0 97.0 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:123.70 Median:149.50 stddev:23.00 (15.4%) stddev-sans-first:24.37 23:12:47 INFO - PROCESS | 1683 | Values: 121.0 143.0 148.0 96.0 147.0 122.0 97.0 120.0 151.0 92.0 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:59.00 stddev:18.58 (31.5%) stddev-sans-first:19.52 23:12:47 INFO - PROCESS | 1683 | Values: 58.0 60.0 60.0 53.0 54.0 83.0 89.0 100.0 49.0 46.0 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:67.00 stddev:16.46 (24.6%) stddev-sans-first:16.12 23:12:47 INFO - PROCESS | 1683 | Values: 62.0 88.0 67.0 86.0 104.0 105.0 89.0 67.0 67.0 65.0 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:95.10 Median:82.00 stddev:13.39 (16.3%) stddev-sans-first:13.46 23:12:47 INFO - PROCESS | 1683 | Values: 83.0 85.0 81.0 87.0 98.0 106.0 107.0 108.0 80.0 116.0 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:124.00 stddev:7.64 (6.2%) stddev-sans-first:7.97 23:12:47 INFO - PROCESS | 1683 | Values: 127.0 119.0 128.0 111.0 131.0 137.0 119.0 117.0 120.0 121.0 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.40 Median:138.50 stddev:9.98 (7.2%) stddev-sans-first:9.85 23:12:47 INFO - PROCESS | 1683 | Values: 128.0 137.0 140.0 145.0 137.0 128.0 135.0 131.0 162.0 141.0 23:12:47 INFO - PROCESS | 1683 | 23:12:47 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.49 (2.2%) stddev-sans-first:1.39 23:12:47 INFO - PROCESS | 1683 | Values: 69.0 69.0 66.0 65.0 68.0 65.0 67.0 66.0 67.0 68.0 23:12:47 INFO - PROCESS | 1683 | -------- Summary: end -------- 23:12:47 INFO - PROCESS | 1683 | 23:12:48 INFO - TEST-INFO | 1683: exit 0 23:12:48 INFO - TEST-OK | kraken | took 57511ms 23:12:48 INFO - SUITE-END | took 1167s 23:12:48 INFO - Completed test suite (00:19:27) 23:12:48 INFO - javascript benchmark 23:12:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3564.9821750891247, 3674.0814796300942, 3694.6120657331, 3722.7766334019943, 3723.9627603723957, 4610.492845786961, 5750.511206547449, 5940.851478713029, 5961.970190149049, 5965.224520812294, 5881.088431293146, 5930.822075337746, 5937.317208521022, 5969.671668058255, 5993.071073983529, 4456.79944402501, 5359.330083739543, 5407.242985981966, 5414.972925135369, 5436.429174936634, 5328.8401347959625, 5408.107662235727, 5427.782888684448, 5444.91832622511, 5449.073657478219, 5328.49379308965, 5408.864778380533, 5458.344998600153, 5459.290292262001, 5472.5621950243885, 5382.327209098863, 5411.864703382407, 5418.783248670068, 5425.213344065108, 5431.21247419122, 4582.427196600425, 5080.704420372818, 5200.557952573998, 5288.074586947308, 5297.099493086146, 5696.857578560528, 5768.3654797972185, 5809.157672137559, 5830.183774271605, 5900.380460051719, 6190.628562286232, 6246.750129994794, 6265.530085243625, 6267.279262884781, 6354.269259035178, 5431.456854314576, 6160.6611636359985, 6170.321264660884, 6299.212598425197, 6327.905081423783, 5055.51972562606, 6077.6353418795015, 6083.726232319512, 6094.939050609526, 6110.052941794029, 6405.551611387252, 6452.257990331078, 6462.579932304385, 6472.288048314682, 6476.125723027331, 6135.04893764628, 6153.384661533811, 6195.783147589903, 6249.312575616678, 6264.812055638338, 6278.434940855253, 6283.497320214372, 6283.905741413882, 6284.151639528696, 6310.305866354697, 6140.074827791203, 6166.81499555014, 6210.813675589739, 6229.4393504583895, 6251.9687401563615, 6180.783672571439, 6222.471089957314, 6223.37766223374, 6252.280987686383, 6254.437100660963, 4981.950180498221, 5008.624353173526, 5031.169856973558, 5031.169856973558, 5041.647084704109, 4380.145871555016, 4466.0, 4539.500654927955, 4565.20108980927, 4570.977145114253, 5965.6718880461995, 6068.4841788448475, 6069.3627169147485, 6167.537434692416, 6188.81433556994, 6251.874962500725, 6314.810555683337, 6325.272593651697, 6334.588251763621, 6336.556441049082, 5270.226737702887, 5960.731767070492, 6146.770645870754, 6167.814965551041, 6179.81460556184, 5543.2793736814765, 5562.360328562187, 5576.442355764391, 5586.720663966786, 5626.971865140648, 6553.770618028441, 6577.375149360803, 6599.109120268702, 6606.504512161607, 6634.767783127568, 6146.0473626587955, 6250.9062364065485, 6284.151639528605, 6325.177726895474, 6329.90505142414, 6511.3163117871945, 6534.934650653623, 6542.084108224757, 6546.967265163834, 6591.670416479253, 6263.749450021948, 6265.122882796321, 6266.686665666607, 6267.6866156692895, 6283.937160628335, 6180.598261113013, 6243.656598887105, 6278.497720182466, 6287.0, 6293.748250070129, 6197.03945888388, 6203.782867599793, 6222.937770622417, 6232.283287421823, 6264.749410023548, 5999.370066143167, 6226.968865155645, 6232.688365581794, 6236.0, 6241.96879015602, 4969.503049695001, 5563.9150365679925, 6137.570370074052, 6138.1713468681155, 6156.322804491592, 5715.971420143039, 6170.629762214281, 6194.4115309045565, 6196.845078873064, 6198.504119670506, 4931.334269873664, 6196.566240363131, 6228.408301211378, 6235.688215589294, 6239.875202496016], "unit": "score", "name": "dojo.html", "value": 5807.816288110722}, {"lowerIsBetter": false, "replicates": [482.65972489394983, 546.61463668114, 584.7018020809386, 678.5521555773189, 683.4464084091886, 27727.445451090967, 39534.80232598836, 39910.0, 39966.0, 40155.99610009751, 38458.80770596143, 38811.223775524544, 42093.78953105238, 42453.0, 42456.57543424565, 9722.902770972289, 9905.356151850106, 9907.157891579225, 9925.950370248138, 9934.105930466256, 9655.903440965605, 9975.800483990351, 9975.90024099757, 9989.100980911717, 9996.650117245897, 9958.751031224241, 10059.34614250075, 10061.044200800912, 10061.849072263922, 10069.345492542998, 9908.900910990906, 10009.399436033862, 10016.849747253797, 10026.097651211354, 10043.19654427644, 9764.218862490983, 9914.702558923243, 9917.0, 9930.957249488843, 9957.0, 35249.94250172499, 41603.7919810402, 41656.58343416557, 41740.0, 42143.36784948228, 3212.678732126792, 3548.946765798515, 3562.6437356264423, 3955.2287303975736, 4065.146319272956, 24231.7884105794, 27895.023674171305, 28404.431911361862, 28417.85791071052, 29110.708892911225, 2747.986260068687, 2789.1493094606135, 2791.4277573097465, 2802.14534566957, 2838.0634390651035, 321445.0, 321817.0, 322433.3878330617, 322434.0, 323585.76414236025, 49338.75330623324, 50057.24914126291, 71407.0, 71563.0, 71704.0, 47736.761316193195, 47902.760486197345, 47906.520934790904, 47946.80132996633, 48008.0, 17226.0, 17322.874013189103, 17385.956842589487, 17407.82592174062, 17476.300947962194, 13999.650008749659, 14073.2963351832, 14139.434422623186, 14145.717085658434, 14161.150330980174, 15252.313645885963, 15311.846881531264, 15610.531684049496, 15762.684746305009, 15882.0, 6658.667066646648, 6773.424258938046, 6823.089534930227, 6829.0, 6834.350736680008, 929.1869614087539, 929.972100836976, 1038.958441662325, 1073.5974009746344, 1217.829503869459, 30329.0, 30686.846565767028, 30694.870692671364, 30963.91626293069, 31178.532322015188, 1136.5169802833764, 1145.8796826333114, 1152.8674202466657, 1186.9436201780422, 1196.1447564991074, 15660.646151087478, 15720.60698482547, 16087.276072576762, 16123.596910077107, 16332.428365007405, 551516.0, 556145.0, 560132.0, 560602.0, 561595.0, 63323.36676633267, 64384.678076609314, 64451.03323450152, 64754.67622661857, 64861.35138648647, 1553.8989965652197, 1571.3871590079877, 1576.9211539422984, 1592.7053495103444, 1595.5612206643266, 25309.74690253074, 30964.380712386075, 31109.533357000117, 31294.0, 31782.68217317797, 55543.33369998907, 55650.0, 55813.72093139508, 56024.0, 56043.71978140083, 443601.0, 443966.0, 445568.0, 524191.0, 524393.3780331074, 34295.485567717005, 35753.1061723459, 36115.277694446486, 46181.30728039149, 46899.765501172275, 44569.55430445784, 45477.0, 46198.769006154755, 46671.29993050039, 47098.82252943567, 30997.225069373446, 35941.46128073274, 36912.44631330478, 37898.810505947295, 38687.806560967016, 31457.370852583277, 37456.625433746405, 37491.0, 37574.0, 38030.0, 34329.48505772366, 34515.96452106441, 39057.6094239054, 39475.60524394719, 39866.0, 31372.843135784176, 32766.67233327636, 32786.508202376506, 32875.835620821745, 33150.5027424584, 25567.87216063908, 25725.0, 25790.45874482367, 26241.868790655924, 26250.081247156257], "unit": "score", "name": "ext.html", "value": 19851.116487161802}, {"lowerIsBetter": false, "replicates": [365.9103519637689, 371.1111887030561, 373.10082700691333, 377.658219311523, 381.21089345055714, 20366.389008329737, 21443.785562144374, 22050.33848984533, 22612.54774904501, 22620.43448913776, 22018.88990555049, 22052.007659655315, 22162.556748865012, 22205.333839984785, 22384.55230895381, 5847.473727364558, 5850.268716410459, 6027.793174439783, 6099.0, 6113.23584551931, 5871.0, 5933.288005439354, 5944.702764861761, 5966.582339236255, 5976.2230909981645, 5691.260136182291, 5944.9108263375865, 5948.167256584082, 5987.161797348374, 5994.730237139339, 5937.435943585352, 5963.642181469126, 5984.820455386367, 5987.820365389045, 6009.5192384609345, 5080.847574572768, 5205.7397130143345, 5217.034848553029, 5220.138677118309, 5249.527542521191, 22068.448288792748, 26867.46265074707, 27127.593086103723, 27488.0, 27612.309692257655, 2176.379731776436, 2199.164317559333, 2200.8899555022185, 2473.7155227148746, 2977.568252603382, 15308.311125999357, 15331.923340383339, 15477.845221547754, 15604.531864044096, 15935.0, 1839.45736007878, 1851.046710943865, 1905.5998240369538, 1906.3708976037874, 1931.9227230910747, 83940.06209782629, 91978.0, 100763.48854767258, 105620.1849958856, 110796.4460177702, 10772.138228941665, 11065.375905233588, 11082.501287442085, 11117.499712512956, 11145.944270278758, 13434.865651343556, 13521.391537380645, 13666.0, 13692.726145477034, 13705.314734263247, 9056.36605437613, 9150.130737579919, 9217.63129474827, 9218.953905230432, 9267.44395336282, 7936.0, 9520.381175223589, 9635.13283804461, 9636.662716804878, 9686.418814870989, 6306.369363063657, 6329.113924050636, 6336.778212762531, 6354.523410744213, 6363.936360636427, 1625.9349626015064, 1887.8395336396286, 1907.628012537542, 1911.550785565391, 1918.5299601597699, 954.665866946577, 998.4957596413765, 1056.0548309263168, 1096.0354887698775, 1158.6204148319366, 18122.637547249244, 21395.358139255848, 22087.116515339207, 22226.0, 22373.216937407113, 1053.994730026345, 1082.9458527073614, 1086.3481910853582, 1095.6986828622194, 1113.432149603708, 11535.711607209887, 11693.048726865813, 11758.706032349088, 11851.525938962344, 11902.523899044114, 647485.0, 650326.0, 656297.0, 717980.0, 730406.0, 70942.58114837675, 106795.0, 110810.0, 110821.0, 111279.44360278147, 1110.189561620022, 1111.2110401614782, 1118.72031992002, 1125.4147843121532, 1128.0580715102817, 16380.590485237964, 18581.25674972986, 19007.239710411428, 19356.90321548383, 19547.902260488605, 47875.0, 48793.0, 49861.501384985684, 50345.99308013746, 51311.0, 71943.0, 72057.0, 72385.27614723785, 73911.2608873926, 78074.0, 8117.553534555656, 8216.83566328682, 8239.299659529008, 8435.746927592181, 8477.491350518989, 11150.832737508781, 12471.750564988468, 13613.727725445238, 13803.964702647141, 14141.858581414053, 10256.948715256376, 11679.591214307458, 11759.647210583697, 11796.882031179579, 12107.818382724443, 11525.769484610428, 11735.530578777094, 11924.523019079139, 11932.403379830801, 11972.940135299268, 10931.18016148776, 11305.0, 11848.70378240551, 12180.512779488721, 12287.87712122903, 8353.498790072616, 8362.832743344978, 8372.581370931552, 8445.662173513236, 8534.957325213583, 10471.842922356018, 12054.578089766816, 12150.270983740651, 12219.51121955112, 12333.753324933272], "unit": "score", "name": "jquery.html", "value": 9952.29260510429}, {"lowerIsBetter": false, "replicates": [1641.0563925742692, 1647.5057482755174, 1989.6915978023403, 2054.4144918698166, 2105.1895020417137, 8400.0, 9044.8643270351, 9110.590023448944, 9377.953110234457, 9419.905800941988, 9080.36437449377, 9092.136247056518, 9165.725028249164, 9199.0, 9211.263098952084, 2575.3432874616947, 2587.4954383895147, 2590.0675756727564, 2595.948081038378, 2606.6220398042274, 2517.0561039610147, 2580.2904201344686, 2582.7546383093577, 2594.2865711929276, 2607.70011448683, 2558.6162075688703, 2589.365605426673, 2590.93522661934, 2592.896284148632, 2599.1812579037637, 2563.51293254282, 2578.9871050644815, 2579.432524844531, 2600.1289567994554, 2605.59613259945, 2076.5431605046865, 2378.607529757588, 2577.4716183182404, 2606.426586151044, 2630.3818602628367, 9312.8603070954, 9337.71986840396, 9346.626134954662, 9352.812943741086, 9405.106514881076, 5741.511971482387, 5938.673372964486, 5940.316863560703, 5965.731542080617, 5994.07091900756, 3194.2014496375905, 3747.138158223624, 3824.9808750956067, 3880.7671539707426, 3897.902552436183, 1020.1838529176629, 1069.6630561373142, 1098.730810951314, 1099.8185299425586, 1102.5644870276196, 12519.74960500794, 12533.937330313382, 12541.498340066386, 12556.874431255661, 12584.748305033849, 5092.2361645753435, 5132.178851383761, 5229.738513074331, 5229.973850130725, 5259.868503287448, 10858.891411085946, 10864.293820901616, 10930.56277748881, 10965.56137754481, 10997.175211859143, 5916.3787802281, 5946.375630558816, 5960.046392577254, 5983.551233657493, 6009.128676341906, 4725.314829349725, 5126.871828204325, 5250.606204534675, 5251.868703282372, 5377.435369286247, 3564.4831499432958, 4132.504099508018, 4155.688323375759, 4162.646175075152, 4176.352665336817, 1386.5563019833558, 1391.6520869782555, 1396.287893174468, 1398.8531204223614, 1402.5091218073796, 1379.9103058301177, 1396.6578188343922, 1400.5728252882766, 1420.6764278440642, 1439.1075735408115, 8593.742187734379, 8609.397342186112, 8627.43921645091, 8630.697925572575, 8653.783655408664, 531.6216429077763, 538.1121150102363, 540.6701911833778, 543.6086018066985, 546.1943633141085, 5374.4625537445945, 6435.51733619971, 6451.29035806061, 6464.159659244362, 6562.606243625398, 11041.558337666404, 11367.09063274936, 11519.02088322502, 11543.422828858691, 11546.018588420078, 10902.291351062315, 11121.443927803577, 11145.275557088764, 11317.0, 11326.093912487146, 7540.434467414966, 8678.262347700516, 8709.259712924346, 8755.255803256794, 8879.24526415249, 7987.281144697005, 8193.139720329518, 8243.464174828858, 8292.543910085004, 8355.95822020886, 9855.605775768889, 10044.949775251076, 10192.439415832201, 10274.589016439259, 10305.021023002802, 9935.65225217114, 10296.588136474456, 10313.432761197906, 10422.583096676048, 10495.580176793148, 7674.577898215652, 7804.882926756217, 7881.960590197013, 7890.250426209501, 7962.7213047543055, 8531.146885311418, 8577.142285771373, 8600.612972416131, 8608.698695545625, 8616.913830861611, 7537.170911199873, 7706.691732330644, 7805.687772489036, 7857.528548287121, 7858.960705196438, 7579.166291707797, 7651.961740191264, 7723.845523089619, 7855.135935047026, 7876.527408355517, 8077.1115177329275, 8177.509349439053, 8251.216134467217, 8257.05043919957, 8323.625436855476, 7339.229380915141, 7398.889016664647, 7412.740554080581, 7415.555066696015, 7502.849943001001, 7372.889406659012, 7412.481126321321, 7498.925010750041, 7512.060992375953, 7529.0], "unit": "score", "name": "mootools.html", "value": 5113.998094887058}, {"lowerIsBetter": false, "replicates": [336.20319841974526, 337.5965720963448, 337.6876389339861, 343.8762045663561, 344.78278684428807, 6915.066466027085, 6926.238113807477, 6952.235254122049, 6956.478264130185, 6977.825554361143, 6867.622280774555, 6869.622170780605, 6900.861982760354, 6902.102726645529, 6940.410065144456, 4932.186189278774, 4996.300517927493, 5125.256837758523, 5126.359205099363, 5127.974360128194, 5089.607884294394, 5142.280080788692, 5146.893417915147, 5148.124818780816, 5163.948360516403, 5054.21659642756, 5055.216441451563, 5063.240513922922, 5100.795968161269, 5117.1556693145585, 4206.72656277341, 5075.314832497603, 5101.54086132248, 5103.438621751604, 5154.613403994716, 4419.977900110511, 4449.26587113126, 4451.599356057938, 4452.0, 4466.888327791831, 5390.97304513475, 5393.4336894626285, 6712.362325579111, 6763.0, 6787.2534021257625, 5306.2571240026045, 5715.142728590745, 6067.18093057436, 6067.7269522871575, 6088.086786981944, 7531.774046778551, 7539.849203015909, 7545.584992825392, 7558.622068896533, 7566.1298950620285, 4134.834606615732, 4999.500049995007, 5001.17480615698, 5002.0, 5020.046191223656, 7487.513311634726, 7565.319121279056, 7829.29536341732, 7909.209079092045, 7931.643076061591, 4572.0627271409285, 4625.820415793951, 4911.140550403737, 5002.099622068063, 5005.199168133081, 5099.847004589868, 5102.770375333119, 5106.872328191825, 5107.233914912793, 5118.846434606968, 5942.405759424109, 5961.225040744762, 5972.58191926561, 5978.192943952511, 5987.491063259585, 6090.299615544181, 7441.441891858132, 7498.962505187439, 7543.886841697379, 7553.848923021619, 1703.872209584286, 1746.0396781769975, 1749.5101371615967, 1785.5625371783735, 1787.865910056725, 1142.1719253541282, 1146.6674664347413, 1157.1841851494676, 1161.0943464098018, 1161.3206274329443, 5750.88498230033, 6299.5275354348605, 6929.0, 7022.859542809218, 7082.043924070287, 7654.4259180561685, 7709.653065612061, 7712.460127791001, 7715.30562249389, 7745.961270193613, 7000.194977577542, 7014.053102831154, 7040.331168539083, 7052.0479735235085, 7075.115610548682, 3886.550959934295, 3974.2846287667917, 4062.959370406258, 4088.1414902870138, 4094.8125043737577, 6783.626900520519, 8170.3872209584515, 8247.134050924567, 8288.088310285864, 8325.708600198965, 6574.441172500296, 8118.553479558681, 8145.737410701351, 8155.184481551797, 8165.183481651788, 6674.766383176566, 8174.223448772357, 8226.05400378952, 8230.09468958414, 8299.211574900375, 7444.888326674996, 7774.844503110019, 7831.921680783119, 7855.410844186595, 7873.803154921173, 7623.123340815877, 7657.085728567858, 7658.195889431529, 7660.923390766021, 7671.041119860018, 8131.430799844191, 8134.471259368122, 8154.551499667576, 8155.673773049011, 8164.42849000588, 4848.466668666514, 4889.119958407521, 4892.730899800546, 4897.485763994871, 4910.091633047898, 7543.924560754323, 7790.4546681734, 7808.57052862098, 7826.452148349561, 7828.45200835936, 7466.216047314953, 7478.850422991619, 7509.774706758806, 7510.211427800003, 7532.924670753441, 6075.1191077294425, 7414.925850741423, 7480.3641690456925, 7492.737754178577, 7496.700131994659, 5881.735321910439, 7075.186353569406, 7275.854482910418, 7309.0, 7398.445116616168, 7503.812404689927, 7519.924800752141, 7521.548707077593, 7532.7740167795055, 7535.058117735283, 5985.191999080243, 7322.157951835394, 7340.192578816219, 7341.229170936975, 7369.889451658337], "unit": "score", "name": "prototype.html", "value": 5424.528246207798}, {"lowerIsBetter": false, "replicates": [683.8974153876918, 748.7903387051625, 762.7330434347975, 782.1044903585398, 790.0558832195527, 15300.923495382536, 15553.144577048259, 15924.601884952883, 15956.122413267265, 15967.441139560118, 14744.778828317583, 14755.40978360867, 14795.852041479582, 14824.036437631547, 14826.0, 795.5743677132735, 944.8015916657511, 962.9422234665925, 990.6037584966035, 996.1482932093065, 974.0357046523961, 978.7748817771917, 984.0749695286407, 984.1388784813288, 984.4929861121492, 1011.0, 1036.2124785163255, 1040.4433628009017, 1041.6770801051698, 1042.7862288230933, 995.5221493683036, 1021.0, 1025.3335332034162, 1029.4543891737353, 1032.4321623107262, 743.4758495260883, 751.943604229685, 766.0118447203101, 769.315309374657, 775.84011902206, 15217.239138043164, 15288.082715037133, 15349.923250383788, 15405.537833865003, 15492.5352239433, 13381.598552043357, 13438.664033399244, 13477.595672129852, 13504.662383440394, 13566.389512471864, 8764.693235736782, 10235.539400726986, 10305.587776489007, 10439.94780026095, 10587.523561439753, 3543.5917243565013, 3577.4454959481322, 3635.909102272438, 3644.726645501598, 3705.814709264553, 81735.59132204301, 82900.0, 83120.50638480794, 83203.16796832075, 85542.57228713878, 9619.0, 9748.707538773848, 9842.803143937224, 9960.452175130438, 10085.344452610558, 21512.569748605252, 21518.0, 21583.0, 21601.891990539945, 21608.459788505414, 7644.273793989562, 7662.731804386931, 7675.117361503499, 7840.13758486566, 8037.799055023671, 3637.618050104754, 4225.915481690349, 4253.085586598896, 4266.893327666833, 4279.379489973936, 3665.6884164845756, 3707.8516859325864, 3715.015520886967, 3719.200371919996, 3763.8494460221286, 701.2987012987013, 725.4812808841704, 746.4252525555293, 751.5227830327672, 754.2871985973203, 563.650536667269, 565.592773203293, 605.6396444115744, 607.6597105620866, 623.2240860129077, 8130.796730081795, 8527.275181609633, 8530.019047809581, 8547.529885856213, 8752.21230089295, 609.2080295615771, 610.8533951851524, 614.2966303582373, 614.8862460444832, 629.2386212682613, 3935.5670876204167, 3967.305721498726, 4017.9397309040387, 4061.735987160884, 4222.81408726823, 100174.0, 100366.49816750869, 100847.99152008533, 101440.49279753702, 101627.49186254169, 85753.0, 88821.0, 88954.0, 89846.55076724706, 90655.0, 76349.0, 77843.44313113706, 77972.61013694895, 78459.0, 78970.21029789743, 7903.446758727064, 8089.2315230053055, 8125.674973001013, 8175.7138500152205, 8291.931637519921, 47481.28778068263, 48308.75845620749, 49382.506174939226, 49763.75118124386, 50039.749801250764, 41288.793556032026, 62284.377156227856, 69195.96206056813, 72265.0, 76965.0, 11162.888371116185, 11191.552337906718, 11361.715957101138, 11651.067914566984, 11802.468888900192, 12372.0, 12375.504979800708, 12500.562480313145, 12629.81055284153, 12768.74462510763, 11804.3507607079, 11866.584669536525, 11949.402529873298, 12048.277103373475, 12656.17734847232, 9782.41305521671, 11627.895349941742, 12037.75924481523, 12314.322712250554, 12468.750624987268, 11538.653840384803, 11588.536458541565, 11613.070954323464, 11749.588764393206, 11906.880931190924, 8619.310455163697, 8643.394962352575, 9336.159745622926, 9870.26201984229, 10103.00437743651, 9739.220862331138, 10109.747256318651, 10204.336718113298, 10252.948735256574, 10285.125764310118], "unit": "score", "name": "yui.html", "value": 7208.285577815149}], "name": "dromaeo_css", "value": 7824.405064408463}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 111.0, 115.0, 107.0, 117.0, 128.0, 115.0, 116.0, 116.0, 118.0], "unit": "score", "name": "ai-astar", "value": 115.7}, {"lowerIsBetter": true, "replicates": [148.0, 124.0, 149.0, 185.0, 120.0, 146.0, 126.0, 181.0, 187.0, 149.0], "unit": "score", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [193.0, 197.0, 198.0, 196.0, 196.0, 194.0, 202.0, 196.0, 195.0, 195.0], "unit": "score", "name": "audio-dft", "value": 196.2}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 71.0, 114.0, 58.0, 57.0, 58.0, 74.0, 144.0, 58.0], "unit": "score", "name": "audio-fft", "value": 77.1}, {"lowerIsBetter": true, "replicates": [87.0, 80.0, 121.0, 86.0, 115.0, 115.0, 137.0, 81.0, 81.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 101.9}, {"lowerIsBetter": true, "replicates": [93.0, 89.0, 91.0, 90.0, 93.0, 89.0, 92.0, 89.0, 92.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 99.0, 97.0, 98.0, 97.0, 97.0, 98.0, 97.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 97.3}, {"lowerIsBetter": true, "replicates": [121.0, 143.0, 148.0, 96.0, 147.0, 122.0, 97.0, 120.0, 151.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 123.7}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 60.0, 53.0, 54.0, 83.0, 89.0, 100.0, 49.0, 46.0], "unit": "score", "name": "json-parse-financial", "value": 65.2}, {"lowerIsBetter": true, "replicates": [62.0, 88.0, 67.0, 86.0, 104.0, 105.0, 89.0, 67.0, 67.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 80.0}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 81.0, 87.0, 98.0, 106.0, 107.0, 108.0, 80.0, 116.0], "unit": "score", "name": "stanford-crypto-aes", "value": 95.1}, {"lowerIsBetter": true, "replicates": [127.0, 119.0, 128.0, 111.0, 131.0, 137.0, 119.0, 117.0, 120.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [128.0, 137.0, 140.0, 145.0, 137.0, 128.0, 135.0, 131.0, 162.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 66.0, 65.0, 68.0, 65.0, 67.0, 66.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1522.7}]} 23:12:49 INFO - Return code: 0 23:12:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:12:49 ERROR - # TBPL SUCCESS # 23:12:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:12:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:12:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:12:49 INFO - 2016-04-25 23:12:49.156 screenresolution[1688:10495] starting screenresolution argv=screenresolution get 23:12:49 INFO - 2016-04-25 23:12:49.158 screenresolution[1688:10495] Display 0: 1600x1200x32@60 23:12:49 INFO - 2016-04-25 23:12:49.164 screenresolution[1689:10498] starting screenresolution argv=screenresolution list 23:12:49 INFO - Available Modes on Display 0 23:12:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:12:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:12:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:12:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:12:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:12:49 INFO - Intel Iris: 23:12:49 INFO - Chipset Model: Intel Iris 23:12:49 INFO - Type: GPU 23:12:49 INFO - Bus: Built-In 23:12:49 INFO - VRAM (Dynamic, Max): 1536 MB 23:12:49 INFO - Vendor: Intel (0x8086) 23:12:49 INFO - Device ID: 0x0a2e 23:12:49 INFO - Revision ID: 0x0009 23:12:49 INFO - Displays: 23:12:49 INFO - Display: 23:12:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:12:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:12:49 INFO - Display Serial Number: 1600x1200 60 23:12:49 INFO - Main Display: Yes 23:12:49 INFO - Mirror: Off 23:12:49 INFO - Online: Yes 23:12:49 INFO - Rotation: Supported 23:12:49 INFO - Return code: 0 23:12:49 INFO - Running post-action listener: _resource_record_post_action 23:12:49 INFO - Running post-run listener: _resource_record_post_run 23:12:50 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 37533184; Write bytes: 509192192; Read time: 392; Write time: 1819 23:12:50 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 202768896; Write bytes: 196104192; Read time: 18827; Write time: 346 23:12:50 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 35730944; Write bytes: 302295040; Read time: 373; Write time: 1394 23:12:50 INFO - Running post-run listener: _upload_blobber_files 23:12:50 INFO - Blob upload gear active. 23:12:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:12:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:12:50 INFO - (blobuploader) - INFO - Open directory for files ... 23:12:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:12:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:12:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:12:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:12:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:12:52 INFO - (blobuploader) - INFO - Done attempting. 23:12:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:12:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:12:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:12:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:12:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:12:53 INFO - (blobuploader) - INFO - Done attempting. 23:12:53 INFO - (blobuploader) - INFO - Iteration through files over. 23:12:53 INFO - Return code: 0 23:12:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:12:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:12:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c82613f6739e62a053fb25cb97d90f57d4f46a4a38cc98979d9554e43ed6131e4aa5034a649541afbd6fb52265a3a747d80792cd6387d4e9458ec07bc95101a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e4d47645db54ff288e378484bcbcf6de2ea58a43e5dc5c69803a467f64093b28ab812862dad2d0bd06bc03b9367d665203dcfc4670c8edc55b041ee0a0b096b"} 23:12:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:12:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:12:53 INFO - Contents: 23:12:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c82613f6739e62a053fb25cb97d90f57d4f46a4a38cc98979d9554e43ed6131e4aa5034a649541afbd6fb52265a3a747d80792cd6387d4e9458ec07bc95101a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e4d47645db54ff288e378484bcbcf6de2ea58a43e5dc5c69803a467f64093b28ab812862dad2d0bd06bc03b9367d665203dcfc4670c8edc55b041ee0a0b096b"} 23:12:53 INFO - Running post-run listener: copy_logs_to_upload_dir 23:12:53 INFO - Copying logs to upload dir... 23:12:53 INFO - mkdir: /builds/slave/test/build/upload/logs 23:12:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.295316 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-25 23:12:53.282910) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 23:12:53.290548) ========= 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.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c82613f6739e62a053fb25cb97d90f57d4f46a4a38cc98979d9554e43ed6131e4aa5034a649541afbd6fb52265a3a747d80792cd6387d4e9458ec07bc95101a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e4d47645db54ff288e378484bcbcf6de2ea58a43e5dc5c69803a467f64093b28ab812862dad2d0bd06bc03b9367d665203dcfc4670c8edc55b041ee0a0b096b"} build_url:https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010835 build_url: 'https://queue.taskcluster.net/v1/task/eJGkIHzISVSyqPt0Ruevrw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c82613f6739e62a053fb25cb97d90f57d4f46a4a38cc98979d9554e43ed6131e4aa5034a649541afbd6fb52265a3a747d80792cd6387d4e9458ec07bc95101a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e4d47645db54ff288e378484bcbcf6de2ea58a43e5dc5c69803a467f64093b28ab812862dad2d0bd06bc03b9367d665203dcfc4670c8edc55b041ee0a0b096b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 23:12:53.320644) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:12:53.320981) ========= 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.3hhKEjvSz4/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.7jvX0O0Vs8/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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.005214 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:12:53.370042) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 23:12:53.373535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 23:12:53.374079) ========= ========= Total master_lag: 0.18 =========