builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0035 starttime: 1461281785.48 results: success (0) buildid: 20160421144315 builduid: b44aac0a02b642e6bb4d839693f363c8 revision: 0891f0fa044cba28024849803e170ed7700e01e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 16:36:25.476442) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 16:36:25.476850) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 16:36:25.477137) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 16:36:25.596325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 16:36:25.600595) ========= 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.tDTbYnFPdh/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.NFYVNuDQBo/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-21 16:36:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.1M=0.001s 2016-04-21 16:36:25 (15.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161276 ========= master_lag: 1.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 16:36:26.898003) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-04-21 16:36:26.898292) ========= 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.tDTbYnFPdh/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.NFYVNuDQBo/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.027680 ========= master_lag: 2.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-04-21 16:36:28.955696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2016-04-21 16:36:28.956019) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0891f0fa044cba28024849803e170ed7700e01e0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0891f0fa044cba28024849803e170ed7700e01e0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tDTbYnFPdh/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.NFYVNuDQBo/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-21 16:36:29,539 truncating revision to first 12 chars 2016-04-21 16:36:29,539 Setting DEBUG logging. 2016-04-21 16:36:29,539 attempt 1/10 2016-04-21 16:36:29,539 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0891f0fa044c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 16:36:31,520 unpacking tar archive at: mozilla-central-0891f0fa044c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.230115 ========= master_lag: 9.66 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2016-04-21 16:36:40.843488) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 16:36:40.843779) ========= script_repo_revision: 0891f0fa044cba28024849803e170ed7700e01e0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 16:36:40.844140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 8 secs) (at 2016-04-21 16:36:40.844404) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 8 secs) (at 2016-04-21 16:36:49.623290) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-04-21 16:36:49.623549) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tDTbYnFPdh/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.NFYVNuDQBo/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 16:36:49 INFO - MultiFileLogger online at 20160421 16:36:49 in /builds/slave/test 16:36:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:36:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:36:49 INFO - {'append_to_log': False, 16:36:49 INFO - 'base_work_dir': '/builds/slave/test', 16:36:49 INFO - 'blob_upload_branch': 'Firefox', 16:36:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:36:49 INFO - 'branch': 'Firefox', 16:36:49 INFO - 'buildbot_json_path': 'buildprops.json', 16:36:49 INFO - 'config_files': ('talos/mac_config.py',), 16:36:49 INFO - 'default_actions': ('clobber', 16:36:49 INFO - 'read-buildbot-config', 16:36:49 INFO - 'download-and-extract', 16:36:49 INFO - 'populate-webroot', 16:36:49 INFO - 'create-virtualenv', 16:36:49 INFO - 'install', 16:36:49 INFO - 'run-tests'), 16:36:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:36:49 INFO - 'download_minidump_stackwalk': True, 16:36:49 INFO - 'download_symbols': 'ondemand', 16:36:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:36:49 INFO - 'tooltool.py': '/tools/tooltool.py', 16:36:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:36:49 INFO - '/tools/misc-python/virtualenv.py')}, 16:36:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:36:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:36:49 INFO - 'installer_path': 'installer.exe', 16:36:49 INFO - 'log_level': 'info', 16:36:49 INFO - 'log_name': 'talos', 16:36:49 INFO - 'log_to_console': True, 16:36:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:36:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:36:49 INFO - 'opt_config_files': (), 16:36:49 INFO - 'pip_index': False, 16:36:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:36:49 INFO - 'cmd': ('bash', 16:36:49 INFO - '-c', 16:36:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:36:49 INFO - 'enabled': True, 16:36:49 INFO - 'halt_on_failure': False, 16:36:49 INFO - 'name': 'check_screen_resolution'},), 16:36:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:36:49 INFO - 'cmd': ('bash', 16:36:49 INFO - '-c', 16:36:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:36:49 INFO - 'enabled': True, 16:36:49 INFO - 'halt_on_failure': False, 16:36:49 INFO - 'name': 'check_screen_resolution'},), 16:36:49 INFO - 'run_cmd_checks_enabled': True, 16:36:49 INFO - 'sps_profile': False, 16:36:49 INFO - 'sps_profile_interval': 0, 16:36:49 INFO - 'suite': 'dromaeojs-e10s', 16:36:49 INFO - 'system_bits': '32', 16:36:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:36:49 INFO - 'title': 't-yosemite-r7-0035', 16:36:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:36:49 INFO - 'use_talos_json': True, 16:36:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:36:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:36:49 INFO - 'work_dir': 'build'} 16:36:49 INFO - ##### 16:36:49 INFO - ##### Running clobber step. 16:36:49 INFO - ##### 16:36:49 INFO - Running pre-action listener: _resource_record_pre_action 16:36:49 INFO - Running main action method: clobber 16:36:49 INFO - rmtree: /builds/slave/test/build 16:36:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:36:51 INFO - Running post-action listener: _resource_record_post_action 16:36:51 INFO - ##### 16:36:51 INFO - ##### Running read-buildbot-config step. 16:36:51 INFO - ##### 16:36:51 INFO - Running pre-action listener: _resource_record_pre_action 16:36:51 INFO - Running main action method: read_buildbot_config 16:36:51 INFO - Using buildbot properties: 16:36:51 INFO - { 16:36:51 INFO - "project": "", 16:36:51 INFO - "product": "firefox", 16:36:51 INFO - "script_repo_revision": "production", 16:36:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 16:36:51 INFO - "repository": "", 16:36:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 16:36:51 INFO - "buildid": "20160421144315", 16:36:51 INFO - "pgo_build": "False", 16:36:51 INFO - "basedir": "/builds/slave/test", 16:36:51 INFO - "buildnumber": 34, 16:36:51 INFO - "slavename": "t-yosemite-r7-0035", 16:36:51 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:36:51 INFO - "platform": "yosemite_r7", 16:36:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:36:51 INFO - "branch": "mozilla-central", 16:36:51 INFO - "repo_path": "mozilla-central", 16:36:51 INFO - "revision": "0891f0fa044cba28024849803e170ed7700e01e0", 16:36:51 INFO - "stage_platform": "macosx64", 16:36:51 INFO - "builduid": "b44aac0a02b642e6bb4d839693f363c8", 16:36:51 INFO - "slavebuilddir": "test" 16:36:51 INFO - } 16:36:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 16:36:51 INFO - Running post-action listener: _resource_record_post_action 16:36:51 INFO - ##### 16:36:51 INFO - ##### Running download-and-extract step. 16:36:51 INFO - ##### 16:36:51 INFO - Running pre-action listener: _resource_record_pre_action 16:36:51 INFO - Running main action method: download_and_extract 16:36:51 INFO - mkdir: /builds/slave/test/build/tests 16:36: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')]} 16:36:51 INFO - https://queue.taskcluster.net/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:36:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:36:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:36:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 16:36:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 16:36:53 INFO - Downloaded 1199 bytes. 16:36:53 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 16:36:53 INFO - Using the following test package requirements: 16:36:53 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:36:53 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:36:53 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 16:36:53 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:36:53 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 16:36:53 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:36:53 INFO - u'jsshell-mac.zip'], 16:36:53 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:36:53 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 16:36:53 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:36:53 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:36:53 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 16:36:53 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:36:53 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 16:36:53 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:36:53 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 16:36:53 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:36:53 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 16:36:53 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:53 INFO - https://queue.taskcluster.net/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:36:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:36:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:36:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:36:55 INFO - Downloaded 18105721 bytes. 16:36:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:36:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:36:58 INFO - Return code: 0 16:36:58 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:58 INFO - https://queue.taskcluster.net/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:36:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:36:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:36:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:36:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:37:00 INFO - Downloaded 18105721 bytes. 16:37:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:37:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:37:04 INFO - Return code: 0 16:37:04 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')]} 16:37:04 INFO - https://queue.taskcluster.net/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:37:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:37:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:37:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:37:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:37:06 INFO - Downloaded 10845952 bytes. 16:37:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:37:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:37:06 INFO - Return code: 0 16:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:06 INFO - https://queue.taskcluster.net/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:37:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:37:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:37:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 16:37:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 16:37:10 INFO - Downloaded 110044448 bytes. 16:37:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:37:10 INFO - mkdir: /builds/slave/test/properties 16:37:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:37:10 INFO - Writing to file /builds/slave/test/properties/build_url 16:37:10 INFO - Contents: 16:37:10 INFO - build_url:https://queue.taskcluster.net/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:37:11 INFO - Running post-action listener: _resource_record_post_action 16:37:11 INFO - Running post-action listener: set_extra_try_arguments 16:37:11 INFO - ##### 16:37:11 INFO - ##### Running populate-webroot step. 16:37:11 INFO - ##### 16:37:11 INFO - Running pre-action listener: _resource_record_pre_action 16:37:11 INFO - Running main action method: populate_webroot 16:37:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:37:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:37:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:37:11 INFO - '--tppagecycles', 16:37:11 INFO - '7'], 16:37:11 INFO - 'tests': ['tsvgm']}}, 16:37:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:37:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:37:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:37:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:37:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:37:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:37:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:11 INFO - 'talos_options': ['--disable-e10s'], 16:37:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:11 INFO - 'talos_options': ['--disable-e10s'], 16:37:11 INFO - 'tests': ['damp', 'tps']}, 16:37:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:11 INFO - 'tests': ['damp', 'tps']}, 16:37:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:37:11 INFO - 'tests': ['dromaeo_dom']}, 16:37:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:37:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:37:11 INFO - 'tests': ['a11yr', 16:37:11 INFO - 'ts_paint', 16:37:11 INFO - 'tpaint', 16:37:11 INFO - 'sessionrestore', 16:37:11 INFO - 'sessionrestore_no_auto_restore', 16:37:11 INFO - 'tabpaint']}, 16:37:11 INFO - 'other-e10s': {'tests': ['a11yr', 16:37:11 INFO - 'ts_paint', 16:37:11 INFO - 'tpaint', 16:37:11 INFO - 'sessionrestore', 16:37:11 INFO - 'sessionrestore_no_auto_restore', 16:37:11 INFO - 'tabpaint']}, 16:37:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:37:11 INFO - 'ts_paint', 16:37:11 INFO - 'tpaint', 16:37:11 INFO - 'sessionrestore', 16:37:11 INFO - 'sessionrestore_no_auto_restore', 16:37:11 INFO - 'tabpaint']}, 16:37:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:37:11 INFO - 'ts_paint', 16:37:11 INFO - 'tpaint', 16:37:11 INFO - 'sessionrestore', 16:37:11 INFO - 'sessionrestore_no_auto_restore', 16:37:11 INFO - 'tabpaint']}, 16:37:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:37:11 INFO - 'tests': ['a11yr', 16:37:11 INFO - 'ts_paint', 16:37:11 INFO - 'tpaint', 16:37:11 INFO - 'sessionrestore', 16:37:11 INFO - 'sessionrestore_no_auto_restore', 16:37:11 INFO - 'tabpaint']}, 16:37:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:37:11 INFO - 'tests': ['a11yr', 16:37:11 INFO - 'ts_paint', 16:37:11 INFO - 'tpaint', 16:37:11 INFO - 'sessionrestore', 16:37:11 INFO - 'sessionrestore_no_auto_restore', 16:37:11 INFO - 'tabpaint']}, 16:37:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:37:11 INFO - 'tests': ['tsvgx', 16:37:11 INFO - 'tsvgr_opacity', 16:37:11 INFO - 'tart', 16:37:11 INFO - 'tscrollx', 16:37:11 INFO - 'cart']}, 16:37:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:37:11 INFO - 'tsvgr_opacity', 16:37:11 INFO - 'tart', 16:37:11 INFO - 'tscrollx', 16:37:11 INFO - 'cart']}, 16:37:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:11 INFO - 'talos_options': ['--disable-e10s'], 16:37:11 INFO - 'tests': ['tp5o']}, 16:37:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:11 INFO - 'tests': ['tp5o']}, 16:37:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:11 INFO - 'talos_options': ['--disable-e10s', 16:37:11 INFO - '--xperf_path', 16:37:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:11 INFO - 'tests': ['tp5n']}, 16:37:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:11 INFO - 'talos_options': ['--xperf_path', 16:37:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:11 INFO - 'tests': ['tp5n']}}, 16:37:11 INFO - 'talos.zip': {'path': '', 16:37:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:37:11 INFO - Running post-action listener: _resource_record_post_action 16:37:11 INFO - ##### 16:37:11 INFO - ##### Running create-virtualenv step. 16:37:11 INFO - ##### 16:37:11 INFO - Running pre-action listener: _resource_record_pre_action 16:37:11 INFO - Running main action method: create_virtualenv 16:37:11 INFO - Creating virtualenv /builds/slave/test/build/venv 16:37:11 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 16:37:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:37:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:37:12 INFO - Using real prefix '/tools/python27' 16:37:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:37:12 INFO - Installing distribute.............................................................................................................................................................................................done. 16:37:15 INFO - Installing pip.................done. 16:37:15 INFO - Return code: 0 16:37:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:37:15 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')]} 16:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:15 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')]} 16:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:15 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 0x10d1c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2ca8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d068e00>, '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 0x10ced1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d063b20>, '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.tDTbYnFPdh/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.NFYVNuDQBo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 16:37:15 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 16:37:15 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 16:37:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tDTbYnFPdh/Render', 16:37:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:15 INFO - 'HOME': '/Users/cltbld', 16:37:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:15 INFO - 'LOGNAME': 'cltbld', 16:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:15 INFO - 'MOZ_NO_REMOTE': '1', 16:37:15 INFO - 'NO_EM_RESTART': '1', 16:37:15 INFO - 'PAGER': '/bin/cat', 16:37:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:15 INFO - 'PWD': '/builds/slave/test', 16:37:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:15 INFO - 'SHELL': '/bin/bash', 16:37:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NFYVNuDQBo/Listeners', 16:37:15 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 16:37:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:15 INFO - 'USER': 'cltbld', 16:37:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:15 INFO - 'XPC_FLAGS': '0x0', 16:37:15 INFO - 'XPC_SERVICE_NAME': '0', 16:37:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:15 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 16:37:15 INFO - Cleaning up... 16:37:15 INFO - Return code: 0 16:37:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:37:15 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')]} 16:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:15 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')]} 16:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:15 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 0x10d1c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2ca8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d068e00>, '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 0x10ced1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d063b20>, '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.tDTbYnFPdh/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.NFYVNuDQBo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 16:37:15 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 16:37:15 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 16:37:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tDTbYnFPdh/Render', 16:37:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:15 INFO - 'HOME': '/Users/cltbld', 16:37:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:15 INFO - 'LOGNAME': 'cltbld', 16:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:15 INFO - 'MOZ_NO_REMOTE': '1', 16:37:15 INFO - 'NO_EM_RESTART': '1', 16:37:15 INFO - 'PAGER': '/bin/cat', 16:37:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:15 INFO - 'PWD': '/builds/slave/test', 16:37:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:15 INFO - 'SHELL': '/bin/bash', 16:37:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NFYVNuDQBo/Listeners', 16:37:15 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 16:37:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:15 INFO - 'USER': 'cltbld', 16:37:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:15 INFO - 'XPC_FLAGS': '0x0', 16:37:15 INFO - 'XPC_SERVICE_NAME': '0', 16:37:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:16 INFO - Downloading/unpacking psutil>=0.7.1 16:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:37:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:19 INFO - Installing collected packages: psutil 16:37:19 INFO - Running setup.py install for psutil 16:37:19 INFO - building 'psutil._psutil_osx' extension 16:37:19 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 16:37:20 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 16:37:20 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 16:37:20 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 16:37:20 INFO - building 'psutil._psutil_posix' extension 16:37:20 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 16:37:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:37:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:37:20 INFO - ^ 16:37:20 INFO - 1 warning generated. 16:37:20 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 16:37:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:20 INFO - Successfully installed psutil 16:37:20 INFO - Cleaning up... 16:37:20 INFO - Return code: 0 16:37:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d1c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2ca8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d068e00>, '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 0x10ced1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d063b20>, '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.tDTbYnFPdh/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.NFYVNuDQBo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 16:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:37:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tDTbYnFPdh/Render', 16:37:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:20 INFO - 'HOME': '/Users/cltbld', 16:37:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:20 INFO - 'LOGNAME': 'cltbld', 16:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:20 INFO - 'MOZ_NO_REMOTE': '1', 16:37:20 INFO - 'NO_EM_RESTART': '1', 16:37:20 INFO - 'PAGER': '/bin/cat', 16:37:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:20 INFO - 'PWD': '/builds/slave/test', 16:37:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:20 INFO - 'SHELL': '/bin/bash', 16:37:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NFYVNuDQBo/Listeners', 16:37:20 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 16:37:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:20 INFO - 'USER': 'cltbld', 16:37:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:20 INFO - 'XPC_FLAGS': '0x0', 16:37:20 INFO - 'XPC_SERVICE_NAME': '0', 16:37:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:37:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:37:23 INFO - Installing collected packages: mozsystemmonitor 16:37:23 INFO - Running setup.py install for mozsystemmonitor 16:37:23 INFO - Successfully installed mozsystemmonitor 16:37:23 INFO - Cleaning up... 16:37:23 INFO - Return code: 0 16:37:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:37:23 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')]} 16:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:23 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')]} 16:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:23 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 0x10d1c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2ca8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d068e00>, '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 0x10ced1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d063b20>, '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.tDTbYnFPdh/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.NFYVNuDQBo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 16:37:23 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 16:37:23 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 16:37:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tDTbYnFPdh/Render', 16:37:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:23 INFO - 'HOME': '/Users/cltbld', 16:37:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:23 INFO - 'LOGNAME': 'cltbld', 16:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:23 INFO - 'MOZ_NO_REMOTE': '1', 16:37:23 INFO - 'NO_EM_RESTART': '1', 16:37:23 INFO - 'PAGER': '/bin/cat', 16:37:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:23 INFO - 'PWD': '/builds/slave/test', 16:37:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:23 INFO - 'SHELL': '/bin/bash', 16:37:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NFYVNuDQBo/Listeners', 16:37:23 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 16:37:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:23 INFO - 'USER': 'cltbld', 16:37:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:23 INFO - 'XPC_FLAGS': '0x0', 16:37:23 INFO - 'XPC_SERVICE_NAME': '0', 16:37:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:23 INFO - Downloading/unpacking blobuploader==1.2.4 16:37:23 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 16:37:23 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 16:37:23 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 16:37:23 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 16:37:23 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 16:37:23 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 16:37:26 INFO - Downloading blobuploader-1.2.4.tar.gz 16:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:37:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:37:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:27 INFO - Downloading docopt-0.6.1.tar.gz 16:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:37:27 INFO - Installing collected packages: blobuploader, requests, docopt 16:37:27 INFO - Running setup.py install for blobuploader 16:37:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:37:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:37:27 INFO - Running setup.py install for requests 16:37:28 INFO - Running setup.py install for docopt 16:37:28 INFO - Successfully installed blobuploader requests docopt 16:37:28 INFO - Cleaning up... 16:37:28 INFO - Return code: 0 16:37:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:28 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 0x10d1c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2ca8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d068e00>, '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 0x10ced1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d063b20>, '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.tDTbYnFPdh/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.NFYVNuDQBo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 16:37:28 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 16:37:28 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 16:37:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tDTbYnFPdh/Render', 16:37:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:28 INFO - 'HOME': '/Users/cltbld', 16:37:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:28 INFO - 'LOGNAME': 'cltbld', 16:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:28 INFO - 'MOZ_NO_REMOTE': '1', 16:37:28 INFO - 'NO_EM_RESTART': '1', 16:37:28 INFO - 'PAGER': '/bin/cat', 16:37:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:28 INFO - 'PWD': '/builds/slave/test', 16:37:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:28 INFO - 'SHELL': '/bin/bash', 16:37:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NFYVNuDQBo/Listeners', 16:37:28 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 16:37:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:28 INFO - 'USER': 'cltbld', 16:37:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:28 INFO - 'XPC_FLAGS': '0x0', 16:37:28 INFO - 'XPC_SERVICE_NAME': '0', 16:37:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:28 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-6BjIWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:28 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-36guLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:28 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-gsPcoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:28 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-C1UVi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:29 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-cS3TGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:29 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-hB4KtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:29 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-rZIqyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:29 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-DVu67U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:29 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-QSP1R1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:29 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-jlfIga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:29 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-SXJz8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:29 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-4LECEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:29 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-QoTIKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:29 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-Kn_SZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:30 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-uoEtE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:30 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-7NgrMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:30 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-gCEwf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:37:30 INFO - Running setup.py install for manifestparser 16:37:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:37:30 INFO - Running setup.py install for mozcrash 16:37:30 INFO - Running setup.py install for mozdebug 16:37:30 INFO - Running setup.py install for mozdevice 16:37:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:37:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:37:30 INFO - Running setup.py install for mozfile 16:37:31 INFO - Running setup.py install for mozhttpd 16:37:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:37:31 INFO - Running setup.py install for mozinfo 16:37:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:37:31 INFO - Running setup.py install for mozInstall 16:37:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:37:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:37:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:37:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:37:31 INFO - Running setup.py install for mozleak 16:37:31 INFO - Running setup.py install for mozlog 16:37:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:37:31 INFO - Running setup.py install for moznetwork 16:37:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:37:32 INFO - Running setup.py install for mozprocess 16:37:32 INFO - Running setup.py install for mozprofile 16:37:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:37:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:37:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:37:32 INFO - Running setup.py install for mozrunner 16:37:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:37:32 INFO - Running setup.py install for mozscreenshot 16:37:32 INFO - Running setup.py install for moztest 16:37:32 INFO - Running setup.py install for mozversion 16:37:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:37:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:37:32 INFO - Cleaning up... 16:37:32 INFO - Return code: 0 16:37:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:32 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 0x10d1c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2ca8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d068e00>, '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 0x10ced1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d063b20>, '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.tDTbYnFPdh/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.NFYVNuDQBo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 16:37:32 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 16:37:32 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 16:37:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tDTbYnFPdh/Render', 16:37:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:32 INFO - 'HOME': '/Users/cltbld', 16:37:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:32 INFO - 'LOGNAME': 'cltbld', 16:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:32 INFO - 'MOZ_NO_REMOTE': '1', 16:37:32 INFO - 'NO_EM_RESTART': '1', 16:37:32 INFO - 'PAGER': '/bin/cat', 16:37:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:32 INFO - 'PWD': '/builds/slave/test', 16:37:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:32 INFO - 'SHELL': '/bin/bash', 16:37:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NFYVNuDQBo/Listeners', 16:37:32 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 16:37:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:32 INFO - 'USER': 'cltbld', 16:37:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:32 INFO - 'XPC_FLAGS': '0x0', 16:37:32 INFO - 'XPC_SERVICE_NAME': '0', 16:37:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:33 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-HgHiXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:33 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)) 16:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:33 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-8eReDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:33 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)) 16:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:33 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-_C0hQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:33 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)) 16:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:33 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-cTsYHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:33 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)) 16:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:33 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-qtLUYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:33 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)) 16:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:33 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-tYPFVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:33 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)) 16:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:33 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-FTFmAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:33 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)) 16:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:33 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-qJpglm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:34 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)) 16:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-k7Zv1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:34 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)) 16:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-aq5pkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:34 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)) 16:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-HTAUGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:34 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)) 16:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-o1iIYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:34 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)) 16:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-TUrdrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:34 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)) 16:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-vu7ksF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:34 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)) 16:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-tDRYnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:34 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)) 16:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-kmlz7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:34 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)) 16:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-s7phf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:35 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)) 16:37:35 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)) 16:37:35 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)) 16:37:35 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)) 16:37:35 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)) 16:37:35 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)) 16:37:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:37 INFO - Downloading blessings-1.6.tar.gz 16:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:37:37 INFO - Installing collected packages: blessings 16:37:37 INFO - Running setup.py install for blessings 16:37:37 INFO - Successfully installed blessings 16:37:37 INFO - Cleaning up... 16:37:37 INFO - Return code: 0 16:37:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:37:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:38 INFO - Reading from file tmpfile_stdout 16:37:38 INFO - Current package versions: 16:37:38 INFO - blessings == 1.6 16:37:38 INFO - blobuploader == 1.2.4 16:37:38 INFO - docopt == 0.6.1 16:37:38 INFO - manifestparser == 1.1 16:37:38 INFO - mozInstall == 1.12 16:37:38 INFO - mozcrash == 0.17 16:37:38 INFO - mozdebug == 0.1 16:37:38 INFO - mozdevice == 0.48 16:37:38 INFO - mozfile == 1.2 16:37:38 INFO - mozhttpd == 0.7 16:37:38 INFO - mozinfo == 0.9 16:37:38 INFO - mozleak == 0.1 16:37:38 INFO - mozlog == 3.1 16:37:38 INFO - moznetwork == 0.27 16:37:38 INFO - mozprocess == 0.22 16:37:38 INFO - mozprofile == 0.28 16:37:38 INFO - mozrunner == 6.11 16:37:38 INFO - mozscreenshot == 0.1 16:37:38 INFO - mozsystemmonitor == 0.0 16:37:38 INFO - moztest == 0.7 16:37:38 INFO - mozversion == 1.4 16:37:38 INFO - psutil == 3.1.1 16:37:38 INFO - requests == 1.2.3 16:37:38 INFO - wsgiref == 0.1.2 16:37:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:38 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 0x10d1c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2ca8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d068e00>, '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 0x10ced1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d063b20>, '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.tDTbYnFPdh/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.NFYVNuDQBo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 16:37:38 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 16:37:38 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 16:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tDTbYnFPdh/Render', 16:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:38 INFO - 'HOME': '/Users/cltbld', 16:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:38 INFO - 'LOGNAME': 'cltbld', 16:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:38 INFO - 'MOZ_NO_REMOTE': '1', 16:37:38 INFO - 'NO_EM_RESTART': '1', 16:37:38 INFO - 'PAGER': '/bin/cat', 16:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:38 INFO - 'PWD': '/builds/slave/test', 16:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:38 INFO - 'SHELL': '/bin/bash', 16:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NFYVNuDQBo/Listeners', 16:37:38 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 16:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:38 INFO - 'USER': 'cltbld', 16:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:38 INFO - 'XPC_FLAGS': '0x0', 16:37:38 INFO - 'XPC_SERVICE_NAME': '0', 16:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:38 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)) 16:37:38 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)) 16:37:38 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)) 16:37:38 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)) 16:37:38 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)) 16:37:38 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)) 16:37:38 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)) 16:37:38 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)) 16:37:38 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)) 16:37:38 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)) 16:37:38 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)) 16:37:38 INFO - Cleaning up... 16:37:38 INFO - Return code: 0 16:37:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:38 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 0x10d1c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2ca8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d068e00>, '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 0x10ced1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d063b20>, '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.tDTbYnFPdh/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.NFYVNuDQBo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 16:37:38 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 16:37:38 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 16:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tDTbYnFPdh/Render', 16:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:38 INFO - 'HOME': '/Users/cltbld', 16:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:38 INFO - 'LOGNAME': 'cltbld', 16:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:38 INFO - 'MOZ_NO_REMOTE': '1', 16:37:38 INFO - 'NO_EM_RESTART': '1', 16:37:38 INFO - 'PAGER': '/bin/cat', 16:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:38 INFO - 'PWD': '/builds/slave/test', 16:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:38 INFO - 'SHELL': '/bin/bash', 16:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NFYVNuDQBo/Listeners', 16:37:38 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 16:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:38 INFO - 'USER': 'cltbld', 16:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:38 INFO - 'XPC_FLAGS': '0x0', 16:37:38 INFO - 'XPC_SERVICE_NAME': '0', 16:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:38 INFO - Downloading/unpacking jsonschema 16:37:38 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 16:37:38 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 16:37:38 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 16:37:38 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 16:37:38 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 16:37:38 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 16:37:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:37:40 INFO - Downloading/unpacking functools32 (from jsonschema) 16:37:40 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 16:37:40 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 16:37:40 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 16:37:40 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 16:37:40 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 16:37:40 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 16:37:41 INFO - Downloading functools32-3.2.3-2.tar.gz 16:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:37:41 INFO - warning: no files found matching '*.txt' 16:37:41 INFO - no previously-included directories found matching 'build' 16:37:41 INFO - no previously-included directories found matching 'dist' 16:37:41 INFO - no previously-included directories found matching '.git*' 16:37:41 INFO - Installing collected packages: jsonschema, functools32 16:37:41 INFO - Running setup.py install for functools32 16:37:41 INFO - warning: no files found matching '*.txt' 16:37:41 INFO - no previously-included directories found matching 'build' 16:37:41 INFO - no previously-included directories found matching 'dist' 16:37:41 INFO - no previously-included directories found matching '.git*' 16:37:41 INFO - Successfully installed jsonschema functools32 16:37:41 INFO - Cleaning up... 16:37:41 INFO - Return code: 0 16:37:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:41 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 0x10d1c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2ca8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d068e00>, '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 0x10ced1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d063b20>, '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.tDTbYnFPdh/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.NFYVNuDQBo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 16:37:41 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 16:37:41 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 16:37:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tDTbYnFPdh/Render', 16:37:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:41 INFO - 'HOME': '/Users/cltbld', 16:37:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:41 INFO - 'LOGNAME': 'cltbld', 16:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:41 INFO - 'MOZ_NO_REMOTE': '1', 16:37:41 INFO - 'NO_EM_RESTART': '1', 16:37:41 INFO - 'PAGER': '/bin/cat', 16:37:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:41 INFO - 'PWD': '/builds/slave/test', 16:37:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:41 INFO - 'SHELL': '/bin/bash', 16:37:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NFYVNuDQBo/Listeners', 16:37:41 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 16:37:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:41 INFO - 'USER': 'cltbld', 16:37:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:41 INFO - 'XPC_FLAGS': '0x0', 16:37:41 INFO - 'XPC_SERVICE_NAME': '0', 16:37:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:41 INFO - Downloading/unpacking flake8 16:37:41 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 16:37:41 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 16:37:41 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 16:37:41 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 16:37:41 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 16:37:41 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 16:37:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:37:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:37:44 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 16:37:44 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 16:37:44 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 16:37:44 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 16:37:44 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 16:37:44 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 16:37:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:37:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:37:44 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 16:37:44 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 16:37:44 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 16:37:44 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 16:37:44 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 16:37:44 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 16:37:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:37:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:45 INFO - no previously-included directories found matching 'docs/_build' 16:37:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:37:45 INFO - Running setup.py install for pep8 16:37:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:45 INFO - no previously-included directories found matching 'docs/_build' 16:37:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:37:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:37:45 INFO - Cleaning up... 16:37:45 INFO - Return code: 0 16:37:45 INFO - Running post-action listener: _resource_record_post_action 16:37:45 INFO - Running post-action listener: _start_resource_monitoring 16:37:45 INFO - Starting resource monitoring. 16:37:45 INFO - ##### 16:37:45 INFO - ##### Running install step. 16:37:45 INFO - ##### 16:37:45 INFO - Running pre-action listener: _resource_record_pre_action 16:37:45 INFO - Running main action method: install 16:37:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:46 INFO - Reading from file tmpfile_stdout 16:37:46 INFO - Detecting whether we're running mozinstall >=1.0... 16:37:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:37:46 INFO - Reading from file tmpfile_stdout 16:37:46 INFO - Output received: 16:37:46 INFO - Usage: mozinstall [options] installer 16:37:46 INFO - Options: 16:37:46 INFO - -h, --help show this help message and exit 16:37:46 INFO - -d DEST, --destination=DEST 16:37:46 INFO - Directory to install application into. [default: 16:37:46 INFO - "/builds/slave/test"] 16:37:46 INFO - --app=APP Application being installed. [default: firefox] 16:37:46 INFO - mkdir: /builds/slave/test/build/application 16:37:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:38:19 INFO - Reading from file tmpfile_stdout 16:38:19 INFO - Output received: 16:38:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:38:19 INFO - Running post-action listener: _resource_record_post_action 16:38:19 INFO - ##### 16:38:19 INFO - ##### Running run-tests step. 16:38:19 INFO - ##### 16:38:19 INFO - Running pre-action listener: _resource_record_pre_action 16:38:19 INFO - Running main action method: run_tests 16:38:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:38:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:38:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:38:19 INFO - 2016-04-21 16:38:19.686 screenresolution[1669:7564] starting screenresolution argv=screenresolution get 16:38:19 INFO - 2016-04-21 16:38:19.688 screenresolution[1669:7564] Display 0: 1600x1200x32@60 16:38:19 INFO - 2016-04-21 16:38:19.694 screenresolution[1670:7566] starting screenresolution argv=screenresolution list 16:38:19 INFO - Available Modes on Display 0 16:38:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:38:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:38:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:38:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:38:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:38:19 INFO - Intel Iris: 16:38:19 INFO - Chipset Model: Intel Iris 16:38:19 INFO - Type: GPU 16:38:19 INFO - Bus: Built-In 16:38:19 INFO - VRAM (Dynamic, Max): 1536 MB 16:38:19 INFO - Vendor: Intel (0x8086) 16:38:19 INFO - Device ID: 0x0a2e 16:38:19 INFO - Revision ID: 0x0009 16:38:19 INFO - Displays: 16:38:19 INFO - Display: 16:38:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:38:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:38:19 INFO - Display Serial Number: 1600x1200 60 16:38:19 INFO - Main Display: Yes 16:38:19 INFO - Mirror: Off 16:38:19 INFO - Online: Yes 16:38:19 INFO - Rotation: Supported 16:38:19 INFO - Return code: 0 16:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:38:19 INFO - Python 2.7.3 16:38:19 INFO - Return code: 0 16:38:19 INFO - grabbing minidump binary from tooltool 16:38: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')]} 16:38:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d068e00>, '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 0x10ced1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d063b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:38:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:38:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:38:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:38:20 INFO - Return code: 0 16:38:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:38:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:38:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:38:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:38:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:38:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:38:21 INFO - Return code: 0 16:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--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 16:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0035 --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 16:38:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tDTbYnFPdh/Render', 16:38:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:21 INFO - 'HOME': '/Users/cltbld', 16:38:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:21 INFO - 'LOGNAME': 'cltbld', 16:38:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:38:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:21 INFO - 'MOZ_NO_REMOTE': '1', 16:38:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:38:21 INFO - 'NO_EM_RESTART': '1', 16:38:21 INFO - 'PAGER': '/bin/cat', 16:38:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:21 INFO - 'PWD': '/builds/slave/test', 16:38:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:38:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:21 INFO - 'SHELL': '/bin/bash', 16:38:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NFYVNuDQBo/Listeners', 16:38:21 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 16:38:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:21 INFO - 'USER': 'cltbld', 16:38:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:21 INFO - 'XPC_FLAGS': '0x0', 16:38:21 INFO - 'XPC_SERVICE_NAME': '0', 16:38:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--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 16:38:21 INFO - mozversion application_buildid: 20160421144315 16:38:21 INFO - mozversion application_changeset: 0891f0fa044cba28024849803e170ed7700e01e0 16:38:21 INFO - mozversion application_display_name: Nightly 16:38:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:38:21 INFO - mozversion application_name: Firefox 16:38:21 INFO - mozversion application_remotingname: firefox 16:38:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:38:21 INFO - mozversion application_vendor: Mozilla 16:38:21 INFO - mozversion application_version: 48.0a1 16:38:21 INFO - mozversion platform_buildid: 20160421144315 16:38:21 INFO - mozversion platform_changeset: 0891f0fa044cba28024849803e170ed7700e01e0 16:38:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:38:21 INFO - mozversion platform_version: 48.0a1 16:38:21 INFO - using testdate: 1461281901 16:38:21 INFO - actual date: 1461281901 16:38:21 INFO - starting webserver on 'localhost:49278' 16:38:21 INFO - SUITE-START | Running 2 tests 16:38:21 INFO - TEST-START | dromaeo_css 16:38:21 INFO - operating with platform_type : mac_ 16:38:21 INFO - Initialising browser for dromaeo_css test... 16:38:21 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpORpqvI/profile http://localhost:49278/getInfo.html) 16:38:24 INFO - PROCESS | 1688 | __metrics Screen width/height:1600/1200 16:38:24 INFO - PROCESS | 1688 | colorDepth:24 16:38:24 INFO - PROCESS | 1688 | Browser inner width/height: 1024/689 16:38:24 INFO - PROCESS | 1688 | __metrics 16:38:24 ERROR - PROCESS | 1688 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:38:25 INFO - TEST-INFO | 1688: exit 0 16:38:25 INFO - Browser initialized. 16:38:25 INFO - Running cycle 1/1 for dromaeo_css test... 16:38:25 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpORpqvI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:37 INFO - PROCESS | 1690 | RSS: Main: 247799808 16:38:37 INFO - PROCESS | 1690 | 16:39:26 INFO - PROCESS | 1690 | 1461281966736 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] 16:41:38 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 16:41:39 INFO - PROCESS | 1690 | RSS: Main: 260141056 16:41:39 INFO - PROCESS | 1690 | 16:44:41 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 16:44:42 INFO - PROCESS | 1690 | RSS: Main: 272535552 16:44:42 INFO - PROCESS | 1690 | 16:47:44 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 16:47:44 INFO - PROCESS | 1690 | RSS: Main: 273924096 16:47:44 INFO - PROCESS | 1690 | 16:50:46 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 16:50:47 INFO - PROCESS | 1690 | RSS: Main: 275578880 16:50:47 INFO - PROCESS | 1690 | 16:53:49 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 16:53:50 INFO - PROCESS | 1690 | RSS: Main: 278364160 16:53:50 INFO - PROCESS | 1690 | 16:56:53 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 16:56:53 INFO - PROCESS | 1690 | RSS: Main: 279654400 16:56:53 INFO - PROCESS | 1690 | 16:56:53 INFO - PROCESS | 1690 | __start_tp_report 16:56:53 INFO - PROCESS | 1690 | _x_x_mozilla_page_load 16:56:53 INFO - PROCESS | 1690 | _x_x_mozilla_page_load_details 16:56:53 INFO - PROCESS | 1690 | |i|pagename|runs| 16:56:53 INFO - PROCESS | 1690 | |0;dojo.html;2942.3232656488995;3082.830444325562;3462.5152478652985;3514.4025515662333;3555.875544355948;5722.7424765885535;5803.100519419486;5804.158397032438;5825.912611310834;5843.094320380337;5707.800226992056;5819.67991760453;5821.6507009579345;5867.677277749722;5985.730642121104;5135.12702840518;5159.251908473269;5201.115810312256;5244.265802787613;5264.868378290555;5285.68285902847;5293.470652934695;5298.867528311785;5332.093544097513;5360.490753378423;5172.896542069157;5244.842654720364;5293.311869456985;5297.390800058004;5325.520703136736;5245.895082098336;5259.447757985433;5276.261323414725;5281.656692315026;5299.49654782795;4280.315149576084;5129.820456284049;5221.39953905302;5264.341957255343;5307.2835167252315;5694.060480020791;5719.513841323493;5733.197352370671;5815.447532484407;5823.737931793079;6218.22272215973;6239.095331176999;6256.374362563753;6295.685215739195;6307.842303942392;6184.659843708594;6228.37716228378;6285.371462853724;6287.528435367366;6302.1177035215105;5972.880542389172;6010.248718910092;6034.487068599218;6036.3360030396625;6049.092636104576;6327.524333768463;6358.809235722936;6402.423781859655;6406.8718625627225;6409.294977552466;6101.85309287306;6153.953827849276;6237.812865614039;6253.843653908689;6271.623702577769;5353.892922141613;6221.2845522765465;6234.127222188898;6270.467010304084;6284.717187726564;6120.0205129226715;6171.814845554641;6197.380261973857;6267.62394256346;6275.560710750295;4783.6651434399255;6145.586515101462;6178.567500275028;6269.686515674198;6276.968615156895;4278.63631591312;5001.774920128603;5010.749462526859;5015.874603134951;5037.672551284155;3792.4311353296675;4184.309588917856;4472.709273897186;4507.030988337523;4512.210363186429;5541.806036788693;5735.971320143456;5889.94110058894;5970.731317090741;6019.398060194033;6252.968735156295;6263.792648238266;6304.211973503312;6323.494120470351;6335.778247761306;5939.4995642972735;5952.434518720715;5959.851003724855;5960.4635582797755;6023.367546407651;5415.512603865671;5435.673859568359;5482.2873026506295;5487.560995120461;5515.586331025189;6433.388828061326;6450.519262313532;6480.25477070143;6481.935180648133;6491.415772580491;5532.889342213214;6156.969215153896;6260.937390626035;6278.968605156945;6286.18279623646;6395.616263024233;6488.643124628191;6537.0194470827855;6537.640429776408;6559.376859198369;6168.599041062316;6213;6250.749970001149;6254;6262.34245404226;6119.724612392364;6175.413335733098;6292.244930608356;6295.024271237966;6313.96843015782;6120.751898419022;6124.724387402489;6160.568760186744;6171.660558669317;6274.372562743689;6212.534059945432;6261.9373806263175;6264.373562643699;6265.937340626535;6300.306966233802;5969.432903874125;6039.365866584121;6061.3029501606115;6103.572749907641;6127.816165515042;6149.385061493815;6232.657203853832;6237.095621135;6241.375862413723;6266.780662676784;5991.490723288395;5997.970010149921;6018.157457955977;6028.005379112397;6045.425684559959 16:56:53 INFO - PROCESS | 1690 | |1;ext.html;492.8496808473415;523.5157479331617;524.375992568843;563.8449426407738;598.0371601721231;30210.546841797364;37705.24589508208;37947.43078853819;38130.42804357937;38136.618633813654;40626.796866015706;41197.7940110299;41206.38190427139;41262.79368603153;41292.58707412925;9411;9741.512924353789;9751.12239898409;9755.219582433423;9786.510674466284;9551.61793528258;9560.187384072362;9573.377730447533;9601.087896649842;9624.518774061304;9632.277579181555;9653.806923861519;9668.854967175497;9680;9727.659531916384;9648.938616752152;9694.806103877954;9698.175655069292;9707.66023189185;9728.951355243178;9500.667476638353;9596.088371604686;9605.03949605034;9623.711288661352;9659.565319560637;31682.683173168203;37973.810130949445;38360.84917452453;38362.232755345016;38390.61609383898;3001.159675290922;3011.744001759853;3138.419392412411;3274.1814546363407;3276.8197749123788;25871.61192582113;26521.336966575796;26527.33681657974;26766.33084172892;26843.865780671167;2611.2557920992617;2623.0556999480173;2630.8553029583363;2673.345030467548;2725.604787305849;292566;292576;294532;296829;348818.99999999744;28916.710832891822;33612.159696007795;35235.471467928;36207;36371.63628363683;31049.379012419624;35171.64828351735;35492.112697182776;35622;35632.10919727028;14773.187474688995;14967.401303947938;14976.700465990838;15127.865410094288;15193.6201594961;12793.040521960704;12885.48458061667;12886.226826390446;12901.870981290067;12918.870811291767;8070.435069545076;8093.757187284391;8160.591970401456;8200.097989221182;8213.712520061888;3336.6663333666925;3347.849346779352;3379.831008449568;3389.6610338965907;3397.1507123219194;905.6731887784427;937.6671281695036;988.9159421449114;1011.2112552209288;1021.1983592879554;25077.62383564248;27745.861270693516;29252.122436326943;29459.558106628418;30489.847550762548;1050.5902697947806;1063.4151216830712;1093.0654290581438;1100.6808025672626;1131.8528591283246;12254.693632659077;15220.619484512976;15466.994645348017;15549.922250388676;15638.687226255412;631360;653356;656084;656914;657640;55222.89554208893;59097.40902591005;59423.70288148532;59994.40005599975;60317;1182.5742732616252;1379.6895698467765;1411.8493427856265;1436.080908218741;1449.9927500362642;29222.561661575517;29272.853635731684;29462.410751784417;29862.552061718656;30055.3988920216;53556.73221634023;53789;54047.189292161434;54382;54395;491372;558894;564563;574714;581375.1862481321;26534.071307504146;26710.86644566765;26775.330616734736;26979.730202697723;27324.590131148445;45070.549294506636;46866.53133468622;46972.530274696815;47191.820204493786;47626.52373476359;28007.579886301315;28871;35271.823640882656;36696.63303366932;36711.89864304075;32287.022412379905;34532.482012769324;36120;36461.45307820438;36783.81608092049;33011.174720632174;35391.29719025235;37433.876983690534;37675.86972390833;38641.42037869378;30275.697243027287;31448;31501.36997259996;31664.683353166172;31737.889173878804;23688.88155559211;23865.164719234745;24202.394940126636;24258.75741242565;24348.878255608608 16:56:53 INFO - PROCESS | 1690 | |2;jquery.html;391.9745216560925;393.1664870474593;394.71383247145815;395.616252235332;405.1350366966527;19817.306394276202;20636.793632063676;20714.378568642947;20714.482137946557;22316.442088947784;20466.874321912288;20953.895230523827;20997.370078897657;21337.893310533465;21351.57296854062;5017.397912250535;5333.893322133555;5361.142217245241;5371.194320851884;5374.435684253156;5332.626716129873;5396.947595218934;7420.257974202564;7930.762077137695;7945.404094692893;6710.966445167792;7264.673089710976;7809.101953275389;7904.841903161933;7935.246151615587;7475.887861682079;7669.348105411047;7741.612919354038;7767.029121359802;8029.839403211903;7707.768766937001;7708.768736937901;7714.807129821743;7754.108277548098;7768.41736869737;28012.299692507648;28592.28519287014;28884.844606215935;29406.117816465325;29835.701642983728;2197.351781224527;2235.418791114322;2356.7171939367213;2371.0160283482332;2561.6413702081722;15588.61028474286;16277.430289939914;16308.918455407766;16401.671966560603;16575.336986520524;1851.1854783895178;1909.8949557774317;1926.7784204816485;1936.3029309448586;1975.4666240115089;139064.30467847697;148494.25752871166;150299;150400;151504.2424787869;17439.47681569555;18877.489800815903;20960.37118886436;21257.68113478299;22082.33752987413;28982.42035159285;35941.64058359435;36011.819940900124;36365;36506.452403213974;10723.30298530593;10947.34315941046;11156.330620162817;11167.664970050912;11193.49629266685;6625.900611490832;9095.909040909639;9117.498537580364;9126.726198214064;9166.67916622915;9916.520869782555;9938.155256803107;9942.453165075845;9942.900570994341;10070.496475176358;3773.603771603942;3894.6689531389584;3902.453656488094;3951.3677811550015;3975.20495900821;841.6533546325829;863.6156910174911;880.3793325705362;1002.7443002034435;1016.5476363018386;15339.769903451457;19823.59305740459;20697.68953465699;20818.85496297688;20901.790982089984;829.1584042197175;881.713443130985;906.6418764587951;925.3661242049218;1008.5612758450097;9869.605215791431;10798.73003174927;10838.132949364031;10861.1854110942;10878.782424351468;610193.949030252;613415;622121.7787822154;634055;634130;135962;137185;137797;138931;140694;977.1108291454742;980.887197972228;992.1219720547367;992.7270000749852;993.4536005197112;18073.728894066335;18203.27186912509;18251.54371140732;18433.883452023914;18518.074096294862;37829.43255851109;49743.507694769214;55601.165982511106;55767.44232557622;56456;79691;79952;81390.18609813826;82598.58700706458;82695.58652206701;7291.489595728248;7541.509801863081;7988.600569971594;8080.919190808252;8506.702265420681;9371.437713737198;10785.784284314426;11615.009459533554;12604.747905042032;12636.810447843474;9628.796400449944;10287.22845786554;10730.678079657622;11174.329540227613;11428;10594.31136976094;10671.146308295472;10941.28881622692;11148.331100134017;11208.159388046091;11193.440327983732;11197.552097915992;11356.772864542829;11483.25358851672;11740.882591173979;8167.673293068211;8201.671933122609;8254.050784159659;8297.377696672653;8319.459235149696;8400.621972011397;10703.411312377582;11064.944675276573;11404.543818247177;11500.654980350602 16:56:53 INFO - PROCESS | 1690 | |3;mootools.html;1582.2326171806671;1584.4850423612324;1835.339277859971;1901.2680118154506;1922.826945574898;8136.755897323075;8707.172818582241;8754.606042728077;8991.460512369255;9033.367664263496;8705.912940870605;8839.646414143443;8914.955425222865;8967.327450441211;8974.910250897488;2461.544614246361;2480.08236952327;2484.354067942339;2494.638277449769;2495.887685054168;2408.0969636386353;2456.987715061431;2459.9016039358403;2461.8030557555444;2470.8270421070533;2454.165583701541;2457.0908763757434;2467.8766061696933;2473.6165894286323;2479.6776419065495;2085.655866781979;2415.45652228249;2423.9757602424015;2434.8417352872093;2443.7922776563837;2408.373822806083;2429.4898071405028;2443.2792326263793;2455;2455.1038870812204;8917.509536975464;8919.152680495343;8931.64273429062;8974.28205743539;8982.640694372218;5250.684958902478;5406.378266499363;5432.891342173174;5436.673799572039;5454.809081682161;3446.483027545863;3513.1568423578415;3518.3491054154806;3521.4365701487895;3528.1179705073732;1007.7379881230933;1023.4217667018186;1024.5338371041232;1040.859483969662;1061.2200032975757;9245.491497967609;9866;11471.942640286828;11588.6523404298;11611.361375124365;3878.650921417086;4693.647976401783;4900.2894580286375;4907.631927605444;4909.459959404463;9935.80128397428;9960.551775170135;9964.20286377088;9979.650712225037;10047.346922450017;4980.676256043345;5284.603654725911;5385.192221166856;5418.241446197457;5442.12925931849;3483.390406678872;4209.684273679486;4432.246518091933;4936.432310284292;4950.331705219821;3681.0981309579324;4054.8175332110127;4083.8960427136076;4124.443200167999;4169.91660166801;1171.824226366035;1271.5486002469174;1344.9865501344862;1357.3416892806981;1365.7473367427058;835.2566216067704;904.7873749668822;915.7435917942987;942.8679984802134;957.5786653872274;5920.2895652521975;5964.642121472725;6069.878602427927;6133.250931998956;6173.783917562864;435.25354017859524;439.1590104949051;447.6128149150961;453.7322979442079;456.4363011680572;4016.718829681894;4042.5755295694116;4072.9592704073175;4121.91756164875;4163.770992595436;10347.017033381817;10811.78376432467;10835.349879007284;10856.565737370416;10873.021428071512;10648;10817.83773243402;10833.241673082808;10839.458027098613;10933.945330273456;8201.384896132813;8297.170282971654;8313.750587482506;8346.8330633387;8359.95820020896;5241.68549887008;5957.642541447527;5971.671558064349;6020.096985452217;6058.454739073328;9533.761655958657;9653.71038868835;9755.853662195215;10033.548490318099;10058.949705251427;9892.50537473109;10023.649172278936;10064.69805905824;10082.445465499175;10134.543945522322;6986.720531178696;7360;7553.886691699739;7594.430417718582;7689.115751688404;7605.543667379975;8007.758797386415;8353.248207661096;8444.831103377775;8484.660613575636;7195.640217988975;7300.087489063867;7532;7600.391968642606;7732.9226707732205;7216.206217315986;7253.492255542062;7304.744333948499;7308.8903666443985;7390.7413240536325;6942.409895158968;6948.5483443576;6963.9651801740665;7017.894731578928;7033.824154395977;4871.123197824426;5002.474740152377;5014.0974624567925;5101.438841727333;5159.974200129125;4569.520200378913;4897.216445368724;5031.974840125776;5079.619028572945;5335.493128152819 16:56:53 INFO - PROCESS | 1690 | |4;prototype.html;298.83713376209977;307.59704786729384;314.5941735161642;316.69597186700764;317.88556119796885;4991.475895031024;6251.937480625193;6272.811815645527;6298.929182039053;6325.177726895503;6226.470749986257;6279;6286.779962701306;6287.968560157205;6321.494280457564;3972.2651309507833;4195.51751548572;4361.280388735855;4573.77548828077;4687.718736875799;4369.453818272716;4464.196444639963;4651.790669419885;4670.2994550817475;4675.088357770236;4555.544445555451;4591.4260717410325;4593.311003349491;4626;4631.096936097462;4427.645788336926;4534.274516077412;4614.400127983375;4630.72215667061;4660.930086048712;3429.988153494725;3612.3317186320614;3612.4039533476944;3647.215848592565;3856.7878766667823;6002.939970600281;6028.788992385289;6071.574989750719;6074.453299203093;6114.2968558615885;4639.791209395552;5284.4187139414635;5286.444923283077;5294.126469132589;5305.761240744176;5675.290588676416;6253.155823963798;6639.80080597578;6653.700583473756;6693.5649182803445;3870.148567315186;4216.7680777557225;4302.204092242945;4304.741715497049;4319.978400108011;6209.9068513972325;6338.461230795434;6574.145361103074;7081.362677359062;7084.716611335541;3618.6743193112748;3660.9633903660624;4308.116836048603;4348.043430445297;4355.06366131277;3728.496652951817;4421.182081314967;4421.646268298528;4424.203643344229;4433.689641725113;4609.838655647036;5261.842144735664;5267.341582302212;5270.997021131945;5289.418164001957;5201.427842937273;6358.364163583605;6506.316836732075;6731.38446772771;6800;1287.46570173377;1503.9699206015819;1520.1639098495782;1524.687439074987;1527.2821773766311;877.3814460805118;954.9474778887089;969.4571040217501;987.511181964932;991.137710192123;5733.426657334233;6233.252009758768;6268.686565671698;6268.811935641938;6269.238456925899;5747.678034052192;6411.262704789009;6412.198475190601;6740.460763138937;6979.336962988508;5075.289459475676;5370.436104209002;5467.371252305956;5725.617919156063;6258.3428739982555;3639;3639.5623728627043;3659.524261845943;3665.395209790408;3673.6142705016123;6066.636001839904;6071.878562428815;6886.655667216619;7282.308180722823;7287.489875708756;5720.911867168536;7219.819504512324;7250.673719682627;7252.492325537267;7257.2742725727;6350.935945817628;6427.775027874002;6892.138482689564;7065.717371305091;7377.299156580117;7001;7014.333638304353;7025.789226323219;7038.260982596754;7038.331358520933;5453.236546883519;6699.39705426514;6876.931230687829;6890.621015844176;6980.616066116412;7260.310270524292;7312.597807120659;7314.524555903849;7334.449916256409;7353.742619008309;4274.786260687016;4283.7001409901;4321.2005778931;4323.178596066738;4330.133973205308;5783.479486846204;6637.4690024798865;6727.428168605723;6782.525223234524;6997.685104170223;6208.410201030895;6672.399484046459;6741.359570840762;6756.898646520208;6799.388055074869;5565.638233514808;5866.67733274674;6489.221293444817;6733.192016957996;6735.6968936397;6442.09810626522;6597.208334999831;6602.933970660424;6603.273639899511;6607.041978912935;6008.836818745161;6746.021826834984;6750;6774.93225067743;6782.0505129280955;6268.843278917881;6565.80302590923;6634.436072933855;6640.236372816995;6647.900281495685 16:56:53 INFO - PROCESS | 1690 | |5;yui.html;649.5940037476577;714.7569826259071;724.3697982755002;735.9190489046204;736.2931585677749;14614.56156315311;15014.699706005873;15054.774178387333;15084.396624135035;15106.924465377657;10544.525496352664;13123.409446574904;13325.200487970704;13546.45814167432;13549.932250338734;717.3579646216633;877.6708734224666;907.4011152639243;922.5940586142076;924.1359329027381;768.5119948832504;913.7258822353267;915.5513798238849;916.6379280184323;920.2270093121776;954.8424509955848;959.501059449086;962.033156677538;967.2358836519142;972.8735264415651;960.188640598693;963.3497389262255;963.4556475591304;964.3394274921701;966.1304825656895;688.5249178067168;697.689528159969;701.3442431326725;702.9578225306498;714.2036629158503;14569.125852448888;14896.404143834234;15005.399784008627;15038.624034399118;15133.54599362021;9473.715788526355;12813.487460501568;12866.87133128666;12954.80567791484;13204;10051.447170405625;10126.797464050751;10209.030142136486;10602;10711.143108551376;3527.8236088195486;3541.7166626670064;3556.395412779834;3644.325799727059;3644.963550364489;73273.6336318315;74126;75388.62305688436;75798.24201757967;76816;9500.42997420157;9513.809723805485;9578.712638620853;9769.706908792748;9945.353552019096;20603.381898543066;21352.893235533724;21931.23240686568;21935.780642193375;21973.890130549244;7485.176630570633;7523.322900938832;7765.53406795594;7897.249761272785;7929.643166057541;4002.959970400317;4069.5320038195396;4105.137921036556;4108.5275193352545;4109.650679692199;2618.3061488705507;2663.8135330526675;2723.7684796792496;3173.0798068559857;3216.6783321667644;642.7796738340852;656.7766959233884;657.6481582353514;661.2032500836576;662.3939095727452;477.81126455050753;497.4701942431299;526.9291683683163;555.7702023954569;575.6143383932775;7808.297253247121;7911.920880791234;8040.437169398086;8074.757757267292;8192.959035204905;496.8252864197779;539.8785273313551;564.8364369399051;584.8274758946121;600.7867207141489;3750.249950010009;3831.7126215533945;3842.1355195080882;3863.729538932304;3996.820143093568;80713.19286807056;89650.55174724215;91333.54333228292;92073;92246.0775392251;65075.02387464192;66300.33699662941;67639.66180169067;68371;69992.65003674949;49604.50395496071;50271.49728502668;63956.68021659955;65066.67466662731;65281.67359163174;6824.283450237654;8079.353651707732;8183.79540511492;8199.877001844858;8335.291500222549;39768.801155994035;40338.798306008284;40907.795461022506;41395.379069313385;41586.58413415948;60869.08696369646;61023.38976610177;61307.69346153419;61807.690961544904;62105.757884842955;10445.373277603368;10603.628872989408;10627.787444251226;10760.569577216824;10975;11777.644471105985;11843.940780296043;11921.165518413974;11982.64052078439;12323.938380308042;11040.227184097357;11481.081513479068;11564.884351156381;11584.94207528957;11641.708957276136;10422.270441069053;11334.716632084264;11382.658520244406;11500.82748758786;11641.59254426125;9167.220786232978;10200.795984080129;11244.775104498029;11273.71815704614;12120.333381664093;9306.441613503212;9414.340996130206;9493.905060949302;9619.951900240454;10083.394996300245;9240.815183696153;9474.621015159317;9563.760905977406;9618.230541556799;9628 16:56:53 INFO - PROCESS | 1690 | __end_tp_report 16:56:53 INFO - PROCESS | 1690 | __start_cc_report 16:56:53 INFO - PROCESS | 1690 | _x_x_mozilla_cycle_collect,409 16:56:53 INFO - PROCESS | 1690 | __end_cc_report 16:56:53 INFO - PROCESS | 1690 | __startTimestamp1461283013390__endTimestamp 16:56:53 INFO - PROCESS | 1690 | 16:56:53 INFO - PROCESS | 1690 | ------- Summary: start ------- 16:56:53 INFO - PROCESS | 1690 | Number of tests: 6 16:56:53 INFO - PROCESS | 1690 | 16:56:53 INFO - PROCESS | 1690 | [#0] dojo.html Cycles:165 Average:5792.19 Median:6039.37 stddev:692.74 (11.5%) stddev-sans-first:657.80 16:56:53 INFO - PROCESS | 1690 | Values: 2942.3 3082.8 3462.5 3514.4 3555.9 5722.7 5803.1 5804.2 5825.9 5843.1 5707.8 5819.7 5821.7 5867.7 5985.7 5135.1 5159.3 5201.1 5244.3 5264.9 5285.7 5293.5 5298.9 5332.1 5360.5 5172.9 5244.8 5293.3 5297.4 5325.5 5245.9 5259.4 5276.3 5281.7 5299.5 4280.3 5129.8 5221.4 5264.3 5307.3 5694.1 5719.5 5733.2 5815.4 5823.7 6218.2 6239.1 6256.4 6295.7 6307.8 6184.7 6228.4 6285.4 6287.5 6302.1 5972.9 6010.2 6034.5 6036.3 6049.1 6327.5 6358.8 6402.4 6406.9 6409.3 6101.9 6154.0 6237.8 6253.8 6271.6 5353.9 6221.3 6234.1 6270.5 6284.7 6120.0 6171.8 6197.4 6267.6 6275.6 4783.7 6145.6 6178.6 6269.7 6277.0 4278.6 5001.8 5010.7 5015.9 5037.7 3792.4 4184.3 4472.7 4507.0 4512.2 5541.8 5736.0 5889.9 5970.7 6019.4 6253.0 6263.8 6304.2 6323.5 6335.8 5939.5 5952.4 5959.9 5960.5 6023.4 5415.5 5435.7 5482.3 5487.6 5515.6 6433.4 6450.5 6480.3 6481.9 6491.4 5532.9 6157.0 6260.9 6279.0 6286.2 6395.6 6488.6 6537.0 6537.6 6559.4 6168.6 6213.0 6250.7 6254.0 6262.3 6119.7 6175.4 6292.2 6295.0 6314.0 6120.8 6124.7 6160.6 6171.7 6274.4 6212.5 6261.9 6264.4 6265.9 6300.3 5969.4 6039.4 6061.3 6103.6 6127.8 6149.4 6232.7 6237.1 6241.4 6266.8 5991.5 5998.0 6018.2 6028.0 6045.4 16:56:53 INFO - PROCESS | 1690 | 16:56:53 INFO - PROCESS | 1690 | [#1] ext.html Cycles:180 Average:62134.17 Median:35441.70 stddev:140985.30 (397.8%) stddev-sans-first:141304.84 16:56:53 INFO - PROCESS | 1690 | Values: 492.8 523.5 524.4 563.8 598.0 30210.5 37705.2 37947.4 38130.4 38136.6 40626.8 41197.8 41206.4 41262.8 41292.6 9411.0 9741.5 9751.1 9755.2 9786.5 9551.6 9560.2 9573.4 9601.1 9624.5 9632.3 9653.8 9668.9 9680.0 9727.7 9648.9 9694.8 9698.2 9707.7 9729.0 9500.7 9596.1 9605.0 9623.7 9659.6 31682.7 37973.8 38360.8 38362.2 38390.6 3001.2 3011.7 3138.4 3274.2 3276.8 25871.6 26521.3 26527.3 26766.3 26843.9 2611.3 2623.1 2630.9 2673.3 2725.6 292566.0 292576.0 294532.0 296829.0 348819.0 28916.7 33612.2 35235.5 36207.0 36371.6 31049.4 35171.6 35492.1 35622.0 35632.1 14773.2 14967.4 14976.7 15127.9 15193.6 12793.0 12885.5 12886.2 12901.9 12918.9 8070.4 8093.8 8160.6 8200.1 8213.7 3336.7 3347.8 3379.8 3389.7 3397.2 905.7 937.7 988.9 1011.2 1021.2 25077.6 27745.9 29252.1 29459.6 30489.8 1050.6 1063.4 1093.1 1100.7 1131.9 12254.7 15220.6 15467.0 15549.9 15638.7 631360.0 653356.0 656084.0 656914.0 657640.0 55222.9 59097.4 59423.7 59994.4 60317.0 1182.6 1379.7 1411.8 1436.1 1450.0 29222.6 29272.9 29462.4 29862.6 30055.4 53556.7 53789.0 54047.2 54382.0 54395.0 491372.0 558894.0 564563.0 574714.0 581375.2 26534.1 26710.9 26775.3 26979.7 27324.6 45070.5 46866.5 46972.5 47191.8 47626.5 28007.6 28871.0 35271.8 36696.6 36711.9 32287.0 34532.5 36120.0 36461.5 36783.8 33011.2 35391.3 37433.9 37675.9 38641.4 30275.7 31448.0 31501.4 31664.7 31737.9 23688.9 23865.2 24202.4 24258.8 24348.9 16:56:53 INFO - PROCESS | 1690 | 16:56:53 INFO - PROCESS | 1690 | [#2] jquery.html Cycles:180 Average:38299.37 Median:32888.67 stddev:104528.47 (317.8%) stddev-sans-first:104782.95 16:56:53 INFO - PROCESS | 1690 | Values: 392.0 393.2 394.7 395.6 405.1 19817.3 20636.8 20714.4 20714.5 22316.4 20466.9 20953.9 20997.4 21337.9 21351.6 5017.4 5333.9 5361.1 5371.2 5374.4 5332.6 5396.9 7420.3 7930.8 7945.4 6711.0 7264.7 7809.1 7904.8 7935.2 7475.9 7669.3 7741.6 7767.0 8029.8 7707.8 7708.8 7714.8 7754.1 7768.4 28012.3 28592.3 28884.8 29406.1 29835.7 2197.4 2235.4 2356.7 2371.0 2561.6 15588.6 16277.4 16308.9 16401.7 16575.3 1851.2 1909.9 1926.8 1936.3 1975.5 139064.3 148494.3 150299.0 150400.0 151504.2 17439.5 18877.5 20960.4 21257.7 22082.3 28982.4 35941.6 36011.8 36365.0 36506.5 10723.3 10947.3 11156.3 11167.7 11193.5 6625.9 9095.9 9117.5 9126.7 9166.7 9916.5 9938.2 9942.5 9942.9 10070.5 3773.6 3894.7 3902.5 3951.4 3975.2 841.7 863.6 880.4 1002.7 1016.5 15339.8 19823.6 20697.7 20818.9 20901.8 829.2 881.7 906.6 925.4 1008.6 9869.6 10798.7 10838.1 10861.2 10878.8 610193.9 613415.0 622121.8 634055.0 634130.0 135962.0 137185.0 137797.0 138931.0 140694.0 977.1 980.9 992.1 992.7 993.5 18073.7 18203.3 18251.5 18433.9 18518.1 37829.4 49743.5 55601.2 55767.4 56456.0 79691.0 79952.0 81390.2 82598.6 82695.6 7291.5 7541.5 7988.6 8080.9 8506.7 9371.4 10785.8 11615.0 12604.7 12636.8 9628.8 10287.2 10730.7 11174.3 11428.0 10594.3 10671.1 10941.3 11148.3 11208.2 11193.4 11197.6 11356.8 11483.3 11740.9 8167.7 8201.7 8254.1 8297.4 8319.5 8400.6 10703.4 11064.9 11404.5 11500.7 16:56:53 INFO - PROCESS | 1690 | 16:56:53 INFO - PROCESS | 1690 | [#3] mootools.html Cycles:180 Average:5702.81 Median:4922.95 stddev:3175.88 (64.5%) stddev-sans-first:3169.69 16:56:53 INFO - PROCESS | 1690 | Values: 1582.2 1584.5 1835.3 1901.3 1922.8 8136.8 8707.2 8754.6 8991.5 9033.4 8705.9 8839.6 8915.0 8967.3 8974.9 2461.5 2480.1 2484.4 2494.6 2495.9 2408.1 2457.0 2459.9 2461.8 2470.8 2454.2 2457.1 2467.9 2473.6 2479.7 2085.7 2415.5 2424.0 2434.8 2443.8 2408.4 2429.5 2443.3 2455.0 2455.1 8917.5 8919.2 8931.6 8974.3 8982.6 5250.7 5406.4 5432.9 5436.7 5454.8 3446.5 3513.2 3518.3 3521.4 3528.1 1007.7 1023.4 1024.5 1040.9 1061.2 9245.5 9866.0 11471.9 11588.7 11611.4 3878.7 4693.6 4900.3 4907.6 4909.5 9935.8 9960.6 9964.2 9979.7 10047.3 4980.7 5284.6 5385.2 5418.2 5442.1 3483.4 4209.7 4432.2 4936.4 4950.3 3681.1 4054.8 4083.9 4124.4 4169.9 1171.8 1271.5 1345.0 1357.3 1365.7 835.3 904.8 915.7 942.9 957.6 5920.3 5964.6 6069.9 6133.3 6173.8 435.3 439.2 447.6 453.7 456.4 4016.7 4042.6 4073.0 4121.9 4163.8 10347.0 10811.8 10835.3 10856.6 10873.0 10648.0 10817.8 10833.2 10839.5 10933.9 8201.4 8297.2 8313.8 8346.8 8360.0 5241.7 5957.6 5971.7 6020.1 6058.5 9533.8 9653.7 9755.9 10033.5 10058.9 9892.5 10023.6 10064.7 10082.4 10134.5 6986.7 7360.0 7553.9 7594.4 7689.1 7605.5 8007.8 8353.2 8444.8 8484.7 7195.6 7300.1 7532.0 7600.4 7732.9 7216.2 7253.5 7304.7 7308.9 7390.7 6942.4 6948.5 6964.0 7017.9 7033.8 4871.1 5002.5 5014.1 5101.4 5160.0 4569.5 4897.2 5032.0 5079.6 5335.5 16:56:53 INFO - PROCESS | 1690 | 16:56:53 INFO - PROCESS | 1690 | [#4] prototype.html Cycles:180 Average:5328.72 Median:6094.38 stddev:1735.63 (28.5%) stddev-sans-first:1698.95 16:56:53 INFO - PROCESS | 1690 | Values: 298.8 307.6 314.6 316.7 317.9 4991.5 6251.9 6272.8 6298.9 6325.2 6226.5 6279.0 6286.8 6288.0 6321.5 3972.3 4195.5 4361.3 4573.8 4687.7 4369.5 4464.2 4651.8 4670.3 4675.1 4555.5 4591.4 4593.3 4626.0 4631.1 4427.6 4534.3 4614.4 4630.7 4660.9 3430.0 3612.3 3612.4 3647.2 3856.8 6002.9 6028.8 6071.6 6074.5 6114.3 4639.8 5284.4 5286.4 5294.1 5305.8 5675.3 6253.2 6639.8 6653.7 6693.6 3870.1 4216.8 4302.2 4304.7 4320.0 6209.9 6338.5 6574.1 7081.4 7084.7 3618.7 3661.0 4308.1 4348.0 4355.1 3728.5 4421.2 4421.6 4424.2 4433.7 4609.8 5261.8 5267.3 5271.0 5289.4 5201.4 6358.4 6506.3 6731.4 6800.0 1287.5 1504.0 1520.2 1524.7 1527.3 877.4 954.9 969.5 987.5 991.1 5733.4 6233.3 6268.7 6268.8 6269.2 5747.7 6411.3 6412.2 6740.5 6979.3 5075.3 5370.4 5467.4 5725.6 6258.3 3639.0 3639.6 3659.5 3665.4 3673.6 6066.6 6071.9 6886.7 7282.3 7287.5 5720.9 7219.8 7250.7 7252.5 7257.3 6350.9 6427.8 6892.1 7065.7 7377.3 7001.0 7014.3 7025.8 7038.3 7038.3 5453.2 6699.4 6876.9 6890.6 6980.6 7260.3 7312.6 7314.5 7334.4 7353.7 4274.8 4283.7 4321.2 4323.2 4330.1 5783.5 6637.5 6727.4 6782.5 6997.7 6208.4 6672.4 6741.4 6756.9 6799.4 5565.6 5866.7 6489.2 6733.2 6735.7 6442.1 6597.2 6602.9 6603.3 6607.0 6008.8 6746.0 6750.0 6774.9 6782.1 6268.8 6565.8 6634.4 6640.2 6647.9 16:56:53 INFO - PROCESS | 1690 | 16:56:53 INFO - PROCESS | 1690 | [#5] yui.html Cycles:180 Average:16930.84 Median:30734.94 stddev:23215.76 (75.5%) stddev-sans-first:23248.69 16:56:53 INFO - PROCESS | 1690 | Values: 649.6 714.8 724.4 735.9 736.3 14614.6 15014.7 15054.8 15084.4 15106.9 10544.5 13123.4 13325.2 13546.5 13549.9 717.4 877.7 907.4 922.6 924.1 768.5 913.7 915.6 916.6 920.2 954.8 959.5 962.0 967.2 972.9 960.2 963.3 963.5 964.3 966.1 688.5 697.7 701.3 703.0 714.2 14569.1 14896.4 15005.4 15038.6 15133.5 9473.7 12813.5 12866.9 12954.8 13204.0 10051.4 10126.8 10209.0 10602.0 10711.1 3527.8 3541.7 3556.4 3644.3 3645.0 73273.6 74126.0 75388.6 75798.2 76816.0 9500.4 9513.8 9578.7 9769.7 9945.4 20603.4 21352.9 21931.2 21935.8 21973.9 7485.2 7523.3 7765.5 7897.2 7929.6 4003.0 4069.5 4105.1 4108.5 4109.7 2618.3 2663.8 2723.8 3173.1 3216.7 642.8 656.8 657.6 661.2 662.4 477.8 497.5 526.9 555.8 575.6 7808.3 7911.9 8040.4 8074.8 8193.0 496.8 539.9 564.8 584.8 600.8 3750.2 3831.7 3842.1 3863.7 3996.8 80713.2 89650.6 91333.5 92073.0 92246.1 65075.0 66300.3 67639.7 68371.0 69992.7 49604.5 50271.5 63956.7 65066.7 65281.7 6824.3 8079.4 8183.8 8199.9 8335.3 39768.8 40338.8 40907.8 41395.4 41586.6 60869.1 61023.4 61307.7 61807.7 62105.8 10445.4 10603.6 10627.8 10760.6 10975.0 11777.6 11843.9 11921.2 11982.6 12323.9 11040.2 11481.1 11564.9 11584.9 11641.7 10422.3 11334.7 11382.7 11500.8 11641.6 9167.2 10200.8 11244.8 11273.7 12120.3 9306.4 9414.3 9493.9 9620.0 10083.4 9240.8 9474.6 9563.8 9618.2 9628.0 16:56:53 INFO - PROCESS | 1690 | -------- Summary: end -------- 16:56:53 INFO - PROCESS | 1690 | 16:56:53 INFO - TEST-INFO | 1690: exit 0 16:56:53 INFO - TEST-OK | dromaeo_css | took 1112475ms 16:56:53 INFO - TEST-START | kraken 16:56:53 INFO - operating with platform_type : mac_ 16:56:53 INFO - Initialising browser for kraken test... 16:56:53 INFO - TEST-INFO | started process 1808 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmp6zOOaU/profile http://localhost:49278/getInfo.html) 16:56:56 INFO - PROCESS | 1808 | __metrics Screen width/height:1600/1200 16:56:56 INFO - PROCESS | 1808 | colorDepth:24 16:56:56 INFO - PROCESS | 1808 | Browser inner width/height: 1024/689 16:56:56 INFO - PROCESS | 1808 | __metrics 16:56:56 ERROR - PROCESS | 1808 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:56:57 INFO - TEST-INFO | 1808: exit 0 16:56:57 INFO - Browser initialized. 16:56:57 INFO - Running cycle 1/1 for kraken test... 16:56:57 INFO - TEST-INFO | started process 1811 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmp6zOOaU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:09 INFO - PROCESS | 1811 | RSS: Main: 248029184 16:57:09 INFO - PROCESS | 1811 | 16:57:12 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 16:57:13 INFO - PROCESS | 1811 | RSS: Main: 260050944 16:57:13 INFO - PROCESS | 1811 | 16:57:15 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 16:57:16 INFO - PROCESS | 1811 | RSS: Main: 268898304 16:57:16 INFO - PROCESS | 1811 | 16:57:19 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 16:57:20 INFO - PROCESS | 1811 | RSS: Main: 272027648 16:57:20 INFO - PROCESS | 1811 | 16:57:22 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 16:57:22 INFO - PROCESS | 1811 | RSS: Main: 273035264 16:57:22 INFO - PROCESS | 1811 | 16:57:24 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:57:25 INFO - PROCESS | 1811 | RSS: Main: 273510400 16:57:25 INFO - PROCESS | 1811 | 16:57:28 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 16:57:28 INFO - PROCESS | 1811 | RSS: Main: 274944000 16:57:28 INFO - PROCESS | 1811 | 16:57:31 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 16:57:32 INFO - PROCESS | 1811 | RSS: Main: 274710528 16:57:32 INFO - PROCESS | 1811 | 16:57:35 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 16:57:36 INFO - PROCESS | 1811 | RSS: Main: 274817024 16:57:36 INFO - PROCESS | 1811 | 16:57:38 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:57:38 INFO - PROCESS | 1811 | RSS: Main: 274788352 16:57:38 INFO - PROCESS | 1811 | 16:57:40 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:57:41 INFO - PROCESS | 1811 | RSS: Main: 274841600 16:57:41 INFO - PROCESS | 1811 | 16:57:43 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:57:43 INFO - PROCESS | 1811 | RSS: Main: 274731008 16:57:43 INFO - PROCESS | 1811 | 16:57:46 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:57:47 INFO - PROCESS | 1811 | RSS: Main: 274878464 16:57:47 INFO - PROCESS | 1811 | 16:57:50 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:57:50 INFO - PROCESS | 1811 | RSS: Main: 274915328 16:57:50 INFO - PROCESS | 1811 | 16:57:52 INFO - PROCESS | 1811 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 16:57:53 INFO - PROCESS | 1811 | RSS: Main: 276717568 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | __start_tp_report 16:57:53 INFO - PROCESS | 1811 | _x_x_mozilla_page_load 16:57:53 INFO - PROCESS | 1811 | _x_x_mozilla_page_load_details 16:57:53 INFO - PROCESS | 1811 | |i|pagename|runs| 16:57:53 INFO - PROCESS | 1811 | |0;ai-astar;116;111;116;119;117;130;117;116;117;117 16:57:53 INFO - PROCESS | 1811 | |1;audio-beat-detection;157;123;142;167;123;142;139;127;175;123 16:57:53 INFO - PROCESS | 1811 | |2;audio-dft;198;201;198;215;225;201;200;197;209;280 16:57:53 INFO - PROCESS | 1811 | |3;audio-fft;70;78;78;145;57;56;56;64;130;59 16:57:53 INFO - PROCESS | 1811 | |4;audio-oscillator;77;81;131;77;80;83;119;80;82;121 16:57:53 INFO - PROCESS | 1811 | |5;imaging-gaussian-blur;90;98;120;86;92;86;89;86;89;85 16:57:53 INFO - PROCESS | 1811 | |6;imaging-darkroom;94;95;96;94;96;94;95;91;103;150 16:57:53 INFO - PROCESS | 1811 | |7;imaging-desaturate;111;144;143;104;140;124;90;109;148;77 16:57:53 INFO - PROCESS | 1811 | |8;json-parse-financial;59;90;91;92;89;61;63;80;65;59 16:57:53 INFO - PROCESS | 1811 | |9;json-stringify-tinderbox;64;68;66;70;74;70;69;68;67;73 16:57:53 INFO - PROCESS | 1811 | |10;stanford-crypto-aes;87;86;84;85;85;83;85;85;84;82 16:57:53 INFO - PROCESS | 1811 | |11;stanford-crypto-ccm;138;142;132;140;141;144;160;164;191;158 16:57:53 INFO - PROCESS | 1811 | |12;stanford-crypto-pbkdf2;177;175;172;174;176;172;173;177;175;172 16:57:53 INFO - PROCESS | 1811 | |13;stanford-crypto-sha256-iterative;71;68;70;87;101;94;102;81;71;70 16:57:53 INFO - PROCESS | 1811 | __end_tp_report 16:57:53 INFO - PROCESS | 1811 | __start_cc_report 16:57:53 INFO - PROCESS | 1811 | _x_x_mozilla_cycle_collect,1058 16:57:53 INFO - PROCESS | 1811 | __end_cc_report 16:57:53 INFO - PROCESS | 1811 | __startTimestamp1461283073073__endTimestamp 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | ------- Summary: start ------- 16:57:53 INFO - PROCESS | 1811 | Number of tests: 14 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | [#0] ai-astar Cycles:10 Average:117.60 Median:117.00 stddev:4.81 (4.1%) stddev-sans-first:5.07 16:57:53 INFO - PROCESS | 1811 | Values: 116.0 111.0 116.0 119.0 117.0 130.0 117.0 116.0 117.0 117.0 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:142.00 stddev:19.02 (13.4%) stddev-sans-first:19.36 16:57:53 INFO - PROCESS | 1811 | Values: 157.0 123.0 142.0 167.0 123.0 142.0 139.0 127.0 175.0 123.0 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | [#2] audio-dft Cycles:10 Average:212.40 Median:205.00 stddev:25.41 (12.4%) stddev-sans-first:26.41 16:57:53 INFO - PROCESS | 1811 | Values: 198.0 201.0 198.0 215.0 225.0 201.0 200.0 197.0 209.0 280.0 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | [#3] audio-fft Cycles:10 Average:79.30 Median:61.50 stddev:31.98 (52.0%) stddev-sans-first:33.75 16:57:53 INFO - PROCESS | 1811 | Values: 70.0 78.0 78.0 145.0 57.0 56.0 56.0 64.0 130.0 59.0 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:80.00 stddev:21.39 (26.7%) stddev-sans-first:21.88 16:57:53 INFO - PROCESS | 1811 | Values: 77.0 81.0 131.0 77.0 80.0 83.0 119.0 80.0 82.0 121.0 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | [#5] imaging-gaussian-blur Cycles:10 Average:92.10 Median:89.00 stddev:10.54 (11.8%) stddev-sans-first:11.15 16:57:53 INFO - PROCESS | 1811 | Values: 90.0 98.0 120.0 86.0 92.0 86.0 89.0 86.0 89.0 85.0 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | [#6] imaging-darkroom Cycles:10 Average:100.80 Median:94.50 stddev:17.55 (18.6%) stddev-sans-first:18.45 16:57:53 INFO - PROCESS | 1811 | Values: 94.0 95.0 96.0 94.0 96.0 94.0 95.0 91.0 103.0 150.0 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | [#7] imaging-desaturate Cycles:10 Average:119.00 Median:143.50 stddev:24.73 (17.2%) stddev-sans-first:26.05 16:57:53 INFO - PROCESS | 1811 | Values: 111.0 144.0 143.0 104.0 140.0 124.0 90.0 109.0 148.0 77.0 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | [#8] json-parse-financial Cycles:10 Average:74.90 Median:84.50 stddev:14.69 (17.4%) stddev-sans-first:14.41 16:57:53 INFO - PROCESS | 1811 | Values: 59.0 90.0 91.0 92.0 89.0 61.0 63.0 80.0 65.0 59.0 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.50 stddev:3.03 (4.4%) stddev-sans-first:2.65 16:57:53 INFO - PROCESS | 1811 | Values: 64.0 68.0 66.0 70.0 74.0 70.0 69.0 68.0 67.0 73.0 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:1.43 (1.7%) stddev-sans-first:1.22 16:57:53 INFO - PROCESS | 1811 | Values: 87.0 86.0 84.0 85.0 85.0 83.0 85.0 85.0 84.0 82.0 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | [#11] stanford-crypto-ccm Cycles:10 Average:151.00 Median:151.00 stddev:17.58 (11.6%) stddev-sans-first:18.00 16:57:53 INFO - PROCESS | 1811 | Values: 138.0 142.0 132.0 140.0 141.0 144.0 160.0 164.0 191.0 158.0 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:175.00 stddev:2.00 (1.1%) stddev-sans-first:1.87 16:57:53 INFO - PROCESS | 1811 | Values: 177.0 175.0 172.0 174.0 176.0 172.0 173.0 177.0 175.0 172.0 16:57:53 INFO - PROCESS | 1811 | 16:57:53 INFO - PROCESS | 1811 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.50 Median:71.00 stddev:13.56 (19.1%) stddev-sans-first:13.84 16:57:53 INFO - PROCESS | 1811 | Values: 71.0 68.0 70.0 87.0 101.0 94.0 102.0 81.0 71.0 70.0 16:57:53 INFO - PROCESS | 1811 | -------- Summary: end -------- 16:57:53 INFO - PROCESS | 1811 | 16:57:54 INFO - TEST-INFO | 1811: exit 0 16:57:54 INFO - TEST-OK | kraken | took 60139ms 16:57:54 INFO - SUITE-END | took 1172s 16:57:54 INFO - Completed test suite (00:19:32) 16:57:54 INFO - javascript benchmark 16:57:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2942.3232656488995, 3082.830444325562, 3462.5152478652985, 3514.4025515662333, 3555.875544355948, 5722.7424765885535, 5803.100519419486, 5804.158397032438, 5825.912611310834, 5843.094320380337, 5707.800226992056, 5819.67991760453, 5821.6507009579345, 5867.677277749722, 5985.730642121104, 5135.12702840518, 5159.251908473269, 5201.115810312256, 5244.265802787613, 5264.868378290555, 5285.68285902847, 5293.470652934695, 5298.867528311785, 5332.093544097513, 5360.490753378423, 5172.896542069157, 5244.842654720364, 5293.311869456985, 5297.390800058004, 5325.520703136736, 5245.895082098336, 5259.447757985433, 5276.261323414725, 5281.656692315026, 5299.49654782795, 4280.315149576084, 5129.820456284049, 5221.39953905302, 5264.341957255343, 5307.2835167252315, 5694.060480020791, 5719.513841323493, 5733.197352370671, 5815.447532484407, 5823.737931793079, 6218.22272215973, 6239.095331176999, 6256.374362563753, 6295.685215739195, 6307.842303942392, 6184.659843708594, 6228.37716228378, 6285.371462853724, 6287.528435367366, 6302.1177035215105, 5972.880542389172, 6010.248718910092, 6034.487068599218, 6036.3360030396625, 6049.092636104576, 6327.524333768463, 6358.809235722936, 6402.423781859655, 6406.8718625627225, 6409.294977552466, 6101.85309287306, 6153.953827849276, 6237.812865614039, 6253.843653908689, 6271.623702577769, 5353.892922141613, 6221.2845522765465, 6234.127222188898, 6270.467010304084, 6284.717187726564, 6120.0205129226715, 6171.814845554641, 6197.380261973857, 6267.62394256346, 6275.560710750295, 4783.6651434399255, 6145.586515101462, 6178.567500275028, 6269.686515674198, 6276.968615156895, 4278.63631591312, 5001.774920128603, 5010.749462526859, 5015.874603134951, 5037.672551284155, 3792.4311353296675, 4184.309588917856, 4472.709273897186, 4507.030988337523, 4512.210363186429, 5541.806036788693, 5735.971320143456, 5889.94110058894, 5970.731317090741, 6019.398060194033, 6252.968735156295, 6263.792648238266, 6304.211973503312, 6323.494120470351, 6335.778247761306, 5939.4995642972735, 5952.434518720715, 5959.851003724855, 5960.4635582797755, 6023.367546407651, 5415.512603865671, 5435.673859568359, 5482.2873026506295, 5487.560995120461, 5515.586331025189, 6433.388828061326, 6450.519262313532, 6480.25477070143, 6481.935180648133, 6491.415772580491, 5532.889342213214, 6156.969215153896, 6260.937390626035, 6278.968605156945, 6286.18279623646, 6395.616263024233, 6488.643124628191, 6537.0194470827855, 6537.640429776408, 6559.376859198369, 6168.599041062316, 6213.0, 6250.749970001149, 6254.0, 6262.34245404226, 6119.724612392364, 6175.413335733098, 6292.244930608356, 6295.024271237966, 6313.96843015782, 6120.751898419022, 6124.724387402489, 6160.568760186744, 6171.660558669317, 6274.372562743689, 6212.534059945432, 6261.9373806263175, 6264.373562643699, 6265.937340626535, 6300.306966233802, 5969.432903874125, 6039.365866584121, 6061.3029501606115, 6103.572749907641, 6127.816165515042, 6149.385061493815, 6232.657203853832, 6237.095621135, 6241.375862413723, 6266.780662676784, 5991.490723288395, 5997.970010149921, 6018.157457955977, 6028.005379112397, 6045.425684559959], "value": 5745.627748203026, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.8496808473415, 523.5157479331617, 524.375992568843, 563.8449426407738, 598.0371601721231, 30210.546841797364, 37705.24589508208, 37947.43078853819, 38130.42804357937, 38136.618633813654, 40626.796866015706, 41197.7940110299, 41206.38190427139, 41262.79368603153, 41292.58707412925, 9411.0, 9741.512924353789, 9751.12239898409, 9755.219582433423, 9786.510674466284, 9551.61793528258, 9560.187384072362, 9573.377730447533, 9601.087896649842, 9624.518774061304, 9632.277579181555, 9653.806923861519, 9668.854967175497, 9680.0, 9727.659531916384, 9648.938616752152, 9694.806103877954, 9698.175655069292, 9707.66023189185, 9728.951355243178, 9500.667476638353, 9596.088371604686, 9605.03949605034, 9623.711288661352, 9659.565319560637, 31682.683173168203, 37973.810130949445, 38360.84917452453, 38362.232755345016, 38390.61609383898, 3001.159675290922, 3011.744001759853, 3138.419392412411, 3274.1814546363407, 3276.8197749123788, 25871.61192582113, 26521.336966575796, 26527.33681657974, 26766.33084172892, 26843.865780671167, 2611.2557920992617, 2623.0556999480173, 2630.8553029583363, 2673.345030467548, 2725.604787305849, 292566.0, 292576.0, 294532.0, 296829.0, 348818.99999999744, 28916.710832891822, 33612.159696007795, 35235.471467928, 36207.0, 36371.63628363683, 31049.379012419624, 35171.64828351735, 35492.112697182776, 35622.0, 35632.10919727028, 14773.187474688995, 14967.401303947938, 14976.700465990838, 15127.865410094288, 15193.6201594961, 12793.040521960704, 12885.48458061667, 12886.226826390446, 12901.870981290067, 12918.870811291767, 8070.435069545076, 8093.757187284391, 8160.591970401456, 8200.097989221182, 8213.712520061888, 3336.6663333666925, 3347.849346779352, 3379.831008449568, 3389.6610338965907, 3397.1507123219194, 905.6731887784427, 937.6671281695036, 988.9159421449114, 1011.2112552209288, 1021.1983592879554, 25077.62383564248, 27745.861270693516, 29252.122436326943, 29459.558106628418, 30489.847550762548, 1050.5902697947806, 1063.4151216830712, 1093.0654290581438, 1100.6808025672626, 1131.8528591283246, 12254.693632659077, 15220.619484512976, 15466.994645348017, 15549.922250388676, 15638.687226255412, 631360.0, 653356.0, 656084.0, 656914.0, 657640.0, 55222.89554208893, 59097.40902591005, 59423.70288148532, 59994.40005599975, 60317.0, 1182.5742732616252, 1379.6895698467765, 1411.8493427856265, 1436.080908218741, 1449.9927500362642, 29222.561661575517, 29272.853635731684, 29462.410751784417, 29862.552061718656, 30055.3988920216, 53556.73221634023, 53789.0, 54047.189292161434, 54382.0, 54395.0, 491372.0, 558894.0, 564563.0, 574714.0, 581375.1862481321, 26534.071307504146, 26710.86644566765, 26775.330616734736, 26979.730202697723, 27324.590131148445, 45070.549294506636, 46866.53133468622, 46972.530274696815, 47191.820204493786, 47626.52373476359, 28007.579886301315, 28871.0, 35271.823640882656, 36696.63303366932, 36711.89864304075, 32287.022412379905, 34532.482012769324, 36120.0, 36461.45307820438, 36783.81608092049, 33011.174720632174, 35391.29719025235, 37433.876983690534, 37675.86972390833, 38641.42037869378, 30275.697243027287, 31448.0, 31501.36997259996, 31664.683353166172, 31737.889173878804, 23688.88155559211, 23865.164719234745, 24202.394940126636, 24258.75741242565, 24348.878255608608], "value": 17721.752362178075, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.9745216560925, 393.1664870474593, 394.71383247145815, 395.616252235332, 405.1350366966527, 19817.306394276202, 20636.793632063676, 20714.378568642947, 20714.482137946557, 22316.442088947784, 20466.874321912288, 20953.895230523827, 20997.370078897657, 21337.893310533465, 21351.57296854062, 5017.397912250535, 5333.893322133555, 5361.142217245241, 5371.194320851884, 5374.435684253156, 5332.626716129873, 5396.947595218934, 7420.257974202564, 7930.762077137695, 7945.404094692893, 6710.966445167792, 7264.673089710976, 7809.101953275389, 7904.841903161933, 7935.246151615587, 7475.887861682079, 7669.348105411047, 7741.612919354038, 7767.029121359802, 8029.839403211903, 7707.768766937001, 7708.768736937901, 7714.807129821743, 7754.108277548098, 7768.41736869737, 28012.299692507648, 28592.28519287014, 28884.844606215935, 29406.117816465325, 29835.701642983728, 2197.351781224527, 2235.418791114322, 2356.7171939367213, 2371.0160283482332, 2561.6413702081722, 15588.61028474286, 16277.430289939914, 16308.918455407766, 16401.671966560603, 16575.336986520524, 1851.1854783895178, 1909.8949557774317, 1926.7784204816485, 1936.3029309448586, 1975.4666240115089, 139064.30467847697, 148494.25752871166, 150299.0, 150400.0, 151504.2424787869, 17439.47681569555, 18877.489800815903, 20960.37118886436, 21257.68113478299, 22082.33752987413, 28982.42035159285, 35941.64058359435, 36011.819940900124, 36365.0, 36506.452403213974, 10723.30298530593, 10947.34315941046, 11156.330620162817, 11167.664970050912, 11193.49629266685, 6625.900611490832, 9095.909040909639, 9117.498537580364, 9126.726198214064, 9166.67916622915, 9916.520869782555, 9938.155256803107, 9942.453165075845, 9942.900570994341, 10070.496475176358, 3773.603771603942, 3894.6689531389584, 3902.453656488094, 3951.3677811550015, 3975.20495900821, 841.6533546325829, 863.6156910174911, 880.3793325705362, 1002.7443002034435, 1016.5476363018386, 15339.769903451457, 19823.59305740459, 20697.68953465699, 20818.85496297688, 20901.790982089984, 829.1584042197175, 881.713443130985, 906.6418764587951, 925.3661242049218, 1008.5612758450097, 9869.605215791431, 10798.73003174927, 10838.132949364031, 10861.1854110942, 10878.782424351468, 610193.949030252, 613415.0, 622121.7787822154, 634055.0, 634130.0, 135962.0, 137185.0, 137797.0, 138931.0, 140694.0, 977.1108291454742, 980.887197972228, 992.1219720547367, 992.7270000749852, 993.4536005197112, 18073.728894066335, 18203.27186912509, 18251.54371140732, 18433.883452023914, 18518.074096294862, 37829.43255851109, 49743.507694769214, 55601.165982511106, 55767.44232557622, 56456.0, 79691.0, 79952.0, 81390.18609813826, 82598.58700706458, 82695.58652206701, 7291.489595728248, 7541.509801863081, 7988.600569971594, 8080.919190808252, 8506.702265420681, 9371.437713737198, 10785.784284314426, 11615.009459533554, 12604.747905042032, 12636.810447843474, 9628.796400449944, 10287.22845786554, 10730.678079657622, 11174.329540227613, 11428.0, 10594.31136976094, 10671.146308295472, 10941.28881622692, 11148.331100134017, 11208.159388046091, 11193.440327983732, 11197.552097915992, 11356.772864542829, 11483.25358851672, 11740.882591173979, 8167.673293068211, 8201.671933122609, 8254.050784159659, 8297.377696672653, 8319.459235149696, 8400.621972011397, 10703.411312377582, 11064.944675276573, 11404.543818247177, 11500.654980350602], "value": 10956.668824130405, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1582.2326171806671, 1584.4850423612324, 1835.339277859971, 1901.2680118154506, 1922.826945574898, 8136.755897323075, 8707.172818582241, 8754.606042728077, 8991.460512369255, 9033.367664263496, 8705.912940870605, 8839.646414143443, 8914.955425222865, 8967.327450441211, 8974.910250897488, 2461.544614246361, 2480.08236952327, 2484.354067942339, 2494.638277449769, 2495.887685054168, 2408.0969636386353, 2456.987715061431, 2459.9016039358403, 2461.8030557555444, 2470.8270421070533, 2454.165583701541, 2457.0908763757434, 2467.8766061696933, 2473.6165894286323, 2479.6776419065495, 2085.655866781979, 2415.45652228249, 2423.9757602424015, 2434.8417352872093, 2443.7922776563837, 2408.373822806083, 2429.4898071405028, 2443.2792326263793, 2455.0, 2455.1038870812204, 8917.509536975464, 8919.152680495343, 8931.64273429062, 8974.28205743539, 8982.640694372218, 5250.684958902478, 5406.378266499363, 5432.891342173174, 5436.673799572039, 5454.809081682161, 3446.483027545863, 3513.1568423578415, 3518.3491054154806, 3521.4365701487895, 3528.1179705073732, 1007.7379881230933, 1023.4217667018186, 1024.5338371041232, 1040.859483969662, 1061.2200032975757, 9245.491497967609, 9866.0, 11471.942640286828, 11588.6523404298, 11611.361375124365, 3878.650921417086, 4693.647976401783, 4900.2894580286375, 4907.631927605444, 4909.459959404463, 9935.80128397428, 9960.551775170135, 9964.20286377088, 9979.650712225037, 10047.346922450017, 4980.676256043345, 5284.603654725911, 5385.192221166856, 5418.241446197457, 5442.12925931849, 3483.390406678872, 4209.684273679486, 4432.246518091933, 4936.432310284292, 4950.331705219821, 3681.0981309579324, 4054.8175332110127, 4083.8960427136076, 4124.443200167999, 4169.91660166801, 1171.824226366035, 1271.5486002469174, 1344.9865501344862, 1357.3416892806981, 1365.7473367427058, 835.2566216067704, 904.7873749668822, 915.7435917942987, 942.8679984802134, 957.5786653872274, 5920.2895652521975, 5964.642121472725, 6069.878602427927, 6133.250931998956, 6173.783917562864, 435.25354017859524, 439.1590104949051, 447.6128149150961, 453.7322979442079, 456.4363011680572, 4016.718829681894, 4042.5755295694116, 4072.9592704073175, 4121.91756164875, 4163.770992595436, 10347.017033381817, 10811.78376432467, 10835.349879007284, 10856.565737370416, 10873.021428071512, 10648.0, 10817.83773243402, 10833.241673082808, 10839.458027098613, 10933.945330273456, 8201.384896132813, 8297.170282971654, 8313.750587482506, 8346.8330633387, 8359.95820020896, 5241.68549887008, 5957.642541447527, 5971.671558064349, 6020.096985452217, 6058.454739073328, 9533.761655958657, 9653.71038868835, 9755.853662195215, 10033.548490318099, 10058.949705251427, 9892.50537473109, 10023.649172278936, 10064.69805905824, 10082.445465499175, 10134.543945522322, 6986.720531178696, 7360.0, 7553.886691699739, 7594.430417718582, 7689.115751688404, 7605.543667379975, 8007.758797386415, 8353.248207661096, 8444.831103377775, 8484.660613575636, 7195.640217988975, 7300.087489063867, 7532.0, 7600.391968642606, 7732.9226707732205, 7216.206217315986, 7253.492255542062, 7304.744333948499, 7308.8903666443985, 7390.7413240536325, 6942.409895158968, 6948.5483443576, 6963.9651801740665, 7017.894731578928, 7033.824154395977, 4871.123197824426, 5002.474740152377, 5014.0974624567925, 5101.438841727333, 5159.974200129125, 4569.520200378913, 4897.216445368724, 5031.974840125776, 5079.619028572945, 5335.493128152819], "value": 4528.187587367467, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.83713376209977, 307.59704786729384, 314.5941735161642, 316.69597186700764, 317.88556119796885, 4991.475895031024, 6251.937480625193, 6272.811815645527, 6298.929182039053, 6325.177726895503, 6226.470749986257, 6279.0, 6286.779962701306, 6287.968560157205, 6321.494280457564, 3972.2651309507833, 4195.51751548572, 4361.280388735855, 4573.77548828077, 4687.718736875799, 4369.453818272716, 4464.196444639963, 4651.790669419885, 4670.2994550817475, 4675.088357770236, 4555.544445555451, 4591.4260717410325, 4593.311003349491, 4626.0, 4631.096936097462, 4427.645788336926, 4534.274516077412, 4614.400127983375, 4630.72215667061, 4660.930086048712, 3429.988153494725, 3612.3317186320614, 3612.4039533476944, 3647.215848592565, 3856.7878766667823, 6002.939970600281, 6028.788992385289, 6071.574989750719, 6074.453299203093, 6114.2968558615885, 4639.791209395552, 5284.4187139414635, 5286.444923283077, 5294.126469132589, 5305.761240744176, 5675.290588676416, 6253.155823963798, 6639.80080597578, 6653.700583473756, 6693.5649182803445, 3870.148567315186, 4216.7680777557225, 4302.204092242945, 4304.741715497049, 4319.978400108011, 6209.9068513972325, 6338.461230795434, 6574.145361103074, 7081.362677359062, 7084.716611335541, 3618.6743193112748, 3660.9633903660624, 4308.116836048603, 4348.043430445297, 4355.06366131277, 3728.496652951817, 4421.182081314967, 4421.646268298528, 4424.203643344229, 4433.689641725113, 4609.838655647036, 5261.842144735664, 5267.341582302212, 5270.997021131945, 5289.418164001957, 5201.427842937273, 6358.364163583605, 6506.316836732075, 6731.38446772771, 6800.0, 1287.46570173377, 1503.9699206015819, 1520.1639098495782, 1524.687439074987, 1527.2821773766311, 877.3814460805118, 954.9474778887089, 969.4571040217501, 987.511181964932, 991.137710192123, 5733.426657334233, 6233.252009758768, 6268.686565671698, 6268.811935641938, 6269.238456925899, 5747.678034052192, 6411.262704789009, 6412.198475190601, 6740.460763138937, 6979.336962988508, 5075.289459475676, 5370.436104209002, 5467.371252305956, 5725.617919156063, 6258.3428739982555, 3639.0, 3639.5623728627043, 3659.524261845943, 3665.395209790408, 3673.6142705016123, 6066.636001839904, 6071.878562428815, 6886.655667216619, 7282.308180722823, 7287.489875708756, 5720.911867168536, 7219.819504512324, 7250.673719682627, 7252.492325537267, 7257.2742725727, 6350.935945817628, 6427.775027874002, 6892.138482689564, 7065.717371305091, 7377.299156580117, 7001.0, 7014.333638304353, 7025.789226323219, 7038.260982596754, 7038.331358520933, 5453.236546883519, 6699.39705426514, 6876.931230687829, 6890.621015844176, 6980.616066116412, 7260.310270524292, 7312.597807120659, 7314.524555903849, 7334.449916256409, 7353.742619008309, 4274.786260687016, 4283.7001409901, 4321.2005778931, 4323.178596066738, 4330.133973205308, 5783.479486846204, 6637.4690024798865, 6727.428168605723, 6782.525223234524, 6997.685104170223, 6208.410201030895, 6672.399484046459, 6741.359570840762, 6756.898646520208, 6799.388055074869, 5565.638233514808, 5866.67733274674, 6489.221293444817, 6733.192016957996, 6735.6968936397, 6442.09810626522, 6597.208334999831, 6602.933970660424, 6603.273639899511, 6607.041978912935, 6008.836818745161, 6746.021826834984, 6750.0, 6774.93225067743, 6782.0505129280955, 6268.843278917881, 6565.80302590923, 6634.436072933855, 6640.236372816995, 6647.900281495685], "value": 4752.569297057131, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.5940037476577, 714.7569826259071, 724.3697982755002, 735.9190489046204, 736.2931585677749, 14614.56156315311, 15014.699706005873, 15054.774178387333, 15084.396624135035, 15106.924465377657, 10544.525496352664, 13123.409446574904, 13325.200487970704, 13546.45814167432, 13549.932250338734, 717.3579646216633, 877.6708734224666, 907.4011152639243, 922.5940586142076, 924.1359329027381, 768.5119948832504, 913.7258822353267, 915.5513798238849, 916.6379280184323, 920.2270093121776, 954.8424509955848, 959.501059449086, 962.033156677538, 967.2358836519142, 972.8735264415651, 960.188640598693, 963.3497389262255, 963.4556475591304, 964.3394274921701, 966.1304825656895, 688.5249178067168, 697.689528159969, 701.3442431326725, 702.9578225306498, 714.2036629158503, 14569.125852448888, 14896.404143834234, 15005.399784008627, 15038.624034399118, 15133.54599362021, 9473.715788526355, 12813.487460501568, 12866.87133128666, 12954.80567791484, 13204.0, 10051.447170405625, 10126.797464050751, 10209.030142136486, 10602.0, 10711.143108551376, 3527.8236088195486, 3541.7166626670064, 3556.395412779834, 3644.325799727059, 3644.963550364489, 73273.6336318315, 74126.0, 75388.62305688436, 75798.24201757967, 76816.0, 9500.42997420157, 9513.809723805485, 9578.712638620853, 9769.706908792748, 9945.353552019096, 20603.381898543066, 21352.893235533724, 21931.23240686568, 21935.780642193375, 21973.890130549244, 7485.176630570633, 7523.322900938832, 7765.53406795594, 7897.249761272785, 7929.643166057541, 4002.959970400317, 4069.5320038195396, 4105.137921036556, 4108.5275193352545, 4109.650679692199, 2618.3061488705507, 2663.8135330526675, 2723.7684796792496, 3173.0798068559857, 3216.6783321667644, 642.7796738340852, 656.7766959233884, 657.6481582353514, 661.2032500836576, 662.3939095727452, 477.81126455050753, 497.4701942431299, 526.9291683683163, 555.7702023954569, 575.6143383932775, 7808.297253247121, 7911.920880791234, 8040.437169398086, 8074.757757267292, 8192.959035204905, 496.8252864197779, 539.8785273313551, 564.8364369399051, 584.8274758946121, 600.7867207141489, 3750.249950010009, 3831.7126215533945, 3842.1355195080882, 3863.729538932304, 3996.820143093568, 80713.19286807056, 89650.55174724215, 91333.54333228292, 92073.0, 92246.0775392251, 65075.02387464192, 66300.33699662941, 67639.66180169067, 68371.0, 69992.65003674949, 49604.50395496071, 50271.49728502668, 63956.68021659955, 65066.67466662731, 65281.67359163174, 6824.283450237654, 8079.353651707732, 8183.79540511492, 8199.877001844858, 8335.291500222549, 39768.801155994035, 40338.798306008284, 40907.795461022506, 41395.379069313385, 41586.58413415948, 60869.08696369646, 61023.38976610177, 61307.69346153419, 61807.690961544904, 62105.757884842955, 10445.373277603368, 10603.628872989408, 10627.787444251226, 10760.569577216824, 10975.0, 11777.644471105985, 11843.940780296043, 11921.165518413974, 11982.64052078439, 12323.938380308042, 11040.227184097357, 11481.081513479068, 11564.884351156381, 11584.94207528957, 11641.708957276136, 10422.270441069053, 11334.716632084264, 11382.658520244406, 11500.82748758786, 11641.59254426125, 9167.220786232978, 10200.795984080129, 11244.775104498029, 11273.71815704614, 12120.333381664093, 9306.441613503212, 9414.340996130206, 9493.905060949302, 9619.951900240454, 10083.394996300245, 9240.815183696153, 9474.621015159317, 9563.760905977406, 9618.230541556799, 9628.0], "value": 6664.510708921347, "unit": "score"}], "name": "dromaeo_css", "value": 7368.239346588388, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 116.0, 119.0, 117.0, 130.0, 117.0, 116.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 142.0, 167.0, 123.0, 142.0, 139.0, 127.0, 175.0, 123.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 201.0, 198.0, 215.0, 225.0, 201.0, 200.0, 197.0, 209.0, 280.0], "value": 212.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 78.0, 145.0, 57.0, 56.0, 56.0, 64.0, 130.0, 59.0], "value": 79.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 131.0, 77.0, 80.0, 83.0, 119.0, 80.0, 82.0, 121.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 98.0, 120.0, 86.0, 92.0, 86.0, 89.0, 86.0, 89.0, 85.0], "value": 92.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 94.0, 96.0, 94.0, 95.0, 91.0, 103.0, 150.0], "value": 100.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 144.0, 143.0, 104.0, 140.0, 124.0, 90.0, 109.0, 148.0, 77.0], "value": 119.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 90.0, 91.0, 92.0, 89.0, 61.0, 63.0, 80.0, 65.0, 59.0], "value": 74.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 66.0, 70.0, 74.0, 70.0, 69.0, 68.0, 67.0, 73.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 84.0, 85.0, 85.0, 83.0, 85.0, 85.0, 84.0, 82.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 142.0, 132.0, 140.0, 141.0, 144.0, 160.0, 164.0, 191.0, 158.0], "value": 151.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 172.0, 174.0, 176.0, 172.0, 173.0, 177.0, 175.0, 172.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 87.0, 101.0, 94.0, 102.0, 81.0, 71.0, 70.0], "value": 81.5, "unit": "score"}], "name": "kraken", "value": 1591.3, "alertThreshold": 2.0}]} 16:57:54 INFO - Return code: 0 16:57:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:57:54 ERROR - # TBPL SUCCESS # 16:57:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:57:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:57:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:57:54 INFO - 2016-04-21 16:57:54.421 screenresolution[1822:10542] starting screenresolution argv=screenresolution get 16:57:54 INFO - 2016-04-21 16:57:54.424 screenresolution[1822:10542] Display 0: 1600x1200x32@60 16:57:54 INFO - 2016-04-21 16:57:54.430 screenresolution[1823:10545] starting screenresolution argv=screenresolution list 16:57:54 INFO - Available Modes on Display 0 16:57:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:57:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:57:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:57:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:57:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:57:54 INFO - Intel Iris: 16:57:54 INFO - Chipset Model: Intel Iris 16:57:54 INFO - Type: GPU 16:57:54 INFO - Bus: Built-In 16:57:54 INFO - VRAM (Dynamic, Max): 1536 MB 16:57:54 INFO - Vendor: Intel (0x8086) 16:57:54 INFO - Device ID: 0x0a2e 16:57:54 INFO - Revision ID: 0x0009 16:57:54 INFO - Displays: 16:57:54 INFO - Display: 16:57:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:57:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:57:54 INFO - Display Serial Number: 1600x1200 60 16:57:54 INFO - Main Display: Yes 16:57:54 INFO - Mirror: Off 16:57:54 INFO - Online: Yes 16:57:54 INFO - Rotation: Supported 16:57:54 INFO - Return code: 0 16:57:54 INFO - Running post-action listener: _resource_record_post_action 16:57:54 INFO - Running post-run listener: _resource_record_post_run 16:57:55 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37742080; Write bytes: 696105472; Read time: 453; Write time: 1872 16:57:55 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 385360384; Write bytes: 374711808; Read time: 28167; Write time: 717 16:57:55 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 31481344; Write bytes: 298255360; Read time: 369; Write time: 1108 16:57:55 INFO - Running post-run listener: _upload_blobber_files 16:57:55 INFO - Blob upload gear active. 16:57:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:57:55 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 16:57:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:57:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:57:56 INFO - (blobuploader) - INFO - Open directory for files ... 16:57:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:57:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:57:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:57 INFO - (blobuploader) - INFO - Done attempting. 16:57:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:57:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:57:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:58 INFO - (blobuploader) - INFO - Done attempting. 16:57:58 INFO - (blobuploader) - INFO - Iteration through files over. 16:57:58 INFO - Return code: 0 16:57:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:57:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:57:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee8aaa73abf348b9c28e2267ac0d0cdf1236883ff8e78b639aa44d1949baae6db87bb267a6ce243491215ce49fdb8870720543ffab3ce29ea0330e1342ad766c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ff7c860fd0a20087c30b3862e038dd6a0cab9cd53c26618348fc175a8f9b2e253422280c23ed7764b45d9f14875d10611fec33b57b6444065ef97a1e9d513de"} 16:57:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:57:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:57:58 INFO - Contents: 16:57:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee8aaa73abf348b9c28e2267ac0d0cdf1236883ff8e78b639aa44d1949baae6db87bb267a6ce243491215ce49fdb8870720543ffab3ce29ea0330e1342ad766c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ff7c860fd0a20087c30b3862e038dd6a0cab9cd53c26618348fc175a8f9b2e253422280c23ed7764b45d9f14875d10611fec33b57b6444065ef97a1e9d513de"} 16:57:58 INFO - Running post-run listener: copy_logs_to_upload_dir 16:57:58 INFO - Copying logs to upload dir... 16:57:58 INFO - mkdir: /builds/slave/test/build/upload/logs 16:57:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.552986 ========= master_lag: 7.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-04-21 16:58:05.547176) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-21 16:58:05.551992) ========= 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.tDTbYnFPdh/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.NFYVNuDQBo/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee8aaa73abf348b9c28e2267ac0d0cdf1236883ff8e78b639aa44d1949baae6db87bb267a6ce243491215ce49fdb8870720543ffab3ce29ea0330e1342ad766c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ff7c860fd0a20087c30b3862e038dd6a0cab9cd53c26618348fc175a8f9b2e253422280c23ed7764b45d9f14875d10611fec33b57b6444065ef97a1e9d513de"} build_url:https://queue.taskcluster.net/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011039 build_url: 'https://queue.taskcluster.net/v1/task/Sz_lYRg6SrCh7TQXyvGy1Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee8aaa73abf348b9c28e2267ac0d0cdf1236883ff8e78b639aa44d1949baae6db87bb267a6ce243491215ce49fdb8870720543ffab3ce29ea0330e1342ad766c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ff7c860fd0a20087c30b3862e038dd6a0cab9cd53c26618348fc175a8f9b2e253422280c23ed7764b45d9f14875d10611fec33b57b6444065ef97a1e9d513de"}' ========= master_lag: 2.57 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-21 16:58:08.129343) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 16:58:08.132754) ========= 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.tDTbYnFPdh/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.NFYVNuDQBo/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.005393 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 16:58:08.288380) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 16:58:08.288721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 16:58:08.330905) ========= ========= Total master_lag: 22.91 =========