builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0102 starttime: 1461683580.06 results: success (0) buildid: 20160426071219 builduid: cef59f457f884b9d8ba69be96f2741e8 revision: 6a441b2b2997cdbd47b5d80283f6f60d5a9e7489 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 08:13:00.056567) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 08:13:00.057040) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-26 08:13:00.057377) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-26 08:13:01.445218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 08:13:01.445546) ========= 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.lqQBbhHsKP/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.1CF5otUwZ6/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-26 08:13:01-- 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% 200M=0s 2016-04-26 08:13:01 (200 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124097 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 08:13:01.588623) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 08:13:01.588911) ========= 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.lqQBbhHsKP/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.1CF5otUwZ6/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.026635 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 08:13:01.754877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-26 08:13:01.755244) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6a441b2b2997cdbd47b5d80283f6f60d5a9e7489 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6a441b2b2997cdbd47b5d80283f6f60d5a9e7489 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lqQBbhHsKP/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.1CF5otUwZ6/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-26 08:13:01,918 truncating revision to first 12 chars 2016-04-26 08:13:01,918 Setting DEBUG logging. 2016-04-26 08:13:01,918 attempt 1/10 2016-04-26 08:13:01,918 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6a441b2b2997?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 08:13:03,121 unpacking tar archive at: fx-team-6a441b2b2997/testing/mozharness/ program finished with exit code 0 elapsedTime=1.449324 ========= master_lag: 1.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-26 08:13:04.399944) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 08:13:04.403291) ========= script_repo_revision: 6a441b2b2997cdbd47b5d80283f6f60d5a9e7489 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 08:13:04.403684) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 08:13:04.404054) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 08:13:04.434665) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-04-26 08:13:04.434982) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lqQBbhHsKP/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.1CF5otUwZ6/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:13:04 INFO - MultiFileLogger online at 20160426 08:13:04 in /builds/slave/test 08:13:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:13:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:13:04 INFO - {'append_to_log': False, 08:13:04 INFO - 'base_work_dir': '/builds/slave/test', 08:13:04 INFO - 'blob_upload_branch': 'Fx-Team', 08:13:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:13:04 INFO - 'branch': 'Fx-Team', 08:13:04 INFO - 'buildbot_json_path': 'buildprops.json', 08:13:04 INFO - 'config_files': ('talos/mac_config.py',), 08:13:04 INFO - 'default_actions': ('clobber', 08:13:04 INFO - 'read-buildbot-config', 08:13:04 INFO - 'download-and-extract', 08:13:04 INFO - 'populate-webroot', 08:13:04 INFO - 'create-virtualenv', 08:13:04 INFO - 'install', 08:13:04 INFO - 'run-tests'), 08:13:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:13:04 INFO - 'download_minidump_stackwalk': True, 08:13:04 INFO - 'download_symbols': 'ondemand', 08:13:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:13:04 INFO - 'tooltool.py': '/tools/tooltool.py', 08:13:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:13:04 INFO - '/tools/misc-python/virtualenv.py')}, 08:13:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:13:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:13:04 INFO - 'installer_path': 'installer.exe', 08:13:04 INFO - 'log_level': 'info', 08:13:04 INFO - 'log_name': 'talos', 08:13:04 INFO - 'log_to_console': True, 08:13:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:13:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:13:04 INFO - 'opt_config_files': (), 08:13:04 INFO - 'pip_index': False, 08:13:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:13:04 INFO - 'cmd': ('bash', 08:13:04 INFO - '-c', 08:13:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:13:04 INFO - 'enabled': True, 08:13:04 INFO - 'halt_on_failure': False, 08:13:04 INFO - 'name': 'check_screen_resolution'},), 08:13:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:13:04 INFO - 'cmd': ('bash', 08:13:04 INFO - '-c', 08:13:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:13:04 INFO - 'enabled': True, 08:13:04 INFO - 'halt_on_failure': False, 08:13:04 INFO - 'name': 'check_screen_resolution'},), 08:13:04 INFO - 'run_cmd_checks_enabled': True, 08:13:04 INFO - 'sps_profile': False, 08:13:04 INFO - 'sps_profile_interval': 0, 08:13:04 INFO - 'suite': 'dromaeojs-e10s', 08:13:04 INFO - 'system_bits': '32', 08:13:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:13:04 INFO - 'title': 't-yosemite-r7-0102', 08:13:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:13:04 INFO - 'use_talos_json': True, 08:13:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:13:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:13:04 INFO - 'work_dir': 'build'} 08:13:04 INFO - ##### 08:13:04 INFO - ##### Running clobber step. 08:13:04 INFO - ##### 08:13:04 INFO - Running pre-action listener: _resource_record_pre_action 08:13:04 INFO - Running main action method: clobber 08:13:04 INFO - rmtree: /builds/slave/test/build 08:13:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:13:06 INFO - Running post-action listener: _resource_record_post_action 08:13:06 INFO - ##### 08:13:06 INFO - ##### Running read-buildbot-config step. 08:13:06 INFO - ##### 08:13:06 INFO - Running pre-action listener: _resource_record_pre_action 08:13:06 INFO - Running main action method: read_buildbot_config 08:13:06 INFO - Using buildbot properties: 08:13:06 INFO - { 08:13:06 INFO - "project": "", 08:13:06 INFO - "product": "firefox", 08:13:06 INFO - "script_repo_revision": "production", 08:13:06 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:13:06 INFO - "repository": "", 08:13:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:13:06 INFO - "buildid": "20160426071219", 08:13:06 INFO - "pgo_build": "False", 08:13:06 INFO - "basedir": "/builds/slave/test", 08:13:06 INFO - "buildnumber": 731, 08:13:06 INFO - "slavename": "t-yosemite-r7-0102", 08:13:06 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:13:06 INFO - "platform": "yosemite_r7", 08:13:06 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 08:13:06 INFO - "branch": "fx-team", 08:13:06 INFO - "repo_path": "integration/fx-team", 08:13:06 INFO - "revision": "6a441b2b2997cdbd47b5d80283f6f60d5a9e7489", 08:13:06 INFO - "stage_platform": "macosx64", 08:13:06 INFO - "builduid": "cef59f457f884b9d8ba69be96f2741e8", 08:13:06 INFO - "slavebuilddir": "test" 08:13:06 INFO - } 08:13:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 08:13:06 INFO - Running post-action listener: _resource_record_post_action 08:13:06 INFO - ##### 08:13:06 INFO - ##### Running download-and-extract step. 08:13:06 INFO - ##### 08:13:06 INFO - Running pre-action listener: _resource_record_pre_action 08:13:06 INFO - Running main action method: download_and_extract 08:13:06 INFO - mkdir: /builds/slave/test/build/tests 08:13: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')]} 08:13:06 INFO - https://queue.taskcluster.net/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:13:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 08:13:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 08:13:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 08:13:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 08:13:08 INFO - Downloaded 1199 bytes. 08:13:08 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 08:13:08 INFO - Using the following test package requirements: 08:13:08 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 08:13:08 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:08 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 08:13:08 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:08 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 08:13:08 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:08 INFO - u'jsshell-mac.zip'], 08:13:08 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:08 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 08:13:08 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 08:13:08 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:08 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 08:13:08 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:08 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 08:13:08 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:08 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 08:13:08 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:08 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 08:13:08 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:08 INFO - https://queue.taskcluster.net/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:13:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:13:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:13:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:13:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:13:09 INFO - Downloaded 18114107 bytes. 08:13:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:13:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:13:12 INFO - Return code: 0 08:13:12 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:12 INFO - https://queue.taskcluster.net/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:13:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:13:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:13:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:13:14 INFO - Downloaded 18114107 bytes. 08:13:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:13:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:13:17 INFO - Return code: 0 08:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:17 INFO - https://queue.taskcluster.net/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:13:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 08:13:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 08:13:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 08:13:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:13:19 INFO - Downloaded 10840145 bytes. 08:13:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:13:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:13:19 INFO - Return code: 0 08:13: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')]} 08:13:19 INFO - https://queue.taskcluster.net/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:13:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:13:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:13:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 08:13:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 08:13:25 INFO - Downloaded 110122720 bytes. 08:13:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:13:25 INFO - mkdir: /builds/slave/test/properties 08:13:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:13:25 INFO - Writing to file /builds/slave/test/properties/build_url 08:13:25 INFO - Contents: 08:13:25 INFO - build_url:https://queue.taskcluster.net/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:13:26 INFO - Running post-action listener: _resource_record_post_action 08:13:26 INFO - Running post-action listener: set_extra_try_arguments 08:13:26 INFO - ##### 08:13:26 INFO - ##### Running populate-webroot step. 08:13:26 INFO - ##### 08:13:26 INFO - Running pre-action listener: _resource_record_pre_action 08:13:26 INFO - Running main action method: populate_webroot 08:13:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:13:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:13:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:13:26 INFO - '--tppagecycles', 08:13:26 INFO - '7'], 08:13:26 INFO - 'tests': ['tsvgm']}}, 08:13:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:13:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:13:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:13:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:13:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:13:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:13:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:26 INFO - 'talos_options': ['--disable-e10s'], 08:13:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:26 INFO - 'talos_options': ['--disable-e10s'], 08:13:26 INFO - 'tests': ['damp', 'tps']}, 08:13:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:26 INFO - 'tests': ['damp', 'tps']}, 08:13:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:13:26 INFO - 'tests': ['dromaeo_dom']}, 08:13:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:13:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:13:26 INFO - 'tests': ['a11yr', 08:13:26 INFO - 'ts_paint', 08:13:26 INFO - 'tpaint', 08:13:26 INFO - 'sessionrestore', 08:13:26 INFO - 'sessionrestore_no_auto_restore', 08:13:26 INFO - 'tabpaint']}, 08:13:26 INFO - 'other-e10s': {'tests': ['a11yr', 08:13:26 INFO - 'ts_paint', 08:13:26 INFO - 'tpaint', 08:13:26 INFO - 'sessionrestore', 08:13:26 INFO - 'sessionrestore_no_auto_restore', 08:13:26 INFO - 'tabpaint']}, 08:13:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:13:26 INFO - 'ts_paint', 08:13:26 INFO - 'tpaint', 08:13:26 INFO - 'sessionrestore', 08:13:26 INFO - 'sessionrestore_no_auto_restore', 08:13:26 INFO - 'tabpaint']}, 08:13:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:13:26 INFO - 'ts_paint', 08:13:26 INFO - 'tpaint', 08:13:26 INFO - 'sessionrestore', 08:13:26 INFO - 'sessionrestore_no_auto_restore', 08:13:26 INFO - 'tabpaint']}, 08:13:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:13:26 INFO - 'tests': ['a11yr', 08:13:26 INFO - 'ts_paint', 08:13:26 INFO - 'tpaint', 08:13:26 INFO - 'sessionrestore', 08:13:26 INFO - 'sessionrestore_no_auto_restore', 08:13:26 INFO - 'tabpaint']}, 08:13:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:13:26 INFO - 'tests': ['a11yr', 08:13:26 INFO - 'ts_paint', 08:13:26 INFO - 'tpaint', 08:13:26 INFO - 'sessionrestore', 08:13:26 INFO - 'sessionrestore_no_auto_restore', 08:13:26 INFO - 'tabpaint']}, 08:13:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:13:26 INFO - 'tests': ['tsvgx', 08:13:26 INFO - 'tsvgr_opacity', 08:13:26 INFO - 'tart', 08:13:26 INFO - 'tscrollx', 08:13:26 INFO - 'cart']}, 08:13:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:13:26 INFO - 'tsvgr_opacity', 08:13:26 INFO - 'tart', 08:13:26 INFO - 'tscrollx', 08:13:26 INFO - 'cart']}, 08:13:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:26 INFO - 'talos_options': ['--disable-e10s'], 08:13:26 INFO - 'tests': ['tp5o']}, 08:13:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:26 INFO - 'tests': ['tp5o']}, 08:13:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:26 INFO - 'talos_options': ['--disable-e10s', 08:13:26 INFO - '--xperf_path', 08:13:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:26 INFO - 'tests': ['tp5n']}, 08:13:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:26 INFO - 'talos_options': ['--xperf_path', 08:13:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:26 INFO - 'tests': ['tp5n']}}, 08:13:26 INFO - 'talos.zip': {'path': '', 08:13:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:13:26 INFO - Running post-action listener: _resource_record_post_action 08:13:26 INFO - ##### 08:13:26 INFO - ##### Running create-virtualenv step. 08:13:26 INFO - ##### 08:13:26 INFO - Running pre-action listener: _resource_record_pre_action 08:13:26 INFO - Running main action method: create_virtualenv 08:13:26 INFO - Creating virtualenv /builds/slave/test/build/venv 08:13:26 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 08:13:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:13:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:13:26 INFO - Using real prefix '/tools/python27' 08:13:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:13:27 INFO - Installing distribute.............................................................................................................................................................................................done. 08:13:30 INFO - Installing pip.................done. 08:13:30 INFO - Return code: 0 08:13:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109816a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fdbc594a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b5e00>, '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 0x10951edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0b20>, '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.lqQBbhHsKP/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.1CF5otUwZ6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:13:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lqQBbhHsKP/Render', 08:13:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:30 INFO - 'HOME': '/Users/cltbld', 08:13:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:30 INFO - 'LOGNAME': 'cltbld', 08:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:30 INFO - 'MOZ_NO_REMOTE': '1', 08:13:30 INFO - 'NO_EM_RESTART': '1', 08:13:30 INFO - 'PAGER': '/bin/cat', 08:13:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:30 INFO - 'PWD': '/builds/slave/test', 08:13:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:30 INFO - 'SHELL': '/bin/bash', 08:13:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1CF5otUwZ6/Listeners', 08:13:30 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:13:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:30 INFO - 'USER': 'cltbld', 08:13:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:30 INFO - 'XPC_FLAGS': '0x0', 08:13:30 INFO - 'XPC_SERVICE_NAME': '0', 08:13:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:30 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 08:13:30 INFO - Cleaning up... 08:13:30 INFO - Return code: 0 08:13:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109816a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fdbc594a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b5e00>, '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 0x10951edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0b20>, '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.lqQBbhHsKP/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.1CF5otUwZ6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:13:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lqQBbhHsKP/Render', 08:13:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:30 INFO - 'HOME': '/Users/cltbld', 08:13:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:30 INFO - 'LOGNAME': 'cltbld', 08:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:30 INFO - 'MOZ_NO_REMOTE': '1', 08:13:30 INFO - 'NO_EM_RESTART': '1', 08:13:30 INFO - 'PAGER': '/bin/cat', 08:13:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:30 INFO - 'PWD': '/builds/slave/test', 08:13:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:30 INFO - 'SHELL': '/bin/bash', 08:13:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1CF5otUwZ6/Listeners', 08:13:30 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:13:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:30 INFO - 'USER': 'cltbld', 08:13:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:30 INFO - 'XPC_FLAGS': '0x0', 08:13:30 INFO - 'XPC_SERVICE_NAME': '0', 08:13:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:30 INFO - Downloading/unpacking psutil>=0.7.1 08:13:30 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 08:13:30 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 08:13:30 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 08:13:30 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 08:13:30 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 08:13:30 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 08:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:13:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:33 INFO - Installing collected packages: psutil 08:13:33 INFO - Running setup.py install for psutil 08:13:33 INFO - building 'psutil._psutil_osx' extension 08:13:33 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 08:13:34 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 08:13:34 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 08:13:34 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 08:13:34 INFO - building 'psutil._psutil_posix' extension 08:13:34 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 08:13:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:13:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:13:34 INFO - ^ 08:13:34 INFO - 1 warning generated. 08:13:34 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 08:13:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:34 INFO - Successfully installed psutil 08:13:34 INFO - Cleaning up... 08:13:34 INFO - Return code: 0 08:13:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:13:34 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')]} 08:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:34 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')]} 08:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:34 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 0x109816a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fdbc594a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b5e00>, '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 0x10951edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0b20>, '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.lqQBbhHsKP/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.1CF5otUwZ6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:13:34 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 08:13:34 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 08:13:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lqQBbhHsKP/Render', 08:13:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:34 INFO - 'HOME': '/Users/cltbld', 08:13:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:34 INFO - 'LOGNAME': 'cltbld', 08:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:34 INFO - 'MOZ_NO_REMOTE': '1', 08:13:34 INFO - 'NO_EM_RESTART': '1', 08:13:34 INFO - 'PAGER': '/bin/cat', 08:13:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:34 INFO - 'PWD': '/builds/slave/test', 08:13:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:34 INFO - 'SHELL': '/bin/bash', 08:13:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1CF5otUwZ6/Listeners', 08:13:34 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:13:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:34 INFO - 'USER': 'cltbld', 08:13:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:34 INFO - 'XPC_FLAGS': '0x0', 08:13:34 INFO - 'XPC_SERVICE_NAME': '0', 08:13:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:13:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:13:37 INFO - Installing collected packages: mozsystemmonitor 08:13:37 INFO - Running setup.py install for mozsystemmonitor 08:13:37 INFO - Successfully installed mozsystemmonitor 08:13:37 INFO - Cleaning up... 08:13:37 INFO - Return code: 0 08:13:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:13:37 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')]} 08:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:37 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')]} 08:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:37 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 0x109816a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fdbc594a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b5e00>, '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 0x10951edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0b20>, '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.lqQBbhHsKP/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.1CF5otUwZ6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:13:37 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 08:13:37 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 08:13:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lqQBbhHsKP/Render', 08:13:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:37 INFO - 'HOME': '/Users/cltbld', 08:13:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:37 INFO - 'LOGNAME': 'cltbld', 08:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:37 INFO - 'MOZ_NO_REMOTE': '1', 08:13:37 INFO - 'NO_EM_RESTART': '1', 08:13:37 INFO - 'PAGER': '/bin/cat', 08:13:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:37 INFO - 'PWD': '/builds/slave/test', 08:13:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:37 INFO - 'SHELL': '/bin/bash', 08:13:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1CF5otUwZ6/Listeners', 08:13:37 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:13:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:37 INFO - 'USER': 'cltbld', 08:13:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:37 INFO - 'XPC_FLAGS': '0x0', 08:13:37 INFO - 'XPC_SERVICE_NAME': '0', 08:13:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:13:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:13:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:41 INFO - Downloading docopt-0.6.1.tar.gz 08:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:13:41 INFO - Installing collected packages: blobuploader, requests, docopt 08:13:41 INFO - Running setup.py install for blobuploader 08:13:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:13:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:13:41 INFO - Running setup.py install for requests 08:13:42 INFO - Running setup.py install for docopt 08:13:42 INFO - Successfully installed blobuploader requests docopt 08:13:42 INFO - Cleaning up... 08:13:42 INFO - Return code: 0 08:13:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:42 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')]} 08:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:42 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')]} 08:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:42 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 0x109816a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fdbc594a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b5e00>, '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 0x10951edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0b20>, '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.lqQBbhHsKP/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.1CF5otUwZ6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:13:42 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 08:13:42 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 08:13:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lqQBbhHsKP/Render', 08:13:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:42 INFO - 'HOME': '/Users/cltbld', 08:13:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:42 INFO - 'LOGNAME': 'cltbld', 08:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:42 INFO - 'MOZ_NO_REMOTE': '1', 08:13:42 INFO - 'NO_EM_RESTART': '1', 08:13:42 INFO - 'PAGER': '/bin/cat', 08:13:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:42 INFO - 'PWD': '/builds/slave/test', 08:13:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:42 INFO - 'SHELL': '/bin/bash', 08:13:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1CF5otUwZ6/Listeners', 08:13:42 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:13:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:42 INFO - 'USER': 'cltbld', 08:13:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:42 INFO - 'XPC_FLAGS': '0x0', 08:13:42 INFO - 'XPC_SERVICE_NAME': '0', 08:13:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-SrtQHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:43 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-rJUwe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:43 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-jeDQ86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:43 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-sFma1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:43 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-G7C5RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:43 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-4GMi88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:43 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-dQlqc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:43 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-erSjMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:43 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-tvjlTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:43 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-v_5mO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:43 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-RkhQNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:44 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ySKBKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:44 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-XCEh2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:44 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-QXluXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:44 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-sapdko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:44 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-5oiUMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:44 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ey0wtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:13:44 INFO - Running setup.py install for manifestparser 08:13:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:13:44 INFO - Running setup.py install for mozcrash 08:13:44 INFO - Running setup.py install for mozdebug 08:13:45 INFO - Running setup.py install for mozdevice 08:13:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:13:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:13:45 INFO - Running setup.py install for mozfile 08:13:45 INFO - Running setup.py install for mozhttpd 08:13:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:13:45 INFO - Running setup.py install for mozinfo 08:13:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:13:45 INFO - Running setup.py install for mozInstall 08:13:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:13:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:13:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:13:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:13:45 INFO - Running setup.py install for mozleak 08:13:45 INFO - Running setup.py install for mozlog 08:13:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Running setup.py install for moznetwork 08:13:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Running setup.py install for mozprocess 08:13:46 INFO - Running setup.py install for mozprofile 08:13:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Running setup.py install for mozrunner 08:13:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Running setup.py install for mozscreenshot 08:13:46 INFO - Running setup.py install for moztest 08:13:47 INFO - Running setup.py install for mozversion 08:13:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:13:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:13:47 INFO - Cleaning up... 08:13:47 INFO - Return code: 0 08:13:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:47 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')]} 08:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:48 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 0x109816a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fdbc594a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b5e00>, '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 0x10951edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0b20>, '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.lqQBbhHsKP/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.1CF5otUwZ6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:13:48 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 08:13:48 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 08:13:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lqQBbhHsKP/Render', 08:13:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:48 INFO - 'HOME': '/Users/cltbld', 08:13:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:48 INFO - 'LOGNAME': 'cltbld', 08:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:48 INFO - 'MOZ_NO_REMOTE': '1', 08:13:48 INFO - 'NO_EM_RESTART': '1', 08:13:48 INFO - 'PAGER': '/bin/cat', 08:13:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:48 INFO - 'PWD': '/builds/slave/test', 08:13:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:48 INFO - 'SHELL': '/bin/bash', 08:13:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1CF5otUwZ6/Listeners', 08:13:48 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:13:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:48 INFO - 'USER': 'cltbld', 08:13:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:48 INFO - 'XPC_FLAGS': '0x0', 08:13:48 INFO - 'XPC_SERVICE_NAME': '0', 08:13:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:48 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-z7Rs1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:48 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-9KWejB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:48 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-EN0_OK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:48 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Bs3rjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:48 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-yLQ1kU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:48 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-mUyZm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:49 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)) 08:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:49 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-YLe6xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:49 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)) 08:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:49 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ISDDPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:49 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)) 08:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:49 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-pbnJYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:49 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)) 08:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:49 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Wtsr1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:49 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)) 08:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:49 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-_o0Xya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:49 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)) 08:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:49 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-96wOFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:49 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)) 08:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:49 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-TDCc2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:49 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)) 08:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:49 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-T2JeI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:49 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)) 08:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:49 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ui61o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:49 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)) 08:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:49 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-4VE6PE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:50 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)) 08:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:50 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-us1ZL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:50 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)) 08:13:50 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)) 08:13:50 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)) 08:13:50 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)) 08:13:50 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)) 08:13:50 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)) 08:13:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:52 INFO - Downloading blessings-1.6.tar.gz 08:13:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:13:52 INFO - Installing collected packages: blessings 08:13:52 INFO - Running setup.py install for blessings 08:13:52 INFO - Successfully installed blessings 08:13:52 INFO - Cleaning up... 08:13:52 INFO - Return code: 0 08:13:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:53 INFO - Reading from file tmpfile_stdout 08:13:53 INFO - Current package versions: 08:13:53 INFO - blessings == 1.6 08:13:53 INFO - blobuploader == 1.2.4 08:13:53 INFO - docopt == 0.6.1 08:13:53 INFO - manifestparser == 1.1 08:13:53 INFO - mozInstall == 1.12 08:13:53 INFO - mozcrash == 0.17 08:13:53 INFO - mozdebug == 0.1 08:13:53 INFO - mozdevice == 0.48 08:13:53 INFO - mozfile == 1.2 08:13:53 INFO - mozhttpd == 0.7 08:13:53 INFO - mozinfo == 0.9 08:13:53 INFO - mozleak == 0.1 08:13:53 INFO - mozlog == 3.1 08:13:53 INFO - moznetwork == 0.27 08:13:53 INFO - mozprocess == 0.22 08:13:53 INFO - mozprofile == 0.28 08:13:53 INFO - mozrunner == 6.11 08:13:53 INFO - mozscreenshot == 0.1 08:13:53 INFO - mozsystemmonitor == 0.0 08:13:53 INFO - moztest == 0.7 08:13:53 INFO - mozversion == 1.4 08:13:53 INFO - psutil == 3.1.1 08:13:53 INFO - requests == 1.2.3 08:13:53 INFO - wsgiref == 0.1.2 08:13:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13: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')]} 08:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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')]} 08:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:53 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 0x109816a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fdbc594a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b5e00>, '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 0x10951edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0b20>, '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.lqQBbhHsKP/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.1CF5otUwZ6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:13:53 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 08:13:53 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 08:13:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lqQBbhHsKP/Render', 08:13:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:53 INFO - 'HOME': '/Users/cltbld', 08:13:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:53 INFO - 'LOGNAME': 'cltbld', 08:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:53 INFO - 'MOZ_NO_REMOTE': '1', 08:13:53 INFO - 'NO_EM_RESTART': '1', 08:13:53 INFO - 'PAGER': '/bin/cat', 08:13:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:53 INFO - 'PWD': '/builds/slave/test', 08:13:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:53 INFO - 'SHELL': '/bin/bash', 08:13:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1CF5otUwZ6/Listeners', 08:13:53 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:13:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:53 INFO - 'USER': 'cltbld', 08:13:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:53 INFO - 'XPC_FLAGS': '0x0', 08:13:53 INFO - 'XPC_SERVICE_NAME': '0', 08:13:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:53 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)) 08:13:53 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)) 08:13:53 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)) 08:13:53 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)) 08:13:53 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)) 08:13:53 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)) 08:13:53 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)) 08:13:53 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)) 08:13:53 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)) 08:13:53 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)) 08:13:53 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)) 08:13:53 INFO - Cleaning up... 08:13:53 INFO - Return code: 0 08:13:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:13: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')]} 08:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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')]} 08:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109816a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fdbc594a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b5e00>, '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 0x10951edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0b20>, '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.lqQBbhHsKP/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.1CF5otUwZ6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:13:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:13:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lqQBbhHsKP/Render', 08:13:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:53 INFO - 'HOME': '/Users/cltbld', 08:13:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:53 INFO - 'LOGNAME': 'cltbld', 08:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:53 INFO - 'MOZ_NO_REMOTE': '1', 08:13:53 INFO - 'NO_EM_RESTART': '1', 08:13:53 INFO - 'PAGER': '/bin/cat', 08:13:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:53 INFO - 'PWD': '/builds/slave/test', 08:13:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:53 INFO - 'SHELL': '/bin/bash', 08:13:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1CF5otUwZ6/Listeners', 08:13:53 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:13:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:53 INFO - 'USER': 'cltbld', 08:13:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:53 INFO - 'XPC_FLAGS': '0x0', 08:13:53 INFO - 'XPC_SERVICE_NAME': '0', 08:13:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:53 INFO - Downloading/unpacking jsonschema 08:13:53 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 08:13:53 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 08:13:53 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 08:13:53 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 08:13:53 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 08:13:53 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 08:13:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:13:56 INFO - Downloading/unpacking functools32 (from jsonschema) 08:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:56 INFO - Downloading functools32-3.2.3-2.tar.gz 08:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:13:56 INFO - warning: no files found matching '*.txt' 08:13:56 INFO - no previously-included directories found matching 'build' 08:13:56 INFO - no previously-included directories found matching 'dist' 08:13:56 INFO - no previously-included directories found matching '.git*' 08:13:56 INFO - Installing collected packages: jsonschema, functools32 08:13:56 INFO - Running setup.py install for functools32 08:13:56 INFO - warning: no files found matching '*.txt' 08:13:56 INFO - no previously-included directories found matching 'build' 08:13:56 INFO - no previously-included directories found matching 'dist' 08:13:56 INFO - no previously-included directories found matching '.git*' 08:13:56 INFO - Successfully installed jsonschema functools32 08:13:56 INFO - Cleaning up... 08:13:56 INFO - Return code: 0 08:13:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109816a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109826420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fdbc594a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b5e00>, '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 0x10951edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0b20>, '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.lqQBbhHsKP/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.1CF5otUwZ6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 08:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:13:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lqQBbhHsKP/Render', 08:13:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:56 INFO - 'HOME': '/Users/cltbld', 08:13:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:56 INFO - 'LOGNAME': 'cltbld', 08:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:56 INFO - 'MOZ_NO_REMOTE': '1', 08:13:56 INFO - 'NO_EM_RESTART': '1', 08:13:56 INFO - 'PAGER': '/bin/cat', 08:13:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:56 INFO - 'PWD': '/builds/slave/test', 08:13:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:56 INFO - 'SHELL': '/bin/bash', 08:13:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1CF5otUwZ6/Listeners', 08:13:56 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:13:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:56 INFO - 'USER': 'cltbld', 08:13:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:56 INFO - 'XPC_FLAGS': '0x0', 08:13:56 INFO - 'XPC_SERVICE_NAME': '0', 08:13:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:57 INFO - Downloading/unpacking flake8 08:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:13:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:13:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:14:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:14:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:14:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:14:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:14:00 INFO - no previously-included directories found matching 'docs/_build' 08:14:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:14:00 INFO - Running setup.py install for pep8 08:14:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:14:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:14:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:14:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:14:01 INFO - no previously-included directories found matching 'docs/_build' 08:14:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:14:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:14:01 INFO - Cleaning up... 08:14:01 INFO - Return code: 0 08:14:01 INFO - Running post-action listener: _resource_record_post_action 08:14:01 INFO - Running post-action listener: _start_resource_monitoring 08:14:01 INFO - Starting resource monitoring. 08:14:01 INFO - ##### 08:14:01 INFO - ##### Running install step. 08:14:01 INFO - ##### 08:14:01 INFO - Running pre-action listener: _resource_record_pre_action 08:14:01 INFO - Running main action method: install 08:14:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:01 INFO - Reading from file tmpfile_stdout 08:14:01 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:01 INFO - Reading from file tmpfile_stdout 08:14:01 INFO - Output received: 08:14:01 INFO - Usage: mozinstall [options] installer 08:14:01 INFO - Options: 08:14:01 INFO - -h, --help show this help message and exit 08:14:01 INFO - -d DEST, --destination=DEST 08:14:01 INFO - Directory to install application into. [default: 08:14:01 INFO - "/builds/slave/test"] 08:14:01 INFO - --app=APP Application being installed. [default: firefox] 08:14:01 INFO - mkdir: /builds/slave/test/build/application 08:14:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:14:35 INFO - Reading from file tmpfile_stdout 08:14:35 INFO - Output received: 08:14:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:14:35 INFO - Running post-action listener: _resource_record_post_action 08:14:35 INFO - ##### 08:14:35 INFO - ##### Running run-tests step. 08:14:35 INFO - ##### 08:14:35 INFO - Running pre-action listener: _resource_record_pre_action 08:14:35 INFO - Running main action method: run_tests 08:14:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:14:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:14:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:14:35 INFO - 2016-04-26 08:14:35.118 screenresolution[1647:7454] starting screenresolution argv=screenresolution get 08:14:35 INFO - 2016-04-26 08:14:35.120 screenresolution[1647:7454] Display 0: 1600x1200x32@60 08:14:35 INFO - 2016-04-26 08:14:35.127 screenresolution[1648:7456] starting screenresolution argv=screenresolution list 08:14:35 INFO - Available Modes on Display 0 08:14:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:14:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:14:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:14:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:14:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:14:35 INFO - Intel Iris: 08:14:35 INFO - Chipset Model: Intel Iris 08:14:35 INFO - Type: GPU 08:14:35 INFO - Bus: Built-In 08:14:35 INFO - VRAM (Dynamic, Max): 1536 MB 08:14:35 INFO - Vendor: Intel (0x8086) 08:14:35 INFO - Device ID: 0x0a2e 08:14:35 INFO - Revision ID: 0x0009 08:14:35 INFO - Displays: 08:14:35 INFO - Display: 08:14:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:14:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:14:35 INFO - Display Serial Number: 1600x1200 60 08:14:35 INFO - Main Display: Yes 08:14:35 INFO - Mirror: Off 08:14:35 INFO - Online: Yes 08:14:35 INFO - Rotation: Supported 08:14:35 INFO - Return code: 0 08:14:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:14:35 INFO - Python 2.7.3 08:14:35 INFO - Return code: 0 08:14:35 INFO - grabbing minidump binary from tooltool 08:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:35 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 0x1096b5e00>, '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 0x10951edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:14:35 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 08:14:35 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 08:14:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:14:35 INFO - Return code: 0 08:14:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:14:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:14:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:14:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:14:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:14:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:14:36 INFO - Return code: 0 08:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 08:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --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 08:14:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lqQBbhHsKP/Render', 08:14:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:36 INFO - 'HOME': '/Users/cltbld', 08:14:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:36 INFO - 'LOGNAME': 'cltbld', 08:14:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:14:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:36 INFO - 'MOZ_NO_REMOTE': '1', 08:14:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:14:36 INFO - 'NO_EM_RESTART': '1', 08:14:36 INFO - 'PAGER': '/bin/cat', 08:14:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:36 INFO - 'PWD': '/builds/slave/test', 08:14:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:14:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:36 INFO - 'SHELL': '/bin/bash', 08:14:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1CF5otUwZ6/Listeners', 08:14:36 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 08:14:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:36 INFO - 'USER': 'cltbld', 08:14:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:36 INFO - 'XPC_FLAGS': '0x0', 08:14:36 INFO - 'XPC_SERVICE_NAME': '0', 08:14:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 08:14:36 INFO - mozversion application_buildid: 20160426071219 08:14:36 INFO - mozversion application_changeset: 6a441b2b2997cdbd47b5d80283f6f60d5a9e7489 08:14:36 INFO - mozversion application_display_name: Nightly 08:14:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:14:36 INFO - mozversion application_name: Firefox 08:14:36 INFO - mozversion application_remotingname: firefox 08:14:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:14:36 INFO - mozversion application_vendor: Mozilla 08:14:36 INFO - mozversion application_version: 49.0a1 08:14:36 INFO - mozversion platform_buildid: 20160426071219 08:14:36 INFO - mozversion platform_changeset: 6a441b2b2997cdbd47b5d80283f6f60d5a9e7489 08:14:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:14:36 INFO - mozversion platform_version: 49.0a1 08:14:36 INFO - using testdate: 1461683676 08:14:36 INFO - actual date: 1461683676 08:14:36 INFO - starting webserver on 'localhost:49270' 08:14:36 INFO - SUITE-START | Running 2 tests 08:14:36 INFO - TEST-START | dromaeo_css 08:14:36 INFO - operating with platform_type : mac_ 08:14:36 INFO - Initialising browser for dromaeo_css test... 08:14:36 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmprPrgJ7/profile http://localhost:49270/getInfo.html) 08:14:39 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 08:14:39 INFO - PROCESS | 1666 | colorDepth:24 08:14:39 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 08:14:39 INFO - PROCESS | 1666 | __metrics 08:14:39 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:14:40 INFO - TEST-INFO | 1666: exit 0 08:14:40 INFO - Browser initialized. 08:14:40 INFO - Running cycle 1/1 for dromaeo_css test... 08:14:40 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmprPrgJ7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:52 INFO - PROCESS | 1669 | RSS: Main: 249626624 08:14:52 INFO - PROCESS | 1669 | 08:15:42 INFO - PROCESS | 1669 | 1461683742188 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] 08:17:52 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 08:17:54 INFO - PROCESS | 1669 | RSS: Main: 263098368 08:17:54 INFO - PROCESS | 1669 | 08:20:56 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 08:20:57 INFO - PROCESS | 1669 | RSS: Main: 273780736 08:20:57 INFO - PROCESS | 1669 | 08:23:58 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 08:23:59 INFO - PROCESS | 1669 | RSS: Main: 275488768 08:23:59 INFO - PROCESS | 1669 | 08:27:01 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 08:27:01 INFO - PROCESS | 1669 | RSS: Main: 277311488 08:27:01 INFO - PROCESS | 1669 | 08:30:04 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 08:30:05 INFO - PROCESS | 1669 | RSS: Main: 280195072 08:30:05 INFO - PROCESS | 1669 | 08:33:07 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 08:33:07 INFO - PROCESS | 1669 | RSS: Main: 281202688 08:33:07 INFO - PROCESS | 1669 | 08:33:07 INFO - PROCESS | 1669 | __start_tp_report 08:33:07 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 08:33:07 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 08:33:07 INFO - PROCESS | 1669 | |i|pagename|runs| 08:33:07 INFO - PROCESS | 1669 | |0;dojo.html;2937.4125174964997;3452.9827350863243;3460.290640418715;3496.5104885316046;3504.8072356020416;5743.138529220624;5824.271966004249;5833.154192642064;5857.6778277194735;5858.970705146479;5012;5114.488551144884;5664.575156863231;5896.646201227929;6046.455818976291;5230.1108811502045;5268.894622107556;5302.363716354023;5353.197020446944;5368.194770784394;468.9768461480621;5190.844274671766;5280.5247527722495;5283.86790330241;5339.119045357531;4304.7632380219075;5255.421903590602;5273.077211487994;5275.525202731734;5303.443138470463;5288.961669213434;5291.417944026154;5311.654742441768;5331.813386531491;5356.491133342326;5186.974065129651;5229.398619158769;5293.444188360205;5318.494742999409;5385.865353366158;5579.577207812023;5594.13290939905;5661.830145095653;5690.60165788395;5699.202111704365;6144.187464697925;6278;6302.653354065525;6343.809685709436;6349.809505714836;6191.4118158774845;6224.502039836802;6276.246850377938;6281.560290779647;6286.842828929268;5927.844070406272;5948.13752005961;5964.045752679551;5975.611585246945;5996.5202783777195;6208.348123447064;6271.843203919939;6340.175777148941;6350.904736428957;6401.3598640135615;6173.660448675366;6175.166352542439;6265.561410701207;6267.62394256346;6279.277883043508;6206.968965155235;6303.968480157661;6306.527010474233;6314.936850631527;6325.114483972247;6206.131141640174;6214.844628884223;6276.121343011982;6308.0537919311555;6308.463780578611;6275.560710750204;6280.340564240781;6285.717142728497;6297.653629050446;6344.080108384258;4997.100521906019;5004.974975125101;5007.248912663057;5032.295478632995;5055.69665820052;4395.7142785718825;4475.664325175625;4477.104579084196;4534.410526631516;4576.993061526458;5759.539236861041;5989.580729348991;6003.6397816131175;6006.759729610854;6007.939920600738;5839.978003849309;5960.344362120163;6264.655443950535;6303.936960630427;6317.936820631827;5030.220315851049;5808.676529388278;5952.970235148883;5969.194158788508;5993.910091348634;5459.498637874616;5464.754086066137;5466.617336786387;5476.397596264408;5476.507114359727;6454.290028096905;6473.06140609609;6502.60984340941;6503.479721622259;6508.60948343101;6197.566170368031;6230.532710046674;6257.843553911007;6273.749050037947;6316.810495685137;5526.557875370041;6402.327755585783;6459.095726598186;6482.57863238888;6522.510811689048;6132.84504737327;6300.873982520416;6303.275123360872;6304.936950630435;6306.558540902093;6209.316975132822;6240.625562466266;6283.591566548343;6287.151234583455;6299.874002519832;6077.20996270482;6098.908516372169;6228.159198508143;6241.750329986749;6255.40573645503;5570.4151064139305;5884.764609415746;6227.595206311576;6244.063390491463;6262.436380725757;5248.134057880559;5956.493698035715;6014;6068.787592434243;6110.205673262625;6180.4437600614365;6197.101420293942;6217.316095229431;6223.688815559113;6228.781992630236;5923.141144533933;6086.3000754913755;6087;6101.572889897842;6143.880361275353 08:33:07 INFO - PROCESS | 1669 | |1;ext.html;486.55966350452854;521.4498703867418;539.2665974274987;539.2854467830125;552.3565046720571;37294.25411491768;38077.61922380776;38124;38124.42813357802;38175;40230.19539609206;40522.594774052326;40989;40998.59001409985;41047;9396;9540;9630.422174669542;9639.132478076972;9647.469389183592;9512.57193426294;9602.471864047475;9634.56644450998;9653.131218190361;9657.46883921384;9362.531873406337;9541.71374858752;9615.278854085971;9660.758481037996;9663.5168241588;9511.714648560554;9569.90430095697;9646.903530964706;9654.469004204766;9680.56437460316;9475.573599188054;9593.856092158623;9624.085711857433;9624.759381015461;9628.074385123004;37988.81005594982;38026.85919422422;38287.617123828684;38525.61474385276;38534.80732596347;2239.6080685879906;3022.637283525969;3024.909252722422;3195.504696772004;3267.722243609296;26325.473490530083;26415.471690566083;26552.60171097435;27039.32401689954;27614;2633.723459036812;2677.0362669438987;2706.07993282283;2747.5054490191756;2825.57616357548;288661;289056;291197.9999999979;291477;292640;33898.15254618605;58226.4177358221;58642.706786465795;58693.70653146792;58874.70562647245;33892.49161262583;34629.30741385158;34845.477317840254;34860.30279394449;34969.47545786815;12898.161619494704;14002.859971400156;14499.420023199165;14542.854571454362;14710.190939498216;9519.143277104955;11240;12432.937835310766;12475.189112707645;12475.625731228078;7763.767086987399;7972.681092756341;7984.081830589556;8044.4368894178015;8127.59362031896;2895.898643547466;3379.0707555421964;3440.346334196495;3449.085992212066;3468.514407982884;928.8838895138108;959.4003747657714;1034.7775228325945;1043.400044974143;1073.915345501034;28699.28251793722;28837.711622883504;28968;28968.634365609472;28972.710272897424;873.3362644390309;1062.5484169228048;1089.128697042363;1191.106669997502;1251.3993283224104;12206.080051175173;13971.930140349234;14240.074395164489;14546.308697998827;14599.416023358946;462167;478956;481006;483114.01315921155;484963;54403.72798135984;54988.72505637446;55857.720711396185;55902.16146757802;55952.720236398556;1471.3158381352723;1477.9113253204628;1479.6966621842496;1486.3385793322084;1486.7621180611266;27546;27729.861350693118;28097.297567560974;28325.433491329644;28340.85829570839;48585.02829943452;48603.27095093505;49004.264936025276;49055.01889962109;49135.01729965309;434479;444335;446643.5335646602;447137;447369;21809.454763631034;25990.09034683777;26069.478610428065;26091.347716307246;26441;35545.466817997236;43604.691859244274;43887.902802430195;44018;44327.11345773131;36022.099447514025;36170.819145904105;36375.90872273836;37003.704870329406;37316;35970.46044309285;36417.635823642486;36704.81647591745;36705.63294367129;37138.81430592938;26812.59781103324;29195.85402072976;34682.826585867915;34996.47505287372;36089.45865811963;28208.717912820608;30566.541501877935;30724.385512290075;30795;30889.382212356075;20677.793222067587;23490.060397584588;23660.408489787893;23830.52338953246;23954.161604343764 08:33:07 INFO - PROCESS | 1669 | |2;jquery.html;386.1234996557816;394.5876558995849;394.6014525329417;394.86179837057017;405.64708703428005;14266.07270527415;19881.900590497044;20055;20470.795292047074;20522.8712420817;20331.796682033175;20420.387388378334;20542.38372848813;21431.57136857266;21464.926753662334;5795.101759227306;5856.180134781134;5923.792667256647;6049.879002419949;6078.939210607904;5956.166136740838;6013.278406591216;6046.455818976291;6051.425114614105;6083.087536869483;5615.185798059279;5957.88084238315;5965.373635768247;5986.7605295788335;5999;5842.64944103353;5858.209141765871;6587.5388722789185;6600.141981542417;6615.040819081254;5009.949900500985;5573.526250268732;5795.594308398414;5796.82609521715;5841.211436456067;13370.665733356647;13392.598222053353;13457.932710336483;13681.452741890313;13743.450261989508;1840.9447716568525;1861.6835138026568;2133.264153579052;2242.1479837661586;2316.6872472216205;10095.646652367132;10107.241956853266;10236.846447303296;10256.94871525645;10300.89699103007;1729.1181497436273;1729.7405389191597;1755.7190849464153;1788.3651303787228;1793.8385545300985;84980.72528912072;107168;109921.80156396907;113234;113861;9612.855807162898;11419.257748246337;11461.598844040418;11604.419779011016;11770.82343764827;14675.57852954272;14743.262836858114;14766.48317308889;14826.258687065603;14839.18384488842;7469.85060298791;8230.053543842534;8639.438436501607;8684.478931264144;8724.8691269631;8395.202455766692;8446.239838414573;8460.8730869037;8585.141485851365;8595.65617375298;4594.839180628662;4682.672212945061;4710.034442939189;4748.121597504472;4802;1935.2839449403812;1984.8709833861042;1986.7019947008064;2009.3570057581726;2051.7435320584927;941.2470023980788;954.627695198873;980.2990861533895;1063.5639387850945;1095.8849320821198;17234.310627575007;19422.931738754505;19843.702344464844;20160.899195504222;20621.07205175741;936.2977766674994;950.4914870544363;966.7631430299622;977.1938151025432;986.9062439068277;10553.525091370906;11010.449477526092;11014;11022.283551569122;11025.283356581796;588144;588161;589634;594262;615231;113875.43062284801;115492.42253788677;120690;121401;122705.38647306706;971.242430903882;974.28390133252;986.358866736627;993.1508560181086;1019.5361110694764;18058.006809625596;18322.450326490227;18344.908275458536;18541.81458185455;18551.44345669632;49149.508504915924;50316;50331.74834125806;51195;51480.22779658233;60336.396636034835;63841.084767457054;67236;72267.63866180636;72976.6351168262;7566.583837888748;7982.600869956363;8145.144759800136;8210.671573137008;8484.151584841466;10352.861185269765;10992.780144397228;11792.764144716886;12536.37318134108;12761.489540418279;10806.945965270123;10959.671209863716;10960;10970.890291097307;11184.273022253528;9420.95289523548;10879.782404352027;10981.176411768989;11030.724231894266;11184.273022253528;11111.499982500645;11285.605003824827;11540.769184616429;11580.652580422264;11660.358680272666;7373.29953654402;7861.371090312876;8128.878066828884;8175.978002749656;8509.191626795444;9252.21356184705;10194.82759482669;10584.4707764613;10955.671329859799;11136.832947505956 08:33:07 INFO - PROCESS | 1669 | |3;mootools.html;1585.389624994377;1631.2659303313508;1899.3067530351418;1936.2545420013291;1967.7245185673999;7661.655225514851;7891.8421631567335;8770.693025744093;9185.540722963842;9200.079992000805;7135.393491553211;7841.902133701286;8615.95692021539;8703.825923481543;8962.775930601738;2387.8209134314907;2457.5207834472285;2458.2870967419426;2461.5323088613104;2467.543504451682;2242.4505996030994;2312.8843557822124;2475.2574227731698;2489.0168383488603;2498.8250822442437;2472.752724727522;2485.6271559266074;2490.5766019776684;2500.112460076665;2507.285423654259;2137.850350475467;2273.6358185088898;2316.409315624505;2481.640162176492;2482.4786794773117;2450.840695354814;2472.0482614193484;2479.454520005596;2496.712878019033;2502.799776017914;7491.475596708233;7673.577953212571;7775.0669919609445;7996.320312773421;9078;5330.92003619946;5415;5545.223668686387;5567.2762540869835;5571.13647384656;3618.565772107364;3626.5648122225502;3632.5277713897026;3740.401535754266;3741.7754934704003;849.3884403229665;1028.1825948371063;1047.5233768635253;1053.6575612925753;1067.6370034188412;11590.76818463626;11823;11829.112816538795;11829.526818927232;11842.289462632183;4786.1863483207935;4826.493218212107;4937.061958227925;4959.231319145538;4978.775955081957;10176.338537995007;10215.284930054824;10218.131458826083;10242.129418999319;10249.59001639941;5481.643693159932;5483.2323474712775;5526.115821468546;5572.888542229214;5580.91628625571;4399.1641588098155;4897.853064408074;5005.74971251436;5069.518395752398;5103.132467480537;4059.127287633173;4070.0453636407865;4097.8770636880945;4136.400221967798;4165.125323682;1232.6979889927024;1351.2297990145523;1371.8559551247174;1371.9375504388775;1380.8895288376905;864.8140649760331;876.7895705030746;905.4748246017294;909.9590518426687;929.0709290709291;5590.2453168821685;5711.742971566289;5777.480026797609;5918.141869428909;5994.790182343597;462.643764301486;467.56049313645065;469.9741514216751;1009.5103874620803;1020.8213562626511;3266.611690031727;3666.2484190740834;3683;3835.0987517933263;3836.2135762168687;10570.894291057144;10780.814110447844;10935.890641093487;10990.395528245863;11081.833772493419;10789.56841726322;10990.725231869108;11004.559817607205;11011.064059555027;11024.724381890517;7957.960210198912;8541.14588541141;8609.698660546976;8678.305735541142;8709.433886797338;5399.5950303726595;5628.577856660685;5679.006173919465;5688.488036076773;5694.231278777312;10039.447830369108;10413.271071024956;10508.316959397614;10511.737206569896;10531.631392901212;10168.949155254177;10411.375317480975;10639.468026598484;10771.6229931952;10778.73053173677;6438.034294855809;6935.826604334932;7083.150021997393;7168.67740951648;7283.271672832674;8258.298044666271;8289.626966786389;8344.165583441607;8366.163383661586;8385.035720892176;7280.927190728236;7318.890216646861;7386.815329616803;7522.736704215545;7610.961945190239;7183.748568800067;7183.964080179566;7307.488475806643;7350.889736653848;7378.667959941708;6698.799036028927;6783.152105986752;6843.349881761224;6894.103766510522;6902.758403455855;4715.740634265011;4753.786079626356;4805;4853.150698627655;4980.203167493184;4823.614110871192;4868.464468908488;4874.658773885794;4940;5082.390113186441 08:33:07 INFO - PROCESS | 1669 | |4;prototype.html;316.6311247396783;321.3588890164122;324.27362707535127;330.03300330033;331.34228556315725;4952.653314267998;5406.107472737174;5557.3886872444;5654.717264136787;5656.264685590878;4527.275635898257;4683.3209184668285;4841.547535739273;5545.449093417033;5579.553635709143;4064.451299074624;4144.585541445861;4187.350960601112;4209.789510524462;4248.426462427579;3940.9408858866996;4033.233685599727;4235.49174099107;4244.893877653052;4259.70182087254;3898.1813819097883;4232.957670423287;4249.80875860587;4251.893702657428;4294.398784170218;3431.9656803431894;4098.8565400211;4228.577142285778;4266.850660226877;4270.615644592001;3230.9030729078167;3647.6170002149656;3655.5247817783784;3680.5583330000304;3684.299983003221;4420.668449866273;4695.835645752416;5047.823326183603;5327.653702509325;5334.946650533484;4218.873433796991;4283.4431523902;4391.407160033386;4788.233882578806;4897.212517431148;5014.774335154927;5269.262303277545;5602.971985140089;5720.798632287225;5756.856078598027;3178.570892929448;4068.30838757409;4100.2414553307435;4105.8973525662095;4133.338665813455;5257.973710131463;5796.362654991968;6138.508919286446;6191.718389253702;6218.3832203626935;4114.423980642712;4123.9381409278885;4133.627973482401;4144.79276036197;4155.420940042764;3811.904702382463;4214.030772922184;4224.4930608327195;4225.809838557211;4254.212970600387;4234.470691163605;4579.22153233951;4783.736894470768;4788.2172884657375;4912.410510738734;5676.347220069662;5833.88332233353;5837.182794408786;5841.912371314434;5859.736311865976;1424.622475044114;1437.338824140886;1483.7848511965703;1514.4245186828934;1545.652228248635;955.2787645327733;985.6303886042734;1011.6762635956424;1032.6282538286212;1033.3593172233113;5298.470152984671;5903.645781253139;5906.5570082244;5925.585209035326;5966.701664916737;6620.3710647488415;6653.367930046637;6654.3345665434035;6664.600433908837;6684.197896252481;4987.276844857475;5041.899162016813;5196.376434827769;5524.8342549723575;5608.261438953856;2965.836878971634;3294.7858389204625;3488.064124410976;3524.6122926478065;3553.7966460794473;5791.333996590446;6461.450776683941;6744.42672372844;6899;6955.478339124485;6299.464545513682;6772.661366931634;6825.044493770876;6843.3840954314355;6845.657717114124;5254.106801843619;6407.807765767035;6845.075914751545;6933.37599616037;6952.443804495628;6111.694415279308;6202.666426718277;6203.689815509116;6371.725654868952;6409.8718025640155;5798.681072540882;6509.772157974448;6564.376384243489;6567.931101702949;6595.439387651912;5640.0129977253;5995;6324.936750632619;6336.968315158395;6390.708784975648;3752.6059763724415;3769.981150094232;4211.873643790691;4237.216115018731;4241.3637954307105;5517.337919449692;5937.940620593911;6115.266168059861;6142.570020098729;6159.760359460809;5370.436104209002;5715.799947002001;5874.911876321773;5911.699426126245;5939.88156217989;5183.429822719422;5193.974030129825;5902.026165682614;5920.815836832737;5963.940360596339;5431.11675152268;5774.769009239583;5797.739101740347;5799.5070419014855;5801.448862358069;5406;5708.029634962149;5871.588988770745;5927.081302398135;5939.316978547522;4456.532064133219;5456.48163424474;5776.624519406225;5811.680357580373;5827.59206855516 08:33:07 INFO - PROCESS | 1669 | |5;yui.html;689.8930665746811;709.6238993333534;745.1430854517305;759.1270039454627;782.2334112569681;14878.330475128618;15024.549263522113;15357.00179488334;15381.92309038456;15396.307166177521;14608.19654918979;14648.707025859476;14650.120992740443;14680.412783488675;14738.484153054646;726.821928627487;929.1034152043277;936.4053825820619;959.6641175588558;971.4511301114883;905.8912930448355;907.2288554728494;955.928305377096;957.6265256549951;962.7448726087592;950.4534892436842;950.7480517662825;968.138356862393;985.8915519292872;1006.7181189267017;943.0239701908491;1000.2847963705949;1003.4631472162358;1005.3515482513811;1007.969760907174;719.1765428584295;726.8836986082255;732.5641243460133;748.6182047155935;751.9848204923364;14996.550103496913;15046.849531504655;15137.016093953858;15143.242837858063;15166.24168791556;12538.874611253954;12600.873991260061;12687.555935542212;12742.171758835739;12857.871421285761;9977.052180042885;10030.448325342104;10200.540975656113;10231.897681023169;10725.731856703567;3043.893463728759;3205.6634053424286;3274.8046962858384;3497.7551571390013;3501.369753444379;66684.6665766668;75302.11744706372;83350.16649833485;84073;85432.14567854366;9329.860052099224;9434.811303774024;9453.196478299422;9629.470379129216;9721.125098741148;19514.5121371964;21723.565528689338;21879.890600546896;21969;22229.888850555642;6600.900986485207;7104.3961263293195;7358.926410735931;7522.285382888617;7549.471536992468;3363.814990175515;3923.7645741255615;4009.1179940413062;4032.2137183248983;4063.4108054332546;3519.894403167909;3621.619729928372;3632.891967949748;3634.7637403568683;3643.5263415756312;649.5031301054697;662.8939369700824;666.7233098264167;667.6728403082552;678.0642713055951;520.6121439527576;559.9944000560024;591.7869566955892;619.1424876545926;634.1819053421127;7967.48211366271;8217.753467395869;8235.547044912588;8263;8352;568.8407245971134;596.3082823924227;618.3630860213987;624.487919905673;627.8116565030564;3656.7074634029213;3849.826757795906;3878.26313000529;3924.274009308287;3952.466417033721;91251.54374228086;95830;96928.51535742417;97330;99273.50363248137;69278.96081558781;80729;80942.59528702436;82440.58779706064;83608.90977725605;64033;69791;71127.64436177786;73585.26414735892;74572.25427745761;7138.179109402485;7148.535345202546;7279.1265048194555;7308.707651693872;7496.550206987598;34383.65616343805;46311.528659237956;46935.8266043338;47329;47695.76152119217;64242.35757642364;65155;65858.67070664615;65934;66342.67314653583;9951.751206219902;10111.696649100539;10170.135538479017;10308.32995855267;11181.664550063511;11890.28658280506;12140.210886292716;12327.69180770488;12346.629601111981;13354.666133346744;11873.643790686294;12027.21823081497;12031.4585843639;12041.397930103634;12130.75738485243;11530.192886497865;11783.175177737476;11906.40467976615;12207.572734954234;12515.4368053436;11461.770764584495;11479.942600286946;11615.245009074382;11887;11968.102392320785;9883.651669777162;9945.154661853823;10097.956342300351;10308;10379.532921018723;9779.119879210904;9847.803043939224;9854.507274636382;9885.55515001841;9914.355566888129 08:33:07 INFO - PROCESS | 1669 | __end_tp_report 08:33:07 INFO - PROCESS | 1669 | __start_cc_report 08:33:07 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,412 08:33:07 INFO - PROCESS | 1669 | __end_cc_report 08:33:07 INFO - PROCESS | 1669 | __startTimestamp1461684787959__endTimestamp 08:33:07 INFO - PROCESS | 1669 | 08:33:07 INFO - PROCESS | 1669 | ------- Summary: start ------- 08:33:07 INFO - PROCESS | 1669 | Number of tests: 6 08:33:07 INFO - PROCESS | 1669 | 08:33:07 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5767.69 Median:6014.00 stddev:781.58 (13.0%) stddev-sans-first:751.78 08:33:07 INFO - PROCESS | 1669 | Values: 2937.4 3453.0 3460.3 3496.5 3504.8 5743.1 5824.3 5833.2 5857.7 5859.0 5012.0 5114.5 5664.6 5896.6 6046.5 5230.1 5268.9 5302.4 5353.2 5368.2 469.0 5190.8 5280.5 5283.9 5339.1 4304.8 5255.4 5273.1 5275.5 5303.4 5289.0 5291.4 5311.7 5331.8 5356.5 5187.0 5229.4 5293.4 5318.5 5385.9 5579.6 5594.1 5661.8 5690.6 5699.2 6144.2 6278.0 6302.7 6343.8 6349.8 6191.4 6224.5 6276.2 6281.6 6286.8 5927.8 5948.1 5964.0 5975.6 5996.5 6208.3 6271.8 6340.2 6350.9 6401.4 6173.7 6175.2 6265.6 6267.6 6279.3 6207.0 6304.0 6306.5 6314.9 6325.1 6206.1 6214.8 6276.1 6308.1 6308.5 6275.6 6280.3 6285.7 6297.7 6344.1 4997.1 5005.0 5007.2 5032.3 5055.7 4395.7 4475.7 4477.1 4534.4 4577.0 5759.5 5989.6 6003.6 6006.8 6007.9 5840.0 5960.3 6264.7 6303.9 6317.9 5030.2 5808.7 5953.0 5969.2 5993.9 5459.5 5464.8 5466.6 5476.4 5476.5 6454.3 6473.1 6502.6 6503.5 6508.6 6197.6 6230.5 6257.8 6273.7 6316.8 5526.6 6402.3 6459.1 6482.6 6522.5 6132.8 6300.9 6303.3 6304.9 6306.6 6209.3 6240.6 6283.6 6287.2 6299.9 6077.2 6098.9 6228.2 6241.8 6255.4 5570.4 5884.8 6227.6 6244.1 6262.4 5248.1 5956.5 6014.0 6068.8 6110.2 6180.4 6197.1 6217.3 6223.7 6228.8 5923.1 6086.3 6087.0 6101.6 6143.9 08:33:07 INFO - PROCESS | 1669 | 08:33:07 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:53918.49 Median:36273.36 stddev:109697.15 (302.4%) stddev-sans-first:109931.52 08:33:07 INFO - PROCESS | 1669 | Values: 486.6 521.4 539.3 539.3 552.4 37294.3 38077.6 38124.0 38124.4 38175.0 40230.2 40522.6 40989.0 40998.6 41047.0 9396.0 9540.0 9630.4 9639.1 9647.5 9512.6 9602.5 9634.6 9653.1 9657.5 9362.5 9541.7 9615.3 9660.8 9663.5 9511.7 9569.9 9646.9 9654.5 9680.6 9475.6 9593.9 9624.1 9624.8 9628.1 37988.8 38026.9 38287.6 38525.6 38534.8 2239.6 3022.6 3024.9 3195.5 3267.7 26325.5 26415.5 26552.6 27039.3 27614.0 2633.7 2677.0 2706.1 2747.5 2825.6 288661.0 289056.0 291198.0 291477.0 292640.0 33898.2 58226.4 58642.7 58693.7 58874.7 33892.5 34629.3 34845.5 34860.3 34969.5 12898.2 14002.9 14499.4 14542.9 14710.2 9519.1 11240.0 12432.9 12475.2 12475.6 7763.8 7972.7 7984.1 8044.4 8127.6 2895.9 3379.1 3440.3 3449.1 3468.5 928.9 959.4 1034.8 1043.4 1073.9 28699.3 28837.7 28968.0 28968.6 28972.7 873.3 1062.5 1089.1 1191.1 1251.4 12206.1 13971.9 14240.1 14546.3 14599.4 462167.0 478956.0 481006.0 483114.0 484963.0 54403.7 54988.7 55857.7 55902.2 55952.7 1471.3 1477.9 1479.7 1486.3 1486.8 27546.0 27729.9 28097.3 28325.4 28340.9 48585.0 48603.3 49004.3 49055.0 49135.0 434479.0 444335.0 446643.5 447137.0 447369.0 21809.5 25990.1 26069.5 26091.3 26441.0 35545.5 43604.7 43887.9 44018.0 44327.1 36022.1 36170.8 36375.9 37003.7 37316.0 35970.5 36417.6 36704.8 36705.6 37138.8 26812.6 29195.9 34682.8 34996.5 36089.5 28208.7 30566.5 30724.4 30795.0 30889.4 20677.8 23490.1 23660.4 23830.5 23954.2 08:33:07 INFO - PROCESS | 1669 | 08:33:07 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:33547.38 Median:21448.25 stddev:98826.08 (460.8%) stddev-sans-first:99071.94 08:33:07 INFO - PROCESS | 1669 | Values: 386.1 394.6 394.6 394.9 405.6 14266.1 19881.9 20055.0 20470.8 20522.9 20331.8 20420.4 20542.4 21431.6 21464.9 5795.1 5856.2 5923.8 6049.9 6078.9 5956.2 6013.3 6046.5 6051.4 6083.1 5615.2 5957.9 5965.4 5986.8 5999.0 5842.6 5858.2 6587.5 6600.1 6615.0 5009.9 5573.5 5795.6 5796.8 5841.2 13370.7 13392.6 13457.9 13681.5 13743.5 1840.9 1861.7 2133.3 2242.1 2316.7 10095.6 10107.2 10236.8 10256.9 10300.9 1729.1 1729.7 1755.7 1788.4 1793.8 84980.7 107168.0 109921.8 113234.0 113861.0 9612.9 11419.3 11461.6 11604.4 11770.8 14675.6 14743.3 14766.5 14826.3 14839.2 7469.9 8230.1 8639.4 8684.5 8724.9 8395.2 8446.2 8460.9 8585.1 8595.7 4594.8 4682.7 4710.0 4748.1 4802.0 1935.3 1984.9 1986.7 2009.4 2051.7 941.2 954.6 980.3 1063.6 1095.9 17234.3 19422.9 19843.7 20160.9 20621.1 936.3 950.5 966.8 977.2 986.9 10553.5 11010.4 11014.0 11022.3 11025.3 588144.0 588161.0 589634.0 594262.0 615231.0 113875.4 115492.4 120690.0 121401.0 122705.4 971.2 974.3 986.4 993.2 1019.5 18058.0 18322.5 18344.9 18541.8 18551.4 49149.5 50316.0 50331.7 51195.0 51480.2 60336.4 63841.1 67236.0 72267.6 72976.6 7566.6 7982.6 8145.1 8210.7 8484.2 10352.9 10992.8 11792.8 12536.4 12761.5 10806.9 10959.7 10960.0 10970.9 11184.3 9421.0 10879.8 10981.2 11030.7 11184.3 11111.5 11285.6 11540.8 11580.7 11660.4 7373.3 7861.4 8128.9 8176.0 8509.2 9252.2 10194.8 10584.5 10955.7 11136.8 08:33:07 INFO - PROCESS | 1669 | 08:33:07 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5728.54 Median:4734.76 stddev:3231.18 (68.2%) stddev-sans-first:3225.25 08:33:07 INFO - PROCESS | 1669 | Values: 1585.4 1631.3 1899.3 1936.3 1967.7 7661.7 7891.8 8770.7 9185.5 9200.1 7135.4 7841.9 8616.0 8703.8 8962.8 2387.8 2457.5 2458.3 2461.5 2467.5 2242.5 2312.9 2475.3 2489.0 2498.8 2472.8 2485.6 2490.6 2500.1 2507.3 2137.9 2273.6 2316.4 2481.6 2482.5 2450.8 2472.0 2479.5 2496.7 2502.8 7491.5 7673.6 7775.1 7996.3 9078.0 5330.9 5415.0 5545.2 5567.3 5571.1 3618.6 3626.6 3632.5 3740.4 3741.8 849.4 1028.2 1047.5 1053.7 1067.6 11590.8 11823.0 11829.1 11829.5 11842.3 4786.2 4826.5 4937.1 4959.2 4978.8 10176.3 10215.3 10218.1 10242.1 10249.6 5481.6 5483.2 5526.1 5572.9 5580.9 4399.2 4897.9 5005.7 5069.5 5103.1 4059.1 4070.0 4097.9 4136.4 4165.1 1232.7 1351.2 1371.9 1371.9 1380.9 864.8 876.8 905.5 910.0 929.1 5590.2 5711.7 5777.5 5918.1 5994.8 462.6 467.6 470.0 1009.5 1020.8 3266.6 3666.2 3683.0 3835.1 3836.2 10570.9 10780.8 10935.9 10990.4 11081.8 10789.6 10990.7 11004.6 11011.1 11024.7 7958.0 8541.1 8609.7 8678.3 8709.4 5399.6 5628.6 5679.0 5688.5 5694.2 10039.4 10413.3 10508.3 10511.7 10531.6 10168.9 10411.4 10639.5 10771.6 10778.7 6438.0 6935.8 7083.2 7168.7 7283.3 8258.3 8289.6 8344.2 8366.2 8385.0 7280.9 7318.9 7386.8 7522.7 7611.0 7183.7 7184.0 7307.5 7350.9 7378.7 6698.8 6783.2 6843.3 6894.1 6902.8 4715.7 4753.8 4805.0 4853.2 4980.2 4823.6 4868.5 4874.7 4940.0 5082.4 08:33:07 INFO - PROCESS | 1669 | 08:33:07 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:4861.22 Median:5313.06 stddev:1540.09 (29.0%) stddev-sans-first:1506.16 08:33:07 INFO - PROCESS | 1669 | Values: 316.6 321.4 324.3 330.0 331.3 4952.7 5406.1 5557.4 5654.7 5656.3 4527.3 4683.3 4841.5 5545.4 5579.6 4064.5 4144.6 4187.4 4209.8 4248.4 3940.9 4033.2 4235.5 4244.9 4259.7 3898.2 4233.0 4249.8 4251.9 4294.4 3432.0 4098.9 4228.6 4266.9 4270.6 3230.9 3647.6 3655.5 3680.6 3684.3 4420.7 4695.8 5047.8 5327.7 5334.9 4218.9 4283.4 4391.4 4788.2 4897.2 5014.8 5269.3 5603.0 5720.8 5756.9 3178.6 4068.3 4100.2 4105.9 4133.3 5258.0 5796.4 6138.5 6191.7 6218.4 4114.4 4123.9 4133.6 4144.8 4155.4 3811.9 4214.0 4224.5 4225.8 4254.2 4234.5 4579.2 4783.7 4788.2 4912.4 5676.3 5833.9 5837.2 5841.9 5859.7 1424.6 1437.3 1483.8 1514.4 1545.7 955.3 985.6 1011.7 1032.6 1033.4 5298.5 5903.6 5906.6 5925.6 5966.7 6620.4 6653.4 6654.3 6664.6 6684.2 4987.3 5041.9 5196.4 5524.8 5608.3 2965.8 3294.8 3488.1 3524.6 3553.8 5791.3 6461.5 6744.4 6899.0 6955.5 6299.5 6772.7 6825.0 6843.4 6845.7 5254.1 6407.8 6845.1 6933.4 6952.4 6111.7 6202.7 6203.7 6371.7 6409.9 5798.7 6509.8 6564.4 6567.9 6595.4 5640.0 5995.0 6324.9 6337.0 6390.7 3752.6 3770.0 4211.9 4237.2 4241.4 5517.3 5937.9 6115.3 6142.6 6159.8 5370.4 5715.8 5874.9 5911.7 5939.9 5183.4 5194.0 5902.0 5920.8 5963.9 5431.1 5774.8 5797.7 5799.5 5801.4 5406.0 5708.0 5871.6 5927.1 5939.3 4456.5 5456.5 5776.6 5811.7 5827.6 08:33:07 INFO - PROCESS | 1669 | 08:33:07 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:18248.24 Median:607.34 stddev:25777.71 (4244.4%) stddev-sans-first:25816.31 08:33:07 INFO - PROCESS | 1669 | Values: 689.9 709.6 745.1 759.1 782.2 14878.3 15024.5 15357.0 15381.9 15396.3 14608.2 14648.7 14650.1 14680.4 14738.5 726.8 929.1 936.4 959.7 971.5 905.9 907.2 955.9 957.6 962.7 950.5 950.7 968.1 985.9 1006.7 943.0 1000.3 1003.5 1005.4 1008.0 719.2 726.9 732.6 748.6 752.0 14996.6 15046.8 15137.0 15143.2 15166.2 12538.9 12600.9 12687.6 12742.2 12857.9 9977.1 10030.4 10200.5 10231.9 10725.7 3043.9 3205.7 3274.8 3497.8 3501.4 66684.7 75302.1 83350.2 84073.0 85432.1 9329.9 9434.8 9453.2 9629.5 9721.1 19514.5 21723.6 21879.9 21969.0 22229.9 6600.9 7104.4 7358.9 7522.3 7549.5 3363.8 3923.8 4009.1 4032.2 4063.4 3519.9 3621.6 3632.9 3634.8 3643.5 649.5 662.9 666.7 667.7 678.1 520.6 560.0 591.8 619.1 634.2 7967.5 8217.8 8235.5 8263.0 8352.0 568.8 596.3 618.4 624.5 627.8 3656.7 3849.8 3878.3 3924.3 3952.5 91251.5 95830.0 96928.5 97330.0 99273.5 69279.0 80729.0 80942.6 82440.6 83608.9 64033.0 69791.0 71127.6 73585.3 74572.3 7138.2 7148.5 7279.1 7308.7 7496.6 34383.7 46311.5 46935.8 47329.0 47695.8 64242.4 65155.0 65858.7 65934.0 66342.7 9951.8 10111.7 10170.1 10308.3 11181.7 11890.3 12140.2 12327.7 12346.6 13354.7 11873.6 12027.2 12031.5 12041.4 12130.8 11530.2 11783.2 11906.4 12207.6 12515.4 11461.8 11479.9 11615.2 11887.0 11968.1 9883.7 9945.2 10098.0 10308.0 10379.5 9779.1 9847.8 9854.5 9885.6 9914.4 08:33:07 INFO - PROCESS | 1669 | -------- Summary: end -------- 08:33:07 INFO - PROCESS | 1669 | 08:33:08 INFO - TEST-INFO | 1669: exit 0 08:33:08 INFO - TEST-OK | dromaeo_css | took 1111741ms 08:33:08 INFO - TEST-START | kraken 08:33:08 INFO - operating with platform_type : mac_ 08:33:08 INFO - Initialising browser for kraken test... 08:33:08 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpyrDI9s/profile http://localhost:49270/getInfo.html) 08:33:11 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 08:33:11 INFO - PROCESS | 1679 | colorDepth:24 08:33:11 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 08:33:11 INFO - PROCESS | 1679 | __metrics 08:33:11 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:33:12 INFO - TEST-INFO | 1679: exit 0 08:33:12 INFO - Browser initialized. 08:33:12 INFO - Running cycle 1/1 for kraken test... 08:33:12 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpyrDI9s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:24 INFO - PROCESS | 1682 | RSS: Main: 249835520 08:33:24 INFO - PROCESS | 1682 | 08:33:26 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 08:33:27 INFO - PROCESS | 1682 | RSS: Main: 261742592 08:33:27 INFO - PROCESS | 1682 | 08:33:30 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 08:33:30 INFO - PROCESS | 1682 | RSS: Main: 271036416 08:33:30 INFO - PROCESS | 1682 | 08:33:34 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 08:33:34 INFO - PROCESS | 1682 | RSS: Main: 274771968 08:33:34 INFO - PROCESS | 1682 | 08:33:36 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 08:33:37 INFO - PROCESS | 1682 | RSS: Main: 275177472 08:33:37 INFO - PROCESS | 1682 | 08:33:39 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:33:40 INFO - PROCESS | 1682 | RSS: Main: 275148800 08:33:40 INFO - PROCESS | 1682 | 08:33:43 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 08:33:43 INFO - PROCESS | 1682 | RSS: Main: 276611072 08:33:43 INFO - PROCESS | 1682 | 08:33:46 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 08:33:47 INFO - PROCESS | 1682 | RSS: Main: 276983808 08:33:47 INFO - PROCESS | 1682 | 08:33:50 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 08:33:50 INFO - PROCESS | 1682 | RSS: Main: 276631552 08:33:50 INFO - PROCESS | 1682 | 08:33:52 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:33:53 INFO - PROCESS | 1682 | RSS: Main: 277073920 08:33:53 INFO - PROCESS | 1682 | 08:33:54 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:33:55 INFO - PROCESS | 1682 | RSS: Main: 276619264 08:33:55 INFO - PROCESS | 1682 | 08:33:57 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:33:58 INFO - PROCESS | 1682 | RSS: Main: 276881408 08:33:58 INFO - PROCESS | 1682 | 08:34:01 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:02 INFO - PROCESS | 1682 | RSS: Main: 276942848 08:34:02 INFO - PROCESS | 1682 | 08:34:05 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:05 INFO - PROCESS | 1682 | RSS: Main: 276959232 08:34:05 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 08:34:07 INFO - PROCESS | 1682 | RSS: Main: 278716416 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | __start_tp_report 08:34:07 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 08:34:07 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 08:34:07 INFO - PROCESS | 1682 | |i|pagename|runs| 08:34:07 INFO - PROCESS | 1682 | |0;ai-astar;117;109;117;115;117;130;112;119;119;135 08:34:07 INFO - PROCESS | 1682 | |1;audio-beat-detection;154;121;144;164;120;143;140;122;169;122 08:34:07 INFO - PROCESS | 1682 | |2;audio-dft;194;192;198;214;227;195;195;198;201;196 08:34:07 INFO - PROCESS | 1682 | |3;audio-fft;66;74;72;108;57;71;80;84;150;79 08:34:07 INFO - PROCESS | 1682 | |4;audio-oscillator;75;84;122;76;81;87;119;80;80;122 08:34:07 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;135;131;89;95;120;85;99;120;90;89 08:34:07 INFO - PROCESS | 1682 | |6;imaging-darkroom;149;125;96;120;112;95;97;96;96;117 08:34:07 INFO - PROCESS | 1682 | |7;imaging-desaturate;88;95;90;91;93;89;90;92;75;140 08:34:07 INFO - PROCESS | 1682 | |8;json-parse-financial;59;62;60;60;61;62;61;79;61;62 08:34:07 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;64;68;57;78;74;66;85;102;94;95 08:34:07 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;104;108;106;81;84;84;83;82;85;82 08:34:07 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;144;143;137;142;162;159;144;142;177;140 08:34:07 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;226;206;203;197;196;200;197;201;199;254 08:34:07 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;72;71;69;70;73;71;68;69;72;68 08:34:07 INFO - PROCESS | 1682 | __end_tp_report 08:34:07 INFO - PROCESS | 1682 | __start_cc_report 08:34:07 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1097 08:34:07 INFO - PROCESS | 1682 | __end_cc_report 08:34:07 INFO - PROCESS | 1682 | __startTimestamp1461684847868__endTimestamp 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | ------- Summary: start ------- 08:34:07 INFO - PROCESS | 1682 | Number of tests: 14 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:119.00 Median:118.00 stddev:7.85 (6.6%) stddev-sans-first:8.29 08:34:07 INFO - PROCESS | 1682 | Values: 117.0 109.0 117.0 115.0 117.0 130.0 112.0 119.0 119.0 135.0 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:143.50 stddev:18.40 (12.8%) stddev-sans-first:18.79 08:34:07 INFO - PROCESS | 1682 | Values: 154.0 121.0 144.0 164.0 120.0 143.0 140.0 122.0 169.0 122.0 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:201.00 Median:198.00 stddev:11.01 (5.6%) stddev-sans-first:11.38 08:34:07 INFO - PROCESS | 1682 | Values: 194.0 192.0 198.0 214.0 227.0 195.0 195.0 198.0 201.0 196.0 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:84.10 Median:73.00 stddev:26.75 (36.6%) stddev-sans-first:27.56 08:34:07 INFO - PROCESS | 1682 | Values: 66.0 74.0 72.0 108.0 57.0 71.0 80.0 84.0 150.0 79.0 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:80.00 stddev:19.91 (24.9%) stddev-sans-first:20.08 08:34:07 INFO - PROCESS | 1682 | Values: 75.0 84.0 122.0 76.0 81.0 87.0 119.0 80.0 80.0 122.0 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:105.30 Median:89.00 stddev:19.14 (21.5%) stddev-sans-first:17.02 08:34:07 INFO - PROCESS | 1682 | Values: 135.0 131.0 89.0 95.0 120.0 85.0 99.0 120.0 90.0 89.0 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:110.30 Median:95.50 stddev:17.89 (18.7%) stddev-sans-first:12.33 08:34:07 INFO - PROCESS | 1682 | Values: 149.0 125.0 96.0 120.0 112.0 95.0 97.0 96.0 96.0 117.0 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:90.50 stddev:16.94 (18.7%) stddev-sans-first:17.82 08:34:07 INFO - PROCESS | 1682 | Values: 88.0 95.0 90.0 91.0 93.0 89.0 90.0 92.0 75.0 140.0 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:61.50 stddev:5.81 (9.5%) stddev-sans-first:6.01 08:34:07 INFO - PROCESS | 1682 | Values: 59.0 62.0 60.0 60.0 61.0 62.0 61.0 79.0 61.0 62.0 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:78.30 Median:76.00 stddev:15.15 (19.9%) stddev-sans-first:15.16 08:34:07 INFO - PROCESS | 1682 | Values: 64.0 68.0 57.0 78.0 74.0 66.0 85.0 102.0 94.0 95.0 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:82.50 stddev:11.21 (13.6%) stddev-sans-first:10.67 08:34:07 INFO - PROCESS | 1682 | Values: 104.0 108.0 106.0 81.0 84.0 84.0 83.0 82.0 85.0 82.0 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:149.00 Median:144.00 stddev:12.75 (8.9%) stddev-sans-first:13.39 08:34:07 INFO - PROCESS | 1682 | Values: 144.0 143.0 137.0 142.0 162.0 159.0 144.0 142.0 177.0 140.0 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:207.90 Median:202.00 stddev:18.41 (9.1%) stddev-sans-first:18.32 08:34:07 INFO - PROCESS | 1682 | Values: 226.0 206.0 203.0 197.0 196.0 200.0 197.0 201.0 199.0 254.0 08:34:07 INFO - PROCESS | 1682 | 08:34:07 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:71.00 stddev:1.77 (2.5%) stddev-sans-first:1.76 08:34:07 INFO - PROCESS | 1682 | Values: 72.0 71.0 69.0 70.0 73.0 71.0 68.0 69.0 72.0 68.0 08:34:07 INFO - PROCESS | 1682 | -------- Summary: end -------- 08:34:07 INFO - PROCESS | 1682 | 08:34:08 INFO - TEST-INFO | 1682: exit 0 08:34:08 INFO - TEST-OK | kraken | took 60108ms 08:34:08 INFO - SUITE-END | took 1171s 08:34:09 INFO - Completed test suite (00:19:32) 08:34:09 INFO - javascript benchmark 08:34:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2937.4125174964997, 3452.9827350863243, 3460.290640418715, 3496.5104885316046, 3504.8072356020416, 5743.138529220624, 5824.271966004249, 5833.154192642064, 5857.6778277194735, 5858.970705146479, 5012.0, 5114.488551144884, 5664.575156863231, 5896.646201227929, 6046.455818976291, 5230.1108811502045, 5268.894622107556, 5302.363716354023, 5353.197020446944, 5368.194770784394, 468.9768461480621, 5190.844274671766, 5280.5247527722495, 5283.86790330241, 5339.119045357531, 4304.7632380219075, 5255.421903590602, 5273.077211487994, 5275.525202731734, 5303.443138470463, 5288.961669213434, 5291.417944026154, 5311.654742441768, 5331.813386531491, 5356.491133342326, 5186.974065129651, 5229.398619158769, 5293.444188360205, 5318.494742999409, 5385.865353366158, 5579.577207812023, 5594.13290939905, 5661.830145095653, 5690.60165788395, 5699.202111704365, 6144.187464697925, 6278.0, 6302.653354065525, 6343.809685709436, 6349.809505714836, 6191.4118158774845, 6224.502039836802, 6276.246850377938, 6281.560290779647, 6286.842828929268, 5927.844070406272, 5948.13752005961, 5964.045752679551, 5975.611585246945, 5996.5202783777195, 6208.348123447064, 6271.843203919939, 6340.175777148941, 6350.904736428957, 6401.3598640135615, 6173.660448675366, 6175.166352542439, 6265.561410701207, 6267.62394256346, 6279.277883043508, 6206.968965155235, 6303.968480157661, 6306.527010474233, 6314.936850631527, 6325.114483972247, 6206.131141640174, 6214.844628884223, 6276.121343011982, 6308.0537919311555, 6308.463780578611, 6275.560710750204, 6280.340564240781, 6285.717142728497, 6297.653629050446, 6344.080108384258, 4997.100521906019, 5004.974975125101, 5007.248912663057, 5032.295478632995, 5055.69665820052, 4395.7142785718825, 4475.664325175625, 4477.104579084196, 4534.410526631516, 4576.993061526458, 5759.539236861041, 5989.580729348991, 6003.6397816131175, 6006.759729610854, 6007.939920600738, 5839.978003849309, 5960.344362120163, 6264.655443950535, 6303.936960630427, 6317.936820631827, 5030.220315851049, 5808.676529388278, 5952.970235148883, 5969.194158788508, 5993.910091348634, 5459.498637874616, 5464.754086066137, 5466.617336786387, 5476.397596264408, 5476.507114359727, 6454.290028096905, 6473.06140609609, 6502.60984340941, 6503.479721622259, 6508.60948343101, 6197.566170368031, 6230.532710046674, 6257.843553911007, 6273.749050037947, 6316.810495685137, 5526.557875370041, 6402.327755585783, 6459.095726598186, 6482.57863238888, 6522.510811689048, 6132.84504737327, 6300.873982520416, 6303.275123360872, 6304.936950630435, 6306.558540902093, 6209.316975132822, 6240.625562466266, 6283.591566548343, 6287.151234583455, 6299.874002519832, 6077.20996270482, 6098.908516372169, 6228.159198508143, 6241.750329986749, 6255.40573645503, 5570.4151064139305, 5884.764609415746, 6227.595206311576, 6244.063390491463, 6262.436380725757, 5248.134057880559, 5956.493698035715, 6014.0, 6068.787592434243, 6110.205673262625, 6180.4437600614365, 6197.101420293942, 6217.316095229431, 6223.688815559113, 6228.781992630236, 5923.141144533933, 6086.3000754913755, 6087.0, 6101.572889897842, 6143.880361275353], "value": 5719.574723500396, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.55966350452854, 521.4498703867418, 539.2665974274987, 539.2854467830125, 552.3565046720571, 37294.25411491768, 38077.61922380776, 38124.0, 38124.42813357802, 38175.0, 40230.19539609206, 40522.594774052326, 40989.0, 40998.59001409985, 41047.0, 9396.0, 9540.0, 9630.422174669542, 9639.132478076972, 9647.469389183592, 9512.57193426294, 9602.471864047475, 9634.56644450998, 9653.131218190361, 9657.46883921384, 9362.531873406337, 9541.71374858752, 9615.278854085971, 9660.758481037996, 9663.5168241588, 9511.714648560554, 9569.90430095697, 9646.903530964706, 9654.469004204766, 9680.56437460316, 9475.573599188054, 9593.856092158623, 9624.085711857433, 9624.759381015461, 9628.074385123004, 37988.81005594982, 38026.85919422422, 38287.617123828684, 38525.61474385276, 38534.80732596347, 2239.6080685879906, 3022.637283525969, 3024.909252722422, 3195.504696772004, 3267.722243609296, 26325.473490530083, 26415.471690566083, 26552.60171097435, 27039.32401689954, 27614.0, 2633.723459036812, 2677.0362669438987, 2706.07993282283, 2747.5054490191756, 2825.57616357548, 288661.0, 289056.0, 291197.9999999979, 291477.0, 292640.0, 33898.15254618605, 58226.4177358221, 58642.706786465795, 58693.70653146792, 58874.70562647245, 33892.49161262583, 34629.30741385158, 34845.477317840254, 34860.30279394449, 34969.47545786815, 12898.161619494704, 14002.859971400156, 14499.420023199165, 14542.854571454362, 14710.190939498216, 9519.143277104955, 11240.0, 12432.937835310766, 12475.189112707645, 12475.625731228078, 7763.767086987399, 7972.681092756341, 7984.081830589556, 8044.4368894178015, 8127.59362031896, 2895.898643547466, 3379.0707555421964, 3440.346334196495, 3449.085992212066, 3468.514407982884, 928.8838895138108, 959.4003747657714, 1034.7775228325945, 1043.400044974143, 1073.915345501034, 28699.28251793722, 28837.711622883504, 28968.0, 28968.634365609472, 28972.710272897424, 873.3362644390309, 1062.5484169228048, 1089.128697042363, 1191.106669997502, 1251.3993283224104, 12206.080051175173, 13971.930140349234, 14240.074395164489, 14546.308697998827, 14599.416023358946, 462167.0, 478956.0, 481006.0, 483114.01315921155, 484963.0, 54403.72798135984, 54988.72505637446, 55857.720711396185, 55902.16146757802, 55952.720236398556, 1471.3158381352723, 1477.9113253204628, 1479.6966621842496, 1486.3385793322084, 1486.7621180611266, 27546.0, 27729.861350693118, 28097.297567560974, 28325.433491329644, 28340.85829570839, 48585.02829943452, 48603.27095093505, 49004.264936025276, 49055.01889962109, 49135.01729965309, 434479.0, 444335.0, 446643.5335646602, 447137.0, 447369.0, 21809.454763631034, 25990.09034683777, 26069.478610428065, 26091.347716307246, 26441.0, 35545.466817997236, 43604.691859244274, 43887.902802430195, 44018.0, 44327.11345773131, 36022.099447514025, 36170.819145904105, 36375.90872273836, 37003.704870329406, 37316.0, 35970.46044309285, 36417.635823642486, 36704.81647591745, 36705.63294367129, 37138.81430592938, 26812.59781103324, 29195.85402072976, 34682.826585867915, 34996.47505287372, 36089.45865811963, 28208.717912820608, 30566.541501877935, 30724.385512290075, 30795.0, 30889.382212356075, 20677.793222067587, 23490.060397584588, 23660.408489787893, 23830.52338953246, 23954.161604343764], "value": 17382.586529838085, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.1234996557816, 394.5876558995849, 394.6014525329417, 394.86179837057017, 405.64708703428005, 14266.07270527415, 19881.900590497044, 20055.0, 20470.795292047074, 20522.8712420817, 20331.796682033175, 20420.387388378334, 20542.38372848813, 21431.57136857266, 21464.926753662334, 5795.101759227306, 5856.180134781134, 5923.792667256647, 6049.879002419949, 6078.939210607904, 5956.166136740838, 6013.278406591216, 6046.455818976291, 6051.425114614105, 6083.087536869483, 5615.185798059279, 5957.88084238315, 5965.373635768247, 5986.7605295788335, 5999.0, 5842.64944103353, 5858.209141765871, 6587.5388722789185, 6600.141981542417, 6615.040819081254, 5009.949900500985, 5573.526250268732, 5795.594308398414, 5796.82609521715, 5841.211436456067, 13370.665733356647, 13392.598222053353, 13457.932710336483, 13681.452741890313, 13743.450261989508, 1840.9447716568525, 1861.6835138026568, 2133.264153579052, 2242.1479837661586, 2316.6872472216205, 10095.646652367132, 10107.241956853266, 10236.846447303296, 10256.94871525645, 10300.89699103007, 1729.1181497436273, 1729.7405389191597, 1755.7190849464153, 1788.3651303787228, 1793.8385545300985, 84980.72528912072, 107168.0, 109921.80156396907, 113234.0, 113861.0, 9612.855807162898, 11419.257748246337, 11461.598844040418, 11604.419779011016, 11770.82343764827, 14675.57852954272, 14743.262836858114, 14766.48317308889, 14826.258687065603, 14839.18384488842, 7469.85060298791, 8230.053543842534, 8639.438436501607, 8684.478931264144, 8724.8691269631, 8395.202455766692, 8446.239838414573, 8460.8730869037, 8585.141485851365, 8595.65617375298, 4594.839180628662, 4682.672212945061, 4710.034442939189, 4748.121597504472, 4802.0, 1935.2839449403812, 1984.8709833861042, 1986.7019947008064, 2009.3570057581726, 2051.7435320584927, 941.2470023980788, 954.627695198873, 980.2990861533895, 1063.5639387850945, 1095.8849320821198, 17234.310627575007, 19422.931738754505, 19843.702344464844, 20160.899195504222, 20621.07205175741, 936.2977766674994, 950.4914870544363, 966.7631430299622, 977.1938151025432, 986.9062439068277, 10553.525091370906, 11010.449477526092, 11014.0, 11022.283551569122, 11025.283356581796, 588144.0, 588161.0, 589634.0, 594262.0, 615231.0, 113875.43062284801, 115492.42253788677, 120690.0, 121401.0, 122705.38647306706, 971.242430903882, 974.28390133252, 986.358866736627, 993.1508560181086, 1019.5361110694764, 18058.006809625596, 18322.450326490227, 18344.908275458536, 18541.81458185455, 18551.44345669632, 49149.508504915924, 50316.0, 50331.74834125806, 51195.0, 51480.22779658233, 60336.396636034835, 63841.084767457054, 67236.0, 72267.63866180636, 72976.6351168262, 7566.583837888748, 7982.600869956363, 8145.144759800136, 8210.671573137008, 8484.151584841466, 10352.861185269765, 10992.780144397228, 11792.764144716886, 12536.37318134108, 12761.489540418279, 10806.945965270123, 10959.671209863716, 10960.0, 10970.890291097307, 11184.273022253528, 9420.95289523548, 10879.782404352027, 10981.176411768989, 11030.724231894266, 11184.273022253528, 11111.499982500645, 11285.605003824827, 11540.769184616429, 11580.652580422264, 11660.358680272666, 7373.29953654402, 7861.371090312876, 8128.878066828884, 8175.978002749656, 8509.191626795444, 9252.21356184705, 10194.82759482669, 10584.4707764613, 10955.671329859799, 11136.832947505956], "value": 9272.446112324613, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1585.389624994377, 1631.2659303313508, 1899.3067530351418, 1936.2545420013291, 1967.7245185673999, 7661.655225514851, 7891.8421631567335, 8770.693025744093, 9185.540722963842, 9200.079992000805, 7135.393491553211, 7841.902133701286, 8615.95692021539, 8703.825923481543, 8962.775930601738, 2387.8209134314907, 2457.5207834472285, 2458.2870967419426, 2461.5323088613104, 2467.543504451682, 2242.4505996030994, 2312.8843557822124, 2475.2574227731698, 2489.0168383488603, 2498.8250822442437, 2472.752724727522, 2485.6271559266074, 2490.5766019776684, 2500.112460076665, 2507.285423654259, 2137.850350475467, 2273.6358185088898, 2316.409315624505, 2481.640162176492, 2482.4786794773117, 2450.840695354814, 2472.0482614193484, 2479.454520005596, 2496.712878019033, 2502.799776017914, 7491.475596708233, 7673.577953212571, 7775.0669919609445, 7996.320312773421, 9078.0, 5330.92003619946, 5415.0, 5545.223668686387, 5567.2762540869835, 5571.13647384656, 3618.565772107364, 3626.5648122225502, 3632.5277713897026, 3740.401535754266, 3741.7754934704003, 849.3884403229665, 1028.1825948371063, 1047.5233768635253, 1053.6575612925753, 1067.6370034188412, 11590.76818463626, 11823.0, 11829.112816538795, 11829.526818927232, 11842.289462632183, 4786.1863483207935, 4826.493218212107, 4937.061958227925, 4959.231319145538, 4978.775955081957, 10176.338537995007, 10215.284930054824, 10218.131458826083, 10242.129418999319, 10249.59001639941, 5481.643693159932, 5483.2323474712775, 5526.115821468546, 5572.888542229214, 5580.91628625571, 4399.1641588098155, 4897.853064408074, 5005.74971251436, 5069.518395752398, 5103.132467480537, 4059.127287633173, 4070.0453636407865, 4097.8770636880945, 4136.400221967798, 4165.125323682, 1232.6979889927024, 1351.2297990145523, 1371.8559551247174, 1371.9375504388775, 1380.8895288376905, 864.8140649760331, 876.7895705030746, 905.4748246017294, 909.9590518426687, 929.0709290709291, 5590.2453168821685, 5711.742971566289, 5777.480026797609, 5918.141869428909, 5994.790182343597, 462.643764301486, 467.56049313645065, 469.9741514216751, 1009.5103874620803, 1020.8213562626511, 3266.611690031727, 3666.2484190740834, 3683.0, 3835.0987517933263, 3836.2135762168687, 10570.894291057144, 10780.814110447844, 10935.890641093487, 10990.395528245863, 11081.833772493419, 10789.56841726322, 10990.725231869108, 11004.559817607205, 11011.064059555027, 11024.724381890517, 7957.960210198912, 8541.14588541141, 8609.698660546976, 8678.305735541142, 8709.433886797338, 5399.5950303726595, 5628.577856660685, 5679.006173919465, 5688.488036076773, 5694.231278777312, 10039.447830369108, 10413.271071024956, 10508.316959397614, 10511.737206569896, 10531.631392901212, 10168.949155254177, 10411.375317480975, 10639.468026598484, 10771.6229931952, 10778.73053173677, 6438.034294855809, 6935.826604334932, 7083.150021997393, 7168.67740951648, 7283.271672832674, 8258.298044666271, 8289.626966786389, 8344.165583441607, 8366.163383661586, 8385.035720892176, 7280.927190728236, 7318.890216646861, 7386.815329616803, 7522.736704215545, 7610.961945190239, 7183.748568800067, 7183.964080179566, 7307.488475806643, 7350.889736653848, 7378.667959941708, 6698.799036028927, 6783.152105986752, 6843.349881761224, 6894.103766510522, 6902.758403455855, 4715.740634265011, 4753.786079626356, 4805.0, 4853.150698627655, 4980.203167493184, 4823.614110871192, 4868.464468908488, 4874.658773885794, 4940.0, 5082.390113186441], "value": 4585.070256808731, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.6311247396783, 321.3588890164122, 324.27362707535127, 330.03300330033, 331.34228556315725, 4952.653314267998, 5406.107472737174, 5557.3886872444, 5654.717264136787, 5656.264685590878, 4527.275635898257, 4683.3209184668285, 4841.547535739273, 5545.449093417033, 5579.553635709143, 4064.451299074624, 4144.585541445861, 4187.350960601112, 4209.789510524462, 4248.426462427579, 3940.9408858866996, 4033.233685599727, 4235.49174099107, 4244.893877653052, 4259.70182087254, 3898.1813819097883, 4232.957670423287, 4249.80875860587, 4251.893702657428, 4294.398784170218, 3431.9656803431894, 4098.8565400211, 4228.577142285778, 4266.850660226877, 4270.615644592001, 3230.9030729078167, 3647.6170002149656, 3655.5247817783784, 3680.5583330000304, 3684.299983003221, 4420.668449866273, 4695.835645752416, 5047.823326183603, 5327.653702509325, 5334.946650533484, 4218.873433796991, 4283.4431523902, 4391.407160033386, 4788.233882578806, 4897.212517431148, 5014.774335154927, 5269.262303277545, 5602.971985140089, 5720.798632287225, 5756.856078598027, 3178.570892929448, 4068.30838757409, 4100.2414553307435, 4105.8973525662095, 4133.338665813455, 5257.973710131463, 5796.362654991968, 6138.508919286446, 6191.718389253702, 6218.3832203626935, 4114.423980642712, 4123.9381409278885, 4133.627973482401, 4144.79276036197, 4155.420940042764, 3811.904702382463, 4214.030772922184, 4224.4930608327195, 4225.809838557211, 4254.212970600387, 4234.470691163605, 4579.22153233951, 4783.736894470768, 4788.2172884657375, 4912.410510738734, 5676.347220069662, 5833.88332233353, 5837.182794408786, 5841.912371314434, 5859.736311865976, 1424.622475044114, 1437.338824140886, 1483.7848511965703, 1514.4245186828934, 1545.652228248635, 955.2787645327733, 985.6303886042734, 1011.6762635956424, 1032.6282538286212, 1033.3593172233113, 5298.470152984671, 5903.645781253139, 5906.5570082244, 5925.585209035326, 5966.701664916737, 6620.3710647488415, 6653.367930046637, 6654.3345665434035, 6664.600433908837, 6684.197896252481, 4987.276844857475, 5041.899162016813, 5196.376434827769, 5524.8342549723575, 5608.261438953856, 2965.836878971634, 3294.7858389204625, 3488.064124410976, 3524.6122926478065, 3553.7966460794473, 5791.333996590446, 6461.450776683941, 6744.42672372844, 6899.0, 6955.478339124485, 6299.464545513682, 6772.661366931634, 6825.044493770876, 6843.3840954314355, 6845.657717114124, 5254.106801843619, 6407.807765767035, 6845.075914751545, 6933.37599616037, 6952.443804495628, 6111.694415279308, 6202.666426718277, 6203.689815509116, 6371.725654868952, 6409.8718025640155, 5798.681072540882, 6509.772157974448, 6564.376384243489, 6567.931101702949, 6595.439387651912, 5640.0129977253, 5995.0, 6324.936750632619, 6336.968315158395, 6390.708784975648, 3752.6059763724415, 3769.981150094232, 4211.873643790691, 4237.216115018731, 4241.3637954307105, 5517.337919449692, 5937.940620593911, 6115.266168059861, 6142.570020098729, 6159.760359460809, 5370.436104209002, 5715.799947002001, 5874.911876321773, 5911.699426126245, 5939.88156217989, 5183.429822719422, 5193.974030129825, 5902.026165682614, 5920.815836832737, 5963.940360596339, 5431.11675152268, 5774.769009239583, 5797.739101740347, 5799.5070419014855, 5801.448862358069, 5406.0, 5708.029634962149, 5871.588988770745, 5927.081302398135, 5939.316978547522, 4456.532064133219, 5456.48163424474, 5776.624519406225, 5811.680357580373, 5827.59206855516], "value": 4381.744862484686, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.8930665746811, 709.6238993333534, 745.1430854517305, 759.1270039454627, 782.2334112569681, 14878.330475128618, 15024.549263522113, 15357.00179488334, 15381.92309038456, 15396.307166177521, 14608.19654918979, 14648.707025859476, 14650.120992740443, 14680.412783488675, 14738.484153054646, 726.821928627487, 929.1034152043277, 936.4053825820619, 959.6641175588558, 971.4511301114883, 905.8912930448355, 907.2288554728494, 955.928305377096, 957.6265256549951, 962.7448726087592, 950.4534892436842, 950.7480517662825, 968.138356862393, 985.8915519292872, 1006.7181189267017, 943.0239701908491, 1000.2847963705949, 1003.4631472162358, 1005.3515482513811, 1007.969760907174, 719.1765428584295, 726.8836986082255, 732.5641243460133, 748.6182047155935, 751.9848204923364, 14996.550103496913, 15046.849531504655, 15137.016093953858, 15143.242837858063, 15166.24168791556, 12538.874611253954, 12600.873991260061, 12687.555935542212, 12742.171758835739, 12857.871421285761, 9977.052180042885, 10030.448325342104, 10200.540975656113, 10231.897681023169, 10725.731856703567, 3043.893463728759, 3205.6634053424286, 3274.8046962858384, 3497.7551571390013, 3501.369753444379, 66684.6665766668, 75302.11744706372, 83350.16649833485, 84073.0, 85432.14567854366, 9329.860052099224, 9434.811303774024, 9453.196478299422, 9629.470379129216, 9721.125098741148, 19514.5121371964, 21723.565528689338, 21879.890600546896, 21969.0, 22229.888850555642, 6600.900986485207, 7104.3961263293195, 7358.926410735931, 7522.285382888617, 7549.471536992468, 3363.814990175515, 3923.7645741255615, 4009.1179940413062, 4032.2137183248983, 4063.4108054332546, 3519.894403167909, 3621.619729928372, 3632.891967949748, 3634.7637403568683, 3643.5263415756312, 649.5031301054697, 662.8939369700824, 666.7233098264167, 667.6728403082552, 678.0642713055951, 520.6121439527576, 559.9944000560024, 591.7869566955892, 619.1424876545926, 634.1819053421127, 7967.48211366271, 8217.753467395869, 8235.547044912588, 8263.0, 8352.0, 568.8407245971134, 596.3082823924227, 618.3630860213987, 624.487919905673, 627.8116565030564, 3656.7074634029213, 3849.826757795906, 3878.26313000529, 3924.274009308287, 3952.466417033721, 91251.54374228086, 95830.0, 96928.51535742417, 97330.0, 99273.50363248137, 69278.96081558781, 80729.0, 80942.59528702436, 82440.58779706064, 83608.90977725605, 64033.0, 69791.0, 71127.64436177786, 73585.26414735892, 74572.25427745761, 7138.179109402485, 7148.535345202546, 7279.1265048194555, 7308.707651693872, 7496.550206987598, 34383.65616343805, 46311.528659237956, 46935.8266043338, 47329.0, 47695.76152119217, 64242.35757642364, 65155.0, 65858.67070664615, 65934.0, 66342.67314653583, 9951.751206219902, 10111.696649100539, 10170.135538479017, 10308.32995855267, 11181.664550063511, 11890.28658280506, 12140.210886292716, 12327.69180770488, 12346.629601111981, 13354.666133346744, 11873.643790686294, 12027.21823081497, 12031.4585843639, 12041.397930103634, 12130.75738485243, 11530.192886497865, 11783.175177737476, 11906.40467976615, 12207.572734954234, 12515.4368053436, 11461.770764584495, 11479.942600286946, 11615.245009074382, 11887.0, 11968.102392320785, 9883.651669777162, 9945.154661853823, 10097.956342300351, 10308.0, 10379.532921018723, 9779.119879210904, 9847.803043939224, 9854.507274636382, 9885.55515001841, 9914.355566888129], "value": 6940.143638394017, "unit": "score"}], "name": "dromaeo_css", "value": 7104.146232198488, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 109.0, 117.0, 115.0, 117.0, 130.0, 112.0, 119.0, 119.0, 135.0], "value": 119.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 144.0, 164.0, 120.0, 143.0, 140.0, 122.0, 169.0, 122.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 192.0, 198.0, 214.0, 227.0, 195.0, 195.0, 198.0, 201.0, 196.0], "value": 201.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 72.0, 108.0, 57.0, 71.0, 80.0, 84.0, 150.0, 79.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 122.0, 76.0, 81.0, 87.0, 119.0, 80.0, 80.0, 122.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 89.0, 95.0, 120.0, 85.0, 99.0, 120.0, 90.0, 89.0], "value": 105.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 125.0, 96.0, 120.0, 112.0, 95.0, 97.0, 96.0, 96.0, 117.0], "value": 110.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 95.0, 90.0, 91.0, 93.0, 89.0, 90.0, 92.0, 75.0, 140.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 60.0, 60.0, 61.0, 62.0, 61.0, 79.0, 61.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 57.0, 78.0, 74.0, 66.0, 85.0, 102.0, 94.0, 95.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 108.0, 106.0, 81.0, 84.0, 84.0, 83.0, 82.0, 85.0, 82.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 143.0, 137.0, 142.0, 162.0, 159.0, 144.0, 142.0, 177.0, 140.0], "value": 149.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [226.0, 206.0, 203.0, 197.0, 196.0, 200.0, 197.0, 201.0, 199.0, 254.0], "value": 207.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 69.0, 70.0, 73.0, 71.0, 68.0, 69.0, 72.0, 68.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1604.6000000000001, "alertThreshold": 2.0}]} 08:34:09 INFO - Return code: 0 08:34:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:34:09 ERROR - # TBPL SUCCESS # 08:34:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:34:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:34:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:34:09 INFO - 2016-04-26 08:34:09.211 screenresolution[1687:10299] starting screenresolution argv=screenresolution get 08:34:09 INFO - 2016-04-26 08:34:09.214 screenresolution[1687:10299] Display 0: 1600x1200x32@60 08:34:09 INFO - 2016-04-26 08:34:09.220 screenresolution[1688:10302] starting screenresolution argv=screenresolution list 08:34:09 INFO - Available Modes on Display 0 08:34:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:34:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:34:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:34:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:34:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:34:09 INFO - Intel Iris: 08:34:09 INFO - Chipset Model: Intel Iris 08:34:09 INFO - Type: GPU 08:34:09 INFO - Bus: Built-In 08:34:09 INFO - VRAM (Dynamic, Max): 1536 MB 08:34:09 INFO - Vendor: Intel (0x8086) 08:34:09 INFO - Device ID: 0x0a2e 08:34:09 INFO - Revision ID: 0x0009 08:34:09 INFO - Displays: 08:34:09 INFO - Display: 08:34:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:34:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:34:09 INFO - Display Serial Number: 1600x1200 60 08:34:09 INFO - Main Display: Yes 08:34:09 INFO - Mirror: Off 08:34:09 INFO - Online: Yes 08:34:09 INFO - Rotation: Supported 08:34:09 INFO - Return code: 0 08:34:09 INFO - Running post-action listener: _resource_record_post_action 08:34:09 INFO - Running post-run listener: _resource_record_post_run 08:34:10 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 37774848; Write bytes: 697105408; Read time: 403; Write time: 2050 08:34:10 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 381587968; Write bytes: 370026496; Read time: 28479; Write time: 664 08:34:10 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 31600128; Write bytes: 298028544; Read time: 315; Write time: 1329 08:34:10 INFO - Running post-run listener: _upload_blobber_files 08:34:10 INFO - Blob upload gear active. 08:34:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:10 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 08:34:10 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:34:10 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:34:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:34:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:34:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:12 INFO - (blobuploader) - INFO - Done attempting. 08:34:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:34:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:34:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:12 INFO - (blobuploader) - INFO - Done attempting. 08:34:12 INFO - (blobuploader) - INFO - Iteration through files over. 08:34:12 INFO - Return code: 0 08:34:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:34:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:34:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/839ebb90fa716e0b00cfa13a899131161af26022acd7f804accdaee8327823adb29ddbad9189393e69e718c2e8ac174d9d1e24cbf4b3631533fc2566f31f4bd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9da6dad3222610e228ca2d1b4551fde39cfcd5fc06247e2ec23e9fff3d5f6628a2638ae4766e224b538173e18dbacdb2dbbc6cdd8dd8645a2eb0dcb08197290e"} 08:34:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:12 INFO - Contents: 08:34:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/839ebb90fa716e0b00cfa13a899131161af26022acd7f804accdaee8327823adb29ddbad9189393e69e718c2e8ac174d9d1e24cbf4b3631533fc2566f31f4bd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9da6dad3222610e228ca2d1b4551fde39cfcd5fc06247e2ec23e9fff3d5f6628a2638ae4766e224b538173e18dbacdb2dbbc6cdd8dd8645a2eb0dcb08197290e"} 08:34:12 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:12 INFO - Copying logs to upload dir... 08:34:12 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.569280 ========= master_lag: 7.76 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-04-26 08:34:20.763169) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 14 secs) (at 2016-04-26 08:34:20.765494) ========= 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.lqQBbhHsKP/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.1CF5otUwZ6/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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/Fx-Team/sha512/839ebb90fa716e0b00cfa13a899131161af26022acd7f804accdaee8327823adb29ddbad9189393e69e718c2e8ac174d9d1e24cbf4b3631533fc2566f31f4bd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9da6dad3222610e228ca2d1b4551fde39cfcd5fc06247e2ec23e9fff3d5f6628a2638ae4766e224b538173e18dbacdb2dbbc6cdd8dd8645a2eb0dcb08197290e"} build_url:https://queue.taskcluster.net/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/V8N6oTUvRHaEI9vlcpO5aw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/839ebb90fa716e0b00cfa13a899131161af26022acd7f804accdaee8327823adb29ddbad9189393e69e718c2e8ac174d9d1e24cbf4b3631533fc2566f31f4bd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9da6dad3222610e228ca2d1b4551fde39cfcd5fc06247e2ec23e9fff3d5f6628a2638ae4766e224b538173e18dbacdb2dbbc6cdd8dd8645a2eb0dcb08197290e"}' ========= master_lag: 14.17 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 14 secs) (at 2016-04-26 08:34:34.943957) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-04-26 08:34:34.952274) ========= 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.lqQBbhHsKP/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.1CF5otUwZ6/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005632 ========= master_lag: 5.57 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-04-26 08:34:40.532678) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-04-26 08:34:40.532979) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-04-26 08:34:44.362029) ========= ========= Total master_lag: 28.85 =========