builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0340 starttime: 1470402805.93 results: success (0) buildid: 20160805030823 builduid: 00c37a42008c4868a8c214e282d1dab7 revision: 2c234f5a191673f6a4b0490435851e61852a54e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 06:13:25.927516) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 06:13:25.927993) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 06:13:25.928275) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 06:13:25.952690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 06:13:25.953126) ========= 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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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-08-05 06:13:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2016-08-05 06:13:26 (18.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107691 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 06:13:26.085782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 06:13:26.086332) ========= 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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.025400 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 06:13:26.135775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 06:13:26.136226) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2c234f5a191673f6a4b0490435851e61852a54e8 --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 2c234f5a191673f6a4b0490435851e61852a54e8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rIR5tiHzJf/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.OyAqIbY9ha/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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-08-05 06:13:26,219 truncating revision to first 12 chars 2016-08-05 06:13:26,219 Setting DEBUG logging. 2016-08-05 06:13:26,219 attempt 1/10 2016-08-05 06:13:26,219 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2c234f5a1916?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 06:13:27,429 unpacking tar archive at: fx-team-2c234f5a1916/testing/mozharness/ program finished with exit code 0 elapsedTime=1.490133 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 06:13:27.648912) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 06:13:27.649255) ========= script_repo_revision: 2c234f5a191673f6a4b0490435851e61852a54e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 06:13:27.649656) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 06:13:27.649959) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 06:13:27.668668) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-05 06:13:27.669084) ========= /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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 06:13:27 INFO - MultiFileLogger online at 20160805 06:13:27 in /builds/slave/test 06:13:27 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 06:13:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:13:27 INFO - {'append_to_log': False, 06:13:27 INFO - 'base_work_dir': '/builds/slave/test', 06:13:27 INFO - 'blob_upload_branch': 'Fx-Team', 06:13:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:13:27 INFO - 'branch': 'Fx-Team', 06:13:27 INFO - 'buildbot_json_path': 'buildprops.json', 06:13:27 INFO - 'config_files': ('talos/mac_config.py',), 06:13:27 INFO - 'default_actions': ('clobber', 06:13:27 INFO - 'read-buildbot-config', 06:13:27 INFO - 'download-and-extract', 06:13:27 INFO - 'populate-webroot', 06:13:27 INFO - 'create-virtualenv', 06:13:27 INFO - 'install', 06:13:27 INFO - 'run-tests'), 06:13:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:13:27 INFO - 'download_minidump_stackwalk': True, 06:13:27 INFO - 'download_symbols': 'ondemand', 06:13:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:13:27 INFO - 'tooltool.py': '/tools/tooltool.py', 06:13:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:13:27 INFO - '/tools/misc-python/virtualenv.py')}, 06:13:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:13:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:13:27 INFO - 'installer_path': 'installer.exe', 06:13:27 INFO - 'log_level': 'info', 06:13:27 INFO - 'log_name': 'talos', 06:13:27 INFO - 'log_to_console': True, 06:13:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:13:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:13:27 INFO - 'opt_config_files': (), 06:13:27 INFO - 'pip_index': False, 06:13:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:13:27 INFO - 'cmd': ('bash', 06:13:27 INFO - '-c', 06:13:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:13:27 INFO - 'enabled': True, 06:13:27 INFO - 'halt_on_failure': False, 06:13:27 INFO - 'name': 'check_screen_resolution'},), 06:13:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:13:27 INFO - 'cmd': ('bash', 06:13:27 INFO - '-c', 06:13:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:13:27 INFO - 'enabled': True, 06:13:27 INFO - 'halt_on_failure': False, 06:13:27 INFO - 'name': 'check_screen_resolution'},), 06:13:27 INFO - 'run_cmd_checks_enabled': True, 06:13:27 INFO - 'sps_profile': False, 06:13:27 INFO - 'sps_profile_interval': 0, 06:13:27 INFO - 'suite': 'dromaeojs-e10s', 06:13:27 INFO - 'system_bits': '32', 06:13:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:13:27 INFO - 'title': 't-yosemite-r7-0340', 06:13:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:13:27 INFO - 'use_talos_json': True, 06:13:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:13:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:13:27 INFO - 'work_dir': 'build'} 06:13:27 INFO - [mozharness: 2016-08-05 13:13:27.880664Z] Running clobber step. 06:13:27 INFO - Running pre-action listener: _resource_record_pre_action 06:13:27 INFO - Running main action method: clobber 06:13:27 INFO - rmtree: /builds/slave/test/build 06:13:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:13:30 INFO - Running post-action listener: _resource_record_post_action 06:13:30 INFO - [mozharness: 2016-08-05 13:13:30.288423Z] Finished clobber step (success) 06:13:30 INFO - [mozharness: 2016-08-05 13:13:30.288555Z] Running read-buildbot-config step. 06:13:30 INFO - Running pre-action listener: _resource_record_pre_action 06:13:30 INFO - Running main action method: read_buildbot_config 06:13:30 INFO - Using buildbot properties: 06:13:30 INFO - { 06:13:30 INFO - "project": "", 06:13:30 INFO - "product": "firefox", 06:13:30 INFO - "script_repo_revision": "production", 06:13:30 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:13:30 INFO - "repository": "", 06:13:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:13:30 INFO - "buildid": "20160805030823", 06:13:30 INFO - "pgo_build": "False", 06:13:30 INFO - "basedir": "/builds/slave/test", 06:13:30 INFO - "buildnumber": 759, 06:13:30 INFO - "slavename": "t-yosemite-r7-0340", 06:13:30 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:13:30 INFO - "platform": "yosemite_r7", 06:13:30 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 06:13:30 INFO - "branch": "fx-team", 06:13:30 INFO - "repo_path": "integration/fx-team", 06:13:30 INFO - "revision": "2c234f5a191673f6a4b0490435851e61852a54e8", 06:13:30 INFO - "stage_platform": "macosx64", 06:13:30 INFO - "builduid": "00c37a42008c4868a8c214e282d1dab7", 06:13:30 INFO - "slavebuilddir": "test" 06:13:30 INFO - } 06:13:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 06:13:30 INFO - Running post-action listener: _resource_record_post_action 06:13:30 INFO - [mozharness: 2016-08-05 13:13:30.291722Z] Finished read-buildbot-config step (success) 06:13:30 INFO - [mozharness: 2016-08-05 13:13:30.291825Z] Running download-and-extract step. 06:13:30 INFO - Running pre-action listener: _resource_record_pre_action 06:13:30 INFO - Running main action method: download_and_extract 06:13:30 INFO - mkdir: /builds/slave/test/build/tests 06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:30 INFO - trying https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 06:13:30 INFO - Downloading https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 06:13:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 06:13:31 INFO - Downloaded 1199 bytes. 06:13:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 06:13:31 INFO - Using the following test package requirements: 06:13:31 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 06:13:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:31 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 06:13:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:31 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 06:13:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:31 INFO - u'jsshell-mac.zip'], 06:13:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:31 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 06:13:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 06:13:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:31 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 06:13:31 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:31 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 06:13:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:31 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 06:13:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:13:31 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 06:13:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:13:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:31 INFO - trying https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:13:31 INFO - Downloading https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:13:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:13:32 INFO - Downloaded 16320543 bytes. 06:13:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 06:13:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:13:39 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:39 INFO - trying https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:13:39 INFO - Downloading https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:13:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:13:40 INFO - Downloaded 16320543 bytes. 06:13:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:47 INFO - trying https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 06:13:47 INFO - Downloading https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 06:13:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:13:48 INFO - Downloaded 14413723 bytes. 06:13:48 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:48 INFO - trying https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:13:48 INFO - Downloading https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 06:13:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 06:13:52 INFO - Downloaded 111464649 bytes. 06:13:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:13:52 INFO - mkdir: /builds/slave/test/properties 06:13:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:13:52 INFO - Writing to file /builds/slave/test/properties/build_url 06:13:52 INFO - Contents: 06:13:52 INFO - build_url:https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:13:53 INFO - Running post-action listener: _resource_record_post_action 06:13:53 INFO - Running post-action listener: set_extra_try_arguments 06:13:53 INFO - [mozharness: 2016-08-05 13:13:53.595811Z] Finished download-and-extract step (success) 06:13:53 INFO - [mozharness: 2016-08-05 13:13:53.595929Z] Running populate-webroot step. 06:13:53 INFO - Running pre-action listener: _resource_record_pre_action 06:13:53 INFO - Running main action method: populate_webroot 06:13:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:13:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:13:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:13:53 INFO - '--tppagecycles', 06:13:53 INFO - '7'], 06:13:53 INFO - 'tests': ['tsvgm']}}, 06:13:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:13:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:13:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:13:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:13:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:13:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:13:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:53 INFO - 'talos_options': ['--disable-e10s'], 06:13:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:13:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:13:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:53 INFO - 'talos_options': ['--disable-e10s'], 06:13:53 INFO - 'tests': ['damp', 'tps']}, 06:13:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:53 INFO - 'tests': ['damp', 'tps']}, 06:13:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:13:53 INFO - 'tests': ['dromaeo_dom']}, 06:13:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:13:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:13:53 INFO - 'tests': ['basic_compositor_video']}, 06:13:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:13:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:13:53 INFO - 'tests': ['a11yr', 06:13:53 INFO - 'ts_paint', 06:13:53 INFO - 'tpaint', 06:13:53 INFO - 'sessionrestore', 06:13:53 INFO - 'sessionrestore_no_auto_restore', 06:13:53 INFO - 'tabpaint']}, 06:13:53 INFO - 'other-e10s': {'tests': ['a11yr', 06:13:53 INFO - 'ts_paint', 06:13:53 INFO - 'tpaint', 06:13:53 INFO - 'sessionrestore', 06:13:53 INFO - 'sessionrestore_no_auto_restore', 06:13:53 INFO - 'tabpaint']}, 06:13:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:13:53 INFO - 'ts_paint', 06:13:53 INFO - 'tpaint', 06:13:53 INFO - 'sessionrestore', 06:13:53 INFO - 'sessionrestore_no_auto_restore', 06:13:53 INFO - 'tabpaint']}, 06:13:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:13:53 INFO - 'ts_paint', 06:13:53 INFO - 'tpaint', 06:13:53 INFO - 'sessionrestore', 06:13:53 INFO - 'sessionrestore_no_auto_restore', 06:13:53 INFO - 'tabpaint']}, 06:13:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:13:53 INFO - 'tests': ['a11yr', 06:13:53 INFO - 'ts_paint', 06:13:53 INFO - 'tpaint', 06:13:53 INFO - 'sessionrestore', 06:13:53 INFO - 'sessionrestore_no_auto_restore', 06:13:53 INFO - 'tabpaint']}, 06:13:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:13:53 INFO - 'tests': ['a11yr', 06:13:53 INFO - 'ts_paint', 06:13:53 INFO - 'tpaint', 06:13:53 INFO - 'sessionrestore', 06:13:53 INFO - 'sessionrestore_no_auto_restore', 06:13:53 INFO - 'tabpaint']}, 06:13:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:13:53 INFO - 'tests': ['tsvgx', 06:13:53 INFO - 'tsvgr_opacity', 06:13:53 INFO - 'tart', 06:13:53 INFO - 'tscrollx', 06:13:53 INFO - 'cart']}, 06:13:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:13:53 INFO - 'tsvgr_opacity', 06:13:53 INFO - 'tart', 06:13:53 INFO - 'tscrollx', 06:13:53 INFO - 'cart']}, 06:13:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:53 INFO - 'talos_options': ['--disable-e10s'], 06:13:53 INFO - 'tests': ['tp5o']}, 06:13:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:53 INFO - 'tests': ['tp5o']}, 06:13:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:53 INFO - 'talos_options': ['--disable-e10s', 06:13:53 INFO - '--xperf_path', 06:13:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:13:53 INFO - 'tests': ['tp5n']}, 06:13:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:53 INFO - 'talos_options': ['--xperf_path', 06:13:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:13:53 INFO - 'tests': ['tp5n']}}, 06:13:53 INFO - 'talos.zip': {'path': '', 06:13:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:13:53 INFO - Running post-action listener: _resource_record_post_action 06:13:53 INFO - [mozharness: 2016-08-05 13:13:53.614754Z] Finished populate-webroot step (success) 06:13:53 INFO - [mozharness: 2016-08-05 13:13:53.614888Z] Running create-virtualenv step. 06:13:53 INFO - Running pre-action listener: _resource_record_pre_action 06:13:53 INFO - Running main action method: create_virtualenv 06:13:53 INFO - Creating virtualenv /builds/slave/test/build/venv 06:13:53 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 06:13:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:13:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:13:53 INFO - Using real prefix '/tools/python27' 06:13:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:13:54 INFO - Installing distribute.............................................................................................................................................................................................done. 06:13:57 INFO - Installing pip.................done. 06:13:57 INFO - Return code: 0 06:13:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:57 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 0x105431a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa973490210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1050fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538db20>, '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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 06:13:57 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 06:13:57 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 06:13:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rIR5tiHzJf/Render', 06:13:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:57 INFO - 'HOME': '/Users/cltbld', 06:13:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:57 INFO - 'LOGNAME': 'cltbld', 06:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:57 INFO - 'MOZ_NO_REMOTE': '1', 06:13:57 INFO - 'NO_EM_RESTART': '1', 06:13:57 INFO - 'PAGER': '/bin/cat', 06:13:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:57 INFO - 'PWD': '/builds/slave/test', 06:13:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:57 INFO - 'SHELL': '/bin/bash', 06:13:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OyAqIbY9ha/Listeners', 06:13:57 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 06:13:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:57 INFO - 'USER': 'cltbld', 06:13:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:57 INFO - 'XPC_FLAGS': '0x0', 06:13:57 INFO - 'XPC_SERVICE_NAME': '0', 06:13:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:57 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 06:13:57 INFO - Cleaning up... 06:13:57 INFO - Return code: 0 06:13:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:57 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105431a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa973490210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1050fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538db20>, '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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 06:13:57 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>=3.1.1'] in /builds/slave/test/build 06:13:57 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>=3.1.1 06:13:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rIR5tiHzJf/Render', 06:13:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:57 INFO - 'HOME': '/Users/cltbld', 06:13:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:57 INFO - 'LOGNAME': 'cltbld', 06:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:57 INFO - 'MOZ_NO_REMOTE': '1', 06:13:57 INFO - 'NO_EM_RESTART': '1', 06:13:57 INFO - 'PAGER': '/bin/cat', 06:13:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:57 INFO - 'PWD': '/builds/slave/test', 06:13:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:57 INFO - 'SHELL': '/bin/bash', 06:13:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OyAqIbY9ha/Listeners', 06:13:57 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 06:13:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:57 INFO - 'USER': 'cltbld', 06:13:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:57 INFO - 'XPC_FLAGS': '0x0', 06:13:57 INFO - 'XPC_SERVICE_NAME': '0', 06:13:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:57 INFO - Downloading/unpacking psutil>=3.1.1 06: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 06: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 06: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 06: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 06: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 06: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 06:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:14:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:01 INFO - Installing collected packages: psutil 06:14:01 INFO - Running setup.py install for psutil 06:14:01 INFO - building 'psutil._psutil_osx' extension 06:14:01 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 06:14:01 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 06:14:01 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 06:14:01 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 06:14:02 INFO - building 'psutil._psutil_posix' extension 06:14:02 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 06:14:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:14:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:14:02 INFO - ^ 06:14:02 INFO - 1 warning generated. 06:14:02 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 06:14:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:02 INFO - Successfully installed psutil 06:14:02 INFO - Cleaning up... 06:14:02 INFO - Return code: 0 06:14:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:14:02 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:02 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:02 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105431a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa973490210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1050fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538db20>, '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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 06:14:02 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.3'] in /builds/slave/test/build 06:14:02 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.3 06:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rIR5tiHzJf/Render', 06:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:02 INFO - 'HOME': '/Users/cltbld', 06:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:02 INFO - 'LOGNAME': 'cltbld', 06:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:02 INFO - 'MOZ_NO_REMOTE': '1', 06:14:02 INFO - 'NO_EM_RESTART': '1', 06:14:02 INFO - 'PAGER': '/bin/cat', 06:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:02 INFO - 'PWD': '/builds/slave/test', 06:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:02 INFO - 'SHELL': '/bin/bash', 06:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OyAqIbY9ha/Listeners', 06:14:02 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 06:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:02 INFO - 'USER': 'cltbld', 06:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:02 INFO - 'XPC_FLAGS': '0x0', 06:14:02 INFO - 'XPC_SERVICE_NAME': '0', 06:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:14:02 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 06:14:02 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 06:14:02 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 06:14:02 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 06:14:02 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 06:14:02 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 06:14:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:14:05 INFO - Installing collected packages: mozsystemmonitor 06:14:05 INFO - Running setup.py install for mozsystemmonitor 06:14:05 INFO - Successfully installed mozsystemmonitor 06:14:05 INFO - Cleaning up... 06:14:05 INFO - Return code: 0 06:14:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:14:05 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:05 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:05 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105431a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa973490210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1050fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538db20>, '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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 06:14:05 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==2.5.1'] in /builds/slave/test/build 06:14:05 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==2.5.1 06:14:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rIR5tiHzJf/Render', 06:14:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:05 INFO - 'HOME': '/Users/cltbld', 06:14:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:05 INFO - 'LOGNAME': 'cltbld', 06:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:05 INFO - 'MOZ_NO_REMOTE': '1', 06:14:05 INFO - 'NO_EM_RESTART': '1', 06:14:05 INFO - 'PAGER': '/bin/cat', 06:14:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:05 INFO - 'PWD': '/builds/slave/test', 06:14:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:05 INFO - 'SHELL': '/bin/bash', 06:14:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OyAqIbY9ha/Listeners', 06:14:05 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 06:14:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:05 INFO - 'USER': 'cltbld', 06:14:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:05 INFO - 'XPC_FLAGS': '0x0', 06:14:05 INFO - 'XPC_SERVICE_NAME': '0', 06:14:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:05 INFO - Downloading/unpacking jsonschema==2.5.1 06:14:05 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 06:14:05 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 06:14:05 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 06:14:05 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 06:14:05 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 06:14:05 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 06:14:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:14:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:08 INFO - Downloading functools32-3.2.3-2.tar.gz 06:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:14:08 INFO - warning: no files found matching '*.txt' 06:14:08 INFO - no previously-included directories found matching 'build' 06:14:08 INFO - no previously-included directories found matching 'dist' 06:14:08 INFO - no previously-included directories found matching '.git*' 06:14:08 INFO - Installing collected packages: jsonschema, functools32 06:14:08 INFO - Running setup.py install for functools32 06:14:08 INFO - warning: no files found matching '*.txt' 06:14:08 INFO - no previously-included directories found matching 'build' 06:14:08 INFO - no previously-included directories found matching 'dist' 06:14:08 INFO - no previously-included directories found matching '.git*' 06:14:08 INFO - Successfully installed jsonschema functools32 06:14:08 INFO - Cleaning up... 06:14:08 INFO - Return code: 0 06:14:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105431a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa973490210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1050fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538db20>, '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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 06:14:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:14:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rIR5tiHzJf/Render', 06:14:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:08 INFO - 'HOME': '/Users/cltbld', 06:14:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:08 INFO - 'LOGNAME': 'cltbld', 06:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:08 INFO - 'MOZ_NO_REMOTE': '1', 06:14:08 INFO - 'NO_EM_RESTART': '1', 06:14:08 INFO - 'PAGER': '/bin/cat', 06:14:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:08 INFO - 'PWD': '/builds/slave/test', 06:14:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:08 INFO - 'SHELL': '/bin/bash', 06:14:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OyAqIbY9ha/Listeners', 06:14:08 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 06:14:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:08 INFO - 'USER': 'cltbld', 06:14:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:08 INFO - 'XPC_FLAGS': '0x0', 06:14:08 INFO - 'XPC_SERVICE_NAME': '0', 06:14:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:14:09 INFO - Cleaning up... 06:14:09 INFO - Return code: 0 06:14:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:14:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:09 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 0x105431a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa973490210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1050fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538db20>, '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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 06:14:09 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 06:14:09 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 06:14:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rIR5tiHzJf/Render', 06:14:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:09 INFO - 'HOME': '/Users/cltbld', 06:14:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:09 INFO - 'LOGNAME': 'cltbld', 06:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:09 INFO - 'MOZ_NO_REMOTE': '1', 06:14:09 INFO - 'NO_EM_RESTART': '1', 06:14:09 INFO - 'PAGER': '/bin/cat', 06:14:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:09 INFO - 'PWD': '/builds/slave/test', 06:14:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:09 INFO - 'SHELL': '/bin/bash', 06:14:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OyAqIbY9ha/Listeners', 06:14:09 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 06:14:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:09 INFO - 'USER': 'cltbld', 06:14:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:09 INFO - 'XPC_FLAGS': '0x0', 06:14:09 INFO - 'XPC_SERVICE_NAME': '0', 06:14:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:09 INFO - Downloading/unpacking blobuploader==1.2.4 06:14:09 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 06:14:09 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 06:14:09 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 06:14:09 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 06:14:09 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 06:14:09 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 06:14:11 INFO - Downloading blobuploader-1.2.4.tar.gz 06:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:14:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:14:11 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 06:14:11 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 06:14:11 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 06:14:11 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 06:14:11 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 06:14:11 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 06:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:14:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:12 INFO - Downloading docopt-0.6.1.tar.gz 06:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:14:13 INFO - Installing collected packages: blobuploader, requests, docopt 06:14:13 INFO - Running setup.py install for blobuploader 06:14:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:14:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:14:13 INFO - Running setup.py install for requests 06:14:13 INFO - Running setup.py install for docopt 06:14:13 INFO - Successfully installed blobuploader requests docopt 06:14:13 INFO - Cleaning up... 06:14:13 INFO - Return code: 0 06:14:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:13 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 0x105431a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa973490210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1050fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538db20>, '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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 06:14:13 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 06:14:13 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 06:14:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rIR5tiHzJf/Render', 06:14:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:13 INFO - 'HOME': '/Users/cltbld', 06:14:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:13 INFO - 'LOGNAME': 'cltbld', 06:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:13 INFO - 'MOZ_NO_REMOTE': '1', 06:14:13 INFO - 'NO_EM_RESTART': '1', 06:14:13 INFO - 'PAGER': '/bin/cat', 06:14:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:13 INFO - 'PWD': '/builds/slave/test', 06:14:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:13 INFO - 'SHELL': '/bin/bash', 06:14:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OyAqIbY9ha/Listeners', 06:14:13 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 06:14:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:13 INFO - 'USER': 'cltbld', 06:14:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:13 INFO - 'XPC_FLAGS': '0x0', 06:14:13 INFO - 'XPC_SERVICE_NAME': '0', 06:14:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:14 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-mTX_Yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:14 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-w8HJb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:14 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-u4KY0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:14 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-PcDfAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:14 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-SYQtjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:14 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-hZYWiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:14 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-hNS2RN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:14 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-fIFQ3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:15 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-ViMkBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:15 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-e2I4Ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:15 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-KHt4wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:15 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-OlLq9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:15 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-5aEJdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:15 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-e3Uew4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:15 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-W1h3n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:15 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-sQpuPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:15 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-McI89p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:14:15 INFO - Running setup.py install for manifestparser 06:14:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:14:16 INFO - Running setup.py install for mozcrash 06:14:16 INFO - Running setup.py install for mozdebug 06:14:16 INFO - Running setup.py install for mozdevice 06:14:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:14:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:14:16 INFO - Running setup.py install for mozfile 06:14:16 INFO - Running setup.py install for mozhttpd 06:14:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:14:16 INFO - Running setup.py install for mozinfo 06:14:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:14:16 INFO - Running setup.py install for mozInstall 06:14:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:14:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:14:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:14:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:14:17 INFO - Running setup.py install for mozleak 06:14:17 INFO - Running setup.py install for mozlog 06:14:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:14:17 INFO - Running setup.py install for moznetwork 06:14:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:14:17 INFO - Running setup.py install for mozprocess 06:14:17 INFO - Running setup.py install for mozprofile 06:14:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:14:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:14:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:14:17 INFO - Running setup.py install for mozrunner 06:14:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:14:18 INFO - Running setup.py install for mozscreenshot 06:14:18 INFO - Running setup.py install for moztest 06:14:18 INFO - Running setup.py install for mozversion 06:14:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:14:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:14:18 INFO - Cleaning up... 06:14:18 INFO - Return code: 0 06:14:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:18 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 0x105431a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa973490210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1050fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538db20>, '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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 06:14:18 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 06:14:18 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 06:14:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rIR5tiHzJf/Render', 06:14:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:18 INFO - 'HOME': '/Users/cltbld', 06:14:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:18 INFO - 'LOGNAME': 'cltbld', 06:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:18 INFO - 'MOZ_NO_REMOTE': '1', 06:14:18 INFO - 'NO_EM_RESTART': '1', 06:14:18 INFO - 'PAGER': '/bin/cat', 06:14:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:18 INFO - 'PWD': '/builds/slave/test', 06:14:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:18 INFO - 'SHELL': '/bin/bash', 06:14:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OyAqIbY9ha/Listeners', 06:14:18 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 06:14:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:18 INFO - 'USER': 'cltbld', 06:14:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:18 INFO - 'XPC_FLAGS': '0x0', 06:14:18 INFO - 'XPC_SERVICE_NAME': '0', 06:14:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:18 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-khKrFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:18 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)) 06:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:18 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-uV0H4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:19 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)) 06:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:19 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-2c9jj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:19 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)) 06:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:19 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-iEWFZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:19 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)) 06:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:19 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-XWW1rY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:19 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)) 06:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:19 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-QfhKPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:19 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)) 06:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:19 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Twvac1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:19 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)) 06:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:19 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-sx21aC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:19 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)) 06:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:19 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-BFB7QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:19 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)) 06:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:19 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-rqftUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 06:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:19 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-lc8zzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:19 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)) 06:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:19 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-bQDesn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 06:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:20 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-GdAHca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:20 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)) 06:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:20 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-J6wNze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:20 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-780m4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:20 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)) 06:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:20 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-r2vN3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:20 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)) 06:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:20 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-pqBSZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:20 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)) 06:14:20 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)) 06:14:20 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)) 06:14:20 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)) 06:14:20 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)) 06:14:20 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)) 06:14:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:22 INFO - Downloading blessings-1.6.tar.gz 06:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:14:23 INFO - Installing collected packages: blessings 06:14:23 INFO - Running setup.py install for blessings 06:14:23 INFO - Successfully installed blessings 06:14:23 INFO - Cleaning up... 06:14:23 INFO - Return code: 0 06:14:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:14:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:23 INFO - Reading from file tmpfile_stdout 06:14:23 INFO - Current package versions: 06:14:23 INFO - blessings == 1.6 06:14:23 INFO - blobuploader == 1.2.4 06:14:23 INFO - docopt == 0.6.1 06:14:23 INFO - functools32 == 3.2.3-2 06:14:23 INFO - jsonschema == 2.5.1 06:14:23 INFO - manifestparser == 1.1 06:14:23 INFO - mozInstall == 1.12 06:14:23 INFO - mozcrash == 0.17 06:14:23 INFO - mozdebug == 0.1 06:14:23 INFO - mozdevice == 0.48 06:14:23 INFO - mozfile == 1.2 06:14:23 INFO - mozhttpd == 0.7 06:14:23 INFO - mozinfo == 0.9 06:14:23 INFO - mozleak == 0.1 06:14:23 INFO - mozlog == 3.3 06:14:23 INFO - moznetwork == 0.27 06:14:23 INFO - mozprocess == 0.23 06:14:23 INFO - mozprofile == 0.28 06:14:23 INFO - mozrunner == 6.12 06:14:23 INFO - mozscreenshot == 0.1 06:14:23 INFO - mozsystemmonitor == 0.3 06:14:23 INFO - moztest == 0.7 06:14:23 INFO - mozversion == 1.4 06:14:23 INFO - psutil == 3.1.1 06:14:23 INFO - requests == 1.2.3 06:14:23 INFO - wsgiref == 0.1.2 06:14:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:24 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 0x105431a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa973490210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1050fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538db20>, '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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 06:14:24 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 06:14:24 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 06:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rIR5tiHzJf/Render', 06:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:24 INFO - 'HOME': '/Users/cltbld', 06:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:24 INFO - 'LOGNAME': 'cltbld', 06:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:24 INFO - 'MOZ_NO_REMOTE': '1', 06:14:24 INFO - 'NO_EM_RESTART': '1', 06:14:24 INFO - 'PAGER': '/bin/cat', 06:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:24 INFO - 'PWD': '/builds/slave/test', 06:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:24 INFO - 'SHELL': '/bin/bash', 06:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OyAqIbY9ha/Listeners', 06:14:24 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 06:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:24 INFO - 'USER': 'cltbld', 06:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:24 INFO - 'XPC_FLAGS': '0x0', 06:14:24 INFO - 'XPC_SERVICE_NAME': '0', 06:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:24 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)) 06:14:24 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)) 06:14:24 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)) 06:14:24 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)) 06:14:24 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)) 06:14:24 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)) 06:14:24 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)) 06:14:24 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)) 06:14:24 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)) 06:14:24 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)) 06:14:24 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)) 06:14:24 INFO - Cleaning up... 06:14:24 INFO - Return code: 0 06:14:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:24 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 0x105431a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa973490210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1050fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538db20>, '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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 06:14:24 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 06:14:24 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 06:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rIR5tiHzJf/Render', 06:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:24 INFO - 'HOME': '/Users/cltbld', 06:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:24 INFO - 'LOGNAME': 'cltbld', 06:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:24 INFO - 'MOZ_NO_REMOTE': '1', 06:14:24 INFO - 'NO_EM_RESTART': '1', 06:14:24 INFO - 'PAGER': '/bin/cat', 06:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:24 INFO - 'PWD': '/builds/slave/test', 06:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:24 INFO - 'SHELL': '/bin/bash', 06:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OyAqIbY9ha/Listeners', 06:14:24 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 06:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:24 INFO - 'USER': 'cltbld', 06:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:24 INFO - 'XPC_FLAGS': '0x0', 06:14:24 INFO - 'XPC_SERVICE_NAME': '0', 06:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:14:24 INFO - Cleaning up... 06:14:24 INFO - Return code: 0 06:14:24 INFO - Running post-action listener: _resource_record_post_action 06:14:24 INFO - Running post-action listener: _start_resource_monitoring 06:14:24 INFO - Starting resource monitoring. 06:14:24 INFO - [mozharness: 2016-08-05 13:14:24.601644Z] Finished create-virtualenv step (success) 06:14:24 INFO - [mozharness: 2016-08-05 13:14:24.602588Z] Running install step. 06:14:24 INFO - Running pre-action listener: _resource_record_pre_action 06:14:24 INFO - Running main action method: install 06:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:24 INFO - Reading from file tmpfile_stdout 06:14:24 INFO - Detecting whether we're running mozinstall >=1.0... 06:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:14:24 INFO - Reading from file tmpfile_stdout 06:14:24 INFO - Output received: 06:14:24 INFO - Usage: mozinstall [options] installer 06:14:24 INFO - Options: 06:14:24 INFO - -h, --help show this help message and exit 06:14:24 INFO - -d DEST, --destination=DEST 06:14:24 INFO - Directory to install application into. [default: 06:14:24 INFO - "/builds/slave/test"] 06:14:24 INFO - --app=APP Application being installed. [default: firefox] 06:14:24 INFO - mkdir: /builds/slave/test/build/application 06:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:14:59 INFO - Reading from file tmpfile_stdout 06:14:59 INFO - Output received: 06:14:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:14:59 INFO - Running post-action listener: _resource_record_post_action 06:14:59 INFO - [mozharness: 2016-08-05 13:14:59.095518Z] Finished install step (success) 06:14:59 INFO - [mozharness: 2016-08-05 13:14:59.095651Z] Running run-tests step. 06:14:59 INFO - Running pre-action listener: _resource_record_pre_action 06:14:59 INFO - Running main action method: run_tests 06:14:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:14:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:14:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:14:59 INFO - 2016-08-05 06:14:59.110 screenresolution[1644:7491] starting screenresolution argv=screenresolution get 06:14:59 INFO - 2016-08-05 06:14:59.112 screenresolution[1644:7491] Display 0: 1600x1200x32@60 06:14:59 INFO - 2016-08-05 06:14:59.118 screenresolution[1645:7493] starting screenresolution argv=screenresolution list 06:14:59 INFO - Available Modes on Display 0 06:14:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:14:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:14:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:14:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:14:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:14:59 INFO - Intel Iris: 06:14:59 INFO - Chipset Model: Intel Iris 06:14:59 INFO - Type: GPU 06:14:59 INFO - Bus: Built-In 06:14:59 INFO - VRAM (Dynamic, Max): 1536 MB 06:14:59 INFO - Vendor: Intel (0x8086) 06:14:59 INFO - Device ID: 0x0a2e 06:14:59 INFO - Revision ID: 0x0009 06:14:59 INFO - Displays: 06:14:59 INFO - Display: 06:14:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:14:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:14:59 INFO - Display Serial Number: 1600x1200 60 06:14:59 INFO - Main Display: Yes 06:14:59 INFO - Mirror: Off 06:14:59 INFO - Online: Yes 06:14:59 INFO - Rotation: Supported 06:14:59 INFO - Return code: 0 06:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:14:59 INFO - Python 2.7.3 06:14:59 INFO - Return code: 0 06:14:59 INFO - grabbing minidump binary from tooltool 06:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:59 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105395d30>, '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 0x1050fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10538db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:14:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:14:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:14:59 INFO - Calling ['/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'] with output_timeout 600 06:14:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:14:59 INFO - Return code: 0 06:14:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:14:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:14:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:14:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:14:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:14:59 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/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--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 06:14:59 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/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0340 --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 06:14:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rIR5tiHzJf/Render', 06:14:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:59 INFO - 'HOME': '/Users/cltbld', 06:14:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:59 INFO - 'LOGNAME': 'cltbld', 06:14:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:14:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:59 INFO - 'MOZ_NO_REMOTE': '1', 06:14:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:14:59 INFO - 'NO_EM_RESTART': '1', 06:14:59 INFO - 'PAGER': '/bin/cat', 06:14:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:59 INFO - 'PWD': '/builds/slave/test', 06:14:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:14:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:59 INFO - 'SHELL': '/bin/bash', 06:14:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OyAqIbY9ha/Listeners', 06:14:59 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 06:14:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:59 INFO - 'USER': 'cltbld', 06:14:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:59 INFO - 'XPC_FLAGS': '0x0', 06:14:59 INFO - 'XPC_SERVICE_NAME': '0', 06:14:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:59 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/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--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 06:14:59 INFO - mozversion application_buildid: 20160805030823 06:14:59 INFO - mozversion application_changeset: 2c234f5a191673f6a4b0490435851e61852a54e8 06:14:59 INFO - mozversion application_display_name: Nightly 06:14:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:14:59 INFO - mozversion application_name: Firefox 06:14:59 INFO - mozversion application_remotingname: firefox 06:14:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:14:59 INFO - mozversion application_vendor: Mozilla 06:14:59 INFO - mozversion application_version: 51.0a1 06:14:59 INFO - mozversion platform_buildid: 20160805030823 06:14:59 INFO - mozversion platform_changeset: 2c234f5a191673f6a4b0490435851e61852a54e8 06:14:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:14:59 INFO - mozversion platform_version: 51.0a1 06:14:59 INFO - using testdate: 1470402899 06:14:59 INFO - actual date: 1470402899 06:14:59 INFO - starting webserver on 'localhost:49274' 06:14:59 INFO - SUITE-START | Running 2 tests 06:14:59 INFO - TEST-START | dromaeo_css 06:14:59 INFO - operating with platform_type : mac_ 06:14:59 INFO - Initialising browser for dromaeo_css test... 06:14:59 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpOd4S5F/profile http://localhost:49274/getInfo.html) 06:15:02 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 06:15:02 INFO - PROCESS | 1655 | colorDepth:24 06:15:02 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 06:15:02 INFO - PROCESS | 1655 | __metrics 06:15:02 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:15:03 INFO - TEST-INFO | 1655: exit 0 06:15:03 INFO - Browser initialized. 06:15:03 INFO - Running cycle 1/1 for dromaeo_css test... 06:15:03 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpOd4S5F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:15 INFO - PROCESS | 1658 | RSS: Main: 254595072 06:15:15 INFO - PROCESS | 1658 | 06:16:05 INFO - PROCESS | 1658 | 1470402965082 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] 06:18:17 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 06:18:18 INFO - PROCESS | 1658 | RSS: Main: 267272192 06:18:18 INFO - PROCESS | 1658 | 06:21:20 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 06:21:21 INFO - PROCESS | 1658 | RSS: Main: 281567232 06:21:21 INFO - PROCESS | 1658 | 06:24:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 06:24:24 INFO - PROCESS | 1658 | RSS: Main: 288878592 06:24:24 INFO - PROCESS | 1658 | 06:27:25 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 06:27:26 INFO - PROCESS | 1658 | RSS: Main: 289103872 06:27:26 INFO - PROCESS | 1658 | 06:30:29 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 06:30:30 INFO - PROCESS | 1658 | RSS: Main: 292745216 06:30:30 INFO - PROCESS | 1658 | 06:33:32 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 06:33:32 INFO - PROCESS | 1658 | RSS: Main: 292614144 06:33:32 INFO - PROCESS | 1658 | 06:33:32 INFO - PROCESS | 1658 | __start_tp_report 06:33:32 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 06:33:32 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 06:33:32 INFO - PROCESS | 1658 | |i|pagename|runs| 06:33:32 INFO - PROCESS | 1658 | |0;dojo.html;3123.3753249350134;3388.88138915138;3444.328355970586;3467.2892057128292;3467.8959631211055;5765.394633563478;5843;5863.58954873159;5891.705414729257;5945.078512830507;5841.415858414167;5843.152742852294;5869.911951320723;5890.705464726768;5991.820245392634;5202.661826981253;5290.68255904647;5307.708076055816;5362.383325917511;5441.401445840955;5412.891742165154;5433.646812957145;5449.237106805051;5479.479449452316;5481.808136715215;5150.4334523202415;5200.24596433515;5207.6875387476875;5221.895562088775;5260.395054568736;5277.050130976423;5296.09966305729;5304.761285742113;5320.148776195829;5323.946760532383;4395.450568678915;5281.07581173297;5339.5461385782255;5345.919811202835;5349.625526213166;4454.443194600675;4854.368932038848;5784.363719990798;5830.533557315404;5886.323072846634;6221.066839973995;6232.9376706232815;6258.499320054385;6269.404406581368;6275.121482992385;5810.448007439287;6091.14723938649;6331.968340158316;6348.555601107924;6364.618122912594;5927.91108133374;6004.309504406961;6022.126791615235;6036.547258955596;6068.544859135583;6448.742050318028;6449.838754031093;6454.386833250834;6466.579672321284;6467.159269295055;6225.159603453566;6259.2488901332135;6259.6870156492;6266.122742816009;6269.7178626961895;5768.74040668171;6158.907616385758;6254.280757712831;6271.466925311308;6334.081558174039;5927.407259274038;6167.814965551041;6168.691565421711;6230.06549017651;6235.189425374672;6136.938630613726;6161.784337548164;6209.875802483925;6232.594881332699;6240.625562466266;4229.809658565372;4998.525140111684;5077.847664570068;5080.949190508121;5115.87210319745;3694.242680250542;4560.110778398181;4570.702904311209;4582.95417045832;4611.584957353787;5894.879972805154;5979.252593425822;5992.490638295793;5999.730012149376;6011.09833524966;6160.661163635953;6253.405926436982;6264.686765661699;6290.24517057956;6357.745690172342;6001.159837622737;6003.309619393738;6006.219191505076;6013.579049466583;6018.759249630053;5568.693721845338;5576.832695019156;5592.944070559323;5604.355499117653;5613.971930140405;6304.968475157595;6386.584871983307;6423.132877061536;6463.935360646521;6507.446867016357;6316.968415157895;6317.936820631735;6319.526035547445;6341.112244285896;6358.650274234961;6423;6437.839054023687;6494.318096599978;6494.707738151889;6507.414332710079;6142.590862071594;6174.753009879554;6207.099970504342;6227.19046523949;6264;6092.543059270483;6263.843403914939;6289.433950944437;6307.30619631831;6317;6167.599106058092;6187.597806142587;6190.845228869314;6201.3178550358525;6213.1922850029205;6128.4790792783115;6138.32709113608;6157.922363586444;6160.599561028519;6215.96892015537;6017.518598512196;6088.969555152196;6109.95128740435;6179.3820617937845;6186.628802271878;6166.691665416801;6171.871488430869;6184.938150618436;6201.503879689524;6203.844903877439;6047.213862197887;6134.650895842834;6141.424638644238;6141.723622437091;6195.566310358412 06:33:32 INFO - PROCESS | 1658 | |1;ext.html;499.97000179989203;511.05454908419426;529.862235818687;536.6860386673795;543.6031696861291;30173.69826301739;40997.59002409982;41054.58945410545;41090.58909410905;41129.794351028206;41858.37212441816;42360;42502.574974250245;42538.36192457116;42565.57434425655;9520.857187142181;9592.232621390307;9611.471369074698;9743.269254805882;9753.658621948232;9591.856122158173;9623.855642165337;9667.90332096677;9689.176420004309;9719.319647624669;8485.95757021214;9664.516774161299;9691.660791872286;9719.271054670893;9775.071368220008;8274.338052955749;9496.287778416612;9590.856137157949;9675.080867317594;9678.370905891095;8043.55760433176;9547.140757331805;9582.13760761528;9593.47235902025;9602.183814375787;39279.21441571181;39335.60664393348;39932.20135597272;39939.20121597552;40041;2939.2357986923553;3099.938001239985;3327.7670563060597;3502.3786822150337;3566.982165089158;30112.698873011428;30184.09447716572;31501.52747708786;31589.84205078983;32349.83825080883;3115.43922094023;3136.074857916897;3141.3246152077186;3161.3677264546955;3252.317013427183;452295.7385213086;454137;454964;457881;465275;33065.17337066593;33144.66855331464;33188.50217246743;33196.50205246923;33282.16794580155;31700;34308;34424;34763;35252.4136413862;16359.836401635832;16593.83406165947;16736.83263167377;16774.077425741456;16777.412790552273;12332.445039973223;12674.302913339854;12743.04427167966;12813.910817580423;12841.357932103358;18711.90644046798;18804.341848035252;18813.15340809667;18818.059097045094;18870.056497175086;8058.11360750317;8181.795455113551;8204.261616454547;8209.38429617781;8219.69848442425;753.5177486408703;917.9954100229456;1023.81059503992;1071.4374953149502;1103.1615971861443;28586.856525738738;29590.556141657893;29679.85160074186;29826.85086574553;30330;1046.3930920066343;1074.9247552671238;1079.4171147580375;1142.7714457108445;1228.4778968938344;13241.337933103307;15308.387664493295;15652;15760.054396736232;15923.761143582855;637366;642459;643220;645160;651746;58522.12216816751;58745.70627146837;59200.703996479744;59271.40728592659;59551.10673339817;1350.210127075652;1382.2328607622867;1405.866442687943;1408.6688079764524;1411.1462565148142;24758.752412475646;27410.72589274082;28167.873285068366;28249.293767655974;28748.568771468865;49166.50833491762;50416;50563;50703.23945140752;50914.23628645647;439701;440927;441104.79447602556;442881;443799;23150.536989259785;26075.217743467725;26600.467990640467;27004.91980320844;27299.04453344203;45738.85652858705;47715.76142119406;48078.27882581694;48308.27537586869;49223;39863.60136398599;40256.59743402646;40601;40904.79547602243;41592.1681566373;39632.801835990635;39750.2049959005;39919.60080399159;40705.982350441474;41093.1781364377;29181.7081829179;38647;38878.222435551696;38997;39098;33951.4907276396;34697;35151.47272790859;35215.295694085464;36192.81903590465;25771.871140644176;25880.61179082353;26030;26081.217563473125;26283.474330513665 06:33:32 INFO - PROCESS | 1658 | |2;jquery.html;301.32503192848026;367.8528588564574;375.20456631940283;384.18744355687727;399.68824317032727;20344.89827550862;21156.047977840997;21299.467513312175;22068.22761203358;22314.330570082882;20399.694004589943;20421.795782042176;20676.586468270627;20721.378358649228;20935.581288374262;4892.633052521057;4961.8511444656715;5900.586958912878;5971.34315225327;6104.08438734189;5006.299118123466;5893.145493903381;5966.492848107916;6067.02927531595;6072.332043475214;5694.857628559298;5852.063669812831;5860.794872179475;5925.822225333247;5985.311689155737;5574.832755017315;5821.27234095738;5824.475797178275;5834.620749651259;5851.707414629294;4396.164728701537;5044.14249577569;5108.923366149511;5171.01750667372;5182.922256166161;21288;26590.6011409829;26612.733872661414;26637.200883973514;27058.052968146218;1995.281698588507;2203.5923354179367;2230.2194232018824;2253.605619016682;2461.1509029384833;12705.936470317682;15255.847441525553;15578.454754083667;15734.685306293924;16348.427805026886;1777.191377923042;1798.3705703003975;1806.5573934386027;1860.3302810988034;1980.5640910340032;122218.77781222163;124837;125235;127136.72863271434;127352;9457.10157535033;9975.551100200508;10023.2482563808;10157.9492102539;10414.218933580012;11867.76264474723;12077.818832717516;12245.510179592717;12257.325847078497;12311;6831.863362732717;7969.282764551218;8055;8125.4718443301;8148;8440.40917135807;8526.062133165347;8553.657853685783;8589.656413743505;8666.436681615674;3152.511360739089;3842.1547259602844;3894.415837624379;3908.5700572936953;3928.5874983126932;1625.2929975460477;1889.338731444011;1891.489297889562;1935.0614951748391;1938.951526211856;874.501534125555;906.8911730592239;930.3022732950287;1013.8479228115841;1037.9672226135044;18354.541136471697;20268.493287667632;21534.892325538272;21551.2457064002;21669.458263543536;760.8891019112048;926.6478738079621;934.2946075712794;942.8020115775627;971.3928794503436;10336.741581460523;10944.945275273732;11153.498092585853;11413.60052398162;11510.424478776027;593670.0316498476;605636;607049;609440;610200;83566;115925;120122;127763.36118319348;138472;980.2452111873818;1022.6676330192718;1049.8740151181908;1052.7157667429751;1053.1890444357955;19905.502362440475;20180.59638807245;20181.697274541188;20221.39335819928;20340.982950852103;56058.59853503532;56921.715391422775;57469;57509.712451437474;58107.709461452425;81775.18224817913;82368;82510.58744706238;82872;83907.54860561901;8142.674293028213;8201.42590018693;8277.54473503963;8407.2433480987;8414.747557573282;11875.703107422383;13025.413856376676;13065.542706005244;13478.123921945042;13549.525766598515;11385.772284554429;11421.657350279505;11683.707907302385;11745.354005529436;11756.882431175922;10980.670579882617;10999.450027498753;11424.48589813477;11560.595379161688;11643.301401915913;10372.858985511437;11451.59919402817;11593.420328983348;11959.222650527689;12039.458224379749;8202.302804261466;8282.58587070632;8295.04606970206;8341.541215233221;8419.7791320257;9508.477033763209;11689.084156807565;11748.823767643664;11799.52801887915;11863.58477453285 06:33:32 INFO - PROCESS | 1658 | |3;mootools.html;1510.5845892379593;1544.8223454302754;1719.4669652407754;1817.3639226270807;1841.2082804394106;7887.960560197205;8343.290820280276;8432.578371081452;8899.110088991098;8916.108389161082;7063.399611033055;8710.21608055275;8711.346649001318;8715.346349023817;8733;2298.9540209195807;2329.6039673255505;2351.670766092748;2352.435415500276;2358.50471401006;2323.1520495019367;2342.9531409371803;2369.1115831563166;2374.489484760776;2377.358113309414;2344.9882750586307;2350.6591544226076;2353.2587235020915;2358.3278765551822;2362.9291121266388;2320.1067588978194;2331.0559223514506;2334.6498025296255;2344.050659482912;2350.670906073151;2311.3297143828268;2333.171724037959;2335.4511689752894;2342.3090188394463;2347.1667558016998;7534.246575342422;8705.738827835175;8735.519546424945;8793.956030219808;8809.38334316598;5115.974420127875;5166.689998600058;5170.534651881311;5241.292425522543;5282.894342113136;2907.331313797817;3379.5944486661756;3531.1878267998504;3570.589382221052;3580.874669386585;1045.8412600310965;1075.4031512510553;1090.1987039525943;1093.7211011192096;1100.0539535999035;11409.54361825526;11433.542658293742;11487.540498380054;11491.42542872853;11503.654890353386;4503.954960450354;4591.678582499259;4751.216049351819;4751.738654374042;4757.977034937436;9714.659986900566;9770.169535589412;9779.119879210904;9786;9788.657396991071;5095.5159259871;5237.371515418098;5254.7635356409055;5283.6037297202865;5297.125974214288;4348.0869017506675;4687.929681054787;4810.95189048105;4831.661783675179;4832.782524786393;3359.882404115844;3824.6175382461533;3907.7264591478893;3917.4319723639915;4011.91976160481;1278.7314663920495;1286.9935650321875;1295.3264302562802;1295.3393769177599;1301.8502872169631;793.8769490728946;803.9508441483803;892.4511425473416;930.418488444722;978.848278516831;5770.451807078321;5954.732037058343;6057.303410107894;6096;6154.907676384858;442.26142342288455;914.7210100919284;947.2564037230741;1040.7450174707244;1062.1874266186373;4012.467273407306;4029.7783621901076;4039.5602428509324;4125.030617804813;4145.108801607669;10476.63331783384;10819.026287633993;10838.403887786248;10845.783084338269;10865.076468500109;9476.620935162655;10609.257351985287;10695.625653102104;10775.83836242457;10845.240833141605;7857.135715071452;7951.642176102089;7966.681332746741;7989.360851132012;8000.799880018044;5708.80019199326;5841.415858414294;5968.880622387441;5979.850503737442;6054.8183554493435;9789.804203915739;9956.900430995887;10022.398656080659;10040.64857729976;10056.748581285234;8582.742517724479;9541;9734.02659734021;9942.453165075991;10023.248256380655;6853.417459515997;7391.963040184764;7555.09338879338;7837.529748215125;7954.00574928134;8141.959290203511;8325.625346859528;8335.291500222549;8336.62485188156;8357.832843342978;7187.928120718726;7381.778546643609;7439.070116235471;7500.812479688051;7538.660760265691;7200.207977122408;7279.672414741455;7377.631118444164;7418.258174182539;7419.517731347445;6893.172819261721;6904.102466679299;6970.198427180939;6996.685149168198;7044.647767611701;4905.092557876804;4910.337104490848;4957.0581589499325;5027.673201241908;5064.316317297265;5013.072581572421;5084.85584248836;5106.923396148986;5222.321098257202;5261.947380526146 06:33:32 INFO - PROCESS | 1658 | |4;prototype.html;307.62162540075707;308.61577336216413;310.75139888089535;312.6841889691412;314.7959056608473;5038.848834534961;5524.475174858387;5599.32808063032;5611.859703507414;5613.410591887854;4719.528047195278;5475.753591088401;5523.917141242885;5537.695426751527;5581.916271255935;3978.9005274868214;4085.101277718897;4143.7513749175;4179.892328532941;4187.7277976931555;3589.910252243689;3789.924201515968;3809.447630093635;4014.7554258180057;4212.473440819897;4157.355609880473;4158.334666453368;4167.666586673059;4190.518090419595;4223.197592457439;3725.2177042820767;4079.2861249281405;4111.732737372061;4158.168366326747;4202.768847713374;3096.9315586122752;3148.7008734170217;3519.260955199411;3575.87484438046;3630.3283892479712;4305.31115021595;5337.412884582693;5340.839774806723;5380.946190538084;5385.192221166817;4186.413902053715;4708.788104535304;4711.505291944365;4838.250071238928;4856.344393506866;4547.522510136421;4885.487023862479;5804.227252286006;5811.360750317462;5819.301683797971;4048.4939382577177;4068.715189936676;4072.5927407259333;4077.7572335215514;4097.385392191165;5390;5768.538516918637;6058.242719660087;6117.174181485487;6141.4472697456995;3838.347480928249;3924.0386105403786;3938.7636741795586;4120.299549076604;4152.43942067817;4197.202531519001;4215.936760948588;4226.408302837605;4242.151569686075;4255.255330317182;4234.280172370704;4697;4880.341153944172;4912.582430493377;4914.827981020719;5495.560355171577;5898.9058884096385;5906.350301466835;5927.792527261611;5939.227900372924;1418.3901272056085;1447.986409513324;1453.5929939616924;1457.271364317841;1461.4300422835104;755.112742527528;828.5857071464268;897.1566727276339;901.9549022548978;904.0823564082461;4420.359047938031;5263.6578622389425;5363.525030616612;5393.759435329817;5418.160185171305;4559.6808223424705;5497.202905578669;6010.368911264254;6016.548758843104;6039.849003774941;5078.949210507848;5220.486059042911;5373.731313434313;5455.699936503531;5473.808416705396;2508.849469031864;2963.4073185363013;3133.3393301550213;3148.464760990637;3184.9203769905475;5414.729263536808;5571.0807716727095;6221.129041934133;6237.877182107264;6272;5151.845444636667;5836.854078648068;6038.026079877748;6056.606320589236;6210.937890621126;5419.241306217212;5570.777168913279;5906.763729450774;6237.781677641261;6256.871564217891;5742.569307302053;5800.596434295475;5923.614965027259;5982.683809562063;6024.951516484241;5082.872928176826;5802.767889284381;5952.553558483044;5961.4038596140035;5973.313068996948;5110.514501122388;6036.63780173191;6211.254649442096;6222.09779581949;6250.406211409909;3026.803257788237;3994.420808982623;4008.579099194543;4009.218202450494;4049.230646177217;5333.253344531691;6037.516998640011;6046.90929636047;6070.423309785563;6080.087986802015;5029.06962211992;5072.67027643202;5094.363204599425;5571.60998730085;5893.852653683693;5001.674891132065;5748.338941021836;5842.415758424124;5842.705611375551;5842.941570584409;4687.406341785138;5699.430056994267;5713;5723.341815691082;5742.822721342199;5656.9717151415625;5706.288113565831;5853.502452291603;5879.5002424794375;5918.23063001807;4767.7603823005575;5221.929504451502;5305.549028332635;5489.670619762827;5804.1874137619925 06:33:32 INFO - PROCESS | 1658 | |5;yui.html;690.3683129936107;696.3454352908266;712.5475323169787;735.474135992765;745.5265906149593;14707.117572945617;15107.320170592322;15503;15526.456574019912;15564.610884727888;13556.389962451689;13803.2408217548;13915.930420347884;13929.791053134211;13941.651458713537;675.1729131813514;796.9601519924009;841.6675413211777;858.6608289725555;863.4517081653132;858.9785255368603;865.5066612031145;868.9739307820744;871.424859592669;871.538084815049;916.1342531307916;926.4950601921935;927.5130556457846;928.3130483442238;928.3547934185743;887.7203680840514;908.9045650206765;909;919.9834183227538;920.6409500294891;674.6862708840364;675.9763408280686;682.6313790553095;691.6541729135432;692.5671455340412;13805.723885522233;14002.229877356742;14063.859361406357;14259.429622815074;14278.714425711427;14606.780898286534;14606.780898286534;14649.487267945571;14726.558203253919;14891.553253402308;11810.763784724344;11974.22167559106;11985.28088314704;12004.759904801855;12153.149279550435;3845.3078445879732;3857.8071096445346;3874.8643797466952;3892.124272038797;4001.559828418872;117697;119181;119636.40181799035;120172;122142.38928805388;11018;11172.050375717992;11205.439728013567;11213.775724485464;11460.656180314603;22079.779202208094;22680;22805.429864253525;22960.311190664306;23012.4246893829;7987.8402431951035;8092.554909479917;8120.147384524658;8267.958660206661;8336.958315208507;4498.347739577743;4522.728636281834;4577.29051996941;4582.541745825458;4656.301554766812;3539.9292014159573;3580.6240344763946;3635.94546081809;3651.3245049665898;3654.470101835219;563.2621266141368;655.429776094791;658.8601719026111;659;659.0312241005714;550.4577990679178;596.5287422935833;635.4217661927623;638.4030931079456;660.244020596424;8038.316743076787;9509.381890177116;9590.376625519319;9593.088656577615;9599.136077752895;540.0710777462758;603.6589327030214;664.139938779282;676.3743537228045;698.7205117952859;3794.29805485986;4152.730072545275;4399.739200979444;4626;4815.398075240595;99740;140429.59570404165;149684;164466.3553364451;168972;137581;137881;138919;143136.28431857983;154908.22545887198;116272.09319766905;127617.36191318984;129046.35476822744;130717.15717901482;133499.66500334872;8375.748727538183;9297.907020929704;9369.625214991323;9386.812263754824;9462.526873656427;49082.26376604282;53792;55075.44924550703;57527.7123614396;67355.66322168357;53506.73246633742;60301.69849150726;61004.694976524836;84537;89828.55085724792;13124.241298154342;13726.176429414267;13783.241921694404;13874.722505550035;13874.93062534681;15472.767908481606;15994.600134996717;16326.673466530365;16446.424375146813;16478.67042659164;11399.544018239178;12004.519819207484;12459.813102803646;12495.187812792139;12528.37358132108;11893.524259029542;12084;12501.874981250072;12530.561430349893;12903;9793.412395256308;13925.442982281;14123.576292711236;14375.496857609933;14519.782203266748;9849.803003940024;10906.291091079054;10943.98288888674;11090.780014198594;11201.495932682887;7647.961760191163;8424.794182149455;10449.16406687448;11563.6530904073;11657.53369865196 06:33:32 INFO - PROCESS | 1658 | __end_tp_report 06:33:32 INFO - PROCESS | 1658 | __start_cc_report 06:33:32 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,415 06:33:32 INFO - PROCESS | 1658 | __end_cc_report 06:33:32 INFO - PROCESS | 1658 | __startTimestamp1470404012968__endTimestamp 06:33:32 INFO - PROCESS | 1658 | 06:33:32 INFO - PROCESS | 1658 | ------- Summary: start ------- 06:33:32 INFO - PROCESS | 1658 | Number of tests: 6 06:33:32 INFO - PROCESS | 1658 | 06:33:32 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5823.97 Median:6092.54 stddev:675.94 (11.1%) stddev-sans-first:643.96 06:33:32 INFO - PROCESS | 1658 | Values: 3123.4 3388.9 3444.3 3467.3 3467.9 5765.4 5843.0 5863.6 5891.7 5945.1 5841.4 5843.2 5869.9 5890.7 5991.8 5202.7 5290.7 5307.7 5362.4 5441.4 5412.9 5433.6 5449.2 5479.5 5481.8 5150.4 5200.2 5207.7 5221.9 5260.4 5277.1 5296.1 5304.8 5320.1 5323.9 4395.5 5281.1 5339.5 5345.9 5349.6 4454.4 4854.4 5784.4 5830.5 5886.3 6221.1 6232.9 6258.5 6269.4 6275.1 5810.4 6091.1 6332.0 6348.6 6364.6 5927.9 6004.3 6022.1 6036.5 6068.5 6448.7 6449.8 6454.4 6466.6 6467.2 6225.2 6259.2 6259.7 6266.1 6269.7 5768.7 6158.9 6254.3 6271.5 6334.1 5927.4 6167.8 6168.7 6230.1 6235.2 6136.9 6161.8 6209.9 6232.6 6240.6 4229.8 4998.5 5077.8 5080.9 5115.9 3694.2 4560.1 4570.7 4583.0 4611.6 5894.9 5979.3 5992.5 5999.7 6011.1 6160.7 6253.4 6264.7 6290.2 6357.7 6001.2 6003.3 6006.2 6013.6 6018.8 5568.7 5576.8 5592.9 5604.4 5614.0 6305.0 6386.6 6423.1 6463.9 6507.4 6317.0 6317.9 6319.5 6341.1 6358.7 6423.0 6437.8 6494.3 6494.7 6507.4 6142.6 6174.8 6207.1 6227.2 6264.0 6092.5 6263.8 6289.4 6307.3 6317.0 6167.6 6187.6 6190.8 6201.3 6213.2 6128.5 6138.3 6157.9 6160.6 6216.0 6017.5 6089.0 6110.0 6179.4 6186.6 6166.7 6171.9 6184.9 6201.5 6203.8 6047.2 6134.7 6141.4 6141.7 6195.6 06:33:32 INFO - PROCESS | 1658 | 06:33:32 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:64179.85 Median:39484.20 stddev:139553.98 (353.4%) stddev-sans-first:139863.57 06:33:32 INFO - PROCESS | 1658 | Values: 500.0 511.1 529.9 536.7 543.6 30173.7 40997.6 41054.6 41090.6 41129.8 41858.4 42360.0 42502.6 42538.4 42565.6 9520.9 9592.2 9611.5 9743.3 9753.7 9591.9 9623.9 9667.9 9689.2 9719.3 8486.0 9664.5 9691.7 9719.3 9775.1 8274.3 9496.3 9590.9 9675.1 9678.4 8043.6 9547.1 9582.1 9593.5 9602.2 39279.2 39335.6 39932.2 39939.2 40041.0 2939.2 3099.9 3327.8 3502.4 3567.0 30112.7 30184.1 31501.5 31589.8 32349.8 3115.4 3136.1 3141.3 3161.4 3252.3 452295.7 454137.0 454964.0 457881.0 465275.0 33065.2 33144.7 33188.5 33196.5 33282.2 31700.0 34308.0 34424.0 34763.0 35252.4 16359.8 16593.8 16736.8 16774.1 16777.4 12332.4 12674.3 12743.0 12813.9 12841.4 18711.9 18804.3 18813.2 18818.1 18870.1 8058.1 8181.8 8204.3 8209.4 8219.7 753.5 918.0 1023.8 1071.4 1103.2 28586.9 29590.6 29679.9 29826.9 30330.0 1046.4 1074.9 1079.4 1142.8 1228.5 13241.3 15308.4 15652.0 15760.1 15923.8 637366.0 642459.0 643220.0 645160.0 651746.0 58522.1 58745.7 59200.7 59271.4 59551.1 1350.2 1382.2 1405.9 1408.7 1411.1 24758.8 27410.7 28167.9 28249.3 28748.6 49166.5 50416.0 50563.0 50703.2 50914.2 439701.0 440927.0 441104.8 442881.0 443799.0 23150.5 26075.2 26600.5 27004.9 27299.0 45738.9 47715.8 48078.3 48308.3 49223.0 39863.6 40256.6 40601.0 40904.8 41592.2 39632.8 39750.2 39919.6 40706.0 41093.2 29181.7 38647.0 38878.2 38997.0 39098.0 33951.5 34697.0 35151.5 35215.3 36192.8 25771.9 25880.6 26030.0 26081.2 26283.5 06:33:32 INFO - PROCESS | 1658 | 06:33:32 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:35476.47 Median:12283.97 stddev:100976.90 (822.0%) stddev-sans-first:101225.62 06:33:32 INFO - PROCESS | 1658 | Values: 301.3 367.9 375.2 384.2 399.7 20344.9 21156.0 21299.5 22068.2 22314.3 20399.7 20421.8 20676.6 20721.4 20935.6 4892.6 4961.9 5900.6 5971.3 6104.1 5006.3 5893.1 5966.5 6067.0 6072.3 5694.9 5852.1 5860.8 5925.8 5985.3 5574.8 5821.3 5824.5 5834.6 5851.7 4396.2 5044.1 5108.9 5171.0 5182.9 21288.0 26590.6 26612.7 26637.2 27058.1 1995.3 2203.6 2230.2 2253.6 2461.2 12705.9 15255.8 15578.5 15734.7 16348.4 1777.2 1798.4 1806.6 1860.3 1980.6 122218.8 124837.0 125235.0 127136.7 127352.0 9457.1 9975.6 10023.2 10157.9 10414.2 11867.8 12077.8 12245.5 12257.3 12311.0 6831.9 7969.3 8055.0 8125.5 8148.0 8440.4 8526.1 8553.7 8589.7 8666.4 3152.5 3842.2 3894.4 3908.6 3928.6 1625.3 1889.3 1891.5 1935.1 1939.0 874.5 906.9 930.3 1013.8 1038.0 18354.5 20268.5 21534.9 21551.2 21669.5 760.9 926.6 934.3 942.8 971.4 10336.7 10944.9 11153.5 11413.6 11510.4 593670.0 605636.0 607049.0 609440.0 610200.0 83566.0 115925.0 120122.0 127763.4 138472.0 980.2 1022.7 1049.9 1052.7 1053.2 19905.5 20180.6 20181.7 20221.4 20341.0 56058.6 56921.7 57469.0 57509.7 58107.7 81775.2 82368.0 82510.6 82872.0 83907.5 8142.7 8201.4 8277.5 8407.2 8414.7 11875.7 13025.4 13065.5 13478.1 13549.5 11385.8 11421.7 11683.7 11745.4 11756.9 10980.7 10999.5 11424.5 11560.6 11643.3 10372.9 11451.6 11593.4 11959.2 12039.5 8202.3 8282.6 8295.0 8341.5 8419.8 9508.5 11689.1 11748.8 11799.5 11863.6 06:33:32 INFO - PROCESS | 1658 | 06:33:32 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5653.89 Median:5045.99 stddev:3141.65 (62.3%) stddev-sans-first:3135.04 06:33:32 INFO - PROCESS | 1658 | Values: 1510.6 1544.8 1719.5 1817.4 1841.2 7888.0 8343.3 8432.6 8899.1 8916.1 7063.4 8710.2 8711.3 8715.3 8733.0 2299.0 2329.6 2351.7 2352.4 2358.5 2323.2 2343.0 2369.1 2374.5 2377.4 2345.0 2350.7 2353.3 2358.3 2362.9 2320.1 2331.1 2334.6 2344.1 2350.7 2311.3 2333.2 2335.5 2342.3 2347.2 7534.2 8705.7 8735.5 8794.0 8809.4 5116.0 5166.7 5170.5 5241.3 5282.9 2907.3 3379.6 3531.2 3570.6 3580.9 1045.8 1075.4 1090.2 1093.7 1100.1 11409.5 11433.5 11487.5 11491.4 11503.7 4504.0 4591.7 4751.2 4751.7 4758.0 9714.7 9770.2 9779.1 9786.0 9788.7 5095.5 5237.4 5254.8 5283.6 5297.1 4348.1 4687.9 4811.0 4831.7 4832.8 3359.9 3824.6 3907.7 3917.4 4011.9 1278.7 1287.0 1295.3 1295.3 1301.9 793.9 804.0 892.5 930.4 978.8 5770.5 5954.7 6057.3 6096.0 6154.9 442.3 914.7 947.3 1040.7 1062.2 4012.5 4029.8 4039.6 4125.0 4145.1 10476.6 10819.0 10838.4 10845.8 10865.1 9476.6 10609.3 10695.6 10775.8 10845.2 7857.1 7951.6 7966.7 7989.4 8000.8 5708.8 5841.4 5968.9 5979.9 6054.8 9789.8 9956.9 10022.4 10040.6 10056.7 8582.7 9541.0 9734.0 9942.5 10023.2 6853.4 7392.0 7555.1 7837.5 7954.0 8142.0 8325.6 8335.3 8336.6 8357.8 7187.9 7381.8 7439.1 7500.8 7538.7 7200.2 7279.7 7377.6 7418.3 7419.5 6893.2 6904.1 6970.2 6996.7 7044.6 4905.1 4910.3 4957.1 5027.7 5064.3 5013.1 5084.9 5106.9 5222.3 5261.9 06:33:32 INFO - PROCESS | 1658 | 06:33:32 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4688.29 Median:5319.40 stddev:1449.59 (27.3%) stddev-sans-first:1415.88 06:33:32 INFO - PROCESS | 1658 | Values: 307.6 308.6 310.8 312.7 314.8 5038.8 5524.5 5599.3 5611.9 5613.4 4719.5 5475.8 5523.9 5537.7 5581.9 3978.9 4085.1 4143.8 4179.9 4187.7 3589.9 3789.9 3809.4 4014.8 4212.5 4157.4 4158.3 4167.7 4190.5 4223.2 3725.2 4079.3 4111.7 4158.2 4202.8 3096.9 3148.7 3519.3 3575.9 3630.3 4305.3 5337.4 5340.8 5380.9 5385.2 4186.4 4708.8 4711.5 4838.3 4856.3 4547.5 4885.5 5804.2 5811.4 5819.3 4048.5 4068.7 4072.6 4077.8 4097.4 5390.0 5768.5 6058.2 6117.2 6141.4 3838.3 3924.0 3938.8 4120.3 4152.4 4197.2 4215.9 4226.4 4242.2 4255.3 4234.3 4697.0 4880.3 4912.6 4914.8 5495.6 5898.9 5906.4 5927.8 5939.2 1418.4 1448.0 1453.6 1457.3 1461.4 755.1 828.6 897.2 902.0 904.1 4420.4 5263.7 5363.5 5393.8 5418.2 4559.7 5497.2 6010.4 6016.5 6039.8 5078.9 5220.5 5373.7 5455.7 5473.8 2508.8 2963.4 3133.3 3148.5 3184.9 5414.7 5571.1 6221.1 6237.9 6272.0 5151.8 5836.9 6038.0 6056.6 6210.9 5419.2 5570.8 5906.8 6237.8 6256.9 5742.6 5800.6 5923.6 5982.7 6025.0 5082.9 5802.8 5952.6 5961.4 5973.3 5110.5 6036.6 6211.3 6222.1 6250.4 3026.8 3994.4 4008.6 4009.2 4049.2 5333.3 6037.5 6046.9 6070.4 6080.1 5029.1 5072.7 5094.4 5571.6 5893.9 5001.7 5748.3 5842.4 5842.7 5842.9 4687.4 5699.4 5713.0 5723.3 5742.8 5657.0 5706.3 5853.5 5879.5 5918.2 4767.8 5221.9 5305.5 5489.7 5804.2 06:33:32 INFO - PROCESS | 1658 | 06:33:32 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:25079.22 Median:3819.80 stddev:41367.90 (1083.0%) stddev-sans-first:41443.42 06:33:32 INFO - PROCESS | 1658 | Values: 690.4 696.3 712.5 735.5 745.5 14707.1 15107.3 15503.0 15526.5 15564.6 13556.4 13803.2 13915.9 13929.8 13941.7 675.2 797.0 841.7 858.7 863.5 859.0 865.5 869.0 871.4 871.5 916.1 926.5 927.5 928.3 928.4 887.7 908.9 909.0 920.0 920.6 674.7 676.0 682.6 691.7 692.6 13805.7 14002.2 14063.9 14259.4 14278.7 14606.8 14606.8 14649.5 14726.6 14891.6 11810.8 11974.2 11985.3 12004.8 12153.1 3845.3 3857.8 3874.9 3892.1 4001.6 117697.0 119181.0 119636.4 120172.0 122142.4 11018.0 11172.1 11205.4 11213.8 11460.7 22079.8 22680.0 22805.4 22960.3 23012.4 7987.8 8092.6 8120.1 8268.0 8337.0 4498.3 4522.7 4577.3 4582.5 4656.3 3539.9 3580.6 3635.9 3651.3 3654.5 563.3 655.4 658.9 659.0 659.0 550.5 596.5 635.4 638.4 660.2 8038.3 9509.4 9590.4 9593.1 9599.1 540.1 603.7 664.1 676.4 698.7 3794.3 4152.7 4399.7 4626.0 4815.4 99740.0 140429.6 149684.0 164466.4 168972.0 137581.0 137881.0 138919.0 143136.3 154908.2 116272.1 127617.4 129046.4 130717.2 133499.7 8375.7 9297.9 9369.6 9386.8 9462.5 49082.3 53792.0 55075.4 57527.7 67355.7 53506.7 60301.7 61004.7 84537.0 89828.6 13124.2 13726.2 13783.2 13874.7 13874.9 15472.8 15994.6 16326.7 16446.4 16478.7 11399.5 12004.5 12459.8 12495.2 12528.4 11893.5 12084.0 12501.9 12530.6 12903.0 9793.4 13925.4 14123.6 14375.5 14519.8 9849.8 10906.3 10944.0 11090.8 11201.5 7648.0 8424.8 10449.2 11563.7 11657.5 06:33:32 INFO - PROCESS | 1658 | -------- Summary: end -------- 06:33:32 INFO - PROCESS | 1658 | 06:33:33 INFO - TEST-INFO | 1658: exit 0 06:33:33 INFO - TEST-OK | dromaeo_css | took 1113865ms 06:33:33 INFO - TEST-START | kraken 06:33:33 INFO - operating with platform_type : mac_ 06:33:33 INFO - Initialising browser for kraken test... 06:33:33 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmptgDhlw/profile http://localhost:49274/getInfo.html) 06:33:36 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 06:33:36 INFO - PROCESS | 1671 | colorDepth:24 06:33:36 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 06:33:36 INFO - PROCESS | 1671 | __metrics 06:33:36 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:33:36 INFO - TEST-INFO | 1671: exit 0 06:33:36 INFO - Browser initialized. 06:33:36 INFO - Running cycle 1/1 for kraken test... 06:33:36 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmptgDhlw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:33:48 INFO - PROCESS | 1673 | RSS: Main: 254697472 06:33:48 INFO - PROCESS | 1673 | 06:33:51 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 06:33:52 INFO - PROCESS | 1673 | RSS: Main: 267472896 06:33:52 INFO - PROCESS | 1673 | 06:33:54 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 06:33:55 INFO - PROCESS | 1673 | RSS: Main: 276320256 06:33:55 INFO - PROCESS | 1673 | 06:33:58 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 06:33:59 INFO - PROCESS | 1673 | RSS: Main: 278978560 06:33:59 INFO - PROCESS | 1673 | 06:34:01 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 06:34:01 INFO - PROCESS | 1673 | RSS: Main: 280379392 06:34:01 INFO - PROCESS | 1673 | 06:34:04 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:34:04 INFO - PROCESS | 1673 | RSS: Main: 281022464 06:34:04 INFO - PROCESS | 1673 | 06:34:07 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 06:34:08 INFO - PROCESS | 1673 | RSS: Main: 282021888 06:34:08 INFO - PROCESS | 1673 | 06:34:11 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 06:34:11 INFO - PROCESS | 1673 | RSS: Main: 282865664 06:34:11 INFO - PROCESS | 1673 | 06:34:14 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 06:34:15 INFO - PROCESS | 1673 | RSS: Main: 283410432 06:34:15 INFO - PROCESS | 1673 | 06:34:17 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:34:17 INFO - PROCESS | 1673 | RSS: Main: 282722304 06:34:17 INFO - PROCESS | 1673 | 06:34:19 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:34:20 INFO - PROCESS | 1673 | RSS: Main: 282587136 06:34:20 INFO - PROCESS | 1673 | 06:34:22 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:34:23 INFO - PROCESS | 1673 | RSS: Main: 282808320 06:34:23 INFO - PROCESS | 1673 | 06:34:26 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:34:26 INFO - PROCESS | 1673 | RSS: Main: 282853376 06:34:26 INFO - PROCESS | 1673 | 06:34:29 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:34:30 INFO - PROCESS | 1673 | RSS: Main: 283111424 06:34:30 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 06:34:32 INFO - PROCESS | 1673 | RSS: Main: 284291072 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | __start_tp_report 06:34:32 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 06:34:32 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 06:34:32 INFO - PROCESS | 1673 | |i|pagename|runs| 06:34:32 INFO - PROCESS | 1673 | |0;ai-astar;103;121;110;117;118;116;114;116;119;117 06:34:32 INFO - PROCESS | 1673 | |1;audio-beat-detection;133;111;126;154;109;128;129;114;154;111 06:34:32 INFO - PROCESS | 1673 | |2;audio-dft;196;198;188;200;202;224;192;193;193;195 06:34:32 INFO - PROCESS | 1673 | |3;audio-fft;69;84;74;144;59;59;59;65;133;57 06:34:32 INFO - PROCESS | 1673 | |4;audio-oscillator;67;69;118;87;102;103;150;98;81;108 06:34:32 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;90;87;113;129;84;131;134;87;90;86 06:34:32 INFO - PROCESS | 1673 | |6;imaging-darkroom;96;109;95;96;97;96;96;96;103;95 06:34:32 INFO - PROCESS | 1673 | |7;imaging-desaturate;91;103;92;95;97;121;85;149;148;107 06:34:32 INFO - PROCESS | 1673 | |8;json-parse-financial;56;55;57;54;56;55;57;56;55;54 06:34:32 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;67;72;73;81;101;80;77;70;73;73 06:34:32 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;88;111;85;88;77;84;102;106;106;102 06:34:32 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;141;143;132;138;140;178;156;163;135;131 06:34:32 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;172;176;171;170;171;168;171;171;171;170 06:34:32 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;65;69;61;78;94;90;89;77;68;69 06:34:32 INFO - PROCESS | 1673 | __end_tp_report 06:34:32 INFO - PROCESS | 1673 | __start_cc_report 06:34:32 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1051 06:34:32 INFO - PROCESS | 1673 | __end_cc_report 06:34:32 INFO - PROCESS | 1673 | __startTimestamp1470404072437__endTimestamp 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | ------- Summary: start ------- 06:34:32 INFO - PROCESS | 1673 | Number of tests: 14 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:115.10 Median:117.00 stddev:5.17 (4.4%) stddev-sans-first:3.13 06:34:32 INFO - PROCESS | 1673 | Values: 103.0 121.0 110.0 117.0 118.0 116.0 114.0 116.0 119.0 117.0 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:128.50 stddev:16.68 (13.0%) stddev-sans-first:17.55 06:34:32 INFO - PROCESS | 1673 | Values: 133.0 111.0 126.0 154.0 109.0 128.0 129.0 114.0 154.0 111.0 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:198.10 Median:197.00 stddev:9.97 (5.1%) stddev-sans-first:10.55 06:34:32 INFO - PROCESS | 1673 | Values: 196.0 198.0 188.0 200.0 202.0 224.0 192.0 193.0 193.0 195.0 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:80.30 Median:62.00 stddev:31.89 (51.4%) stddev-sans-first:33.56 06:34:32 INFO - PROCESS | 1673 | Values: 69.0 84.0 74.0 144.0 59.0 59.0 59.0 65.0 133.0 57.0 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:98.30 Median:68.00 stddev:24.62 (36.2%) stddev-sans-first:23.37 06:34:32 INFO - PROCESS | 1673 | Values: 67.0 69.0 118.0 87.0 102.0 103.0 150.0 98.0 81.0 108.0 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:103.10 Median:86.50 stddev:21.14 (24.4%) stddev-sans-first:21.88 06:34:32 INFO - PROCESS | 1673 | Values: 90.0 87.0 113.0 129.0 84.0 131.0 134.0 87.0 90.0 86.0 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:97.90 Median:96.00 stddev:4.53 (4.7%) stddev-sans-first:4.76 06:34:32 INFO - PROCESS | 1673 | Values: 96.0 109.0 95.0 96.0 97.0 96.0 96.0 96.0 103.0 95.0 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:108.80 Median:88.00 stddev:23.17 (26.3%) stddev-sans-first:23.67 06:34:32 INFO - PROCESS | 1673 | Values: 91.0 103.0 92.0 95.0 97.0 121.0 85.0 149.0 148.0 107.0 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.08 (1.9%) stddev-sans-first:1.13 06:34:32 INFO - PROCESS | 1673 | Values: 56.0 55.0 57.0 54.0 56.0 55.0 57.0 56.0 55.0 54.0 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:76.70 Median:73.00 stddev:9.56 (13.1%) stddev-sans-first:9.47 06:34:32 INFO - PROCESS | 1673 | Values: 67.0 72.0 73.0 81.0 101.0 80.0 77.0 70.0 73.0 73.0 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:94.90 Median:80.50 stddev:11.73 (14.6%) stddev-sans-first:12.18 06:34:32 INFO - PROCESS | 1673 | Values: 88.0 111.0 85.0 88.0 77.0 84.0 102.0 106.0 106.0 102.0 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:142.00 stddev:15.23 (10.7%) stddev-sans-first:16.06 06:34:32 INFO - PROCESS | 1673 | Values: 141.0 143.0 132.0 138.0 140.0 178.0 156.0 163.0 135.0 131.0 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:171.00 stddev:2.02 (1.2%) stddev-sans-first:2.12 06:34:32 INFO - PROCESS | 1673 | Values: 172.0 176.0 171.0 170.0 171.0 168.0 171.0 171.0 171.0 170.0 06:34:32 INFO - PROCESS | 1673 | 06:34:32 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:77.50 stddev:11.56 (14.9%) stddev-sans-first:11.55 06:34:32 INFO - PROCESS | 1673 | Values: 65.0 69.0 61.0 78.0 94.0 90.0 89.0 77.0 68.0 69.0 06:34:32 INFO - PROCESS | 1673 | -------- Summary: end -------- 06:34:32 INFO - PROCESS | 1673 | 06:34:33 INFO - TEST-INFO | 1673: exit 0 06:34:33 INFO - TEST-OK | kraken | took 59824ms 06:34:33 INFO - SUITE-END | took 1173s 06:34:33 INFO - Completed test suite (00:19:33) 06:34:33 INFO - javascript benchmark 06:34:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7358.444347388831, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3123.3753249350134, 3388.88138915138, 3444.328355970586, 3467.2892057128292, 3467.8959631211055, 5765.394633563478, 5843.0, 5863.58954873159, 5891.705414729257, 5945.078512830507, 5841.415858414167, 5843.152742852294, 5869.911951320723, 5890.705464726768, 5991.820245392634, 5202.661826981253, 5290.68255904647, 5307.708076055816, 5362.383325917511, 5441.401445840955, 5412.891742165154, 5433.646812957145, 5449.237106805051, 5479.479449452316, 5481.808136715215, 5150.4334523202415, 5200.24596433515, 5207.6875387476875, 5221.895562088775, 5260.395054568736, 5277.050130976423, 5296.09966305729, 5304.761285742113, 5320.148776195829, 5323.946760532383, 4395.450568678915, 5281.07581173297, 5339.5461385782255, 5345.919811202835, 5349.625526213166, 4454.443194600675, 4854.368932038848, 5784.363719990798, 5830.533557315404, 5886.323072846634, 6221.066839973995, 6232.9376706232815, 6258.499320054385, 6269.404406581368, 6275.121482992385, 5810.448007439287, 6091.14723938649, 6331.968340158316, 6348.555601107924, 6364.618122912594, 5927.91108133374, 6004.309504406961, 6022.126791615235, 6036.547258955596, 6068.544859135583, 6448.742050318028, 6449.838754031093, 6454.386833250834, 6466.579672321284, 6467.159269295055, 6225.159603453566, 6259.2488901332135, 6259.6870156492, 6266.122742816009, 6269.7178626961895, 5768.74040668171, 6158.907616385758, 6254.280757712831, 6271.466925311308, 6334.081558174039, 5927.407259274038, 6167.814965551041, 6168.691565421711, 6230.06549017651, 6235.189425374672, 6136.938630613726, 6161.784337548164, 6209.875802483925, 6232.594881332699, 6240.625562466266, 4229.809658565372, 4998.525140111684, 5077.847664570068, 5080.949190508121, 5115.87210319745, 3694.242680250542, 4560.110778398181, 4570.702904311209, 4582.95417045832, 4611.584957353787, 5894.879972805154, 5979.252593425822, 5992.490638295793, 5999.730012149376, 6011.09833524966, 6160.661163635953, 6253.405926436982, 6264.686765661699, 6290.24517057956, 6357.745690172342, 6001.159837622737, 6003.309619393738, 6006.219191505076, 6013.579049466583, 6018.759249630053, 5568.693721845338, 5576.832695019156, 5592.944070559323, 5604.355499117653, 5613.971930140405, 6304.968475157595, 6386.584871983307, 6423.132877061536, 6463.935360646521, 6507.446867016357, 6316.968415157895, 6317.936820631735, 6319.526035547445, 6341.112244285896, 6358.650274234961, 6423.0, 6437.839054023687, 6494.318096599978, 6494.707738151889, 6507.414332710079, 6142.590862071594, 6174.753009879554, 6207.099970504342, 6227.19046523949, 6264.0, 6092.543059270483, 6263.843403914939, 6289.433950944437, 6307.30619631831, 6317.0, 6167.599106058092, 6187.597806142587, 6190.845228869314, 6201.3178550358525, 6213.1922850029205, 6128.4790792783115, 6138.32709113608, 6157.922363586444, 6160.599561028519, 6215.96892015537, 6017.518598512196, 6088.969555152196, 6109.95128740435, 6179.3820617937845, 6186.628802271878, 6166.691665416801, 6171.871488430869, 6184.938150618436, 6201.503879689524, 6203.844903877439, 6047.213862197887, 6134.650895842834, 6141.424638644238, 6141.723622437091, 6195.566310358412], "value": 5779.8763106540955, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.97000179989203, 511.05454908419426, 529.862235818687, 536.6860386673795, 543.6031696861291, 30173.69826301739, 40997.59002409982, 41054.58945410545, 41090.58909410905, 41129.794351028206, 41858.37212441816, 42360.0, 42502.574974250245, 42538.36192457116, 42565.57434425655, 9520.857187142181, 9592.232621390307, 9611.471369074698, 9743.269254805882, 9753.658621948232, 9591.856122158173, 9623.855642165337, 9667.90332096677, 9689.176420004309, 9719.319647624669, 8485.95757021214, 9664.516774161299, 9691.660791872286, 9719.271054670893, 9775.071368220008, 8274.338052955749, 9496.287778416612, 9590.856137157949, 9675.080867317594, 9678.370905891095, 8043.55760433176, 9547.140757331805, 9582.13760761528, 9593.47235902025, 9602.183814375787, 39279.21441571181, 39335.60664393348, 39932.20135597272, 39939.20121597552, 40041.0, 2939.2357986923553, 3099.938001239985, 3327.7670563060597, 3502.3786822150337, 3566.982165089158, 30112.698873011428, 30184.09447716572, 31501.52747708786, 31589.84205078983, 32349.83825080883, 3115.43922094023, 3136.074857916897, 3141.3246152077186, 3161.3677264546955, 3252.317013427183, 452295.7385213086, 454137.0, 454964.0, 457881.0, 465275.0, 33065.17337066593, 33144.66855331464, 33188.50217246743, 33196.50205246923, 33282.16794580155, 31700.0, 34308.0, 34424.0, 34763.0, 35252.4136413862, 16359.836401635832, 16593.83406165947, 16736.83263167377, 16774.077425741456, 16777.412790552273, 12332.445039973223, 12674.302913339854, 12743.04427167966, 12813.910817580423, 12841.357932103358, 18711.90644046798, 18804.341848035252, 18813.15340809667, 18818.059097045094, 18870.056497175086, 8058.11360750317, 8181.795455113551, 8204.261616454547, 8209.38429617781, 8219.69848442425, 753.5177486408703, 917.9954100229456, 1023.81059503992, 1071.4374953149502, 1103.1615971861443, 28586.856525738738, 29590.556141657893, 29679.85160074186, 29826.85086574553, 30330.0, 1046.3930920066343, 1074.9247552671238, 1079.4171147580375, 1142.7714457108445, 1228.4778968938344, 13241.337933103307, 15308.387664493295, 15652.0, 15760.054396736232, 15923.761143582855, 637366.0, 642459.0, 643220.0, 645160.0, 651746.0, 58522.12216816751, 58745.70627146837, 59200.703996479744, 59271.40728592659, 59551.10673339817, 1350.210127075652, 1382.2328607622867, 1405.866442687943, 1408.6688079764524, 1411.1462565148142, 24758.752412475646, 27410.72589274082, 28167.873285068366, 28249.293767655974, 28748.568771468865, 49166.50833491762, 50416.0, 50563.0, 50703.23945140752, 50914.23628645647, 439701.0, 440927.0, 441104.79447602556, 442881.0, 443799.0, 23150.536989259785, 26075.217743467725, 26600.467990640467, 27004.91980320844, 27299.04453344203, 45738.85652858705, 47715.76142119406, 48078.27882581694, 48308.27537586869, 49223.0, 39863.60136398599, 40256.59743402646, 40601.0, 40904.79547602243, 41592.1681566373, 39632.801835990635, 39750.2049959005, 39919.60080399159, 40705.982350441474, 41093.1781364377, 29181.7081829179, 38647.0, 38878.222435551696, 38997.0, 39098.0, 33951.4907276396, 34697.0, 35151.47272790859, 35215.295694085464, 36192.81903590465, 25771.871140644176, 25880.61179082353, 26030.0, 26081.217563473125, 26283.474330513665], "value": 19187.419909185326, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.32503192848026, 367.8528588564574, 375.20456631940283, 384.18744355687727, 399.68824317032727, 20344.89827550862, 21156.047977840997, 21299.467513312175, 22068.22761203358, 22314.330570082882, 20399.694004589943, 20421.795782042176, 20676.586468270627, 20721.378358649228, 20935.581288374262, 4892.633052521057, 4961.8511444656715, 5900.586958912878, 5971.34315225327, 6104.08438734189, 5006.299118123466, 5893.145493903381, 5966.492848107916, 6067.02927531595, 6072.332043475214, 5694.857628559298, 5852.063669812831, 5860.794872179475, 5925.822225333247, 5985.311689155737, 5574.832755017315, 5821.27234095738, 5824.475797178275, 5834.620749651259, 5851.707414629294, 4396.164728701537, 5044.14249577569, 5108.923366149511, 5171.01750667372, 5182.922256166161, 21288.0, 26590.6011409829, 26612.733872661414, 26637.200883973514, 27058.052968146218, 1995.281698588507, 2203.5923354179367, 2230.2194232018824, 2253.605619016682, 2461.1509029384833, 12705.936470317682, 15255.847441525553, 15578.454754083667, 15734.685306293924, 16348.427805026886, 1777.191377923042, 1798.3705703003975, 1806.5573934386027, 1860.3302810988034, 1980.5640910340032, 122218.77781222163, 124837.0, 125235.0, 127136.72863271434, 127352.0, 9457.10157535033, 9975.551100200508, 10023.2482563808, 10157.9492102539, 10414.218933580012, 11867.76264474723, 12077.818832717516, 12245.510179592717, 12257.325847078497, 12311.0, 6831.863362732717, 7969.282764551218, 8055.0, 8125.4718443301, 8148.0, 8440.40917135807, 8526.062133165347, 8553.657853685783, 8589.656413743505, 8666.436681615674, 3152.511360739089, 3842.1547259602844, 3894.415837624379, 3908.5700572936953, 3928.5874983126932, 1625.2929975460477, 1889.338731444011, 1891.489297889562, 1935.0614951748391, 1938.951526211856, 874.501534125555, 906.8911730592239, 930.3022732950287, 1013.8479228115841, 1037.9672226135044, 18354.541136471697, 20268.493287667632, 21534.892325538272, 21551.2457064002, 21669.458263543536, 760.8891019112048, 926.6478738079621, 934.2946075712794, 942.8020115775627, 971.3928794503436, 10336.741581460523, 10944.945275273732, 11153.498092585853, 11413.60052398162, 11510.424478776027, 593670.0316498476, 605636.0, 607049.0, 609440.0, 610200.0, 83566.0, 115925.0, 120122.0, 127763.36118319348, 138472.0, 980.2452111873818, 1022.6676330192718, 1049.8740151181908, 1052.7157667429751, 1053.1890444357955, 19905.502362440475, 20180.59638807245, 20181.697274541188, 20221.39335819928, 20340.982950852103, 56058.59853503532, 56921.715391422775, 57469.0, 57509.712451437474, 58107.709461452425, 81775.18224817913, 82368.0, 82510.58744706238, 82872.0, 83907.54860561901, 8142.674293028213, 8201.42590018693, 8277.54473503963, 8407.2433480987, 8414.747557573282, 11875.703107422383, 13025.413856376676, 13065.542706005244, 13478.123921945042, 13549.525766598515, 11385.772284554429, 11421.657350279505, 11683.707907302385, 11745.354005529436, 11756.882431175922, 10980.670579882617, 10999.450027498753, 11424.48589813477, 11560.595379161688, 11643.301401915913, 10372.858985511437, 11451.59919402817, 11593.420328983348, 11959.222650527689, 12039.458224379749, 8202.302804261466, 8282.58587070632, 8295.04606970206, 8341.541215233221, 8419.7791320257, 9508.477033763209, 11689.084156807565, 11748.823767643664, 11799.52801887915, 11863.58477453285], "value": 9577.953811892328, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1510.5845892379593, 1544.8223454302754, 1719.4669652407754, 1817.3639226270807, 1841.2082804394106, 7887.960560197205, 8343.290820280276, 8432.578371081452, 8899.110088991098, 8916.108389161082, 7063.399611033055, 8710.21608055275, 8711.346649001318, 8715.346349023817, 8733.0, 2298.9540209195807, 2329.6039673255505, 2351.670766092748, 2352.435415500276, 2358.50471401006, 2323.1520495019367, 2342.9531409371803, 2369.1115831563166, 2374.489484760776, 2377.358113309414, 2344.9882750586307, 2350.6591544226076, 2353.2587235020915, 2358.3278765551822, 2362.9291121266388, 2320.1067588978194, 2331.0559223514506, 2334.6498025296255, 2344.050659482912, 2350.670906073151, 2311.3297143828268, 2333.171724037959, 2335.4511689752894, 2342.3090188394463, 2347.1667558016998, 7534.246575342422, 8705.738827835175, 8735.519546424945, 8793.956030219808, 8809.38334316598, 5115.974420127875, 5166.689998600058, 5170.534651881311, 5241.292425522543, 5282.894342113136, 2907.331313797817, 3379.5944486661756, 3531.1878267998504, 3570.589382221052, 3580.874669386585, 1045.8412600310965, 1075.4031512510553, 1090.1987039525943, 1093.7211011192096, 1100.0539535999035, 11409.54361825526, 11433.542658293742, 11487.540498380054, 11491.42542872853, 11503.654890353386, 4503.954960450354, 4591.678582499259, 4751.216049351819, 4751.738654374042, 4757.977034937436, 9714.659986900566, 9770.169535589412, 9779.119879210904, 9786.0, 9788.657396991071, 5095.5159259871, 5237.371515418098, 5254.7635356409055, 5283.6037297202865, 5297.125974214288, 4348.0869017506675, 4687.929681054787, 4810.95189048105, 4831.661783675179, 4832.782524786393, 3359.882404115844, 3824.6175382461533, 3907.7264591478893, 3917.4319723639915, 4011.91976160481, 1278.7314663920495, 1286.9935650321875, 1295.3264302562802, 1295.3393769177599, 1301.8502872169631, 793.8769490728946, 803.9508441483803, 892.4511425473416, 930.418488444722, 978.848278516831, 5770.451807078321, 5954.732037058343, 6057.303410107894, 6096.0, 6154.907676384858, 442.26142342288455, 914.7210100919284, 947.2564037230741, 1040.7450174707244, 1062.1874266186373, 4012.467273407306, 4029.7783621901076, 4039.5602428509324, 4125.030617804813, 4145.108801607669, 10476.63331783384, 10819.026287633993, 10838.403887786248, 10845.783084338269, 10865.076468500109, 9476.620935162655, 10609.257351985287, 10695.625653102104, 10775.83836242457, 10845.240833141605, 7857.135715071452, 7951.642176102089, 7966.681332746741, 7989.360851132012, 8000.799880018044, 5708.80019199326, 5841.415858414294, 5968.880622387441, 5979.850503737442, 6054.8183554493435, 9789.804203915739, 9956.900430995887, 10022.398656080659, 10040.64857729976, 10056.748581285234, 8582.742517724479, 9541.0, 9734.02659734021, 9942.453165075991, 10023.248256380655, 6853.417459515997, 7391.963040184764, 7555.09338879338, 7837.529748215125, 7954.00574928134, 8141.959290203511, 8325.625346859528, 8335.291500222549, 8336.62485188156, 8357.832843342978, 7187.928120718726, 7381.778546643609, 7439.070116235471, 7500.812479688051, 7538.660760265691, 7200.207977122408, 7279.672414741455, 7377.631118444164, 7418.258174182539, 7419.517731347445, 6893.172819261721, 6904.102466679299, 6970.198427180939, 6996.685149168198, 7044.647767611701, 4905.092557876804, 4910.337104490848, 4957.0581589499325, 5027.673201241908, 5064.316317297265, 5013.072581572421, 5084.85584248836, 5106.923396148986, 5222.321098257202, 5261.947380526146], "value": 4554.88625443372, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.62162540075707, 308.61577336216413, 310.75139888089535, 312.6841889691412, 314.7959056608473, 5038.848834534961, 5524.475174858387, 5599.32808063032, 5611.859703507414, 5613.410591887854, 4719.528047195278, 5475.753591088401, 5523.917141242885, 5537.695426751527, 5581.916271255935, 3978.9005274868214, 4085.101277718897, 4143.7513749175, 4179.892328532941, 4187.7277976931555, 3589.910252243689, 3789.924201515968, 3809.447630093635, 4014.7554258180057, 4212.473440819897, 4157.355609880473, 4158.334666453368, 4167.666586673059, 4190.518090419595, 4223.197592457439, 3725.2177042820767, 4079.2861249281405, 4111.732737372061, 4158.168366326747, 4202.768847713374, 3096.9315586122752, 3148.7008734170217, 3519.260955199411, 3575.87484438046, 3630.3283892479712, 4305.31115021595, 5337.412884582693, 5340.839774806723, 5380.946190538084, 5385.192221166817, 4186.413902053715, 4708.788104535304, 4711.505291944365, 4838.250071238928, 4856.344393506866, 4547.522510136421, 4885.487023862479, 5804.227252286006, 5811.360750317462, 5819.301683797971, 4048.4939382577177, 4068.715189936676, 4072.5927407259333, 4077.7572335215514, 4097.385392191165, 5390.0, 5768.538516918637, 6058.242719660087, 6117.174181485487, 6141.4472697456995, 3838.347480928249, 3924.0386105403786, 3938.7636741795586, 4120.299549076604, 4152.43942067817, 4197.202531519001, 4215.936760948588, 4226.408302837605, 4242.151569686075, 4255.255330317182, 4234.280172370704, 4697.0, 4880.341153944172, 4912.582430493377, 4914.827981020719, 5495.560355171577, 5898.9058884096385, 5906.350301466835, 5927.792527261611, 5939.227900372924, 1418.3901272056085, 1447.986409513324, 1453.5929939616924, 1457.271364317841, 1461.4300422835104, 755.112742527528, 828.5857071464268, 897.1566727276339, 901.9549022548978, 904.0823564082461, 4420.359047938031, 5263.6578622389425, 5363.525030616612, 5393.759435329817, 5418.160185171305, 4559.6808223424705, 5497.202905578669, 6010.368911264254, 6016.548758843104, 6039.849003774941, 5078.949210507848, 5220.486059042911, 5373.731313434313, 5455.699936503531, 5473.808416705396, 2508.849469031864, 2963.4073185363013, 3133.3393301550213, 3148.464760990637, 3184.9203769905475, 5414.729263536808, 5571.0807716727095, 6221.129041934133, 6237.877182107264, 6272.0, 5151.845444636667, 5836.854078648068, 6038.026079877748, 6056.606320589236, 6210.937890621126, 5419.241306217212, 5570.777168913279, 5906.763729450774, 6237.781677641261, 6256.871564217891, 5742.569307302053, 5800.596434295475, 5923.614965027259, 5982.683809562063, 6024.951516484241, 5082.872928176826, 5802.767889284381, 5952.553558483044, 5961.4038596140035, 5973.313068996948, 5110.514501122388, 6036.63780173191, 6211.254649442096, 6222.09779581949, 6250.406211409909, 3026.803257788237, 3994.420808982623, 4008.579099194543, 4009.218202450494, 4049.230646177217, 5333.253344531691, 6037.516998640011, 6046.90929636047, 6070.423309785563, 6080.087986802015, 5029.06962211992, 5072.67027643202, 5094.363204599425, 5571.60998730085, 5893.852653683693, 5001.674891132065, 5748.338941021836, 5842.415758424124, 5842.705611375551, 5842.941570584409, 4687.406341785138, 5699.430056994267, 5713.0, 5723.341815691082, 5742.822721342199, 5656.9717151415625, 5706.288113565831, 5853.502452291603, 5879.5002424794375, 5918.23063001807, 4767.7603823005575, 5221.929504451502, 5305.549028332635, 5489.670619762827, 5804.1874137619925], "value": 4223.707216024153, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.3683129936107, 696.3454352908266, 712.5475323169787, 735.474135992765, 745.5265906149593, 14707.117572945617, 15107.320170592322, 15503.0, 15526.456574019912, 15564.610884727888, 13556.389962451689, 13803.2408217548, 13915.930420347884, 13929.791053134211, 13941.651458713537, 675.1729131813514, 796.9601519924009, 841.6675413211777, 858.6608289725555, 863.4517081653132, 858.9785255368603, 865.5066612031145, 868.9739307820744, 871.424859592669, 871.538084815049, 916.1342531307916, 926.4950601921935, 927.5130556457846, 928.3130483442238, 928.3547934185743, 887.7203680840514, 908.9045650206765, 909.0, 919.9834183227538, 920.6409500294891, 674.6862708840364, 675.9763408280686, 682.6313790553095, 691.6541729135432, 692.5671455340412, 13805.723885522233, 14002.229877356742, 14063.859361406357, 14259.429622815074, 14278.714425711427, 14606.780898286534, 14606.780898286534, 14649.487267945571, 14726.558203253919, 14891.553253402308, 11810.763784724344, 11974.22167559106, 11985.28088314704, 12004.759904801855, 12153.149279550435, 3845.3078445879732, 3857.8071096445346, 3874.8643797466952, 3892.124272038797, 4001.559828418872, 117697.0, 119181.0, 119636.40181799035, 120172.0, 122142.38928805388, 11018.0, 11172.050375717992, 11205.439728013567, 11213.775724485464, 11460.656180314603, 22079.779202208094, 22680.0, 22805.429864253525, 22960.311190664306, 23012.4246893829, 7987.8402431951035, 8092.554909479917, 8120.147384524658, 8267.958660206661, 8336.958315208507, 4498.347739577743, 4522.728636281834, 4577.29051996941, 4582.541745825458, 4656.301554766812, 3539.9292014159573, 3580.6240344763946, 3635.94546081809, 3651.3245049665898, 3654.470101835219, 563.2621266141368, 655.429776094791, 658.8601719026111, 659.0, 659.0312241005714, 550.4577990679178, 596.5287422935833, 635.4217661927623, 638.4030931079456, 660.244020596424, 8038.316743076787, 9509.381890177116, 9590.376625519319, 9593.088656577615, 9599.136077752895, 540.0710777462758, 603.6589327030214, 664.139938779282, 676.3743537228045, 698.7205117952859, 3794.29805485986, 4152.730072545275, 4399.739200979444, 4626.0, 4815.398075240595, 99740.0, 140429.59570404165, 149684.0, 164466.3553364451, 168972.0, 137581.0, 137881.0, 138919.0, 143136.28431857983, 154908.22545887198, 116272.09319766905, 127617.36191318984, 129046.35476822744, 130717.15717901482, 133499.66500334872, 8375.748727538183, 9297.907020929704, 9369.625214991323, 9386.812263754824, 9462.526873656427, 49082.26376604282, 53792.0, 55075.44924550703, 57527.7123614396, 67355.66322168357, 53506.73246633742, 60301.69849150726, 61004.694976524836, 84537.0, 89828.55085724792, 13124.241298154342, 13726.176429414267, 13783.241921694404, 13874.722505550035, 13874.93062534681, 15472.767908481606, 15994.600134996717, 16326.673466530365, 16446.424375146813, 16478.67042659164, 11399.544018239178, 12004.519819207484, 12459.813102803646, 12495.187812792139, 12528.37358132108, 11893.524259029542, 12084.0, 12501.874981250072, 12530.561430349893, 12903.0, 9793.412395256308, 13925.442982281, 14123.576292711236, 14375.496857609933, 14519.782203266748, 9849.803003940024, 10906.291091079054, 10943.98288888674, 11090.780014198594, 11201.495932682887, 7647.961760191163, 8424.794182149455, 10449.16406687448, 11563.6530904073, 11657.53369865196], "value": 7767.724020098805, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 121.0, 110.0, 117.0, 118.0, 116.0, 114.0, 116.0, 119.0, 117.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 111.0, 126.0, 154.0, 109.0, 128.0, 129.0, 114.0, 154.0, 111.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 198.0, 188.0, 200.0, 202.0, 224.0, 192.0, 193.0, 193.0, 195.0], "value": 198.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 84.0, 74.0, 144.0, 59.0, 59.0, 59.0, 65.0, 133.0, 57.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 118.0, 87.0, 102.0, 103.0, 150.0, 98.0, 81.0, 108.0], "value": 98.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 113.0, 129.0, 84.0, 131.0, 134.0, 87.0, 90.0, 86.0], "value": 103.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 109.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 103.0, 95.0], "value": 97.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 103.0, 92.0, 95.0, 97.0, 121.0, 85.0, 149.0, 148.0, 107.0], "value": 108.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 54.0, 56.0, 55.0, 57.0, 56.0, 55.0, 54.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 73.0, 81.0, 101.0, 80.0, 77.0, 70.0, 73.0, 73.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 111.0, 85.0, 88.0, 77.0, 84.0, 102.0, 106.0, 106.0, 102.0], "value": 94.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 143.0, 132.0, 138.0, 140.0, 178.0, 156.0, 163.0, 135.0, 131.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 176.0, 171.0, 170.0, 171.0, 168.0, 171.0, 171.0, 171.0, 170.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 61.0, 78.0, 94.0, 90.0, 89.0, 77.0, 68.0, 69.0], "value": 76.0, "unit": "score"}]}]} 06:34:33 INFO - Return code: 0 06:34:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:34:33 ERROR - # TBPL SUCCESS # 06:34:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:34:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:34:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:34:33 INFO - 2016-08-05 06:34:33.788 screenresolution[1678:10491] starting screenresolution argv=screenresolution get 06:34:33 INFO - 2016-08-05 06:34:33.791 screenresolution[1678:10491] Display 0: 1600x1200x32@60 06:34:33 INFO - 2016-08-05 06:34:33.797 screenresolution[1679:10494] starting screenresolution argv=screenresolution list 06:34:33 INFO - Available Modes on Display 0 06:34:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:34:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:34:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:34:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:34:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:34:34 INFO - Intel Iris: 06:34:34 INFO - Chipset Model: Intel Iris 06:34:34 INFO - Type: GPU 06:34:34 INFO - Bus: Built-In 06:34:34 INFO - VRAM (Dynamic, Max): 1536 MB 06:34:34 INFO - Vendor: Intel (0x8086) 06:34:34 INFO - Device ID: 0x0a2e 06:34:34 INFO - Revision ID: 0x0009 06:34:34 INFO - Displays: 06:34:34 INFO - Display: 06:34:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:34:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:34:34 INFO - Display Serial Number: 1600x1200 60 06:34:34 INFO - Main Display: Yes 06:34:34 INFO - Mirror: Off 06:34:34 INFO - Online: Yes 06:34:34 INFO - Rotation: Supported 06:34:34 INFO - Return code: 0 06:34:34 INFO - Running post-action listener: _resource_record_post_action 06:34:34 INFO - [mozharness: 2016-08-05 13:34:34.036060Z] Finished run-tests step (success) 06:34:34 INFO - Running post-run listener: _resource_record_post_run 06:34:34 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37200896; Write bytes: 705640960; Read time: 239; Write time: 2025 06:34:34 INFO - TinderboxPrint: CPU usage
54.3% 06:34:34 INFO - TinderboxPrint: I/O read bytes / time
37,200,896 / 239 06:34:34 INFO - TinderboxPrint: I/O write bytes / time
705,640,960 / 2,025 06:34:34 INFO - TinderboxPrint: CPU idle
2,207.5 (45.7%) 06:34:34 INFO - TinderboxPrint: CPU system
974.1 (20.2%) 06:34:34 INFO - TinderboxPrint: CPU user
1,652.1 (34.2%) 06:34:34 INFO - TinderboxPrint: Swap in / out
441,667,584 / 0 06:34:34 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 396100096; Write bytes: 392257024; Read time: 29565; Write time: 844 06:34:34 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 35197952; Write bytes: 295603200; Read time: 221; Write time: 1138 06:34:34 INFO - Running post-run listener: _upload_blobber_files 06:34:34 INFO - Blob upload gear active. 06:34:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:34:34 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 06:34:34 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'] 06:34:34 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 06:34:34 INFO - (blobuploader) - INFO - Open directory for files ... 06:34:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:34:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:34:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:35 INFO - (blobuploader) - INFO - Done attempting. 06:34:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:34:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:34:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:36 INFO - (blobuploader) - INFO - Done attempting. 06:34:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:34:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:34:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:41 INFO - (blobuploader) - INFO - Done attempting. 06:34:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:34:41 INFO - Return code: 0 06:34:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:34:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:34:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a796fc6e5a6818d2b129c07e48afbac53e6497d57d29082e74f9cb7c86e29cec01436677b2ddf46344917f97a6cd2f04b886fa633fe183b5f77f94d5efb445e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0fcd2e46cf36ec7653328c63a22450097cde04bca8e2034bb8863004377eca08fe02dc600cd59a0ae37c070406701b284777c4dafa4387105a3cb400ae1a104e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5ac2fdb19641a85c3f2a7eba108a6d839b2833d1be7b5d77f8c2a49bec351629892b63ede04c4ba8992bcbc35f2feb929ad609c4a3956923758bd6d337bda28"} 06:34:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:34:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:34:41 INFO - Contents: 06:34:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a796fc6e5a6818d2b129c07e48afbac53e6497d57d29082e74f9cb7c86e29cec01436677b2ddf46344917f97a6cd2f04b886fa633fe183b5f77f94d5efb445e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0fcd2e46cf36ec7653328c63a22450097cde04bca8e2034bb8863004377eca08fe02dc600cd59a0ae37c070406701b284777c4dafa4387105a3cb400ae1a104e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5ac2fdb19641a85c3f2a7eba108a6d839b2833d1be7b5d77f8c2a49bec351629892b63ede04c4ba8992bcbc35f2feb929ad609c4a3956923758bd6d337bda28"} 06:34:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:34:41 INFO - Copying logs to upload dir... 06:34:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:34:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.481021 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-05 06:34:41.187535) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 06:34:41.191177) ========= 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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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/a796fc6e5a6818d2b129c07e48afbac53e6497d57d29082e74f9cb7c86e29cec01436677b2ddf46344917f97a6cd2f04b886fa633fe183b5f77f94d5efb445e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0fcd2e46cf36ec7653328c63a22450097cde04bca8e2034bb8863004377eca08fe02dc600cd59a0ae37c070406701b284777c4dafa4387105a3cb400ae1a104e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5ac2fdb19641a85c3f2a7eba108a6d839b2833d1be7b5d77f8c2a49bec351629892b63ede04c4ba8992bcbc35f2feb929ad609c4a3956923758bd6d337bda28"} build_url:https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010825 build_url: 'https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a796fc6e5a6818d2b129c07e48afbac53e6497d57d29082e74f9cb7c86e29cec01436677b2ddf46344917f97a6cd2f04b886fa633fe183b5f77f94d5efb445e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0fcd2e46cf36ec7653328c63a22450097cde04bca8e2034bb8863004377eca08fe02dc600cd59a0ae37c070406701b284777c4dafa4387105a3cb400ae1a104e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5ac2fdb19641a85c3f2a7eba108a6d839b2833d1be7b5d77f8c2a49bec351629892b63ede04c4ba8992bcbc35f2feb929ad609c4a3956923758bd6d337bda28"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 06:34:41.228027) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 06:34:41.228342) ========= 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.rIR5tiHzJf/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.OyAqIbY9ha/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.005112 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 06:34:41.378569) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 06:34:41.378888) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 06:34:41.379241) ========= ========= Total master_lag: 0.28 =========