builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0352 starttime: 1466501379.9 results: success (0) buildid: 20160621002003 builduid: 553f73d9ebe6486394dd8017761d8f1e revision: bef93a95add04ae173138d8391603bf77f9ae666 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 02:29:39.923692) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 02:29:39.928240) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 02:29:39.928530) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 02:29:39.956804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:29:39.957139) ========= 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.S1dG4QKl4P/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.CB7vO2u4o1/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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-06-21 02:29:39-- 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% 156M=0s 2016-06-21 02:29:40 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103776 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:29:40.088569) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:29:40.092906) ========= 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.S1dG4QKl4P/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.CB7vO2u4o1/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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.021060 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:29:40.141626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 02:29:40.145041) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bef93a95add04ae173138d8391603bf77f9ae666 --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 bef93a95add04ae173138d8391603bf77f9ae666 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.S1dG4QKl4P/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.CB7vO2u4o1/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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-06-21 02:29:40,218 truncating revision to first 12 chars 2016-06-21 02:29:40,219 Setting DEBUG logging. 2016-06-21 02:29:40,219 attempt 1/10 2016-06-21 02:29:40,219 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bef93a95add0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 02:29:41,322 unpacking tar archive at: mozilla-beta-bef93a95add0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.361422 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 02:29:41.530365) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 02:29:41.531203) ========= script_repo_revision: bef93a95add04ae173138d8391603bf77f9ae666 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 02:29:41.532181) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 02:29:41.532928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 02:29:41.552955) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-21 02:29:41.553630) ========= /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.S1dG4QKl4P/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.CB7vO2u4o1/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 02:29:41 INFO - MultiFileLogger online at 20160621 02:29:41 in /builds/slave/test 02:29:41 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 02:29:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:29:41 INFO - {'append_to_log': False, 02:29:41 INFO - 'base_work_dir': '/builds/slave/test', 02:29:41 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:29:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:29:41 INFO - 'branch': 'Mozilla-Beta', 02:29:41 INFO - 'buildbot_json_path': 'buildprops.json', 02:29:41 INFO - 'config_files': ('talos/mac_config.py',), 02:29:41 INFO - 'default_actions': ('clobber', 02:29:41 INFO - 'read-buildbot-config', 02:29:41 INFO - 'download-and-extract', 02:29:41 INFO - 'populate-webroot', 02:29:41 INFO - 'create-virtualenv', 02:29:41 INFO - 'install', 02:29:41 INFO - 'run-tests'), 02:29:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:29:41 INFO - 'download_minidump_stackwalk': True, 02:29:41 INFO - 'download_symbols': 'ondemand', 02:29:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:29:41 INFO - 'tooltool.py': '/tools/tooltool.py', 02:29:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:29:41 INFO - '/tools/misc-python/virtualenv.py')}, 02:29:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:29:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:29:41 INFO - 'installer_path': 'installer.exe', 02:29:41 INFO - 'log_level': 'info', 02:29:41 INFO - 'log_name': 'talos', 02:29:41 INFO - 'log_to_console': True, 02:29:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:29:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:29:41 INFO - 'opt_config_files': (), 02:29:41 INFO - 'pip_index': False, 02:29:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:29:41 INFO - 'cmd': ('bash', 02:29:41 INFO - '-c', 02:29:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:29:41 INFO - 'enabled': True, 02:29:41 INFO - 'halt_on_failure': False, 02:29:41 INFO - 'name': 'check_screen_resolution'},), 02:29:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:29:41 INFO - 'cmd': ('bash', 02:29:41 INFO - '-c', 02:29:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:29:41 INFO - 'enabled': True, 02:29:41 INFO - 'halt_on_failure': False, 02:29:41 INFO - 'name': 'check_screen_resolution'},), 02:29:41 INFO - 'run_cmd_checks_enabled': True, 02:29:41 INFO - 'sps_profile': False, 02:29:41 INFO - 'sps_profile_interval': 0, 02:29:41 INFO - 'suite': 'dromaeojs-e10s', 02:29:41 INFO - 'system_bits': '32', 02:29:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:29:41 INFO - 'title': 't-yosemite-r7-0352', 02:29:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:29:41 INFO - 'use_talos_json': True, 02:29:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:29:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:29:41 INFO - 'work_dir': 'build'} 02:29:41 INFO - ##### 02:29:41 INFO - ##### Running clobber step. 02:29:41 INFO - ##### 02:29:41 INFO - Running pre-action listener: _resource_record_pre_action 02:29:41 INFO - Running main action method: clobber 02:29:41 INFO - rmtree: /builds/slave/test/build 02:29:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:29:43 INFO - Running post-action listener: _resource_record_post_action 02:29:43 INFO - ##### 02:29:43 INFO - ##### Running read-buildbot-config step. 02:29:43 INFO - ##### 02:29:43 INFO - Running pre-action listener: _resource_record_pre_action 02:29:43 INFO - Running main action method: read_buildbot_config 02:29:43 INFO - Using buildbot properties: 02:29:43 INFO - { 02:29:43 INFO - "project": "", 02:29:43 INFO - "product": "firefox", 02:29:43 INFO - "script_repo_revision": "production", 02:29:43 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 02:29:43 INFO - "repository": "", 02:29:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 02:29:43 INFO - "buildid": "20160621002003", 02:29:43 INFO - "pgo_build": "False", 02:29:43 INFO - "basedir": "/builds/slave/test", 02:29:43 INFO - "buildnumber": 5, 02:29:43 INFO - "slavename": "t-yosemite-r7-0352", 02:29:43 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:29:43 INFO - "platform": "yosemite_r7", 02:29:43 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 02:29:43 INFO - "branch": "mozilla-beta", 02:29:43 INFO - "repo_path": "releases/mozilla-beta", 02:29:43 INFO - "revision": "bef93a95add04ae173138d8391603bf77f9ae666", 02:29:43 INFO - "stage_platform": "macosx64", 02:29:43 INFO - "builduid": "553f73d9ebe6486394dd8017761d8f1e", 02:29:43 INFO - "slavebuilddir": "test" 02:29:43 INFO - } 02:29:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 02:29:43 INFO - Running post-action listener: _resource_record_post_action 02:29:43 INFO - ##### 02:29:43 INFO - ##### Running download-and-extract step. 02:29:43 INFO - ##### 02:29:43 INFO - Running pre-action listener: _resource_record_pre_action 02:29:43 INFO - Running main action method: download_and_extract 02:29:43 INFO - mkdir: /builds/slave/test/build/tests 02:29: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')]} 02:29:43 INFO - https://queue.taskcluster.net/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:29:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 02:29:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 02:29:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 02:29:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 02:29:44 INFO - Downloaded 1165 bytes. 02:29:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 02:29:44 INFO - Using the following test package requirements: 02:29:44 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 02:29:44 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:29:44 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 02:29:44 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:29:44 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 02:29:44 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 02:29:44 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:29:44 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 02:29:44 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 02:29:44 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:29:44 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 02:29:44 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:29:44 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 02:29:44 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:29:44 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 02:29:44 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:29:44 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 02:29:44 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 02:29:44 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')]} 02:29:44 INFO - https://queue.taskcluster.net/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:29:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:29:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:29:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 02:29:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 02:29:48 INFO - Downloaded 18300426 bytes. 02:29:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:29:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:29:51 INFO - Return code: 0 02:29:51 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 02:29:51 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')]} 02:29:51 INFO - https://queue.taskcluster.net/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:29:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:29:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:29:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 02:29:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 02:29:52 INFO - Downloaded 18300426 bytes. 02:29:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:29:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:29:55 INFO - Return code: 0 02:29:55 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')]} 02:29:55 INFO - https://queue.taskcluster.net/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:29:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 02:29:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 02:29:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 02:29:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 02:29:57 INFO - Downloaded 10840145 bytes. 02:29:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:29:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:29:57 INFO - Return code: 0 02:29:57 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')]} 02:29:57 INFO - https://queue.taskcluster.net/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 02:29:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:29:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:29:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 02:29:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 02:30:02 INFO - Downloaded 86252105 bytes. 02:30:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:30:02 INFO - mkdir: /builds/slave/test/properties 02:30:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:30:02 INFO - Writing to file /builds/slave/test/properties/build_url 02:30:02 INFO - Contents: 02:30:02 INFO - build_url:https://queue.taskcluster.net/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:30:04 INFO - Running post-action listener: _resource_record_post_action 02:30:04 INFO - Running post-action listener: set_extra_try_arguments 02:30:04 INFO - ##### 02:30:04 INFO - ##### Running populate-webroot step. 02:30:04 INFO - ##### 02:30:04 INFO - Running pre-action listener: _resource_record_pre_action 02:30:04 INFO - Running main action method: populate_webroot 02:30:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:30:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:30:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:30:04 INFO - '--tppagecycles', 02:30:04 INFO - '7'], 02:30:04 INFO - 'tests': ['tsvgm']}}, 02:30:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:30:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:30:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:30:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:30:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:30:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:30:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:04 INFO - 'talos_options': ['--disable-e10s'], 02:30:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:30:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:30:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:04 INFO - 'talos_options': ['--disable-e10s'], 02:30:04 INFO - 'tests': ['damp', 'tps']}, 02:30:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:04 INFO - 'tests': ['damp', 'tps']}, 02:30:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:30:04 INFO - 'tests': ['dromaeo_dom']}, 02:30:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:30:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:30:04 INFO - 'tests': ['a11yr', 02:30:04 INFO - 'ts_paint', 02:30:04 INFO - 'tpaint', 02:30:04 INFO - 'sessionrestore', 02:30:04 INFO - 'sessionrestore_no_auto_restore', 02:30:04 INFO - 'tabpaint']}, 02:30:04 INFO - 'other-e10s': {'tests': ['a11yr', 02:30:04 INFO - 'ts_paint', 02:30:04 INFO - 'tpaint', 02:30:04 INFO - 'sessionrestore', 02:30:04 INFO - 'sessionrestore_no_auto_restore', 02:30:04 INFO - 'tabpaint']}, 02:30:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:30:04 INFO - 'ts_paint', 02:30:04 INFO - 'tpaint', 02:30:04 INFO - 'sessionrestore', 02:30:04 INFO - 'sessionrestore_no_auto_restore', 02:30:04 INFO - 'tabpaint']}, 02:30:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:30:04 INFO - 'ts_paint', 02:30:04 INFO - 'tpaint', 02:30:04 INFO - 'sessionrestore', 02:30:04 INFO - 'sessionrestore_no_auto_restore', 02:30:04 INFO - 'tabpaint']}, 02:30:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:30:04 INFO - 'tests': ['a11yr', 02:30:04 INFO - 'ts_paint', 02:30:04 INFO - 'tpaint', 02:30:04 INFO - 'sessionrestore', 02:30:04 INFO - 'sessionrestore_no_auto_restore', 02:30:04 INFO - 'tabpaint']}, 02:30:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:30:04 INFO - 'tests': ['a11yr', 02:30:04 INFO - 'ts_paint', 02:30:04 INFO - 'tpaint', 02:30:04 INFO - 'sessionrestore', 02:30:04 INFO - 'sessionrestore_no_auto_restore', 02:30:04 INFO - 'tabpaint']}, 02:30:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:30:04 INFO - 'tests': ['tsvgx', 02:30:04 INFO - 'tsvgr_opacity', 02:30:04 INFO - 'tart', 02:30:04 INFO - 'tscrollx', 02:30:04 INFO - 'cart']}, 02:30:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:30:04 INFO - 'tsvgr_opacity', 02:30:04 INFO - 'tart', 02:30:04 INFO - 'tscrollx', 02:30:04 INFO - 'cart']}, 02:30:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:04 INFO - 'talos_options': ['--disable-e10s'], 02:30:04 INFO - 'tests': ['tp5o']}, 02:30:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:04 INFO - 'tests': ['tp5o']}, 02:30:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:04 INFO - 'talos_options': ['--disable-e10s', 02:30:04 INFO - '--xperf_path', 02:30:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:30:04 INFO - 'tests': ['tp5n']}, 02:30:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:04 INFO - 'talos_options': ['--xperf_path', 02:30:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:30:04 INFO - 'tests': ['tp5n']}}, 02:30:04 INFO - 'talos.zip': {'path': '', 02:30:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:30:04 INFO - Running post-action listener: _resource_record_post_action 02:30:04 INFO - ##### 02:30:04 INFO - ##### Running create-virtualenv step. 02:30:04 INFO - ##### 02:30:04 INFO - Running pre-action listener: _resource_record_pre_action 02:30:04 INFO - Running main action method: create_virtualenv 02:30:04 INFO - Creating virtualenv /builds/slave/test/build/venv 02:30:04 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 02:30:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:30:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:30:04 INFO - Using real prefix '/tools/python27' 02:30:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:30:04 INFO - Installing distribute.............................................................................................................................................................................................done. 02:30:07 INFO - Installing pip.................done. 02:30:07 INFO - Return code: 0 02:30:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:07 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 0x109df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e08420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbedac65650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c97e00>, '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 0x109b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c92b20>, '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.S1dG4QKl4P/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.CB7vO2u4o1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 02:30:07 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 02:30:07 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 02:30:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S1dG4QKl4P/Render', 02:30:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:07 INFO - 'HOME': '/Users/cltbld', 02:30:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:07 INFO - 'LOGNAME': 'cltbld', 02:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:07 INFO - 'MOZ_NO_REMOTE': '1', 02:30:07 INFO - 'NO_EM_RESTART': '1', 02:30:07 INFO - 'PAGER': '/bin/cat', 02:30:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:07 INFO - 'PWD': '/builds/slave/test', 02:30:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:07 INFO - 'SHELL': '/bin/bash', 02:30:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CB7vO2u4o1/Listeners', 02:30:07 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 02:30:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:07 INFO - 'USER': 'cltbld', 02:30:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:07 INFO - 'XPC_FLAGS': '0x0', 02:30:07 INFO - 'XPC_SERVICE_NAME': '0', 02:30:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:08 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 02:30:08 INFO - Cleaning up... 02:30:08 INFO - Return code: 0 02:30:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:30: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')]} 02:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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')]} 02:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e08420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbedac65650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c97e00>, '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 0x109b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c92b20>, '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.S1dG4QKl4P/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.CB7vO2u4o1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 02:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:30:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S1dG4QKl4P/Render', 02:30:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:08 INFO - 'HOME': '/Users/cltbld', 02:30:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:08 INFO - 'LOGNAME': 'cltbld', 02:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:08 INFO - 'MOZ_NO_REMOTE': '1', 02:30:08 INFO - 'NO_EM_RESTART': '1', 02:30:08 INFO - 'PAGER': '/bin/cat', 02:30:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:08 INFO - 'PWD': '/builds/slave/test', 02:30:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:08 INFO - 'SHELL': '/bin/bash', 02:30:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CB7vO2u4o1/Listeners', 02:30:08 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 02:30:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:08 INFO - 'USER': 'cltbld', 02:30:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:08 INFO - 'XPC_FLAGS': '0x0', 02:30:08 INFO - 'XPC_SERVICE_NAME': '0', 02:30:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:08 INFO - Downloading/unpacking psutil>=0.7.1 02:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:30:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:10 INFO - Installing collected packages: psutil 02:30:10 INFO - Running setup.py install for psutil 02:30:11 INFO - building 'psutil._psutil_osx' extension 02:30:11 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 02:30:11 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 02:30:11 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 02:30:11 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 02:30:11 INFO - building 'psutil._psutil_posix' extension 02:30:11 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 02:30:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:30:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:30:11 INFO - ^ 02:30:11 INFO - 1 warning generated. 02:30:11 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 02:30:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:11 INFO - Successfully installed psutil 02:30:11 INFO - Cleaning up... 02:30:11 INFO - Return code: 0 02:30:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:11 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 0x109df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e08420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbedac65650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c97e00>, '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 0x109b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c92b20>, '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.S1dG4QKl4P/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.CB7vO2u4o1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 02:30:11 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 02:30:11 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 02:30:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S1dG4QKl4P/Render', 02:30:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:11 INFO - 'HOME': '/Users/cltbld', 02:30:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:11 INFO - 'LOGNAME': 'cltbld', 02:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:11 INFO - 'MOZ_NO_REMOTE': '1', 02:30:11 INFO - 'NO_EM_RESTART': '1', 02:30:11 INFO - 'PAGER': '/bin/cat', 02:30:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:11 INFO - 'PWD': '/builds/slave/test', 02:30:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:11 INFO - 'SHELL': '/bin/bash', 02:30:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CB7vO2u4o1/Listeners', 02:30:11 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 02:30:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:11 INFO - 'USER': 'cltbld', 02:30:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:11 INFO - 'XPC_FLAGS': '0x0', 02:30:11 INFO - 'XPC_SERVICE_NAME': '0', 02:30:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:30:14 INFO - Installing collected packages: mozsystemmonitor 02:30:14 INFO - Running setup.py install for mozsystemmonitor 02:30:14 INFO - Successfully installed mozsystemmonitor 02:30:14 INFO - Cleaning up... 02:30:14 INFO - Return code: 0 02:30:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:30:14 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')]} 02:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:14 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')]} 02:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:14 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 0x109df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e08420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbedac65650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c97e00>, '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 0x109b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c92b20>, '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.S1dG4QKl4P/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.CB7vO2u4o1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 02:30:14 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 02:30:14 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 02:30:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S1dG4QKl4P/Render', 02:30:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:14 INFO - 'HOME': '/Users/cltbld', 02:30:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:14 INFO - 'LOGNAME': 'cltbld', 02:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:14 INFO - 'MOZ_NO_REMOTE': '1', 02:30:14 INFO - 'NO_EM_RESTART': '1', 02:30:14 INFO - 'PAGER': '/bin/cat', 02:30:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:14 INFO - 'PWD': '/builds/slave/test', 02:30:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:14 INFO - 'SHELL': '/bin/bash', 02:30:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CB7vO2u4o1/Listeners', 02:30:14 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 02:30:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:14 INFO - 'USER': 'cltbld', 02:30:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:14 INFO - 'XPC_FLAGS': '0x0', 02:30:14 INFO - 'XPC_SERVICE_NAME': '0', 02:30:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:15 INFO - Downloading/unpacking blobuploader==1.2.4 02:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:17 INFO - Downloading blobuploader-1.2.4.tar.gz 02:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:30:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:30:17 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 02:30:17 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 02:30:17 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 02:30:17 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 02:30:17 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 02:30:17 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 02:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:30:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:18 INFO - Downloading docopt-0.6.1.tar.gz 02:30:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:30:18 INFO - Installing collected packages: blobuploader, requests, docopt 02:30:18 INFO - Running setup.py install for blobuploader 02:30:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:30:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:30:18 INFO - Running setup.py install for requests 02:30:19 INFO - Running setup.py install for docopt 02:30:19 INFO - Successfully installed blobuploader requests docopt 02:30:19 INFO - Cleaning up... 02:30:19 INFO - Return code: 0 02:30:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:30: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')]} 02:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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')]} 02:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:19 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 0x109df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e08420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbedac65650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c97e00>, '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 0x109b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c92b20>, '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.S1dG4QKl4P/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.CB7vO2u4o1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 02:30:19 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 02:30:19 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 02:30:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S1dG4QKl4P/Render', 02:30:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:19 INFO - 'HOME': '/Users/cltbld', 02:30:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:19 INFO - 'LOGNAME': 'cltbld', 02:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:19 INFO - 'MOZ_NO_REMOTE': '1', 02:30:19 INFO - 'NO_EM_RESTART': '1', 02:30:19 INFO - 'PAGER': '/bin/cat', 02:30:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:19 INFO - 'PWD': '/builds/slave/test', 02:30:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:19 INFO - 'SHELL': '/bin/bash', 02:30:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CB7vO2u4o1/Listeners', 02:30:19 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 02:30:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:19 INFO - 'USER': 'cltbld', 02:30:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:19 INFO - 'XPC_FLAGS': '0x0', 02:30:19 INFO - 'XPC_SERVICE_NAME': '0', 02:30:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:30:19 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-VrETSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:30:19 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-B8AVWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:30:20 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-Et9Qf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:30:20 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-QtEsyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:30:20 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-AJkmpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:30:20 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-YA4mGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:30:20 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-kNax_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:30:20 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-tNTNU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:30:20 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-I2vWlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:30:20 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-U9jdod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:30:20 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-R8_mOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:30:21 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-Xn6Erz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:30:21 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-S9Kxfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:30:21 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-ydefjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:21 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-d4rJHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:30:21 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-8rbSq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:30:21 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-5segYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:30:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:30:21 INFO - Running setup.py install for manifestparser 02:30:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:30:21 INFO - Running setup.py install for mozcrash 02:30:21 INFO - Running setup.py install for mozdebug 02:30:22 INFO - Running setup.py install for mozdevice 02:30:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:30:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:30:22 INFO - Running setup.py install for mozfile 02:30:22 INFO - Running setup.py install for mozhttpd 02:30:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:30:22 INFO - Running setup.py install for mozinfo 02:30:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:30:22 INFO - Running setup.py install for mozInstall 02:30:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:30:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:30:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:30:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:30:22 INFO - Running setup.py install for mozleak 02:30:22 INFO - Running setup.py install for mozlog 02:30:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:30:23 INFO - Running setup.py install for moznetwork 02:30:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:30:23 INFO - Running setup.py install for mozprocess 02:30:23 INFO - Running setup.py install for mozprofile 02:30:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:30:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:30:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:30:23 INFO - Running setup.py install for mozrunner 02:30:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:30:23 INFO - Running setup.py install for mozscreenshot 02:30:23 INFO - Running setup.py install for moztest 02:30:24 INFO - Running setup.py install for mozversion 02:30:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:30:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:30:24 INFO - Cleaning up... 02:30:24 INFO - Return code: 0 02:30:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:30:24 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')]} 02:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:24 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')]} 02:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:24 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 0x109df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e08420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbedac65650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c97e00>, '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 0x109b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c92b20>, '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.S1dG4QKl4P/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.CB7vO2u4o1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 02:30:24 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 02:30:24 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 02:30:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S1dG4QKl4P/Render', 02:30:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:24 INFO - 'HOME': '/Users/cltbld', 02:30:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:24 INFO - 'LOGNAME': 'cltbld', 02:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:24 INFO - 'MOZ_NO_REMOTE': '1', 02:30:24 INFO - 'NO_EM_RESTART': '1', 02:30:24 INFO - 'PAGER': '/bin/cat', 02:30:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:24 INFO - 'PWD': '/builds/slave/test', 02:30:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:24 INFO - 'SHELL': '/bin/bash', 02:30:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CB7vO2u4o1/Listeners', 02:30:24 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 02:30:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:24 INFO - 'USER': 'cltbld', 02:30:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:24 INFO - 'XPC_FLAGS': '0x0', 02:30:24 INFO - 'XPC_SERVICE_NAME': '0', 02:30:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:30:24 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-9J8CPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:30:24 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)) 02:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:30:24 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-x8O4G4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:30:24 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)) 02:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:30:24 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-BgPci8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:30:24 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)) 02:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:30:24 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-AZpXF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:30:24 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)) 02:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:30:24 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-WuzRke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:30:25 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)) 02:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:30:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-ylHW1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:30:25 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)) 02:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:30:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-2RO6Or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:30:25 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)) 02:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:30:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-g6W7yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:30:25 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)) 02:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:30:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-CYVn7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:30:25 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)) 02:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:30:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-MpiuJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:30:25 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)) 02:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:30:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-BiqDvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:30:25 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)) 02:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:30:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-srdyBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:30:25 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)) 02:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:30:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-c86yRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:30:25 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)) 02:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:30:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-ijWoKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:30:26 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)) 02:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:26 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-D_L99I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:26 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)) 02:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:30:26 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-SmQZsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:30:26 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)) 02:30:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:30:26 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-U9TcRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:30:26 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)) 02:30:26 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)) 02:30:26 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)) 02:30:26 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)) 02:30:26 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)) 02:30:26 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)) 02:30:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:30: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 02:30: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 02:30: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 02:30: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 02:30: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 02:30: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 02:30:28 INFO - Downloading blessings-1.6.tar.gz 02:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:30:28 INFO - Installing collected packages: blessings 02:30:28 INFO - Running setup.py install for blessings 02:30:28 INFO - Successfully installed blessings 02:30:28 INFO - Cleaning up... 02:30:29 INFO - Return code: 0 02:30:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:30:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:30:29 INFO - Reading from file tmpfile_stdout 02:30:29 INFO - Current package versions: 02:30:29 INFO - blessings == 1.6 02:30:29 INFO - blobuploader == 1.2.4 02:30:29 INFO - docopt == 0.6.1 02:30:29 INFO - manifestparser == 1.1 02:30:29 INFO - mozInstall == 1.12 02:30:29 INFO - mozcrash == 0.17 02:30:29 INFO - mozdebug == 0.1 02:30:29 INFO - mozdevice == 0.48 02:30:29 INFO - mozfile == 1.2 02:30:29 INFO - mozhttpd == 0.7 02:30:29 INFO - mozinfo == 0.9 02:30:29 INFO - mozleak == 0.1 02:30:29 INFO - mozlog == 3.1 02:30:29 INFO - moznetwork == 0.27 02:30:29 INFO - mozprocess == 0.22 02:30:29 INFO - mozprofile == 0.28 02:30:29 INFO - mozrunner == 6.11 02:30:29 INFO - mozscreenshot == 0.1 02:30:29 INFO - mozsystemmonitor == 0.0 02:30:29 INFO - moztest == 0.7 02:30:29 INFO - mozversion == 1.4 02:30:29 INFO - psutil == 3.1.1 02:30:29 INFO - requests == 1.2.3 02:30:29 INFO - wsgiref == 0.1.2 02:30:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:29 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 0x109df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e08420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbedac65650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c97e00>, '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 0x109b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c92b20>, '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.S1dG4QKl4P/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.CB7vO2u4o1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 02:30:29 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 02:30:29 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 02:30:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S1dG4QKl4P/Render', 02:30:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:29 INFO - 'HOME': '/Users/cltbld', 02:30:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:29 INFO - 'LOGNAME': 'cltbld', 02:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:29 INFO - 'MOZ_NO_REMOTE': '1', 02:30:29 INFO - 'NO_EM_RESTART': '1', 02:30:29 INFO - 'PAGER': '/bin/cat', 02:30:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:29 INFO - 'PWD': '/builds/slave/test', 02:30:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:29 INFO - 'SHELL': '/bin/bash', 02:30:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CB7vO2u4o1/Listeners', 02:30:29 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 02:30:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:29 INFO - 'USER': 'cltbld', 02:30:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:29 INFO - 'XPC_FLAGS': '0x0', 02:30:29 INFO - 'XPC_SERVICE_NAME': '0', 02:30:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:29 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)) 02:30:29 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)) 02:30:29 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)) 02:30:29 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)) 02:30:29 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)) 02:30:29 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)) 02:30:29 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)) 02:30:29 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)) 02:30:29 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)) 02:30:29 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)) 02:30:29 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)) 02:30:29 INFO - Cleaning up... 02:30:29 INFO - Return code: 0 02:30:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:29 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 0x109df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e08420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbedac65650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c97e00>, '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 0x109b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c92b20>, '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.S1dG4QKl4P/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.CB7vO2u4o1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 02:30:29 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 02:30:29 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 02:30:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S1dG4QKl4P/Render', 02:30:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:29 INFO - 'HOME': '/Users/cltbld', 02:30:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:29 INFO - 'LOGNAME': 'cltbld', 02:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:29 INFO - 'MOZ_NO_REMOTE': '1', 02:30:29 INFO - 'NO_EM_RESTART': '1', 02:30:29 INFO - 'PAGER': '/bin/cat', 02:30:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:29 INFO - 'PWD': '/builds/slave/test', 02:30:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:29 INFO - 'SHELL': '/bin/bash', 02:30:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CB7vO2u4o1/Listeners', 02:30:29 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 02:30:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:29 INFO - 'USER': 'cltbld', 02:30:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:29 INFO - 'XPC_FLAGS': '0x0', 02:30:29 INFO - 'XPC_SERVICE_NAME': '0', 02:30:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:29 INFO - Downloading/unpacking jsonschema 02:30:29 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 02:30:29 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 02:30:29 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 02:30:29 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 02:30:29 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 02:30:29 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 02:30:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:30:32 INFO - Downloading/unpacking functools32 (from jsonschema) 02:30:32 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 02:30:32 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 02:30:32 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 02:30:32 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 02:30:32 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 02:30:32 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 02:30:32 INFO - Downloading functools32-3.2.3-2.tar.gz 02:30:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:30:32 INFO - warning: no files found matching '*.txt' 02:30:32 INFO - no previously-included directories found matching 'build' 02:30:32 INFO - no previously-included directories found matching 'dist' 02:30:32 INFO - no previously-included directories found matching '.git*' 02:30:32 INFO - Installing collected packages: jsonschema, functools32 02:30:32 INFO - Running setup.py install for functools32 02:30:32 INFO - warning: no files found matching '*.txt' 02:30:32 INFO - no previously-included directories found matching 'build' 02:30:32 INFO - no previously-included directories found matching 'dist' 02:30:32 INFO - no previously-included directories found matching '.git*' 02:30:32 INFO - Successfully installed jsonschema functools32 02:30:32 INFO - Cleaning up... 02:30:33 INFO - Return code: 0 02:30:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:30: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')]} 02:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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')]} 02:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109df8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e08420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbedac65650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c97e00>, '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 0x109b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c92b20>, '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.S1dG4QKl4P/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.CB7vO2u4o1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 02:30: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', 'flake8'] in /builds/slave/test/build 02:30: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 flake8 02:30:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S1dG4QKl4P/Render', 02:30:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:33 INFO - 'HOME': '/Users/cltbld', 02:30:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:33 INFO - 'LOGNAME': 'cltbld', 02:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:33 INFO - 'MOZ_NO_REMOTE': '1', 02:30:33 INFO - 'NO_EM_RESTART': '1', 02:30:33 INFO - 'PAGER': '/bin/cat', 02:30:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:33 INFO - 'PWD': '/builds/slave/test', 02:30:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:33 INFO - 'SHELL': '/bin/bash', 02:30:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CB7vO2u4o1/Listeners', 02:30:33 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 02:30:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:33 INFO - 'USER': 'cltbld', 02:30:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:33 INFO - 'XPC_FLAGS': '0x0', 02:30:33 INFO - 'XPC_SERVICE_NAME': '0', 02:30:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:33 INFO - Downloading/unpacking flake8 02:30: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 02:30: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 02:30: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 02:30: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 02:30: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 02:30: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 02:30:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:30:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:30:35 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 02:30:35 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 02:30:35 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 02:30:35 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 02:30:35 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 02:30:35 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 02:30:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:30:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:30: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 02:30: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 02:30: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 02:30: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 02:30: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 02:30: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 02:30:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:30: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 02:30: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 02:30: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 02:30: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 02:30: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 02:30: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 02:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:30:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:30:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:30:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:30:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:30:37 INFO - no previously-included directories found matching 'docs/_build' 02:30:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:30:37 INFO - Running setup.py install for pep8 02:30:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:30:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:30:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:30:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:30:37 INFO - no previously-included directories found matching 'docs/_build' 02:30:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:30:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:30:37 INFO - Cleaning up... 02:30:37 INFO - Return code: 0 02:30:37 INFO - Running post-action listener: _resource_record_post_action 02:30:37 INFO - Running post-action listener: _start_resource_monitoring 02:30:37 INFO - Starting resource monitoring. 02:30:37 INFO - ##### 02:30:37 INFO - ##### Running install step. 02:30:37 INFO - ##### 02:30:37 INFO - Running pre-action listener: _resource_record_pre_action 02:30:37 INFO - Running main action method: install 02:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:30:37 INFO - Reading from file tmpfile_stdout 02:30:37 INFO - Detecting whether we're running mozinstall >=1.0... 02:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:30:37 INFO - Reading from file tmpfile_stdout 02:30:37 INFO - Output received: 02:30:37 INFO - Usage: mozinstall [options] installer 02:30:37 INFO - Options: 02:30:37 INFO - -h, --help show this help message and exit 02:30:37 INFO - -d DEST, --destination=DEST 02:30:37 INFO - Directory to install application into. [default: 02:30:37 INFO - "/builds/slave/test"] 02:30:37 INFO - --app=APP Application being installed. [default: firefox] 02:30:37 INFO - mkdir: /builds/slave/test/build/application 02:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 02:30:59 INFO - Reading from file tmpfile_stdout 02:30:59 INFO - Output received: 02:30:59 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 02:30:59 INFO - Running post-action listener: _resource_record_post_action 02:30:59 INFO - ##### 02:30:59 INFO - ##### Running run-tests step. 02:30:59 INFO - ##### 02:30:59 INFO - Running pre-action listener: _resource_record_pre_action 02:30:59 INFO - Running main action method: run_tests 02:30:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:30:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:30:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:30:59 INFO - 2016-06-21 02:30:59.322 screenresolution[2208:16135] starting screenresolution argv=screenresolution get 02:30:59 INFO - 2016-06-21 02:30:59.324 screenresolution[2208:16135] Display 0: 1600x1200x32@60 02:30:59 INFO - 2016-06-21 02:30:59.330 screenresolution[2209:16137] starting screenresolution argv=screenresolution list 02:30:59 INFO - Available Modes on Display 0 02:30:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:30:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:30:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:30:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:30:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:30:59 INFO - Intel Iris: 02:30:59 INFO - Chipset Model: Intel Iris 02:30:59 INFO - Type: GPU 02:30:59 INFO - Bus: Built-In 02:30:59 INFO - VRAM (Dynamic, Max): 1536 MB 02:30:59 INFO - Vendor: Intel (0x8086) 02:30:59 INFO - Device ID: 0x0a2e 02:30:59 INFO - Revision ID: 0x0009 02:30:59 INFO - Displays: 02:30:59 INFO - Display: 02:30:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:30:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:30:59 INFO - Display Serial Number: 1600x1200 60 02:30:59 INFO - Main Display: Yes 02:30:59 INFO - Mirror: Off 02:30:59 INFO - Online: Yes 02:30:59 INFO - Rotation: Supported 02:30:59 INFO - Return code: 0 02:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:30:59 INFO - Python 2.7.3 02:30:59 INFO - Return code: 0 02:30:59 INFO - grabbing minidump binary from tooltool 02:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:59 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 0x109c97e00>, '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 0x109b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c92b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:30:59 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 02:30:59 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 02:30:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:30:59 INFO - Return code: 0 02:30:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:30:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:30:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:30:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:30:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:31:00 INFO - Return code: 0 02:31:00 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/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0352', '--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 02:31:00 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/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0352 --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 02:31:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S1dG4QKl4P/Render', 02:31:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:31:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:31:00 INFO - 'HOME': '/Users/cltbld', 02:31:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:31:00 INFO - 'LOGNAME': 'cltbld', 02:31:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:31:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:00 INFO - 'MOZ_NO_REMOTE': '1', 02:31:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:31:00 INFO - 'NO_EM_RESTART': '1', 02:31:00 INFO - 'PAGER': '/bin/cat', 02:31:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:00 INFO - 'PWD': '/builds/slave/test', 02:31:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:31:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:31:00 INFO - 'SHELL': '/bin/bash', 02:31:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CB7vO2u4o1/Listeners', 02:31:00 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 02:31:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:31:00 INFO - 'USER': 'cltbld', 02:31:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:31:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:00 INFO - 'XPC_FLAGS': '0x0', 02:31:00 INFO - 'XPC_SERVICE_NAME': '0', 02:31:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:31:00 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/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0352', '--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 02:31:00 INFO - mozversion application_buildid: 20160621002003 02:31:00 INFO - mozversion application_changeset: bef93a95add04ae173138d8391603bf77f9ae666 02:31:00 INFO - mozversion application_display_name: Firefox 02:31:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:31:00 INFO - mozversion application_name: Firefox 02:31:00 INFO - mozversion application_remotingname: firefox 02:31:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:31:00 INFO - mozversion application_vendor: Mozilla 02:31:00 INFO - mozversion application_version: 48.0 02:31:00 INFO - mozversion platform_buildid: 20160621002003 02:31:00 INFO - mozversion platform_changeset: bef93a95add04ae173138d8391603bf77f9ae666 02:31:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:31:00 INFO - mozversion platform_version: 48.0 02:31:00 INFO - using testdate: 1466501460 02:31:00 INFO - actual date: 1466501460 02:31:00 INFO - starting webserver on 'localhost:52593' 02:31:00 INFO - SUITE-START | Running 2 tests 02:31:00 INFO - TEST-START | dromaeo_css 02:31:00 INFO - operating with platform_type : mac_ 02:31:00 INFO - Initialising browser for dromaeo_css test... 02:31:01 INFO - TEST-INFO | started process 2227 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmp58hwao/profile http://localhost:52593/getInfo.html) 02:31:03 INFO - PROCESS | 2227 | __metrics Screen width/height:1600/1200 02:31:03 INFO - PROCESS | 2227 | colorDepth:24 02:31:03 INFO - PROCESS | 2227 | Browser inner width/height: 1024/689 02:31:03 INFO - PROCESS | 2227 | __metrics 02:31:03 ERROR - PROCESS | 2227 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:31:04 INFO - TEST-INFO | 2227: exit 0 02:31:04 INFO - Browser initialized. 02:31:04 INFO - Running cycle 1/1 for dromaeo_css test... 02:31:04 INFO - TEST-INFO | started process 2231 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmp58hwao/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:31:16 INFO - PROCESS | 2231 | RSS: Main: 171184128 02:31:16 INFO - PROCESS | 2231 | 02:32:05 INFO - PROCESS | 2231 | 1466501525904 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] 02:34:15 INFO - PROCESS | 2231 | Cycle 1(1): loaded http://localhost:52593/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52593/tests/dromaeo/cssquery-ext.html) 02:34:17 INFO - PROCESS | 2231 | RSS: Main: 181792768 02:34:17 INFO - PROCESS | 2231 | 02:37:19 INFO - PROCESS | 2231 | Cycle 1(1): loaded http://localhost:52593/tests/dromaeo/cssquery-ext.html (next: http://localhost:52593/tests/dromaeo/cssquery-jquery.html) 02:37:19 INFO - PROCESS | 2231 | RSS: Main: 192339968 02:37:19 INFO - PROCESS | 2231 | 02:40:21 INFO - PROCESS | 2231 | Cycle 1(1): loaded http://localhost:52593/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52593/tests/dromaeo/cssquery-mootools.html) 02:40:22 INFO - PROCESS | 2231 | RSS: Main: 194564096 02:40:22 INFO - PROCESS | 2231 | 02:43:23 INFO - PROCESS | 2231 | Cycle 1(1): loaded http://localhost:52593/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52593/tests/dromaeo/cssquery-prototype.html) 02:43:24 INFO - PROCESS | 2231 | RSS: Main: 198119424 02:43:24 INFO - PROCESS | 2231 | 02:46:26 INFO - PROCESS | 2231 | Cycle 1(1): loaded http://localhost:52593/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52593/tests/dromaeo/cssquery-yui.html) 02:46:27 INFO - PROCESS | 2231 | RSS: Main: 197365760 02:46:27 INFO - PROCESS | 2231 | 02:49:29 INFO - PROCESS | 2231 | Cycle 1(1): loaded http://localhost:52593/tests/dromaeo/cssquery-yui.html (next: http://localhost:52593/tests/dromaeo/cssquery-dojo.html) 02:49:29 INFO - PROCESS | 2231 | RSS: Main: 202919936 02:49:29 INFO - PROCESS | 2231 | 02:49:29 INFO - PROCESS | 2231 | __start_tp_report 02:49:29 INFO - PROCESS | 2231 | _x_x_mozilla_page_load 02:49:29 INFO - PROCESS | 2231 | _x_x_mozilla_page_load_details 02:49:29 INFO - PROCESS | 2231 | |i|pagename|runs| 02:49:29 INFO - PROCESS | 2231 | |0;dojo.html;3584.838682259298;3642.453631955206;3643.508126402938;3672.596014438413;3724.9813750931226;5842.678652674112;5867.618604790697;5875.764969401224;5885.411458854118;5910.497607703345;5875.735591898364;5888.64668119912;5894.322152952412;5917.881642367161;5930.347661757214;5227.634065615418;5265.65773224741;5320.397855854677;5322.2282768998475;5420.783168673248;5289.365276166846;5346.438623944488;5370.838874833742;5374.677519348852;5420.403755586883;5348.732563371836;5358.115910874701;5363.973180134094;5372.811951581695;5382.273393091921;5068.898622027557;5313.654612450217;5326.493983071602;5354.330708661418;5382.219578161184;4322.459692538433;5208.791648334062;5217.930324283513;5286.947130528684;5334.786608535693;4823.252395878644;5463.672179669233;5670.376258611591;5675.602707810455;5799.101139323369;6117.755289788403;6173.567850250484;6174.7530098796;6183.1034499997695;6184.536159788034;6158.261008678987;6159.4456498915315;6161.568690191689;6177.66022868742;6190.938090619081;5943.227380440515;5996.790112346047;5999.820005399845;6007.068904319881;6023.578349515536;6165.198524191826;6300.338464461257;6305.432511073934;6353.3329000455215;6368.012957991518;6111.877762444727;6125.479334256549;6137.447629713347;6153.815385538441;6173.012318029094;6201.503879689614;6204.100405441186;6204.162438070893;6211.440970312694;6213.130161777355;6126.693665316806;6130.47890929276;6140.692965351804;6143.938560614426;6165.506759459233;5178.352705911761;6120.141272347778;6127.403330890726;6144.56988010835;6154.353792851775;4731.4558825735485;4864.856758661712;4984.252362145708;5032.622553308516;5101.566366858784;4133.937990930139;4482.551744825491;4482.7534485602955;4515.187266292099;4554.4990051094355;4848.660593758474;5046.293518907356;6006.249218847644;6114.419130182626;6117.553376797925;6163.3528479509905;6201.069839524108;6231.3145553989025;6261.8747625047245;6287.7799277026;5296.390915044819;6004.609700369462;6108.5723999319625;6155.261368635793;6159.907601385983;5571.888562228733;5587.1339942309005;5587.217789509472;5594.216809646653;5594.636348637326;6633.701483433354;6663.966680166568;6669.266380698119;6679.732810687616;6686.7993960181275;6121.051237058263;6171.413715697181;6191.9690401547705;6245.9063114052415;6255.374462553708;6642.43539299165;6666.300038495888;6682.131322927989;6685.231198412245;6685.298043705536;6157.199564056823;6162.414570615784;6185.536084793568;6193.6903154841175;6195;6102.786402475892;6178.845528861814;6205.751769929152;6221.657808820377;6239.719212635351;5960.940390596212;6089.269287685506;6089.421504957022;6109.480694141048;6112.388761123852;6071.787487437919;6094.908576371269;6108.236470441195;6110.388961103854;6113.358097399709;5987.012142996531;5993.880122397615;5997.850053748692;6072.119542666377;6117.632942023492;6106.236720409949;6110.816675499742;6124.081387791867;6124.418180272867;6138.907916381348;5942.6731529766275;6080.604760690541;6108.511319094373;6157.753689852535;6158.261008678987 02:49:29 INFO - PROCESS | 2231 | |1;ext.html;528.0732314787548;535.6223862177166;563.1468325486888;575.8502789274788;588.2411688921292;40854.18291634169;41842;41883;42096.737097887075;42128;43199.35200971988;43373.783131084376;43607;43936.560634393725;44000.11999760003;9752.804943901136;9937.652182173626;9975.401475911469;9985.15126214269;10015.799684006352;9660.71017869465;9901.257405694601;9915.851262231072;9928.851067233998;9955.601775928953;9943.801123977517;9947.204223662126;9959.302848800588;9969;10023.899761002369;9917.355371900876;9918.752031199205;9951.502424878763;9961.601535938626;9976.201903847747;8692.782680432976;9583.7541119654;9717.368371055929;9846.704598862045;9901.108900198944;41415.585844141475;41497.377539336936;41574.792126039174;41740.791296043324;41882;2988.8057276276973;3278.2951665392056;3322.186064414234;3375.1562109472634;3509.94735078974;29635.55546666802;30372.544411833842;30460.695393046008;30848.53727194094;32034.839825800955;2533.9493210135693;2830.249983754307;2844.0472441732045;2868.9713102869123;2934.1344303430324;426120;427298;428379;434585;435445.8227708873;38457.615423845404;67577.3242267581;67919.64160716758;67975;68070.65964670244;38577.22845543073;38596.61403385986;38733;38770;38779.6122038776;16682.666346673;17055.48833534996;17059.14704264782;17077.91461042687;17112.88766230191;13947.232902190477;14302.57092287233;14478.565643030726;14481.92759036198;14567.635809104857;8553.272971797467;8594.14058594148;8602;8640.30877529796;8673.956630216808;3531.5585551806025;3584.6415358464465;3593.874214402483;3597.6941959933174;3599.208174201671;1044.0362780255712;1073.3774410841693;1107.6953837694698;1185.7413117635708;1206.849143857018;31471.52792708111;31516.36967260642;31896.840515797736;32266;32414.35171296561;1023.4422239879284;1087.211771465681;1109.1016276815644;1124.3872089711126;1202.392791640216;14000.649983750487;15016;15729.764053539206;15898.205089745466;16106.677866442606;670116;683794;688640;688824;693076;64233.357666423675;65432.67283663551;66474;66510.33489665041;66594;1526.3665578784903;1530.8775297976135;1554.4714796968858;1563.4762354611105;1564.3195210083422;30436;30582.12680978532;30629.846850765603;31113.688863111984;31198.68801311958;50930.745346273034;57212.42787572237;57554.848903020866;57969;58282.7085864568;594533;608595;614802;615202;615557;28903.988360407286;29255.707442925297;45809.08381832278;46423.53576464192;47560;45126.77436612796;45851.3122303159;45880.541194588965;46396.072078558915;47636.285455718884;37515.43726844154;37561.87314380573;38227.04432389212;38709.80645096757;38932.02669933161;30289.848550757106;30574.235644109074;37700.868973930825;37748.62251377451;38219.808900955315;38031.429528557645;38357.84926452211;38683;38695.80652096721;39119.80440097781;30737.846310769197;31226;34082.31835363329;36993.07517312089;38003.42994855135;25877.223683289532;26305.605415918395;26324.736752632227;26548.203553893414;26745.06392276261 02:49:29 INFO - PROCESS | 2231 | |2;jquery.html;420.2813189446047;422.1409431806273;422.9534751177368;430.1955343507641;432.67333163461603;20374.98125093745;20861.582768344622;21614.459638509044;21614.459638509044;21633;22233;22397.776022239774;22613.86930653469;22757.4310642234;23020.65469017966;5971.4625683688455;6258.280297765747;6272.717727702242;6275.278342990546;6285.560010799223;5856.414358564152;6199.628022318653;6247.531435142359;6252.187215661957;6282.340354262805;6153.7538498460235;6161;6179.69101544921;6187.535934804908;6192.5974811637325;5913.113033045035;6288;6298.181236439279;6299.811005669837;6301.495880329563;5938.138969849391;6104.816855494342;6111.480524155452;6169.598976066542;6172.105044768484;13935.930320348434;13958.860411395857;14060;14107.36516856744;14168.937329700313;2212.225720997654;2223.155201023617;2246.730392352928;2357.0689577616745;2385.7733515316017;8273.255407013397;10097.495125243782;10207.234457415723;14053.156810591398;14475.565733028026;1796.8023517413073;1833.3491610478354;1853.972190417145;1862.5622978600018;1887.773467183933;116579.83420165775;116714;121353.78646213513;122072;124071.3796431012;11722.531098756124;11998.100142489347;12121.333326666942;12128.75742485163;12288.877111228774;15167;15510.224488775742;15634.9218253908;15644.765328520081;15744.60638484047;9167.08329167078;9206.217471514863;9234.122758337948;9424.481653509123;9439.480828554495;6925.861482770317;7636.427267954815;8387.832243355098;9343.486108263975;9366.110219529133;4008.5590585035625;4736.621070314367;4781.330613714083;4827.444843842933;4867.050925069578;1705.8294170582842;1977.9121483184192;2081.7918208179362;2109.093089971296;2112.6936594193758;891.826093911681;989.2185173712686;1011.8836333821557;1019.2915923433291;1074.1353210665334;20890;21491.247806326704;21676;21744.15059256361;21816.672749908765;934.966861617916;998.2712619787595;1023.81059503992;1081.2755453845941;1120.56298043763;11400.828987565194;11580.88419115815;11588.88411115895;11627;11892.702682433008;608847;614955;615540;628732;664827;126624.36687816687;127395;130337.69662303255;134377.32811335882;136426.31786841003;961.5961296255589;1021.1881554164457;1097.6816723150357;1098.9780204396027;1111.472050775875;18045.909770451064;18059.729104063186;18384.908075460073;18481.81518184801;18692.06539672984;38974.610253897095;50222.2466662993;51179.232311514614;52203.47796521986;54293;76878;78095.43809123672;80011.59994199991;80289.19710802817;80791.78812317703;6925.688344024632;8605.741827745178;8635.093315201813;8655.870161947701;8789.516576588094;8333.624986875484;9704.514774261399;12234.938825305817;12829.486820527074;13538.323083845571;10925.453727313443;11691.298522088702;11699;11812.232204906997;11835.408229588314;10865.728356791144;11241.156913231376;11472.31166130035;11618;11704.88295117072;6070.089486576872;10876.640419947507;11668;11735.41322933867;11820.468078936297;8513;8534.658613655385;8748.343874209333;8753.212210901049;9025.548722563713;10707.464626768475;11687.474063667325;11849.585264515701;11937.045036397241;11989.940050299692 02:49:29 INFO - PROCESS | 2231 | |3;mootools.html;1569.7566877134045;1645.605054786851;1914.25802519707;2011.818936295732;2061.6701327787537;8279.668813247463;8837.293016558677;8996.955015224923;9239.953800230998;9272.90727092729;8927.55362231889;8964.462132272069;9102.544872756369;9110.407823491469;9120;2556.18202175304;2582.612608108789;2586.935326616831;2587.3531617095728;2589.9093531726394;2532.1390727152766;2546.6052761821948;2547.414094758207;2548.745125487455;2553.770160685538;2557.3350928758564;2570.4730530241254;2589.2361753282735;2609.673790776153;2610.530104581175;2565.743425657438;2568.8715564221716;2578.033237535924;2587.159173268695;2593.442409881875;2316.2628028978265;2428.3200703802963;2580.767730904228;2585.17274472169;2614.16346769034;9124.406913550665;9242.491662958535;9268.536573171314;9280.443173409618;9281.953590232073;5689.573282003867;5752.2234498342605;5851.941480585225;5870.882582348372;5895.027320492114;3654.524911761454;3771.41543060826;3797.9240415191543;3805.2009078093633;3823.260416510509;1032.488917985602;1032.6798692405303;1069.1927594666056;1086.2233503045281;1102.1127991966464;10503.369797812156;12280.07899407548;12283.57007504742;12320.445579949013;12331.815022774575;4995.925061124086;5010.69935803853;5052.7726252318735;5063.518965698253;5109.20807274873;10417.739556511147;10446.63436779709;10466;10490;10501.422421766723;5638.35158956717;5654.74553645087;5666.15007748841;5715.971420142872;5764.07774756037;3926.450296958428;5051.3433253676785;5155.74221288934;5185.481451854785;5317.8936421271355;4263.467066616673;4266.445362102907;4311.8490852820005;4363.105563359503;4370.672199585044;1395.1489591349268;1418.6595217148017;1420.3040510149951;1421.0460616652103;1428.250168661461;885.6368888755579;903.4759839293325;920.8572671235969;965.9758506037265;969.7963427680126;6087.6956152192215;6115.877682446326;6131.908021379683;6179.598326108879;6226.034964580497;482.71278589239347;485.6236416777026;486.8612445453029;492.3943549434216;507.2163507381105;3902.1025164211824;3993.860214892523;3995.1610161866333;4084.571120032413;4126.587341265849;9570.904290957002;11174;11200.663980080612;11395.829062564067;11513.309201447772;10460.320079194827;10739.624113156158;10835.51240194193;10852.294600850919;10992.725181870357;8495.36284778644;8644.049154592863;8685.08806575313;8694.739157825275;8721.040685524587;5864.648121112747;6064.090386442069;6064.636121832704;6074.453299203093;6223.9691145884;9768.267379946674;9842.65550705722;10012.349197302152;10033.14718248957;10065.547050382604;9854.063863933201;10161.882192958916;10191.28660993753;10210.642627508001;10225.130863876357;7130.2869713028285;7622.69509219625;7799.688012479437;7832.295093441618;7948.443608947318;8573.056963734109;8592.742217733477;8635.963684357666;8698.304135669257;8707.825843483222;7538.434617403607;7686.154523002577;7729.884051739116;7748.806279843049;7773.650185741542;7458.627068646654;7488.850222995618;7504.699812007459;7511.3615342696485;7708;7197.82005449847;7235.8552828944175;7236.276372362721;7239.819004524718;7241.855162896607;4452.821887124479;4889.850885042083;5018.648694591344;5195.792168313225;5216.9739151304;5152.922706159486;5175.741212939413;5178.6374953752875;5253.763580638957;5368.4631536846 02:49:29 INFO - PROCESS | 2231 | |4;prototype.html;344.31824986526675;345.1922501346848;345.5732170769101;348.71579662575;348.98445523526533;6346.365363463651;6986.231514533403;7020.368166864975;7045.225025247219;7049.436045116391;5673.347565030022;6893.103896493449;6916.100906882111;6959.443244540437;6964.233934267227;4874.195757699975;4970.900581988376;5116.974415127919;5155.639105262633;5171.896562068757;5069.518395752416;5137.897242055156;5153.716545589991;5156.994386094713;5188.870278243036;5088.1350170471105;5101.591872650179;5104.387473503166;5111.233315002761;5123.487651234866;5103.4896510349035;5121.692698438105;5125.026245013435;5145.511176438251;5155.819546315861;4405.185040767468;4408.515063343029;4411.051623900845;4414.955850441486;4419.674097770688;6546.050822630739;6573.112629794964;6633.734650613969;6687.531872768908;6737.427318677918;5919.230500034968;5957.582969192158;5979.820605381846;5986.640801551877;5992.730327135289;7396.9274455203695;7400.111986561647;7407.370373518257;7420.406367490587;7445.069366329209;4013.7391069580676;4893.559579637814;4899;4911.8280860169725;4920.975395123037;7150.356467917861;7466.55200687955;7765.650545725456;7814.960925195394;7834.4907581007055;4949.628777841676;4977.776000080005;5043.949560504348;5050.469700681376;5058.418281897629;3742.962570374316;4629.976850115795;5128.794848206105;5129.538341549279;5134.7946082156295;5489.725513724298;5945.732442040118;5968.22413086296;5971.492423144082;5973.940260597338;7478.626068696543;7522.473426860067;7536.585487798114;7537.2462753724185;7539.472236943361;1724.387842315985;1778.4486809088964;1809.3034181840087;1811.8007019227875;1813.6463389639157;1148.4257871064467;1165.091228841505;1167.486306025346;1170.7541416302672;1173.2198088271375;7009.369156775812;7108.537945033556;7115.71537138519;7127.679254433563;7152.570845749272;7465.29079737424;7624.885626715603;7699.153093159748;7722.884156737653;7724.150343462215;7124.323189297009;7137.714491420389;7146.249643787328;7203.639818009184;7223.133224013047;4064.9796751016647;4115.444415003996;4122.525909520444;4125.195586860534;4127.669786417079;6477.862305439194;6706.731730730716;8427.367947403847;8429.32565394767;8435.451695639886;7493.4005279577505;7754.457187996899;8037.598120093972;8051.677932882619;8059.63731632078;6754.662266886734;8349.582520873932;8389.916100839158;8409.495430274203;8451.915480845359;7816.64825082884;7825.608719563885;7829.45193836426;7831.530108193527;7846.058472983279;7677.385809135144;7686.077670679554;7687.423443241667;7691.269329413697;7704.036995375578;6997.230304666381;8066.395020373378;8106.108328084024;8320.292775114183;8350.958245208734;4737.952620473751;4866.610671146229;4876.536729010738;4882.414110306786;4884.780184891617;7786.143524212445;7788.493747906368;7799.259070388304;7806;7828.608569571613;6495.740170393131;6903.1371078615175;7501.1373692023935;7509.399248060033;7514.211007844097;7393.44549158826;7454.291842274975;7455.366293865082;7472.813179670552;7478.663460144197;7309.963450182715;7331.156916954618;7331.890021649786;7343.77968660941;7357.374623157091;7475;7488.625568721433;7500.199952011369;7505.099388073466;7534.773956781305;6219.720112595034;7119.252478489684;7130.322619351154;7318.121825380776;7382.114146302478 02:49:29 INFO - PROCESS | 2231 | |5;yui.html;676.7935779587231;781.7107670162037;790.6955822008525;791.4103992525569;807.3057170833084;15287.235638218086;15674.843251567481;15691.21543922805;15699.058056516602;15721.292541835617;14152.29238538074;14340.713185736278;14346.641333966656;14393.992420530567;14429.917756168277;757.4054367321654;909.713440266314;916.812053529025;920.2913756407562;934.3506263147116;915.1946287267228;928.2481190235897;936.8782058332407;941.1106504353389;949.4066208619613;978.8189185000762;984.1339621133393;999.3104757717189;1000.2148313573846;1008.2438171371472;948.5921053946801;992.533509250651;994.0854413939157;996.1234113979724;1013.229945241618;723.7720118162762;726.8582626387856;743.6839343279084;762.2301475509774;769.3921801776589;15163.24183790817;15183.240837958057;15459;15534.300956456873;15611.531654050397;13526.797098043537;13536.052476326562;13577.049606527547;13631.977601679815;13722.65693357664;10250.897491025069;10323.535440905178;10336.84494732572;10437.582496700123;10639.202059845542;3447.827608619584;3566.696830769362;3647.288778688157;3647.81760911956;3707.0917625181733;84118.15881841164;85356.57321713414;85865.57067214623;86262.56868715679;90167.09832901653;9838;9853.950730246303;9927.553260103312;10197.235207359477;10542.977839473635;22591.322260332217;23213.53572928532;23305.300840974458;23770.88114559416;23776.88111559431;7681.731139410093;7696.307332340116;7744.41916856238;7749.992500974837;8007.879881801778;4198.265303571863;4228.76741779199;4238.554951730086;4325.199838029912;4325.41606883073;3731.5149030625844;3783.319002579562;3799.525059367579;3822.4648549203134;3827;595.4938302442976;653.8394350028642;676.4588329336511;684.090160087083;684.7295318349225;590;608.716946619824;622.7695752571487;628.7327885648581;645.5610185074195;7614.847703045908;8279.917200827915;8516.446430981967;8577.75622534729;8729.825403492021;606.8027890935464;609.1411110334407;609.8719268953481;616.512954765739;620.8416853702277;3922.8626998054933;3935.252302062599;3953.1698343347643;4015.277250095011;4120.938185927213;95282.52358738161;97162;97935.51032244794;98110;98403;82658.17341826625;83062;83233.58383208167;83318;85193;56729;65556.67221663862;67058.66470667615;71113;72248.91626625604;7854.371650267851;7872.763817085268;7949.920500794918;7997.440179187401;8015.719449819228;48109;49359;49633;49699.50300497093;50381.49618503768;62692.37307627048;64013;65315.673421632586;65448.67275663591;65556;10537.157027437634;10538.262321637718;10798.56805727762;10809.405482698527;10851.782964340828;10969.50637221311;10970.957759012881;11212.943935280271;11474.139439542234;11517.82723259135;10550.103241224275;10582.100521455763;10626.787464250827;10875.347479151276;10984.890151098387;10466.790664186521;10471.94764026175;10687.412192329497;10825.512851921525;11024.007839294502;10462.110720588835;11248.437578120898;11867.287962722265;11996.58011969577;12027.518899244282;9855.487307929463;10076.505883346948;10079.647212347532;10103.292769506357;10248;10025.5488503019;10036.598536058767;10178.847317290394;10189.898101018895;10247.59009639636 02:49:29 INFO - PROCESS | 2231 | __end_tp_report 02:49:29 INFO - PROCESS | 2231 | __start_cc_report 02:49:29 INFO - PROCESS | 2231 | _x_x_mozilla_cycle_collect,391 02:49:29 INFO - PROCESS | 2231 | __end_cc_report 02:49:29 INFO - PROCESS | 2231 | __startTimestamp1466502569908__endTimestamp 02:49:29 INFO - PROCESS | 2231 | 02:49:29 INFO - PROCESS | 2231 | ------- Summary: start ------- 02:49:29 INFO - PROCESS | 2231 | Number of tests: 6 02:49:29 INFO - PROCESS | 2231 | 02:49:29 INFO - PROCESS | 2231 | [#0] dojo.html Cycles:165 Average:5801.99 Median:6102.79 stddev:636.33 (10.4%) stddev-sans-first:614.05 02:49:29 INFO - PROCESS | 2231 | Values: 3584.8 3642.5 3643.5 3672.6 3725.0 5842.7 5867.6 5875.8 5885.4 5910.5 5875.7 5888.6 5894.3 5917.9 5930.3 5227.6 5265.7 5320.4 5322.2 5420.8 5289.4 5346.4 5370.8 5374.7 5420.4 5348.7 5358.1 5364.0 5372.8 5382.3 5068.9 5313.7 5326.5 5354.3 5382.2 4322.5 5208.8 5217.9 5286.9 5334.8 4823.3 5463.7 5670.4 5675.6 5799.1 6117.8 6173.6 6174.8 6183.1 6184.5 6158.3 6159.4 6161.6 6177.7 6190.9 5943.2 5996.8 5999.8 6007.1 6023.6 6165.2 6300.3 6305.4 6353.3 6368.0 6111.9 6125.5 6137.4 6153.8 6173.0 6201.5 6204.1 6204.2 6211.4 6213.1 6126.7 6130.5 6140.7 6143.9 6165.5 5178.4 6120.1 6127.4 6144.6 6154.4 4731.5 4864.9 4984.3 5032.6 5101.6 4133.9 4482.6 4482.8 4515.2 4554.5 4848.7 5046.3 6006.2 6114.4 6117.6 6163.4 6201.1 6231.3 6261.9 6287.8 5296.4 6004.6 6108.6 6155.3 6159.9 5571.9 5587.1 5587.2 5594.2 5594.6 6633.7 6664.0 6669.3 6679.7 6686.8 6121.1 6171.4 6192.0 6245.9 6255.4 6642.4 6666.3 6682.1 6685.2 6685.3 6157.2 6162.4 6185.5 6193.7 6195.0 6102.8 6178.8 6205.8 6221.7 6239.7 5960.9 6089.3 6089.4 6109.5 6112.4 6071.8 6094.9 6108.2 6110.4 6113.4 5987.0 5993.9 5997.9 6072.1 6117.6 6106.2 6110.8 6124.1 6124.4 6138.9 5942.7 6080.6 6108.5 6157.8 6158.3 02:49:29 INFO - PROCESS | 2231 | 02:49:29 INFO - PROCESS | 2231 | [#1] ext.html Cycles:180 Average:70692.16 Median:38751.50 stddev:156672.18 (404.3%) stddev-sans-first:157023.12 02:49:29 INFO - PROCESS | 2231 | Values: 528.1 535.6 563.1 575.9 588.2 40854.2 41842.0 41883.0 42096.7 42128.0 43199.4 43373.8 43607.0 43936.6 44000.1 9752.8 9937.7 9975.4 9985.2 10015.8 9660.7 9901.3 9915.9 9928.9 9955.6 9943.8 9947.2 9959.3 9969.0 10023.9 9917.4 9918.8 9951.5 9961.6 9976.2 8692.8 9583.8 9717.4 9846.7 9901.1 41415.6 41497.4 41574.8 41740.8 41882.0 2988.8 3278.3 3322.2 3375.2 3509.9 29635.6 30372.5 30460.7 30848.5 32034.8 2533.9 2830.2 2844.0 2869.0 2934.1 426120.0 427298.0 428379.0 434585.0 435445.8 38457.6 67577.3 67919.6 67975.0 68070.7 38577.2 38596.6 38733.0 38770.0 38779.6 16682.7 17055.5 17059.1 17077.9 17112.9 13947.2 14302.6 14478.6 14481.9 14567.6 8553.3 8594.1 8602.0 8640.3 8674.0 3531.6 3584.6 3593.9 3597.7 3599.2 1044.0 1073.4 1107.7 1185.7 1206.8 31471.5 31516.4 31896.8 32266.0 32414.4 1023.4 1087.2 1109.1 1124.4 1202.4 14000.6 15016.0 15729.8 15898.2 16106.7 670116.0 683794.0 688640.0 688824.0 693076.0 64233.4 65432.7 66474.0 66510.3 66594.0 1526.4 1530.9 1554.5 1563.5 1564.3 30436.0 30582.1 30629.8 31113.7 31198.7 50930.7 57212.4 57554.8 57969.0 58282.7 594533.0 608595.0 614802.0 615202.0 615557.0 28904.0 29255.7 45809.1 46423.5 47560.0 45126.8 45851.3 45880.5 46396.1 47636.3 37515.4 37561.9 38227.0 38709.8 38932.0 30289.8 30574.2 37700.9 37748.6 38219.8 38031.4 38357.8 38683.0 38695.8 39119.8 30737.8 31226.0 34082.3 36993.1 38003.4 25877.2 26305.6 26324.7 26548.2 26745.1 02:49:29 INFO - PROCESS | 2231 | 02:49:29 INFO - PROCESS | 2231 | [#2] jquery.html Cycles:180 Average:35858.64 Median:12014.45 stddev:104492.40 (869.7%) stddev-sans-first:104751.65 02:49:29 INFO - PROCESS | 2231 | Values: 420.3 422.1 423.0 430.2 432.7 20375.0 20861.6 21614.5 21614.5 21633.0 22233.0 22397.8 22613.9 22757.4 23020.7 5971.5 6258.3 6272.7 6275.3 6285.6 5856.4 6199.6 6247.5 6252.2 6282.3 6153.8 6161.0 6179.7 6187.5 6192.6 5913.1 6288.0 6298.2 6299.8 6301.5 5938.1 6104.8 6111.5 6169.6 6172.1 13935.9 13958.9 14060.0 14107.4 14168.9 2212.2 2223.2 2246.7 2357.1 2385.8 8273.3 10097.5 10207.2 14053.2 14475.6 1796.8 1833.3 1854.0 1862.6 1887.8 116579.8 116714.0 121353.8 122072.0 124071.4 11722.5 11998.1 12121.3 12128.8 12288.9 15167.0 15510.2 15634.9 15644.8 15744.6 9167.1 9206.2 9234.1 9424.5 9439.5 6925.9 7636.4 8387.8 9343.5 9366.1 4008.6 4736.6 4781.3 4827.4 4867.1 1705.8 1977.9 2081.8 2109.1 2112.7 891.8 989.2 1011.9 1019.3 1074.1 20890.0 21491.2 21676.0 21744.2 21816.7 935.0 998.3 1023.8 1081.3 1120.6 11400.8 11580.9 11588.9 11627.0 11892.7 608847.0 614955.0 615540.0 628732.0 664827.0 126624.4 127395.0 130337.7 134377.3 136426.3 961.6 1021.2 1097.7 1099.0 1111.5 18045.9 18059.7 18384.9 18481.8 18692.1 38974.6 50222.2 51179.2 52203.5 54293.0 76878.0 78095.4 80011.6 80289.2 80791.8 6925.7 8605.7 8635.1 8655.9 8789.5 8333.6 9704.5 12234.9 12829.5 13538.3 10925.5 11691.3 11699.0 11812.2 11835.4 10865.7 11241.2 11472.3 11618.0 11704.9 6070.1 10876.6 11668.0 11735.4 11820.5 8513.0 8534.7 8748.3 8753.2 9025.5 10707.5 11687.5 11849.6 11937.0 11989.9 02:49:29 INFO - PROCESS | 2231 | 02:49:29 INFO - PROCESS | 2231 | [#3] mootools.html Cycles:180 Average:5926.69 Median:5035.00 stddev:3268.07 (64.9%) stddev-sans-first:3260.84 02:49:29 INFO - PROCESS | 2231 | Values: 1569.8 1645.6 1914.3 2011.8 2061.7 8279.7 8837.3 8997.0 9240.0 9272.9 8927.6 8964.5 9102.5 9110.4 9120.0 2556.2 2582.6 2586.9 2587.4 2589.9 2532.1 2546.6 2547.4 2548.7 2553.8 2557.3 2570.5 2589.2 2609.7 2610.5 2565.7 2568.9 2578.0 2587.2 2593.4 2316.3 2428.3 2580.8 2585.2 2614.2 9124.4 9242.5 9268.5 9280.4 9282.0 5689.6 5752.2 5851.9 5870.9 5895.0 3654.5 3771.4 3797.9 3805.2 3823.3 1032.5 1032.7 1069.2 1086.2 1102.1 10503.4 12280.1 12283.6 12320.4 12331.8 4995.9 5010.7 5052.8 5063.5 5109.2 10417.7 10446.6 10466.0 10490.0 10501.4 5638.4 5654.7 5666.2 5716.0 5764.1 3926.5 5051.3 5155.7 5185.5 5317.9 4263.5 4266.4 4311.8 4363.1 4370.7 1395.1 1418.7 1420.3 1421.0 1428.3 885.6 903.5 920.9 966.0 969.8 6087.7 6115.9 6131.9 6179.6 6226.0 482.7 485.6 486.9 492.4 507.2 3902.1 3993.9 3995.2 4084.6 4126.6 9570.9 11174.0 11200.7 11395.8 11513.3 10460.3 10739.6 10835.5 10852.3 10992.7 8495.4 8644.0 8685.1 8694.7 8721.0 5864.6 6064.1 6064.6 6074.5 6224.0 9768.3 9842.7 10012.3 10033.1 10065.5 9854.1 10161.9 10191.3 10210.6 10225.1 7130.3 7622.7 7799.7 7832.3 7948.4 8573.1 8592.7 8636.0 8698.3 8707.8 7538.4 7686.2 7729.9 7748.8 7773.7 7458.6 7488.9 7504.7 7511.4 7708.0 7197.8 7235.9 7236.3 7239.8 7241.9 4452.8 4889.9 5018.6 5195.8 5217.0 5152.9 5175.7 5178.6 5253.8 5368.5 02:49:29 INFO - PROCESS | 2231 | 02:49:29 INFO - PROCESS | 2231 | [#4] prototype.html Cycles:180 Average:6098.55 Median:6961.84 stddev:1954.55 (28.1%) stddev-sans-first:1911.72 02:49:29 INFO - PROCESS | 2231 | Values: 344.3 345.2 345.6 348.7 349.0 6346.4 6986.2 7020.4 7045.2 7049.4 5673.3 6893.1 6916.1 6959.4 6964.2 4874.2 4970.9 5117.0 5155.6 5171.9 5069.5 5137.9 5153.7 5157.0 5188.9 5088.1 5101.6 5104.4 5111.2 5123.5 5103.5 5121.7 5125.0 5145.5 5155.8 4405.2 4408.5 4411.1 4415.0 4419.7 6546.1 6573.1 6633.7 6687.5 6737.4 5919.2 5957.6 5979.8 5986.6 5992.7 7396.9 7400.1 7407.4 7420.4 7445.1 4013.7 4893.6 4899.0 4911.8 4921.0 7150.4 7466.6 7765.7 7815.0 7834.5 4949.6 4977.8 5043.9 5050.5 5058.4 3743.0 4630.0 5128.8 5129.5 5134.8 5489.7 5945.7 5968.2 5971.5 5973.9 7478.6 7522.5 7536.6 7537.2 7539.5 1724.4 1778.4 1809.3 1811.8 1813.6 1148.4 1165.1 1167.5 1170.8 1173.2 7009.4 7108.5 7115.7 7127.7 7152.6 7465.3 7624.9 7699.2 7722.9 7724.2 7124.3 7137.7 7146.2 7203.6 7223.1 4065.0 4115.4 4122.5 4125.2 4127.7 6477.9 6706.7 8427.4 8429.3 8435.5 7493.4 7754.5 8037.6 8051.7 8059.6 6754.7 8349.6 8389.9 8409.5 8451.9 7816.6 7825.6 7829.5 7831.5 7846.1 7677.4 7686.1 7687.4 7691.3 7704.0 6997.2 8066.4 8106.1 8320.3 8351.0 4738.0 4866.6 4876.5 4882.4 4884.8 7786.1 7788.5 7799.3 7806.0 7828.6 6495.7 6903.1 7501.1 7509.4 7514.2 7393.4 7454.3 7455.4 7472.8 7478.7 7310.0 7331.2 7331.9 7343.8 7357.4 7475.0 7488.6 7500.2 7505.1 7534.8 6219.7 7119.3 7130.3 7318.1 7382.1 02:49:29 INFO - PROCESS | 2231 | 02:49:29 INFO - PROCESS | 2231 | [#5] yui.html Cycles:180 Average:18681.86 Median:49496.00 stddev:26491.03 (53.5%) stddev-sans-first:26530.85 02:49:29 INFO - PROCESS | 2231 | Values: 676.8 781.7 790.7 791.4 807.3 15287.2 15674.8 15691.2 15699.1 15721.3 14152.3 14340.7 14346.6 14394.0 14429.9 757.4 909.7 916.8 920.3 934.4 915.2 928.2 936.9 941.1 949.4 978.8 984.1 999.3 1000.2 1008.2 948.6 992.5 994.1 996.1 1013.2 723.8 726.9 743.7 762.2 769.4 15163.2 15183.2 15459.0 15534.3 15611.5 13526.8 13536.1 13577.0 13632.0 13722.7 10250.9 10323.5 10336.8 10437.6 10639.2 3447.8 3566.7 3647.3 3647.8 3707.1 84118.2 85356.6 85865.6 86262.6 90167.1 9838.0 9854.0 9927.6 10197.2 10543.0 22591.3 23213.5 23305.3 23770.9 23776.9 7681.7 7696.3 7744.4 7750.0 8007.9 4198.3 4228.8 4238.6 4325.2 4325.4 3731.5 3783.3 3799.5 3822.5 3827.0 595.5 653.8 676.5 684.1 684.7 590.0 608.7 622.8 628.7 645.6 7614.8 8279.9 8516.4 8577.8 8729.8 606.8 609.1 609.9 616.5 620.8 3922.9 3935.3 3953.2 4015.3 4120.9 95282.5 97162.0 97935.5 98110.0 98403.0 82658.2 83062.0 83233.6 83318.0 85193.0 56729.0 65556.7 67058.7 71113.0 72248.9 7854.4 7872.8 7949.9 7997.4 8015.7 48109.0 49359.0 49633.0 49699.5 50381.5 62692.4 64013.0 65315.7 65448.7 65556.0 10537.2 10538.3 10798.6 10809.4 10851.8 10969.5 10971.0 11212.9 11474.1 11517.8 10550.1 10582.1 10626.8 10875.3 10984.9 10466.8 10471.9 10687.4 10825.5 11024.0 10462.1 11248.4 11867.3 11996.6 12027.5 9855.5 10076.5 10079.6 10103.3 10248.0 10025.5 10036.6 10178.8 10189.9 10247.6 02:49:29 INFO - PROCESS | 2231 | -------- Summary: end -------- 02:49:29 INFO - PROCESS | 2231 | 02:49:30 INFO - TEST-INFO | 2231: exit 0 02:49:30 INFO - TEST-OK | dromaeo_css | took 1109436ms 02:49:30 INFO - TEST-START | kraken 02:49:30 INFO - operating with platform_type : mac_ 02:49:30 INFO - Initialising browser for kraken test... 02:49:30 INFO - TEST-INFO | started process 2236 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpqQxSfo/profile http://localhost:52593/getInfo.html) 02:49:33 INFO - PROCESS | 2236 | __metrics Screen width/height:1600/1200 02:49:33 INFO - PROCESS | 2236 | colorDepth:24 02:49:33 INFO - PROCESS | 2236 | Browser inner width/height: 1024/689 02:49:33 INFO - PROCESS | 2236 | __metrics 02:49:33 ERROR - PROCESS | 2236 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:49:33 INFO - TEST-INFO | 2236: exit 0 02:49:33 INFO - Browser initialized. 02:49:33 INFO - Running cycle 1/1 for kraken test... 02:49:33 INFO - TEST-INFO | started process 2240 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpqQxSfo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:45 INFO - PROCESS | 2240 | RSS: Main: 170795008 02:49:45 INFO - PROCESS | 2240 | 02:49:48 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52593/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52593/tests/kraken/driver.html?testName=audio-beat-detection) 02:49:49 INFO - PROCESS | 2240 | RSS: Main: 183668736 02:49:49 INFO - PROCESS | 2240 | 02:49:52 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52593/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52593/tests/kraken/driver.html?testName=audio-dft) 02:49:52 INFO - PROCESS | 2240 | RSS: Main: 192409600 02:49:52 INFO - PROCESS | 2240 | 02:49:56 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52593/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52593/tests/kraken/driver.html?testName=audio-fft) 02:49:56 INFO - PROCESS | 2240 | RSS: Main: 196083712 02:49:56 INFO - PROCESS | 2240 | 02:49:58 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52593/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52593/tests/kraken/driver.html?testName=audio-oscillator) 02:49:59 INFO - PROCESS | 2240 | RSS: Main: 196243456 02:49:59 INFO - PROCESS | 2240 | 02:50:01 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52593/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52593/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:50:01 INFO - PROCESS | 2240 | RSS: Main: 198275072 02:50:01 INFO - PROCESS | 2240 | 02:50:04 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52593/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52593/tests/kraken/driver.html?testName=imaging-darkroom) 02:50:05 INFO - PROCESS | 2240 | RSS: Main: 198459392 02:50:05 INFO - PROCESS | 2240 | 02:50:08 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52593/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52593/tests/kraken/driver.html?testName=imaging-desaturate) 02:50:09 INFO - PROCESS | 2240 | RSS: Main: 198574080 02:50:09 INFO - PROCESS | 2240 | 02:50:12 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52593/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52593/tests/kraken/driver.html?testName=json-parse-financial) 02:50:12 INFO - PROCESS | 2240 | RSS: Main: 198696960 02:50:12 INFO - PROCESS | 2240 | 02:50:14 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52593/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52593/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:50:15 INFO - PROCESS | 2240 | RSS: Main: 197918720 02:50:15 INFO - PROCESS | 2240 | 02:50:16 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52593/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52593/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:50:17 INFO - PROCESS | 2240 | RSS: Main: 197836800 02:50:17 INFO - PROCESS | 2240 | 02:50:19 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52593/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52593/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:50:20 INFO - PROCESS | 2240 | RSS: Main: 197853184 02:50:20 INFO - PROCESS | 2240 | 02:50:22 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52593/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:50:23 INFO - PROCESS | 2240 | RSS: Main: 198045696 02:50:23 INFO - PROCESS | 2240 | 02:50:26 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:50:27 INFO - PROCESS | 2240 | RSS: Main: 197955584 02:50:27 INFO - PROCESS | 2240 | 02:50:28 INFO - PROCESS | 2240 | Cycle 1(1): loaded http://localhost:52593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52593/tests/kraken/driver.html?testName=ai-astar) 02:50:29 INFO - PROCESS | 2240 | RSS: Main: 199667712 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | __start_tp_report 02:50:29 INFO - PROCESS | 2240 | _x_x_mozilla_page_load 02:50:29 INFO - PROCESS | 2240 | _x_x_mozilla_page_load_details 02:50:29 INFO - PROCESS | 2240 | |i|pagename|runs| 02:50:29 INFO - PROCESS | 2240 | |0;ai-astar;116;109;116;117;116;132;117;120;171;168 02:50:29 INFO - PROCESS | 2240 | |1;audio-beat-detection;158;129;135;178;120;166;150;155;203;119 02:50:29 INFO - PROCESS | 2240 | |2;audio-dft;282;205;274;214;196;194;192;197;196;205 02:50:29 INFO - PROCESS | 2240 | |3;audio-fft;68;82;74;146;56;57;61;67;133;56 02:50:29 INFO - PROCESS | 2240 | |4;audio-oscillator;78;87;130;76;80;79;124;80;78;124 02:50:29 INFO - PROCESS | 2240 | |5;imaging-gaussian-blur;91;79;133;128;91;74;132;87;121;125 02:50:29 INFO - PROCESS | 2240 | |6;imaging-darkroom;94;95;102;138;96;94;96;95;116;119 02:50:29 INFO - PROCESS | 2240 | |7;imaging-desaturate;147;141;91;91;92;92;143;119;92;138 02:50:29 INFO - PROCESS | 2240 | |8;json-parse-financial;51;59;65;64;64;65;61;85;89;90 02:50:29 INFO - PROCESS | 2240 | |9;json-stringify-tinderbox;62;69;66;71;73;77;72;79;58;85 02:50:29 INFO - PROCESS | 2240 | |10;stanford-crypto-aes;79;78;82;79;81;81;82;79;84;84 02:50:29 INFO - PROCESS | 2240 | |11;stanford-crypto-ccm;147;141;143;159;152;150;126;127;147;146 02:50:29 INFO - PROCESS | 2240 | |12;stanford-crypto-pbkdf2;161;159;160;223;177;155;161;155;162;162 02:50:29 INFO - PROCESS | 2240 | |13;stanford-crypto-sha256-iterative;67;64;68;66;68;68;85;91;93;89 02:50:29 INFO - PROCESS | 2240 | __end_tp_report 02:50:29 INFO - PROCESS | 2240 | __start_cc_report 02:50:29 INFO - PROCESS | 2240 | _x_x_mozilla_cycle_collect,1033 02:50:29 INFO - PROCESS | 2240 | __end_cc_report 02:50:29 INFO - PROCESS | 2240 | __startTimestamp1466502629039__endTimestamp 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | ------- Summary: start ------- 02:50:29 INFO - PROCESS | 2240 | Number of tests: 14 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | [#0] ai-astar Cycles:10 Average:128.20 Median:118.50 stddev:22.52 (19.0%) stddev-sans-first:23.45 02:50:29 INFO - PROCESS | 2240 | Values: 116.0 109.0 116.0 117.0 116.0 132.0 117.0 120.0 171.0 168.0 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:156.50 stddev:26.77 (17.1%) stddev-sans-first:28.28 02:50:29 INFO - PROCESS | 2240 | Values: 158.0 129.0 135.0 178.0 120.0 166.0 150.0 155.0 203.0 119.0 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | [#2] audio-dft Cycles:10 Average:215.50 Median:205.00 stddev:33.64 (16.4%) stddev-sans-first:25.67 02:50:29 INFO - PROCESS | 2240 | Values: 282.0 205.0 274.0 214.0 196.0 194.0 192.0 197.0 196.0 205.0 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | [#3] audio-fft Cycles:10 Average:80.00 Median:64.00 stddev:32.59 (50.9%) stddev-sans-first:34.28 02:50:29 INFO - PROCESS | 2240 | Values: 68.0 82.0 74.0 146.0 56.0 57.0 61.0 67.0 133.0 56.0 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:78.50 stddev:22.60 (28.8%) stddev-sans-first:23.25 02:50:29 INFO - PROCESS | 2240 | Values: 78.0 87.0 130.0 76.0 80.0 79.0 124.0 80.0 78.0 124.0 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | [#5] imaging-gaussian-blur Cycles:10 Average:106.10 Median:76.50 stddev:23.66 (30.9%) stddev-sans-first:24.46 02:50:29 INFO - PROCESS | 2240 | Values: 91.0 79.0 133.0 128.0 91.0 74.0 132.0 87.0 121.0 125.0 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | [#6] imaging-darkroom Cycles:10 Average:104.50 Median:94.50 stddev:14.97 (15.8%) stddev-sans-first:15.39 02:50:29 INFO - PROCESS | 2240 | Values: 94.0 95.0 102.0 138.0 96.0 94.0 96.0 95.0 116.0 119.0 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | [#7] imaging-desaturate Cycles:10 Average:114.60 Median:91.00 stddev:25.31 (27.8%) stddev-sans-first:23.98 02:50:29 INFO - PROCESS | 2240 | Values: 147.0 141.0 91.0 91.0 92.0 92.0 143.0 119.0 92.0 138.0 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | [#8] json-parse-financial Cycles:10 Average:69.30 Median:65.00 stddev:13.61 (20.9%) stddev-sans-first:12.72 02:50:29 INFO - PROCESS | 2240 | Values: 51.0 59.0 65.0 64.0 64.0 65.0 61.0 85.0 89.0 90.0 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:72.50 stddev:8.02 (11.1%) stddev-sans-first:7.79 02:50:29 INFO - PROCESS | 2240 | Values: 62.0 69.0 66.0 71.0 73.0 77.0 72.0 79.0 58.0 85.0 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.50 stddev:2.13 (2.6%) stddev-sans-first:2.15 02:50:29 INFO - PROCESS | 2240 | Values: 79.0 78.0 82.0 79.0 81.0 81.0 82.0 79.0 84.0 84.0 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:147.00 stddev:10.38 (7.1%) stddev-sans-first:10.94 02:50:29 INFO - PROCESS | 2240 | Values: 147.0 141.0 143.0 159.0 152.0 150.0 126.0 127.0 147.0 146.0 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:161.50 stddev:20.43 (12.7%) stddev-sans-first:21.53 02:50:29 INFO - PROCESS | 2240 | Values: 161.0 159.0 160.0 223.0 177.0 155.0 161.0 155.0 162.0 162.0 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - PROCESS | 2240 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:76.50 stddev:11.93 (15.6%) stddev-sans-first:12.21 02:50:29 INFO - PROCESS | 2240 | Values: 67.0 64.0 68.0 66.0 68.0 68.0 85.0 91.0 93.0 89.0 02:50:29 INFO - PROCESS | 2240 | -------- Summary: end -------- 02:50:29 INFO - PROCESS | 2240 | 02:50:29 INFO - TEST-INFO | 2240: exit 0 02:50:29 INFO - TEST-OK | kraken | took 59359ms 02:50:29 INFO - SUITE-END | took 1168s 02:50:30 INFO - Completed test suite (00:19:29) 02:50:30 INFO - javascript benchmark 02:50:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3584.838682259298, 3642.453631955206, 3643.508126402938, 3672.596014438413, 3724.9813750931226, 5842.678652674112, 5867.618604790697, 5875.764969401224, 5885.411458854118, 5910.497607703345, 5875.735591898364, 5888.64668119912, 5894.322152952412, 5917.881642367161, 5930.347661757214, 5227.634065615418, 5265.65773224741, 5320.397855854677, 5322.2282768998475, 5420.783168673248, 5289.365276166846, 5346.438623944488, 5370.838874833742, 5374.677519348852, 5420.403755586883, 5348.732563371836, 5358.115910874701, 5363.973180134094, 5372.811951581695, 5382.273393091921, 5068.898622027557, 5313.654612450217, 5326.493983071602, 5354.330708661418, 5382.219578161184, 4322.459692538433, 5208.791648334062, 5217.930324283513, 5286.947130528684, 5334.786608535693, 4823.252395878644, 5463.672179669233, 5670.376258611591, 5675.602707810455, 5799.101139323369, 6117.755289788403, 6173.567850250484, 6174.7530098796, 6183.1034499997695, 6184.536159788034, 6158.261008678987, 6159.4456498915315, 6161.568690191689, 6177.66022868742, 6190.938090619081, 5943.227380440515, 5996.790112346047, 5999.820005399845, 6007.068904319881, 6023.578349515536, 6165.198524191826, 6300.338464461257, 6305.432511073934, 6353.3329000455215, 6368.012957991518, 6111.877762444727, 6125.479334256549, 6137.447629713347, 6153.815385538441, 6173.012318029094, 6201.503879689614, 6204.100405441186, 6204.162438070893, 6211.440970312694, 6213.130161777355, 6126.693665316806, 6130.47890929276, 6140.692965351804, 6143.938560614426, 6165.506759459233, 5178.352705911761, 6120.141272347778, 6127.403330890726, 6144.56988010835, 6154.353792851775, 4731.4558825735485, 4864.856758661712, 4984.252362145708, 5032.622553308516, 5101.566366858784, 4133.937990930139, 4482.551744825491, 4482.7534485602955, 4515.187266292099, 4554.4990051094355, 4848.660593758474, 5046.293518907356, 6006.249218847644, 6114.419130182626, 6117.553376797925, 6163.3528479509905, 6201.069839524108, 6231.3145553989025, 6261.8747625047245, 6287.7799277026, 5296.390915044819, 6004.609700369462, 6108.5723999319625, 6155.261368635793, 6159.907601385983, 5571.888562228733, 5587.1339942309005, 5587.217789509472, 5594.216809646653, 5594.636348637326, 6633.701483433354, 6663.966680166568, 6669.266380698119, 6679.732810687616, 6686.7993960181275, 6121.051237058263, 6171.413715697181, 6191.9690401547705, 6245.9063114052415, 6255.374462553708, 6642.43539299165, 6666.300038495888, 6682.131322927989, 6685.231198412245, 6685.298043705536, 6157.199564056823, 6162.414570615784, 6185.536084793568, 6193.6903154841175, 6195.0, 6102.786402475892, 6178.845528861814, 6205.751769929152, 6221.657808820377, 6239.719212635351, 5960.940390596212, 6089.269287685506, 6089.421504957022, 6109.480694141048, 6112.388761123852, 6071.787487437919, 6094.908576371269, 6108.236470441195, 6110.388961103854, 6113.358097399709, 5987.012142996531, 5993.880122397615, 5997.850053748692, 6072.119542666377, 6117.632942023492, 6106.236720409949, 6110.816675499742, 6124.081387791867, 6124.418180272867, 6138.907916381348, 5942.6731529766275, 6080.604760690541, 6108.511319094373, 6157.753689852535, 6158.261008678987], "value": 5764.827419866475, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.0732314787548, 535.6223862177166, 563.1468325486888, 575.8502789274788, 588.2411688921292, 40854.18291634169, 41842.0, 41883.0, 42096.737097887075, 42128.0, 43199.35200971988, 43373.783131084376, 43607.0, 43936.560634393725, 44000.11999760003, 9752.804943901136, 9937.652182173626, 9975.401475911469, 9985.15126214269, 10015.799684006352, 9660.71017869465, 9901.257405694601, 9915.851262231072, 9928.851067233998, 9955.601775928953, 9943.801123977517, 9947.204223662126, 9959.302848800588, 9969.0, 10023.899761002369, 9917.355371900876, 9918.752031199205, 9951.502424878763, 9961.601535938626, 9976.201903847747, 8692.782680432976, 9583.7541119654, 9717.368371055929, 9846.704598862045, 9901.108900198944, 41415.585844141475, 41497.377539336936, 41574.792126039174, 41740.791296043324, 41882.0, 2988.8057276276973, 3278.2951665392056, 3322.186064414234, 3375.1562109472634, 3509.94735078974, 29635.55546666802, 30372.544411833842, 30460.695393046008, 30848.53727194094, 32034.839825800955, 2533.9493210135693, 2830.249983754307, 2844.0472441732045, 2868.9713102869123, 2934.1344303430324, 426120.0, 427298.0, 428379.0, 434585.0, 435445.8227708873, 38457.615423845404, 67577.3242267581, 67919.64160716758, 67975.0, 68070.65964670244, 38577.22845543073, 38596.61403385986, 38733.0, 38770.0, 38779.6122038776, 16682.666346673, 17055.48833534996, 17059.14704264782, 17077.91461042687, 17112.88766230191, 13947.232902190477, 14302.57092287233, 14478.565643030726, 14481.92759036198, 14567.635809104857, 8553.272971797467, 8594.14058594148, 8602.0, 8640.30877529796, 8673.956630216808, 3531.5585551806025, 3584.6415358464465, 3593.874214402483, 3597.6941959933174, 3599.208174201671, 1044.0362780255712, 1073.3774410841693, 1107.6953837694698, 1185.7413117635708, 1206.849143857018, 31471.52792708111, 31516.36967260642, 31896.840515797736, 32266.0, 32414.35171296561, 1023.4422239879284, 1087.211771465681, 1109.1016276815644, 1124.3872089711126, 1202.392791640216, 14000.649983750487, 15016.0, 15729.764053539206, 15898.205089745466, 16106.677866442606, 670116.0, 683794.0, 688640.0, 688824.0, 693076.0, 64233.357666423675, 65432.67283663551, 66474.0, 66510.33489665041, 66594.0, 1526.3665578784903, 1530.8775297976135, 1554.4714796968858, 1563.4762354611105, 1564.3195210083422, 30436.0, 30582.12680978532, 30629.846850765603, 31113.688863111984, 31198.68801311958, 50930.745346273034, 57212.42787572237, 57554.848903020866, 57969.0, 58282.7085864568, 594533.0, 608595.0, 614802.0, 615202.0, 615557.0, 28903.988360407286, 29255.707442925297, 45809.08381832278, 46423.53576464192, 47560.0, 45126.77436612796, 45851.3122303159, 45880.541194588965, 46396.072078558915, 47636.285455718884, 37515.43726844154, 37561.87314380573, 38227.04432389212, 38709.80645096757, 38932.02669933161, 30289.848550757106, 30574.235644109074, 37700.868973930825, 37748.62251377451, 38219.808900955315, 38031.429528557645, 38357.84926452211, 38683.0, 38695.80652096721, 39119.80440097781, 30737.846310769197, 31226.0, 34082.31835363329, 36993.07517312089, 38003.42994855135, 25877.223683289532, 26305.605415918395, 26324.736752632227, 26548.203553893414, 26745.06392276261], "value": 19600.362420851096, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.2813189446047, 422.1409431806273, 422.9534751177368, 430.1955343507641, 432.67333163461603, 20374.98125093745, 20861.582768344622, 21614.459638509044, 21614.459638509044, 21633.0, 22233.0, 22397.776022239774, 22613.86930653469, 22757.4310642234, 23020.65469017966, 5971.4625683688455, 6258.280297765747, 6272.717727702242, 6275.278342990546, 6285.560010799223, 5856.414358564152, 6199.628022318653, 6247.531435142359, 6252.187215661957, 6282.340354262805, 6153.7538498460235, 6161.0, 6179.69101544921, 6187.535934804908, 6192.5974811637325, 5913.113033045035, 6288.0, 6298.181236439279, 6299.811005669837, 6301.495880329563, 5938.138969849391, 6104.816855494342, 6111.480524155452, 6169.598976066542, 6172.105044768484, 13935.930320348434, 13958.860411395857, 14060.0, 14107.36516856744, 14168.937329700313, 2212.225720997654, 2223.155201023617, 2246.730392352928, 2357.0689577616745, 2385.7733515316017, 8273.255407013397, 10097.495125243782, 10207.234457415723, 14053.156810591398, 14475.565733028026, 1796.8023517413073, 1833.3491610478354, 1853.972190417145, 1862.5622978600018, 1887.773467183933, 116579.83420165775, 116714.0, 121353.78646213513, 122072.0, 124071.3796431012, 11722.531098756124, 11998.100142489347, 12121.333326666942, 12128.75742485163, 12288.877111228774, 15167.0, 15510.224488775742, 15634.9218253908, 15644.765328520081, 15744.60638484047, 9167.08329167078, 9206.217471514863, 9234.122758337948, 9424.481653509123, 9439.480828554495, 6925.861482770317, 7636.427267954815, 8387.832243355098, 9343.486108263975, 9366.110219529133, 4008.5590585035625, 4736.621070314367, 4781.330613714083, 4827.444843842933, 4867.050925069578, 1705.8294170582842, 1977.9121483184192, 2081.7918208179362, 2109.093089971296, 2112.6936594193758, 891.826093911681, 989.2185173712686, 1011.8836333821557, 1019.2915923433291, 1074.1353210665334, 20890.0, 21491.247806326704, 21676.0, 21744.15059256361, 21816.672749908765, 934.966861617916, 998.2712619787595, 1023.81059503992, 1081.2755453845941, 1120.56298043763, 11400.828987565194, 11580.88419115815, 11588.88411115895, 11627.0, 11892.702682433008, 608847.0, 614955.0, 615540.0, 628732.0, 664827.0, 126624.36687816687, 127395.0, 130337.69662303255, 134377.32811335882, 136426.31786841003, 961.5961296255589, 1021.1881554164457, 1097.6816723150357, 1098.9780204396027, 1111.472050775875, 18045.909770451064, 18059.729104063186, 18384.908075460073, 18481.81518184801, 18692.06539672984, 38974.610253897095, 50222.2466662993, 51179.232311514614, 52203.47796521986, 54293.0, 76878.0, 78095.43809123672, 80011.59994199991, 80289.19710802817, 80791.78812317703, 6925.688344024632, 8605.741827745178, 8635.093315201813, 8655.870161947701, 8789.516576588094, 8333.624986875484, 9704.514774261399, 12234.938825305817, 12829.486820527074, 13538.323083845571, 10925.453727313443, 11691.298522088702, 11699.0, 11812.232204906997, 11835.408229588314, 10865.728356791144, 11241.156913231376, 11472.31166130035, 11618.0, 11704.88295117072, 6070.089486576872, 10876.640419947507, 11668.0, 11735.41322933867, 11820.468078936297, 8513.0, 8534.658613655385, 8748.343874209333, 8753.212210901049, 9025.548722563713, 10707.464626768475, 11687.474063667325, 11849.585264515701, 11937.045036397241, 11989.940050299692], "value": 9765.409791234366, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1569.7566877134045, 1645.605054786851, 1914.25802519707, 2011.818936295732, 2061.6701327787537, 8279.668813247463, 8837.293016558677, 8996.955015224923, 9239.953800230998, 9272.90727092729, 8927.55362231889, 8964.462132272069, 9102.544872756369, 9110.407823491469, 9120.0, 2556.18202175304, 2582.612608108789, 2586.935326616831, 2587.3531617095728, 2589.9093531726394, 2532.1390727152766, 2546.6052761821948, 2547.414094758207, 2548.745125487455, 2553.770160685538, 2557.3350928758564, 2570.4730530241254, 2589.2361753282735, 2609.673790776153, 2610.530104581175, 2565.743425657438, 2568.8715564221716, 2578.033237535924, 2587.159173268695, 2593.442409881875, 2316.2628028978265, 2428.3200703802963, 2580.767730904228, 2585.17274472169, 2614.16346769034, 9124.406913550665, 9242.491662958535, 9268.536573171314, 9280.443173409618, 9281.953590232073, 5689.573282003867, 5752.2234498342605, 5851.941480585225, 5870.882582348372, 5895.027320492114, 3654.524911761454, 3771.41543060826, 3797.9240415191543, 3805.2009078093633, 3823.260416510509, 1032.488917985602, 1032.6798692405303, 1069.1927594666056, 1086.2233503045281, 1102.1127991966464, 10503.369797812156, 12280.07899407548, 12283.57007504742, 12320.445579949013, 12331.815022774575, 4995.925061124086, 5010.69935803853, 5052.7726252318735, 5063.518965698253, 5109.20807274873, 10417.739556511147, 10446.63436779709, 10466.0, 10490.0, 10501.422421766723, 5638.35158956717, 5654.74553645087, 5666.15007748841, 5715.971420142872, 5764.07774756037, 3926.450296958428, 5051.3433253676785, 5155.74221288934, 5185.481451854785, 5317.8936421271355, 4263.467066616673, 4266.445362102907, 4311.8490852820005, 4363.105563359503, 4370.672199585044, 1395.1489591349268, 1418.6595217148017, 1420.3040510149951, 1421.0460616652103, 1428.250168661461, 885.6368888755579, 903.4759839293325, 920.8572671235969, 965.9758506037265, 969.7963427680126, 6087.6956152192215, 6115.877682446326, 6131.908021379683, 6179.598326108879, 6226.034964580497, 482.71278589239347, 485.6236416777026, 486.8612445453029, 492.3943549434216, 507.2163507381105, 3902.1025164211824, 3993.860214892523, 3995.1610161866333, 4084.571120032413, 4126.587341265849, 9570.904290957002, 11174.0, 11200.663980080612, 11395.829062564067, 11513.309201447772, 10460.320079194827, 10739.624113156158, 10835.51240194193, 10852.294600850919, 10992.725181870357, 8495.36284778644, 8644.049154592863, 8685.08806575313, 8694.739157825275, 8721.040685524587, 5864.648121112747, 6064.090386442069, 6064.636121832704, 6074.453299203093, 6223.9691145884, 9768.267379946674, 9842.65550705722, 10012.349197302152, 10033.14718248957, 10065.547050382604, 9854.063863933201, 10161.882192958916, 10191.28660993753, 10210.642627508001, 10225.130863876357, 7130.2869713028285, 7622.69509219625, 7799.688012479437, 7832.295093441618, 7948.443608947318, 8573.056963734109, 8592.742217733477, 8635.963684357666, 8698.304135669257, 8707.825843483222, 7538.434617403607, 7686.154523002577, 7729.884051739116, 7748.806279843049, 7773.650185741542, 7458.627068646654, 7488.850222995618, 7504.699812007459, 7511.3615342696485, 7708.0, 7197.82005449847, 7235.8552828944175, 7236.276372362721, 7239.819004524718, 7241.855162896607, 4452.821887124479, 4889.850885042083, 5018.648694591344, 5195.792168313225, 5216.9739151304, 5152.922706159486, 5175.741212939413, 5178.6374953752875, 5253.763580638957, 5368.4631536846], "value": 4727.096533514714, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.31824986526675, 345.1922501346848, 345.5732170769101, 348.71579662575, 348.98445523526533, 6346.365363463651, 6986.231514533403, 7020.368166864975, 7045.225025247219, 7049.436045116391, 5673.347565030022, 6893.103896493449, 6916.100906882111, 6959.443244540437, 6964.233934267227, 4874.195757699975, 4970.900581988376, 5116.974415127919, 5155.639105262633, 5171.896562068757, 5069.518395752416, 5137.897242055156, 5153.716545589991, 5156.994386094713, 5188.870278243036, 5088.1350170471105, 5101.591872650179, 5104.387473503166, 5111.233315002761, 5123.487651234866, 5103.4896510349035, 5121.692698438105, 5125.026245013435, 5145.511176438251, 5155.819546315861, 4405.185040767468, 4408.515063343029, 4411.051623900845, 4414.955850441486, 4419.674097770688, 6546.050822630739, 6573.112629794964, 6633.734650613969, 6687.531872768908, 6737.427318677918, 5919.230500034968, 5957.582969192158, 5979.820605381846, 5986.640801551877, 5992.730327135289, 7396.9274455203695, 7400.111986561647, 7407.370373518257, 7420.406367490587, 7445.069366329209, 4013.7391069580676, 4893.559579637814, 4899.0, 4911.8280860169725, 4920.975395123037, 7150.356467917861, 7466.55200687955, 7765.650545725456, 7814.960925195394, 7834.4907581007055, 4949.628777841676, 4977.776000080005, 5043.949560504348, 5050.469700681376, 5058.418281897629, 3742.962570374316, 4629.976850115795, 5128.794848206105, 5129.538341549279, 5134.7946082156295, 5489.725513724298, 5945.732442040118, 5968.22413086296, 5971.492423144082, 5973.940260597338, 7478.626068696543, 7522.473426860067, 7536.585487798114, 7537.2462753724185, 7539.472236943361, 1724.387842315985, 1778.4486809088964, 1809.3034181840087, 1811.8007019227875, 1813.6463389639157, 1148.4257871064467, 1165.091228841505, 1167.486306025346, 1170.7541416302672, 1173.2198088271375, 7009.369156775812, 7108.537945033556, 7115.71537138519, 7127.679254433563, 7152.570845749272, 7465.29079737424, 7624.885626715603, 7699.153093159748, 7722.884156737653, 7724.150343462215, 7124.323189297009, 7137.714491420389, 7146.249643787328, 7203.639818009184, 7223.133224013047, 4064.9796751016647, 4115.444415003996, 4122.525909520444, 4125.195586860534, 4127.669786417079, 6477.862305439194, 6706.731730730716, 8427.367947403847, 8429.32565394767, 8435.451695639886, 7493.4005279577505, 7754.457187996899, 8037.598120093972, 8051.677932882619, 8059.63731632078, 6754.662266886734, 8349.582520873932, 8389.916100839158, 8409.495430274203, 8451.915480845359, 7816.64825082884, 7825.608719563885, 7829.45193836426, 7831.530108193527, 7846.058472983279, 7677.385809135144, 7686.077670679554, 7687.423443241667, 7691.269329413697, 7704.036995375578, 6997.230304666381, 8066.395020373378, 8106.108328084024, 8320.292775114183, 8350.958245208734, 4737.952620473751, 4866.610671146229, 4876.536729010738, 4882.414110306786, 4884.780184891617, 7786.143524212445, 7788.493747906368, 7799.259070388304, 7806.0, 7828.608569571613, 6495.740170393131, 6903.1371078615175, 7501.1373692023935, 7509.399248060033, 7514.211007844097, 7393.44549158826, 7454.291842274975, 7455.366293865082, 7472.813179670552, 7478.663460144197, 7309.963450182715, 7331.156916954618, 7331.890021649786, 7343.77968660941, 7357.374623157091, 7475.0, 7488.625568721433, 7500.199952011369, 7505.099388073466, 7534.773956781305, 6219.720112595034, 7119.252478489684, 7130.322619351154, 7318.121825380776, 7382.114146302478], "value": 5451.840779055362, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.7935779587231, 781.7107670162037, 790.6955822008525, 791.4103992525569, 807.3057170833084, 15287.235638218086, 15674.843251567481, 15691.21543922805, 15699.058056516602, 15721.292541835617, 14152.29238538074, 14340.713185736278, 14346.641333966656, 14393.992420530567, 14429.917756168277, 757.4054367321654, 909.713440266314, 916.812053529025, 920.2913756407562, 934.3506263147116, 915.1946287267228, 928.2481190235897, 936.8782058332407, 941.1106504353389, 949.4066208619613, 978.8189185000762, 984.1339621133393, 999.3104757717189, 1000.2148313573846, 1008.2438171371472, 948.5921053946801, 992.533509250651, 994.0854413939157, 996.1234113979724, 1013.229945241618, 723.7720118162762, 726.8582626387856, 743.6839343279084, 762.2301475509774, 769.3921801776589, 15163.24183790817, 15183.240837958057, 15459.0, 15534.300956456873, 15611.531654050397, 13526.797098043537, 13536.052476326562, 13577.049606527547, 13631.977601679815, 13722.65693357664, 10250.897491025069, 10323.535440905178, 10336.84494732572, 10437.582496700123, 10639.202059845542, 3447.827608619584, 3566.696830769362, 3647.288778688157, 3647.81760911956, 3707.0917625181733, 84118.15881841164, 85356.57321713414, 85865.57067214623, 86262.56868715679, 90167.09832901653, 9838.0, 9853.950730246303, 9927.553260103312, 10197.235207359477, 10542.977839473635, 22591.322260332217, 23213.53572928532, 23305.300840974458, 23770.88114559416, 23776.88111559431, 7681.731139410093, 7696.307332340116, 7744.41916856238, 7749.992500974837, 8007.879881801778, 4198.265303571863, 4228.76741779199, 4238.554951730086, 4325.199838029912, 4325.41606883073, 3731.5149030625844, 3783.319002579562, 3799.525059367579, 3822.4648549203134, 3827.0, 595.4938302442976, 653.8394350028642, 676.4588329336511, 684.090160087083, 684.7295318349225, 590.0, 608.716946619824, 622.7695752571487, 628.7327885648581, 645.5610185074195, 7614.847703045908, 8279.917200827915, 8516.446430981967, 8577.75622534729, 8729.825403492021, 606.8027890935464, 609.1411110334407, 609.8719268953481, 616.512954765739, 620.8416853702277, 3922.8626998054933, 3935.252302062599, 3953.1698343347643, 4015.277250095011, 4120.938185927213, 95282.52358738161, 97162.0, 97935.51032244794, 98110.0, 98403.0, 82658.17341826625, 83062.0, 83233.58383208167, 83318.0, 85193.0, 56729.0, 65556.67221663862, 67058.66470667615, 71113.0, 72248.91626625604, 7854.371650267851, 7872.763817085268, 7949.920500794918, 7997.440179187401, 8015.719449819228, 48109.0, 49359.0, 49633.0, 49699.50300497093, 50381.49618503768, 62692.37307627048, 64013.0, 65315.673421632586, 65448.67275663591, 65556.0, 10537.157027437634, 10538.262321637718, 10798.56805727762, 10809.405482698527, 10851.782964340828, 10969.50637221311, 10970.957759012881, 11212.943935280271, 11474.139439542234, 11517.82723259135, 10550.103241224275, 10582.100521455763, 10626.787464250827, 10875.347479151276, 10984.890151098387, 10466.790664186521, 10471.94764026175, 10687.412192329497, 10825.512851921525, 11024.007839294502, 10462.110720588835, 11248.437578120898, 11867.287962722265, 11996.58011969577, 12027.518899244282, 9855.487307929463, 10076.505883346948, 10079.647212347532, 10103.292769506357, 10248.0, 10025.5488503019, 10036.598536058767, 10178.847317290394, 10189.898101018895, 10247.59009639636], "value": 7075.935194127431, "unit": "score"}], "name": "dromaeo_css", "value": 7655.075399103375, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 116.0, 117.0, 116.0, 132.0, 117.0, 120.0, 171.0, 168.0], "value": 128.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 135.0, 178.0, 120.0, 166.0, 150.0, 155.0, 203.0, 119.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [282.0, 205.0, 274.0, 214.0, 196.0, 194.0, 192.0, 197.0, 196.0, 205.0], "value": 215.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 82.0, 74.0, 146.0, 56.0, 57.0, 61.0, 67.0, 133.0, 56.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 87.0, 130.0, 76.0, 80.0, 79.0, 124.0, 80.0, 78.0, 124.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 79.0, 133.0, 128.0, 91.0, 74.0, 132.0, 87.0, 121.0, 125.0], "value": 106.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 102.0, 138.0, 96.0, 94.0, 96.0, 95.0, 116.0, 119.0], "value": 104.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 141.0, 91.0, 91.0, 92.0, 92.0, 143.0, 119.0, 92.0, 138.0], "value": 114.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 59.0, 65.0, 64.0, 64.0, 65.0, 61.0, 85.0, 89.0, 90.0], "value": 69.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 69.0, 66.0, 71.0, 73.0, 77.0, 72.0, 79.0, 58.0, 85.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 82.0, 79.0, 81.0, 81.0, 82.0, 79.0, 84.0, 84.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 141.0, 143.0, 159.0, 152.0, 150.0, 126.0, 127.0, 147.0, 146.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 223.0, 177.0, 155.0, 161.0, 155.0, 162.0, 162.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 68.0, 66.0, 68.0, 68.0, 85.0, 91.0, 93.0, 89.0], "value": 75.9, "unit": "score"}], "name": "kraken", "value": 1602.4000000000003, "alertThreshold": 2.0}]} 02:50:30 INFO - Return code: 0 02:50:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:50:30 ERROR - # TBPL SUCCESS # 02:50:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:50:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:50:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:50:30 INFO - 2016-06-21 02:50:30.356 screenresolution[2245:18680] starting screenresolution argv=screenresolution get 02:50:30 INFO - 2016-06-21 02:50:30.359 screenresolution[2245:18680] Display 0: 1600x1200x32@60 02:50:30 INFO - 2016-06-21 02:50:30.365 screenresolution[2246:18683] starting screenresolution argv=screenresolution list 02:50:30 INFO - Available Modes on Display 0 02:50:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:50:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:50:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:50:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:50:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:50:30 INFO - Intel Iris: 02:50:30 INFO - Chipset Model: Intel Iris 02:50:30 INFO - Type: GPU 02:50:30 INFO - Bus: Built-In 02:50:30 INFO - VRAM (Dynamic, Max): 1536 MB 02:50:30 INFO - Vendor: Intel (0x8086) 02:50:30 INFO - Device ID: 0x0a2e 02:50:30 INFO - Revision ID: 0x0009 02:50:30 INFO - Displays: 02:50:30 INFO - Display: 02:50:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:50:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:50:30 INFO - Display Serial Number: 1600x1200 60 02:50:30 INFO - Main Display: Yes 02:50:30 INFO - Mirror: Off 02:50:30 INFO - Online: Yes 02:50:30 INFO - Rotation: Supported 02:50:30 INFO - Return code: 0 02:50:30 INFO - Running post-action listener: _resource_record_post_action 02:50:30 INFO - Running post-run listener: _resource_record_post_run 02:50:31 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 1110016; Write bytes: 494805504; Read time: 11; Write time: 1566 02:50:31 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 182858240; Write bytes: 177394176; Read time: 16497; Write time: 405 02:50:31 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 1007616; Write bytes: 298078208; Read time: 8; Write time: 1108 02:50:31 INFO - Running post-run listener: _upload_blobber_files 02:50:31 INFO - Blob upload gear active. 02:50:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:50:31 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 02:50:31 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'] 02:50:31 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 02:50:32 INFO - (blobuploader) - INFO - Open directory for files ... 02:50:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:50:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:50:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:33 INFO - (blobuploader) - INFO - Done attempting. 02:50:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:50:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:50:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:34 INFO - (blobuploader) - INFO - Done attempting. 02:50:34 INFO - (blobuploader) - INFO - Iteration through files over. 02:50:34 INFO - Return code: 0 02:50:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:50:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:50:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e6f59d2bf16505526d15d6cdbd3ba4048d4b89ee22c8e44c596db15d255597300d7dfb9d9caabb97f8000181bbfca2ec640cd77cc0ddee7b5c2ce7680a4f811", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/439c47a289f3fca6190317cb96f5bb749dcd7f1618d24427fd269f25f02b0469c9be9627e7d57a6d1acfd61951290a16cfbcb814921262befd8eeb9fd8e40587"} 02:50:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:50:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:50:34 INFO - Contents: 02:50:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e6f59d2bf16505526d15d6cdbd3ba4048d4b89ee22c8e44c596db15d255597300d7dfb9d9caabb97f8000181bbfca2ec640cd77cc0ddee7b5c2ce7680a4f811", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/439c47a289f3fca6190317cb96f5bb749dcd7f1618d24427fd269f25f02b0469c9be9627e7d57a6d1acfd61951290a16cfbcb814921262befd8eeb9fd8e40587"} 02:50:34 INFO - Running post-run listener: copy_logs_to_upload_dir 02:50:34 INFO - Copying logs to upload dir... 02:50:34 INFO - mkdir: /builds/slave/test/build/upload/logs 02:50:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.245017 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-21 02:50:34.840422) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 02:50:34.844086) ========= 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.S1dG4QKl4P/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.CB7vO2u4o1/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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/7e6f59d2bf16505526d15d6cdbd3ba4048d4b89ee22c8e44c596db15d255597300d7dfb9d9caabb97f8000181bbfca2ec640cd77cc0ddee7b5c2ce7680a4f811", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/439c47a289f3fca6190317cb96f5bb749dcd7f1618d24427fd269f25f02b0469c9be9627e7d57a6d1acfd61951290a16cfbcb814921262befd8eeb9fd8e40587"} build_url:https://queue.taskcluster.net/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/PiAetYqjTOq5PSwpIpmRYg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e6f59d2bf16505526d15d6cdbd3ba4048d4b89ee22c8e44c596db15d255597300d7dfb9d9caabb97f8000181bbfca2ec640cd77cc0ddee7b5c2ce7680a4f811", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/439c47a289f3fca6190317cb96f5bb749dcd7f1618d24427fd269f25f02b0469c9be9627e7d57a6d1acfd61951290a16cfbcb814921262befd8eeb9fd8e40587"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 02:50:34.880029) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:50:34.880818) ========= 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.S1dG4QKl4P/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.CB7vO2u4o1/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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.005371 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:50:34.933256) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 02:50:34.933948) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 02:50:34.934634) ========= ========= Total master_lag: 0.19 =========