builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0062 starttime: 1471995804.46 results: success (0) buildid: 20160823145014 builduid: 768790183eed48899efdec01509f26ce revision: 3f7afc56fae2a3bdc25fb25a3f69d62b32a54c94 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 16:43:24.456395) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 16:43:24.456816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 16:43:24.457181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 16:43:24.683695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 16:43:24.683944) ========= 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.lsMhZL8HmI/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.O4XHgHCP13/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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-23 16:43:24-- 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% 61.3M=0s 2016-08-23 16:43:25 (61.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.518493 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 16:43:25.229254) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 16:43:25.229642) ========= 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.lsMhZL8HmI/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.O4XHgHCP13/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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.027531 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 16:43:25.279081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 16:43:25.279455) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3f7afc56fae2a3bdc25fb25a3f69d62b32a54c94 --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 3f7afc56fae2a3bdc25fb25a3f69d62b32a54c94 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lsMhZL8HmI/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.O4XHgHCP13/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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-23 16:43:25,354 truncating revision to first 12 chars 2016-08-23 16:43:25,354 Setting DEBUG logging. 2016-08-23 16:43:25,354 attempt 1/10 2016-08-23 16:43:25,354 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3f7afc56fae2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 16:43:25,687 unpacking tar archive at: fx-team-3f7afc56fae2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.589967 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 16:43:25.891083) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 16:43:25.891365) ========= script_repo_revision: 3f7afc56fae2a3bdc25fb25a3f69d62b32a54c94 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 16:43:25.891749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 16:43:25.892011) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 16:43:25.910591) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-23 16:43:25.910890) ========= /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.lsMhZL8HmI/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.O4XHgHCP13/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:43:26 INFO - MultiFileLogger online at 20160823 16:43:26 in /builds/slave/test 16:43:26 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 16:43:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:43:26 INFO - {'append_to_log': False, 16:43:26 INFO - 'base_work_dir': '/builds/slave/test', 16:43:26 INFO - 'blob_upload_branch': 'Fx-Team', 16:43:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:43:26 INFO - 'branch': 'Fx-Team', 16:43:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:43:26 INFO - 'config_files': ('talos/mac_config.py',), 16:43:26 INFO - 'default_actions': ('clobber', 16:43:26 INFO - 'read-buildbot-config', 16:43:26 INFO - 'download-and-extract', 16:43:26 INFO - 'populate-webroot', 16:43:26 INFO - 'create-virtualenv', 16:43:26 INFO - 'install', 16:43:26 INFO - 'run-tests'), 16:43:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:43:26 INFO - 'download_minidump_stackwalk': True, 16:43:26 INFO - 'download_symbols': 'ondemand', 16:43:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:43:26 INFO - 'tooltool.py': '/tools/tooltool.py', 16:43:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:43:26 INFO - '/tools/misc-python/virtualenv.py')}, 16:43:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:43:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:43:26 INFO - 'installer_path': 'installer.exe', 16:43:26 INFO - 'log_level': 'info', 16:43:26 INFO - 'log_name': 'talos', 16:43:26 INFO - 'log_to_console': True, 16:43:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:43:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:43:26 INFO - 'opt_config_files': (), 16:43:26 INFO - 'pip_index': False, 16:43:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:43:26 INFO - 'cmd': ('bash', 16:43:26 INFO - '-c', 16:43:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:43:26 INFO - 'enabled': True, 16:43:26 INFO - 'halt_on_failure': False, 16:43:26 INFO - 'name': 'check_screen_resolution'},), 16:43:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:43:26 INFO - 'cmd': ('bash', 16:43:26 INFO - '-c', 16:43:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:43:26 INFO - 'enabled': True, 16:43:26 INFO - 'halt_on_failure': False, 16:43:26 INFO - 'name': 'check_screen_resolution'},), 16:43:26 INFO - 'run_cmd_checks_enabled': True, 16:43:26 INFO - 'sps_profile': False, 16:43:26 INFO - 'sps_profile_interval': 0, 16:43:26 INFO - 'suite': 'dromaeojs-e10s', 16:43:26 INFO - 'system_bits': '32', 16:43:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:43:26 INFO - 'title': 't-yosemite-r7-0062', 16:43:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:43:26 INFO - 'use_talos_json': True, 16:43:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:43:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:43:26 INFO - 'work_dir': 'build'} 16:43:26 INFO - [mozharness: 2016-08-23 23:43:26.108687Z] Running clobber step. 16:43:26 INFO - Running pre-action listener: _resource_record_pre_action 16:43:26 INFO - Running main action method: clobber 16:43:26 INFO - rmtree: /builds/slave/test/build 16:43:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:43:28 INFO - Running post-action listener: _resource_record_post_action 16:43:28 INFO - [mozharness: 2016-08-23 23:43:28.224359Z] Finished clobber step (success) 16:43:28 INFO - [mozharness: 2016-08-23 23:43:28.224529Z] Running read-buildbot-config step. 16:43:28 INFO - Running pre-action listener: _resource_record_pre_action 16:43:28 INFO - Running main action method: read_buildbot_config 16:43:28 INFO - Using buildbot properties: 16:43:28 INFO - { 16:43:28 INFO - "project": "", 16:43:28 INFO - "product": "firefox", 16:43:28 INFO - "script_repo_revision": "production", 16:43:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:43:28 INFO - "repository": "", 16:43:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:43:28 INFO - "buildid": "20160823145014", 16:43:28 INFO - "pgo_build": "False", 16:43:28 INFO - "basedir": "/builds/slave/test", 16:43:28 INFO - "buildnumber": 768, 16:43:28 INFO - "slavename": "t-yosemite-r7-0062", 16:43:28 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:43:28 INFO - "platform": "yosemite_r7", 16:43:28 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 16:43:28 INFO - "branch": "fx-team", 16:43:28 INFO - "repo_path": "integration/fx-team", 16:43:28 INFO - "revision": "3f7afc56fae2a3bdc25fb25a3f69d62b32a54c94", 16:43:28 INFO - "stage_platform": "macosx64", 16:43:28 INFO - "builduid": "768790183eed48899efdec01509f26ce", 16:43:28 INFO - "slavebuilddir": "test" 16:43:28 INFO - } 16:43:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 16:43:28 INFO - Running post-action listener: _resource_record_post_action 16:43:28 INFO - [mozharness: 2016-08-23 23:43:28.227893Z] Finished read-buildbot-config step (success) 16:43:28 INFO - [mozharness: 2016-08-23 23:43:28.228036Z] Running download-and-extract step. 16:43:28 INFO - Running pre-action listener: _resource_record_pre_action 16:43:28 INFO - Running main action method: download_and_extract 16:43:28 INFO - mkdir: /builds/slave/test/build/tests 16:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:28 INFO - trying https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 16:43:28 INFO - Downloading https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/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 16:43:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/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 16:43:29 INFO - Downloaded 1199 bytes. 16:43:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:43:29 INFO - Using the following test package requirements: 16:43:29 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:43:29 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:43:29 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 16:43:29 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:43:29 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 16:43:29 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:43:29 INFO - u'jsshell-mac.zip'], 16:43:29 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:43:29 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 16:43:29 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:43:29 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:43:29 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 16:43:29 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:43:29 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 16:43:29 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:43:29 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 16:43:29 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:43:29 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 16:43:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:29 INFO - trying https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:43:29 INFO - Downloading https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/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 16:43:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/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 16:43:30 INFO - Downloaded 16346134 bytes. 16:43:30 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 16:43:37 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 16:43:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:37 INFO - trying https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:43:37 INFO - Downloading https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/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 16:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/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 16:43:38 INFO - Downloaded 16346134 bytes. 16:43:38 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 16:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:44 INFO - trying https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 16:43:44 INFO - Downloading https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/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 16:43:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/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 16:43:45 INFO - Downloaded 14413981 bytes. 16:43:45 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 16:43:46 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')]} 16:43:46 INFO - trying https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:43:46 INFO - Downloading https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 16:43:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/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 16:43:48 INFO - Downloaded 111484248 bytes. 16:43:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:43:48 INFO - mkdir: /builds/slave/test/properties 16:43:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:43:48 INFO - Writing to file /builds/slave/test/properties/build_url 16:43:48 INFO - Contents: 16:43:48 INFO - build_url:https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:43:49 INFO - Running post-action listener: _resource_record_post_action 16:43:49 INFO - Running post-action listener: set_extra_try_arguments 16:43:49 INFO - [mozharness: 2016-08-23 23:43:49.452500Z] Finished download-and-extract step (success) 16:43:49 INFO - [mozharness: 2016-08-23 23:43:49.452630Z] Running populate-webroot step. 16:43:49 INFO - Running pre-action listener: _resource_record_pre_action 16:43:49 INFO - Running main action method: populate_webroot 16:43:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:43:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:43:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:43:49 INFO - '--tppagecycles', 16:43:49 INFO - '7'], 16:43:49 INFO - 'tests': ['tsvgm']}}, 16:43:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:43:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:43:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:43:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:43:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:43:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:43:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:49 INFO - 'talos_options': ['--disable-e10s'], 16:43:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:49 INFO - 'talos_options': ['--disable-e10s'], 16:43:49 INFO - 'tests': ['damp', 'tps']}, 16:43:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:49 INFO - 'tests': ['damp', 'tps']}, 16:43:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:43:49 INFO - 'tests': ['dromaeo_dom']}, 16:43:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:43:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:43:49 INFO - 'tests': ['basic_compositor_video']}, 16:43:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:43:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:43:49 INFO - 'tests': ['a11yr', 16:43:49 INFO - 'ts_paint', 16:43:49 INFO - 'tpaint', 16:43:49 INFO - 'sessionrestore', 16:43:49 INFO - 'sessionrestore_no_auto_restore', 16:43:49 INFO - 'tabpaint']}, 16:43:49 INFO - 'other-e10s': {'tests': ['a11yr', 16:43:49 INFO - 'ts_paint', 16:43:49 INFO - 'tpaint', 16:43:49 INFO - 'sessionrestore', 16:43:49 INFO - 'sessionrestore_no_auto_restore', 16:43:49 INFO - 'tabpaint']}, 16:43:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:43:49 INFO - 'ts_paint', 16:43:49 INFO - 'tpaint', 16:43:49 INFO - 'sessionrestore', 16:43:49 INFO - 'sessionrestore_no_auto_restore', 16:43:49 INFO - 'tabpaint']}, 16:43:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:43:49 INFO - 'ts_paint', 16:43:49 INFO - 'tpaint', 16:43:49 INFO - 'sessionrestore', 16:43:49 INFO - 'sessionrestore_no_auto_restore', 16:43:49 INFO - 'tabpaint']}, 16:43:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:43:49 INFO - 'tests': ['a11yr', 16:43:49 INFO - 'ts_paint', 16:43:49 INFO - 'tpaint', 16:43:49 INFO - 'sessionrestore', 16:43:49 INFO - 'sessionrestore_no_auto_restore', 16:43:49 INFO - 'tabpaint']}, 16:43:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:43:49 INFO - 'tests': ['a11yr', 16:43:49 INFO - 'ts_paint', 16:43:49 INFO - 'tpaint', 16:43:49 INFO - 'sessionrestore', 16:43:49 INFO - 'sessionrestore_no_auto_restore', 16:43:49 INFO - 'tabpaint']}, 16:43:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:43:49 INFO - 'tests': ['tsvgx', 16:43:49 INFO - 'tsvgr_opacity', 16:43:49 INFO - 'tart', 16:43:49 INFO - 'tscrollx', 16:43:49 INFO - 'cart']}, 16:43:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:43:49 INFO - 'tsvgr_opacity', 16:43:49 INFO - 'tart', 16:43:49 INFO - 'tscrollx', 16:43:49 INFO - 'cart']}, 16:43:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:49 INFO - 'talos_options': ['--disable-e10s'], 16:43:49 INFO - 'tests': ['tp5o']}, 16:43:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:49 INFO - 'tests': ['tp5o']}, 16:43:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:49 INFO - 'talos_options': ['--disable-e10s', 16:43:49 INFO - '--xperf_path', 16:43:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:49 INFO - 'tests': ['tp5n']}, 16:43:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:49 INFO - 'talos_options': ['--xperf_path', 16:43:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:49 INFO - 'tests': ['tp5n']}}, 16:43:49 INFO - 'talos.zip': {'path': '', 16:43:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:43:49 INFO - Running post-action listener: _resource_record_post_action 16:43:49 INFO - [mozharness: 2016-08-23 23:43:49.471322Z] Finished populate-webroot step (success) 16:43:49 INFO - [mozharness: 2016-08-23 23:43:49.471451Z] Running create-virtualenv step. 16:43:49 INFO - Running pre-action listener: _resource_record_pre_action 16:43:49 INFO - Running main action method: create_virtualenv 16:43:49 INFO - Creating virtualenv /builds/slave/test/build/venv 16:43:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:43:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:43:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:43:49 INFO - Using real prefix '/tools/python27' 16:43:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:43:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:43:53 INFO - Installing pip.................done. 16:43:53 INFO - Return code: 0 16:43:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b14ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac9358e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b2d30>, '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 0x10ae17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0aab20>, '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.lsMhZL8HmI/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.O4XHgHCP13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:43:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsMhZL8HmI/Render', 16:43:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:53 INFO - 'HOME': '/Users/cltbld', 16:43:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:53 INFO - 'LOGNAME': 'cltbld', 16:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:53 INFO - 'MOZ_NO_REMOTE': '1', 16:43:53 INFO - 'NO_EM_RESTART': '1', 16:43:53 INFO - 'PAGER': '/bin/cat', 16:43:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:53 INFO - 'PWD': '/builds/slave/test', 16:43:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:53 INFO - 'SHELL': '/bin/bash', 16:43:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O4XHgHCP13/Listeners', 16:43:53 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 16:43:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:53 INFO - 'USER': 'cltbld', 16:43:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:53 INFO - 'XPC_FLAGS': '0x0', 16:43:53 INFO - 'XPC_SERVICE_NAME': '0', 16:43:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:43:53 INFO - Cleaning up... 16:43:53 INFO - Return code: 0 16:43:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b14ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac9358e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b2d30>, '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 0x10ae17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0aab20>, '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.lsMhZL8HmI/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.O4XHgHCP13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:43:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsMhZL8HmI/Render', 16:43:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:53 INFO - 'HOME': '/Users/cltbld', 16:43:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:53 INFO - 'LOGNAME': 'cltbld', 16:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:53 INFO - 'MOZ_NO_REMOTE': '1', 16:43:53 INFO - 'NO_EM_RESTART': '1', 16:43:53 INFO - 'PAGER': '/bin/cat', 16:43:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:53 INFO - 'PWD': '/builds/slave/test', 16:43:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:53 INFO - 'SHELL': '/bin/bash', 16:43:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O4XHgHCP13/Listeners', 16:43:53 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 16:43:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:53 INFO - 'USER': 'cltbld', 16:43:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:53 INFO - 'XPC_FLAGS': '0x0', 16:43:53 INFO - 'XPC_SERVICE_NAME': '0', 16:43:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:53 INFO - Downloading/unpacking psutil>=3.1.1 16:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:43:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:43:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:43:57 INFO - Installing collected packages: psutil 16:43:57 INFO - Running setup.py install for psutil 16:43:57 INFO - building 'psutil._psutil_osx' extension 16:43:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:43:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:43:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:43:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:43:58 INFO - building 'psutil._psutil_posix' extension 16:43:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:43:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:43:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:43:58 INFO - ^ 16:43:58 INFO - 1 warning generated. 16:43:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:43:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:43:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:43:58 INFO - Successfully installed psutil 16:43:58 INFO - Cleaning up... 16:43:58 INFO - Return code: 0 16:43:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:58 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 0x10b14ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac9358e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b2d30>, '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 0x10ae17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0aab20>, '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.lsMhZL8HmI/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.O4XHgHCP13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:43:58 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 16:43:58 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 16:43:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsMhZL8HmI/Render', 16:43:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:58 INFO - 'HOME': '/Users/cltbld', 16:43:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:58 INFO - 'LOGNAME': 'cltbld', 16:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:58 INFO - 'MOZ_NO_REMOTE': '1', 16:43:58 INFO - 'NO_EM_RESTART': '1', 16:43:58 INFO - 'PAGER': '/bin/cat', 16:43:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:58 INFO - 'PWD': '/builds/slave/test', 16:43:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:58 INFO - 'SHELL': '/bin/bash', 16:43:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O4XHgHCP13/Listeners', 16:43:58 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 16:43:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:58 INFO - 'USER': 'cltbld', 16:43:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:58 INFO - 'XPC_FLAGS': '0x0', 16:43:58 INFO - 'XPC_SERVICE_NAME': '0', 16:43:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:44:01 INFO - Installing collected packages: mozsystemmonitor 16:44:01 INFO - Running setup.py install for mozsystemmonitor 16:44:01 INFO - Successfully installed mozsystemmonitor 16:44:01 INFO - Cleaning up... 16:44:01 INFO - Return code: 0 16:44:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:44:01 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')]} 16:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:01 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')]} 16:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:01 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 0x10b14ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac9358e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b2d30>, '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 0x10ae17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0aab20>, '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.lsMhZL8HmI/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.O4XHgHCP13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:44:01 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 16:44:01 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 16:44:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsMhZL8HmI/Render', 16:44:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:01 INFO - 'HOME': '/Users/cltbld', 16:44:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:01 INFO - 'LOGNAME': 'cltbld', 16:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:01 INFO - 'MOZ_NO_REMOTE': '1', 16:44:01 INFO - 'NO_EM_RESTART': '1', 16:44:01 INFO - 'PAGER': '/bin/cat', 16:44:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:01 INFO - 'PWD': '/builds/slave/test', 16:44:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:01 INFO - 'SHELL': '/bin/bash', 16:44:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O4XHgHCP13/Listeners', 16:44:01 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 16:44:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:01 INFO - 'USER': 'cltbld', 16:44:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:01 INFO - 'XPC_FLAGS': '0x0', 16:44:01 INFO - 'XPC_SERVICE_NAME': '0', 16:44:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:01 INFO - Downloading/unpacking jsonschema==2.5.1 16:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:44:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:04 INFO - Downloading functools32-3.2.3-2.tar.gz 16:44:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:44:04 INFO - warning: no files found matching '*.txt' 16:44:04 INFO - no previously-included directories found matching 'build' 16:44:04 INFO - no previously-included directories found matching 'dist' 16:44:04 INFO - no previously-included directories found matching '.git*' 16:44:04 INFO - Installing collected packages: jsonschema, functools32 16:44:05 INFO - Running setup.py install for functools32 16:44:05 INFO - warning: no files found matching '*.txt' 16:44:05 INFO - no previously-included directories found matching 'build' 16:44:05 INFO - no previously-included directories found matching 'dist' 16:44:05 INFO - no previously-included directories found matching '.git*' 16:44:05 INFO - Successfully installed jsonschema functools32 16:44:05 INFO - Cleaning up... 16:44:05 INFO - Return code: 0 16:44:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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', '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 0x10b14ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac9358e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b2d30>, '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 0x10ae17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0aab20>, '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.lsMhZL8HmI/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.O4XHgHCP13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:44: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:44: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 functools32==3.2.3-2 16:44:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsMhZL8HmI/Render', 16:44:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:05 INFO - 'HOME': '/Users/cltbld', 16:44:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:05 INFO - 'LOGNAME': 'cltbld', 16:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:05 INFO - 'MOZ_NO_REMOTE': '1', 16:44:05 INFO - 'NO_EM_RESTART': '1', 16:44:05 INFO - 'PAGER': '/bin/cat', 16:44:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:05 INFO - 'PWD': '/builds/slave/test', 16:44:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:05 INFO - 'SHELL': '/bin/bash', 16:44:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O4XHgHCP13/Listeners', 16:44:05 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 16:44:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:05 INFO - 'USER': 'cltbld', 16:44:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:05 INFO - 'XPC_FLAGS': '0x0', 16:44:05 INFO - 'XPC_SERVICE_NAME': '0', 16:44:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:44:05 INFO - Cleaning up... 16:44:05 INFO - Return code: 0 16:44:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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', '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 0x10b14ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac9358e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b2d30>, '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 0x10ae17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0aab20>, '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.lsMhZL8HmI/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.O4XHgHCP13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:44: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:44: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 blobuploader==1.2.4 16:44:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsMhZL8HmI/Render', 16:44:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:05 INFO - 'HOME': '/Users/cltbld', 16:44:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:05 INFO - 'LOGNAME': 'cltbld', 16:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:05 INFO - 'MOZ_NO_REMOTE': '1', 16:44:05 INFO - 'NO_EM_RESTART': '1', 16:44:05 INFO - 'PAGER': '/bin/cat', 16:44:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:05 INFO - 'PWD': '/builds/slave/test', 16:44:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:05 INFO - 'SHELL': '/bin/bash', 16:44:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O4XHgHCP13/Listeners', 16:44:05 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 16:44:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:05 INFO - 'USER': 'cltbld', 16:44:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:05 INFO - 'XPC_FLAGS': '0x0', 16:44:05 INFO - 'XPC_SERVICE_NAME': '0', 16:44:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:05 INFO - Downloading/unpacking blobuploader==1.2.4 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:08 INFO - Downloading blobuploader-1.2.4.tar.gz 16:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:44:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:44:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:09 INFO - Downloading docopt-0.6.1.tar.gz 16:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:44:09 INFO - Installing collected packages: blobuploader, requests, docopt 16:44:09 INFO - Running setup.py install for blobuploader 16:44:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:44:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:44:09 INFO - Running setup.py install for requests 16:44:10 INFO - Running setup.py install for docopt 16:44:10 INFO - Successfully installed blobuploader requests docopt 16:44:10 INFO - Cleaning up... 16:44:10 INFO - Return code: 0 16:44:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:10 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')]} 16:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:10 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')]} 16:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:10 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 0x10b14ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac9358e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b2d30>, '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 0x10ae17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0aab20>, '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.lsMhZL8HmI/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.O4XHgHCP13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:44:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:44:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsMhZL8HmI/Render', 16:44:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:10 INFO - 'HOME': '/Users/cltbld', 16:44:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:10 INFO - 'LOGNAME': 'cltbld', 16:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:10 INFO - 'MOZ_NO_REMOTE': '1', 16:44:10 INFO - 'NO_EM_RESTART': '1', 16:44:10 INFO - 'PAGER': '/bin/cat', 16:44:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:10 INFO - 'PWD': '/builds/slave/test', 16:44:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:10 INFO - 'SHELL': '/bin/bash', 16:44:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O4XHgHCP13/Listeners', 16:44:10 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 16:44:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:10 INFO - 'USER': 'cltbld', 16:44:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:10 INFO - 'XPC_FLAGS': '0x0', 16:44:10 INFO - 'XPC_SERVICE_NAME': '0', 16:44:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:10 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-FjltWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:10 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-KqyU49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:10 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-l0OP4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:10 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-c4LJi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-ekJwlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Ru7esL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-uvbors-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-bfmy75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Ej_MCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-bg9Sqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-hpVeqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-9LaEjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-z0OASv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:11 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-L2WBN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:12 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-nrnlZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:12 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-irqNAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:12 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-x8kzz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:44:12 INFO - Running setup.py install for manifestparser 16:44:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:44:12 INFO - Running setup.py install for mozcrash 16:44:12 INFO - Running setup.py install for mozdebug 16:44:12 INFO - Running setup.py install for mozdevice 16:44:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:44:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:44:13 INFO - Running setup.py install for mozfile 16:44:13 INFO - Running setup.py install for mozhttpd 16:44:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:44:13 INFO - Running setup.py install for mozinfo 16:44:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:44:13 INFO - Running setup.py install for mozInstall 16:44:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:44:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:44:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:44:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:44:13 INFO - Running setup.py install for mozleak 16:44:13 INFO - Running setup.py install for mozlog 16:44:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:44:13 INFO - Running setup.py install for moznetwork 16:44:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:44:14 INFO - Running setup.py install for mozprocess 16:44:14 INFO - Running setup.py install for mozprofile 16:44:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:44:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:44:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:44:14 INFO - Running setup.py install for mozrunner 16:44:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:44:14 INFO - Running setup.py install for mozscreenshot 16:44:14 INFO - Running setup.py install for moztest 16:44:14 INFO - Running setup.py install for mozversion 16:44:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:44:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:44:14 INFO - Cleaning up... 16:44:14 INFO - Return code: 0 16:44:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:14 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 0x10b14ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac9358e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b2d30>, '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 0x10ae17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0aab20>, '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.lsMhZL8HmI/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.O4XHgHCP13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:44:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:44:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsMhZL8HmI/Render', 16:44:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:14 INFO - 'HOME': '/Users/cltbld', 16:44:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:14 INFO - 'LOGNAME': 'cltbld', 16:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:14 INFO - 'MOZ_NO_REMOTE': '1', 16:44:14 INFO - 'NO_EM_RESTART': '1', 16:44:14 INFO - 'PAGER': '/bin/cat', 16:44:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:14 INFO - 'PWD': '/builds/slave/test', 16:44:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:14 INFO - 'SHELL': '/bin/bash', 16:44:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O4XHgHCP13/Listeners', 16:44:14 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 16:44:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:14 INFO - 'USER': 'cltbld', 16:44:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:14 INFO - 'XPC_FLAGS': '0x0', 16:44:14 INFO - 'XPC_SERVICE_NAME': '0', 16:44:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:15 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-1Iby64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:15 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-rGafTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:15 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-WSF08C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:15 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-k8wQHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:15 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-TCz6N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:15 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-wc6Geg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:15 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-KpQ2L7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-SWF8la-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-q7WEB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-KuYjvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:16 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)) 16:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-xEUMqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-oKJPCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:16 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)) 16:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-LLMl1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-0qRajX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:16 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)) 16:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-fLO59m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-GxCEw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:16 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-NIIEo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:44:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:19 INFO - Downloading blessings-1.6.tar.gz 16:44:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:44:19 INFO - Installing collected packages: blessings 16:44:19 INFO - Running setup.py install for blessings 16:44:19 INFO - Successfully installed blessings 16:44:19 INFO - Cleaning up... 16:44:19 INFO - Return code: 0 16:44:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:44:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:20 INFO - Reading from file tmpfile_stdout 16:44:20 INFO - Current package versions: 16:44:20 INFO - blessings == 1.6 16:44:20 INFO - blobuploader == 1.2.4 16:44:20 INFO - docopt == 0.6.1 16:44:20 INFO - functools32 == 3.2.3-2 16:44:20 INFO - jsonschema == 2.5.1 16:44:20 INFO - manifestparser == 1.1 16:44:20 INFO - mozInstall == 1.12 16:44:20 INFO - mozcrash == 0.17 16:44:20 INFO - mozdebug == 0.1 16:44:20 INFO - mozdevice == 0.48 16:44:20 INFO - mozfile == 1.2 16:44:20 INFO - mozhttpd == 0.7 16:44:20 INFO - mozinfo == 0.9 16:44:20 INFO - mozleak == 0.1 16:44:20 INFO - mozlog == 3.3 16:44:20 INFO - moznetwork == 0.27 16:44:20 INFO - mozprocess == 0.23 16:44:20 INFO - mozprofile == 0.28 16:44:20 INFO - mozrunner == 6.12 16:44:20 INFO - mozscreenshot == 0.1 16:44:20 INFO - mozsystemmonitor == 0.3 16:44:20 INFO - moztest == 0.7 16:44:20 INFO - mozversion == 1.4 16:44:20 INFO - psutil == 3.1.1 16:44:20 INFO - requests == 1.2.3 16:44:20 INFO - wsgiref == 0.1.2 16:44:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:20 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 0x10b14ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac9358e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b2d30>, '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 0x10ae17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0aab20>, '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.lsMhZL8HmI/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.O4XHgHCP13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:44:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:44:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsMhZL8HmI/Render', 16:44:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:20 INFO - 'HOME': '/Users/cltbld', 16:44:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:20 INFO - 'LOGNAME': 'cltbld', 16:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:20 INFO - 'MOZ_NO_REMOTE': '1', 16:44:20 INFO - 'NO_EM_RESTART': '1', 16:44:20 INFO - 'PAGER': '/bin/cat', 16:44:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:20 INFO - 'PWD': '/builds/slave/test', 16:44:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:20 INFO - 'SHELL': '/bin/bash', 16:44:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O4XHgHCP13/Listeners', 16:44:20 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 16:44:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:20 INFO - 'USER': 'cltbld', 16:44:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:20 INFO - 'XPC_FLAGS': '0x0', 16:44:20 INFO - 'XPC_SERVICE_NAME': '0', 16:44:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:44:20 INFO - Cleaning up... 16:44:20 INFO - Return code: 0 16:44:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b14ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac9358e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0b2d30>, '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 0x10ae17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0aab20>, '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.lsMhZL8HmI/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.O4XHgHCP13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:44:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:44:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsMhZL8HmI/Render', 16:44:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:20 INFO - 'HOME': '/Users/cltbld', 16:44:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:20 INFO - 'LOGNAME': 'cltbld', 16:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:20 INFO - 'MOZ_NO_REMOTE': '1', 16:44:20 INFO - 'NO_EM_RESTART': '1', 16:44:20 INFO - 'PAGER': '/bin/cat', 16:44:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:20 INFO - 'PWD': '/builds/slave/test', 16:44:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:20 INFO - 'SHELL': '/bin/bash', 16:44:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O4XHgHCP13/Listeners', 16:44:20 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 16:44:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:20 INFO - 'USER': 'cltbld', 16:44:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:20 INFO - 'XPC_FLAGS': '0x0', 16:44:20 INFO - 'XPC_SERVICE_NAME': '0', 16:44:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:44:20 INFO - Cleaning up... 16:44:20 INFO - Return code: 0 16:44:20 INFO - Running post-action listener: _resource_record_post_action 16:44:20 INFO - Running post-action listener: _start_resource_monitoring 16:44:20 INFO - Starting resource monitoring. 16:44:20 INFO - [mozharness: 2016-08-23 23:44:20.787810Z] Finished create-virtualenv step (success) 16:44:20 INFO - [mozharness: 2016-08-23 23:44:20.788772Z] Running install step. 16:44:20 INFO - Running pre-action listener: _resource_record_pre_action 16:44:20 INFO - Running main action method: install 16:44:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:21 INFO - Reading from file tmpfile_stdout 16:44:21 INFO - Detecting whether we're running mozinstall >=1.0... 16:44:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:44:21 INFO - Reading from file tmpfile_stdout 16:44:21 INFO - Output received: 16:44:21 INFO - Usage: mozinstall [options] installer 16:44:21 INFO - Options: 16:44:21 INFO - -h, --help show this help message and exit 16:44:21 INFO - -d DEST, --destination=DEST 16:44:21 INFO - Directory to install application into. [default: 16:44:21 INFO - "/builds/slave/test"] 16:44:21 INFO - --app=APP Application being installed. [default: firefox] 16:44:21 INFO - mkdir: /builds/slave/test/build/application 16:44:21 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'] 16:44:21 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 16:44:54 INFO - Reading from file tmpfile_stdout 16:44:54 INFO - Output received: 16:44:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:44:54 INFO - Running post-action listener: _resource_record_post_action 16:44:54 INFO - [mozharness: 2016-08-23 23:44:54.925082Z] Finished install step (success) 16:44:54 INFO - [mozharness: 2016-08-23 23:44:54.925217Z] Running run-tests step. 16:44:54 INFO - Running pre-action listener: _resource_record_pre_action 16:44:54 INFO - Running main action method: run_tests 16:44:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:44:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:44:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:44:54 INFO - 2016-08-23 16:44:54.939 screenresolution[1647:8764] starting screenresolution argv=screenresolution get 16:44:54 INFO - 2016-08-23 16:44:54.942 screenresolution[1647:8764] Display 0: 1600x1200x32@60 16:44:54 INFO - 2016-08-23 16:44:54.948 screenresolution[1648:8766] starting screenresolution argv=screenresolution list 16:44:54 INFO - Available Modes on Display 0 16:44:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:44:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:44:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:44:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:44:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:44:55 INFO - Intel Iris: 16:44:55 INFO - Chipset Model: Intel Iris 16:44:55 INFO - Type: GPU 16:44:55 INFO - Bus: Built-In 16:44:55 INFO - VRAM (Dynamic, Max): 1536 MB 16:44:55 INFO - Vendor: Intel (0x8086) 16:44:55 INFO - Device ID: 0x0a2e 16:44:55 INFO - Revision ID: 0x0009 16:44:55 INFO - Displays: 16:44:55 INFO - Display: 16:44:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:44:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:44:55 INFO - Display Serial Number: 1600x1200 60 16:44:55 INFO - Main Display: Yes 16:44:55 INFO - Mirror: Off 16:44:55 INFO - Online: Yes 16:44:55 INFO - Rotation: Supported 16:44:55 INFO - Return code: 0 16:44:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:44:55 INFO - Python 2.7.3 16:44:55 INFO - Return code: 0 16:44:55 INFO - grabbing minidump binary from tooltool 16:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:55 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 0x10b0b2d30>, '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 0x10ae17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0aab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:44:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:44:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:44:55 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 16:44:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:44:55 INFO - Return code: 0 16:44:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:44:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:44:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:44:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:44:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:44:55 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/b_gtrB5-RKiNSAeI7wLiqg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:44:55 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/b_gtrB5-RKiNSAeI7wLiqg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:44:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lsMhZL8HmI/Render', 16:44:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:55 INFO - 'HOME': '/Users/cltbld', 16:44:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:55 INFO - 'LOGNAME': 'cltbld', 16:44:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:44:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:55 INFO - 'MOZ_NO_REMOTE': '1', 16:44:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:44:55 INFO - 'NO_EM_RESTART': '1', 16:44:55 INFO - 'PAGER': '/bin/cat', 16:44:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:55 INFO - 'PWD': '/builds/slave/test', 16:44:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:44:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:55 INFO - 'SHELL': '/bin/bash', 16:44:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O4XHgHCP13/Listeners', 16:44:55 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 16:44:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:55 INFO - 'USER': 'cltbld', 16:44:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:55 INFO - 'XPC_FLAGS': '0x0', 16:44:55 INFO - 'XPC_SERVICE_NAME': '0', 16:44:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:55 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/b_gtrB5-RKiNSAeI7wLiqg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:44:55 INFO - mozversion application_buildid: 20160823145014 16:44:55 INFO - mozversion application_changeset: 3f7afc56fae2a3bdc25fb25a3f69d62b32a54c94 16:44:55 INFO - mozversion application_display_name: Nightly 16:44:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:44:55 INFO - mozversion application_name: Firefox 16:44:55 INFO - mozversion application_remotingname: firefox 16:44:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:44:55 INFO - mozversion application_vendor: Mozilla 16:44:55 INFO - mozversion application_version: 51.0a1 16:44:55 INFO - mozversion platform_buildid: 20160823145014 16:44:55 INFO - mozversion platform_changeset: 3f7afc56fae2a3bdc25fb25a3f69d62b32a54c94 16:44:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:44:55 INFO - mozversion platform_version: 51.0a1 16:44:55 INFO - using testdate: 1471995895 16:44:55 INFO - actual date: 1471995895 16:44:55 INFO - starting webserver on 'localhost:49270' 16:44:55 INFO - SUITE-START | Running 2 tests 16:44:55 INFO - TEST-START | dromaeo_css 16:44:55 INFO - operating with platform_type : mac_ 16:44:55 INFO - Initialising browser for dromaeo_css test... 16:44:55 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpSqpuIb/profile http://localhost:49270/getInfo.html) 16:44:58 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 16:44:58 INFO - PROCESS | 1658 | colorDepth:24 16:44:58 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 16:44:58 INFO - PROCESS | 1658 | __metrics 16:44:58 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 16:44:59 INFO - TEST-INFO | 1658: exit 0 16:44:59 INFO - Browser initialized. 16:44:59 INFO - Running cycle 1/1 for dromaeo_css test... 16:44:59 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpSqpuIb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:45:11 INFO - PROCESS | 1662 | RSS: Main: 247144448 16:45:11 INFO - PROCESS | 1662 | 16:46:00 INFO - PROCESS | 1662 | 1471995960967 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:48:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 16:48:14 INFO - PROCESS | 1662 | RSS: Main: 270442496 16:48:14 INFO - PROCESS | 1662 | 16:51:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 16:51:17 INFO - PROCESS | 1662 | RSS: Main: 279330816 16:51:17 INFO - PROCESS | 1662 | 16:54:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 16:54:20 INFO - PROCESS | 1662 | RSS: Main: 279117824 16:54:20 INFO - PROCESS | 1662 | 16:57:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 16:57:22 INFO - PROCESS | 1662 | RSS: Main: 274329600 16:57:22 INFO - PROCESS | 1662 | 17:00:25 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 17:00:26 INFO - PROCESS | 1662 | RSS: Main: 279638016 17:00:26 INFO - PROCESS | 1662 | 17:03:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 17:03:29 INFO - PROCESS | 1662 | RSS: Main: 281784320 17:03:29 INFO - PROCESS | 1662 | 17:03:29 INFO - PROCESS | 1662 | __start_tp_report 17:03:29 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 17:03:29 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 17:03:29 INFO - PROCESS | 1662 | |i|pagename|runs| 17:03:29 INFO - PROCESS | 1662 | |0;dojo.html;3437.72498200144;3458.0836078439233;3470.4273794823857;3481.042713253855;3517.824108794561;5837.678927658977;5865.648061116331;5867.677277749722;5924.58527903047;5941.346451890288;5870.442307980746;5930.911036334448;5951.22634057573;5964.194833697449;6000.009998350267;5317.73411329432;5373.382061062969;5431.293931788881;5451.781928722866;5463.426340234278;5234.162533994561;5274.789008439658;5347.946520534803;5375.274337964383;5377.4084850666395;5314.096603577382;5354.946450535484;5358.785648574052;5366.597505187126;5388.757505912224;5322.3879253885525;5368;5374.059539580558;5378.8924221515745;5432.565394768409;4731.313959475891;5234.81678141267;5289.841304760864;5318.680879147263;5321.175217841241;5849.61977471463;5942.821715348547;5948.226730525047;5968.70156492178;6014.578979471439;5282;6152.784652537184;6169.167162433104;6251.12484252205;6259.6870156492;6144.003198960311;6196.1944947157035;6203.2556093269095;6310.747570097191;6325.209348831396;5982.102684597258;6041.577089603686;6052.243469566304;6073.1497590337385;6090.817275481742;6382.074599183093;6400.295967443578;6456.225252969673;6483.935160648333;6484.578502397329;6111.95640283616;6135.01831721223;6155.322914479404;6235;6238.001919692827;6263.342349053284;6286.591371560834;6290.968545157245;6292.590981586274;6301.936980630227;6177.567570270128;6200.224971878515;6211.937880621226;6234.844128896814;6245.469135123565;6010.098485227251;6060.909036373495;6160.722767475385;6210.875782484325;6220.595661282002;4335.848245311462;4945.166481000124;5056.241563765465;5075.213341932006;5114.130597798383;3887.280853042196;4513.977430112828;4517.796699148546;4556.6126879215635;4571.954280457219;5785.363610002896;5981.671008094597;5983.6708981005595;6004.1294012368835;6020.096985452217;6287.339829317856;6300.117983482316;6307.810765677037;6319.431251187415;6325.557210995278;6010.278766547955;6011.879762404815;6023.879522409615;6029.6683682397015;6043;5480.506754392124;5524.723763811793;5527.088030474926;5562.749676264497;5638.126090455986;6450.5484616077365;6501.187351581052;6518.967405162944;6563.507736919845;6572.934270657423;6200.976838821544;6313.715882785194;6316.842078948063;6325.77859774924;6345.714442850175;6312.842178945563;6577.704003319958;6581.605103693793;6585.1439312889015;6603;6163.013917773134;6198.535109866688;6204.937950620617;6270.874582508415;6291;6283.02613094971;6296.150019747275;6298.779542715983;6308.842278943063;6314.905276420765;5140.306058682179;6112.1748563945075;6124.2588809726185;6147.877042459037;6170.845728856814;6182.072689096492;6193.380661933951;6197.442230199304;6199.1011303361665;6212.658303793335;6043.879122417615;6061.36355682647;6099.3900609938655;6166.383361663798;6167.044108163242;5959.433853783884;6104.125697713769;6139.768135342541;6151.400635834626;6213.068039793886;6109.95128740435;6117.579072698688;6123.598586248296;6131.013867888357;6147.538934580014 17:03:29 INFO - PROCESS | 1662 | |1;ext.html;449.842555105713;474.80295677293924;535.7160704826443;544.945505449455;570.5435651478816;38185.23629527408;40785.3882191767;40932.7720168395;40964.795176024076;41037.7948110259;41964.58035419645;42413;42445;42456.78771606138;42566.787166064205;9772.8045439091;9943.10512053915;9986.201103911706;9991.350562213433;9998.000199980017;9834.114929656329;9889.653862114792;9923.801523969516;9954.701358959206;9990.300678952477;9945.955674654166;9962.701118966443;9965.950170249174;9995.55020024097;10012.449315287657;9899;9920.503974801268;9939.801203975952;9953.601855925754;9976.750581235454;9862.753431164278;9890.30767846251;9924.255680823895;9934.304598678096;9936.304458687895;39982;40074.79962600168;40104.79947600243;40417.98955026118;40572.39141412881;3209.133533945845;3272.5091236314743;3293.950590741141;3313.3207692422993;3357.3117510910206;31638;31885.521717174262;32143.678563214304;32458.837705811555;33175.17062073443;3288.490284005983;3294.8352582370785;3344.5484859543894;3434.862605495777;3440.1055725511546;425695;515648;515705;516152;516201;59311;59713.507162321286;59858;59876.401235987956;59935.70032149899;30412.847935760623;31561.684383155876;34627.65372346294;35171.4724279136;35753.642463575554;12974.870251297367;13055.543055992996;16356.591085222964;16398.18009099564;16440.424585139463;12595.24428534291;12634;12723.809142862865;12733.29966851832;12743.936280318725;18983.145758440904;18988.81011189898;18996;19043.857368557652;19151.904240478987;6716.3955244028275;7927.603619818986;7933.484323518953;7970.92392527013;8045.15525869787;839.6935118681637;963.9469829159324;1000.8899021107673;1047.2041248650928;1090.36758679967;28614.713852861205;30304.090877273717;30376.088717338072;30437.847810760806;30561.235969100504;998.32612986234;1020.8928062553473;1069.2515239332342;1141.6004398460473;1144.9866867822038;15428.84571154274;15747.68504629901;15941.96377235476;15986.440474583334;16343.509694709177;641725;645103;645748;646167;649679;58847;59208.70395647994;59291.11063334053;59454.70272648609;60712;1374.9518766843112;1389.7290028444559;1410.6261840612042;1417.1922004457567;1419;24882.129125480522;28269.43461130807;28886;30236.24409389695;30519.779208831398;50479;50877.49122508727;50963.235551466016;51008.48991510038;51135.48864511456;603189;603867;605957;608197;616301;26325;27165.86417067902;27415.17754467369;27470;27510.724892750815;46907.061858763314;47304.7634761824;48343.5165648339;48557.02885942332;49004.264936025276;27863.721362786113;39319;39552.01119972024;39972.800136000296;40567.3914891271;34113.82943085269;39105.41341879931;39566;40255.59105431296;40336.1932761349;37232.44151337786;37968.620313796506;38377.42433863439;38579.228415432095;38893;34212.31575368528;35079.64920350764;35273.47089793706;35537.1115722109;35655.82172089123;24434.755652443248;24584.68441011458;24791.50416991686;24844.875775621007;25337.746622533537 17:03:29 INFO - PROCESS | 1662 | |2;jquery.html;327.9979662132186;374.91939233064886;383.992320153597;389.2021356219749;405.1653593597188;20210.39368818936;21042.579148417022;21889.233876814335;21898.89050554749;21934.122635094576;20985.160593576238;21386;21412.8929355353;21770;22064.44838879029;5939.67331796751;5970.820875373745;6137;6198.977168767148;6212.596181248205;4217.325227963526;6069.1199776032445;6171.290301615304;6587.769428070019;6838.7264509419565;6888.138982627172;6905.378515933565;6911.136107986502;6916.308369163068;6930.757423490179;6416.743330266807;6750.898736518931;6770.72917083316;6811.25076241613;6818.965905170492;4411.757353345564;4935.210366341368;4970.602351811846;5816.854578635525;5967.850803729898;13817.240051797147;13999.440022399092;14002.859971400258;14140;26051.348716282057;2034.7049677796786;2220.378294077661;2303.884805759722;2414.8913298901416;2471.308033750535;8343.95828020862;10570.365778053265;10830.40432776197;11224.831627525593;12278.38608069593;1570.458191923796;1936.4771511691765;1951.1024928532893;2022.9595408091757;2024.1498570600236;122360;127142;132678;135878;137236;10907.672769816918;11546.364949927667;11600.94199528997;11625.76748465026;11762.470688818852;14491.710165796625;14503.782443263359;14595.635109122357;14598.270086495633;14638.048526845721;8454.957725211334;8586.356023298278;8643.827123457622;8731.563421828883;8766.780830479289;8698.608562614698;8702.825943481095;8744.475331480131;8892.688755893512;8941.821163576822;4483.32750087483;4550.067236216634;4562.703424277412;4596.4254468191475;4616.330632058332;1702.7229577816638;1771.8405343518887;1814.4738025972583;1840.9966568220084;1913.9233931184542;634.3624657219465;679.5956405938458;689.7723751162105;780.5433821214654;798.6006996501749;20774.58450830975;21191.576168476546;21508.569151056072;21534.892325538585;21793.029639392247;813.3241635020834;848.9702860399856;849.2781136034322;860.423516244118;875.0156074416282;10688.625898093529;11143.777124457465;11209.495572699248;11232.55069797199;11357.432128393548;605729.5702822306;614049;624554;638024;638460;97589.51205243928;110359;121243;126943;130148;411.4075730947486;433.1013147718497;433.57726216938863;436.3040949685247;437.34180059010987;9339.953300233727;10735.46322683847;11156.721081973015;11159.660840699167;11464;54043.72978135084;57013.85972280614;57595.71202143963;57935.420645793005;57946;82549;82820;83320.58339708262;85146.57426712826;85464.71802922837;11341.489632966372;11391.259568128045;11971.64085077449;12161.81757273624;12260.203086799685;12569.811452828031;13417.731645367234;13516.93241533786;14001.649958751113;14108.929455352658;11474.246180916352;11568.768624627628;11623.59317423886;11784.116191285859;11800.232984855957;11347.432628368384;11433.771324573629;11760.235584686969;11793.52825886955;11880.821787673365;11662.76674466489;11870.643880683594;11874.881251187722;11993.700157496132;12066.75866482683;11650.359230242419;12077.839174928487;12207.511699531919;12288.815667764811;12357.75284494323;11675;11713.297202167556;11937.28376297425;11979.221350612183;11989.700257493632 17:03:29 INFO - PROCESS | 1662 | |3;mootools.html;1384.550021243096;1402.8176337076181;1574.3073047858934;1577.8875892495792;1802.9909850450745;7373.152087509925;8239.629216685249;8524;8607.870881936777;9072.228860546853;8738.432001919871;8843.115688431153;8846;8852.955735221314;8854.690085846996;2315;2346.061575369857;2358.84667496613;2358.988205058972;2363.2201373546773;2300.332903457995;2336.6261398176293;2338.1348900906605;2343.1798870395396;2349.142562964514;2315.78000089992;2334.206369834256;2351.835371523994;2355.4346956730433;2357.1985524921524;2301.5051763870765;2317.8841057947034;2322.036354912718;2331.6269396896414;2332.172078911996;2312.479692069288;2318.7565305643;2321.4892723600783;2322.3729593009793;2336.1706594159;8793.824123517557;8913;8966.327525435554;8978.281737460988;9027.819443611092;5144.897102057937;5270.710110943896;5277.287566178555;5304.389995150568;5317.202419637047;2863.7422631963013;3435.845386957593;3535.681788639035;3629.709623230135;3696.2607478504137;1085.6905781852213;1108.6009036746764;1120.0423637789736;1129.091081679248;1142.4630423700846;11500.25248358854;11528.59649912249;11653.126015548867;11659.417029148508;11670.416479176092;4115.97942010288;4239.1521695660995;4591.897944493365;4695.22528782747;4705.1765940960195;9649.228061755042;9727.173190278905;9740.95129524362;9750.707478775648;9760.072793084646;5195.844124676266;5230.607704422184;5233.842984710464;5248.63259571834;5252.44849290819;4320.611144996902;4569.2689169732685;4666.533346665306;4701.529847015339;4810.5670489656095;3647.0699971507097;3721;3773.8867833965023;3784.2053168834304;3820.904477388032;1291.7222797098668;1293.1336004876755;1293.4244261303818;1303.8696130386886;1314.309987256698;908.0102688070035;921.6728061538191;923.9027407784292;929.7815013471828;936.4147407870081;5847.853803654858;6061;6084.939150608526;6124.265088189357;6276.435120839146;416.26113648274554;421.9662427005832;422.2989836870841;423.18325631530826;429.7722207230173;4046.615571520701;4070;4073.551909289976;4145.108801607669;4145.253854306254;10359.430231337348;10833.241673082808;10863.40251286171;10998.900109988937;11018.39398833072;10938.726531836768;10943;10945.179111566664;10946.616868409568;10952.945235273774;8123.4313598047565;8164.061132969785;8341.66633334672;8355.039170495349;8365.24712775853;4118.032262418389;4976.776045078052;5980.581359304807;6103.42017508336;6155.1382806406245;9898.554565044735;9933.3543319684;10001.199904007808;10048.538108163546;10091.344062635904;9635.699180610527;9962.55168517404;10169.389836609827;10184.439855808001;10307.433091180057;6697.631630260383;6784.2876497967;7492.400607951242;7609;7670.616469176631;8363.707270245512;8450.830983380421;8493.532855692996;8525.658973641233;8546.188112129337;7402.740904068547;7504.249575042452;7548.358389536951;7605.429592780453;7634.351080158027;7312.341889229995;7350.375218106521;7361.8159546011775;7480.326770590673;7514.812129696801;6842.281560436082;6974.6861391238535;6981.0924579804305;6981.219788953785;6986.336298051677;4992.450830408579;5005.099082165245;5156.5616922562;5156.9742151289;5178.223266510054;5075.87310317245;5175.9741201293755;5176.275321454924;5209.322788037531;5269.235960785742 17:03:29 INFO - PROCESS | 1662 | |4;prototype.html;297.1753384358405;299.30113185711366;309.05583442582906;311.52647975077895;313.72078849823663;5298.337707786527;5339.905319409521;5486.47878451547;5546.334439867216;5596.972015139923;4833.75831208439;4995.525425084611;5302.443243459439;5338.733063346836;5485.204645326426;3335.949960750591;3682.558093028827;3858.6527212550864;4235.7246778959425;4243.596858298457;3888.786116763591;4030.476038115041;4197.81109850056;4250.724782565234;4268.530461649216;3814.5803961564206;4192.790360481979;4206.411102445645;4220.97889510552;4239.448871646681;3828.55971563271;4199.181159673864;4207.474065741798;4224.493060832689;4228.9154216915485;3148.511980643004;3545.166885781839;3646.179609587848;3656.524651795276;3670.8164591770305;4493.955060449419;4945.714114330264;5032.547070763612;5296.470352964711;5322.654027488201;4650.372199753024;4740.976295118537;4750.477447480775;4751.786169622375;4787.688800228009;5026.346574945233;5750.827475175752;5775.971120144372;5784.929787989236;5831.970840145772;3603.6036036036267;3746.2775461584224;3840.711946604016;3896.941545876814;3914.2954268231993;5241.213817927303;5622.690752008638;6080;6135.349467067088;6153.353897840751;3650.762700424464;3761.4545890845675;3967.147063381329;3998.820053097618;4007.218592374459;3143.685631436838;3541.9551232385993;3714.2200137971327;3756.6055564165918;4003.4395184674167;3692.981535092361;4388.542416246912;4654.162250794821;4697;4751.4535828379485;5800.39095894925;5890.5568135807;5900;5932.249986254065;5956.910646340309;1115.6039605939775;1153.1985270237105;1189.7739429508365;1254.9686257843628;1288.7486940046788;850.8978922529212;889.0398369760643;900.5677274907949;903.2367649336301;920.6961702638114;4702.9764851176205;4851.95148048515;4868.519008908576;5019.322391477177;5311.9734401328515;5386.407495175527;5863.941360586425;5865.442782935615;5867.501262392744;5870.471657550841;4963.131451995886;5267.552258058108;5275.340582427197;5319.893602127936;5364.570834333244;2376.5484557933937;2421.6488609151575;2467.703875534947;2535.6069809179608;2669.519486492411;4222.556631553704;4291.184674911757;5118.436971933084;5170.699038927641;5252;4338.913221735547;4379.1241751649795;4532.914859164755;4601.194790911577;4885.5358740919555;4057.6524367397014;4267.997020700133;4764.809407623657;4917.5082491751255;4992.975035124801;4125.2986992212;4426.933595996127;4831.4685384608365;4997.8255110048385;5031.572316353151;3759;4588.977055114703;4843.200871856246;4955.603551715782;4980.9329128412755;4826.8069277228515;4850.320955066364;4893;4986.7257300848805;5050.91405347852;2820.562812764025;3391.3386889557287;3411.94882076774;3486.633903440102;3524.3303772283184;4688.742119183477;4783;4793.952060479351;4878.853634390974;5029.84910452687;4851.345068415719;5283.762230699551;5569.384878385223;5744.798932037359;5873.882522349443;5810.820942146695;5811.331696854916;5850.5027072699295;5854.209681692917;5872.588918775816;4714.457837348612;5439;5675.971620142038;5692.31692196939;5719.199312096227;5041.899162016813;5855.677937713466;5860.589758716849;5895.64626122434;5937.673427961331;5565.30433695788;5750.30996280449;5761.91357129635;5791.814502023954;5819.738111785065 17:03:29 INFO - PROCESS | 1662 | |5;yui.html;706.5019161491149;737.469022303941;753.1639879733494;810.841885832263;860.9311255099591;15670.608234794121;16477.093759843203;16500.587485312873;16549.420770273056;16580.8393412461;14796.890233232496;14930.253487325645;14934.40262389506;14936;14939.17834519101;820.5938060659967;834.2950207075012;863.8272345530887;867.6095756909416;869.7869022089566;856.9357298202628;866.0646501778097;871.4684042733927;871.5990644303628;873.2184694698241;877.714742708619;904.6652738486769;912.7946212102257;913.0367462327242;913.2693844924067;904.8642703594447;907.3875134284365;908.2506931781273;908.3596064774318;909.6634245329237;667.3093348384448;671.8219671786981;675.8682056998887;676.1548064918851;676.4824908944661;15333.463328783551;15659.843401565953;15718.29267682957;15754.842451575452;15778.97436666613;11004.339739615649;12362;13699.315034248348;13760.380782864795;14507.911906606942;10255.897441025569;11219.709733380603;11423.314601123877;11483.540658373655;11960.40197990097;3458.4985177149424;3646.705419576065;3870.825812838429;3897.162110146304;3992.5608183099835;125728;126123;126669.36665316706;128129.35935320357;129315.70684293225;11077.667669969915;11112.388818614892;11133.721656958478;11296.887031129749;11559.306441613362;22125.336239912827;22301.665475017886;22313.88843055807;22328.665070023962;22484.887575562017;6932.48006399512;7883.645235964395;8010.158933312035;8308.12764659714;8309.335253179732;4585.28928016158;4645.5354464553275;4652;4705.270683044134;4821.059893320768;3571.2857428514403;3685.631436856293;3689.763929083787;3691.335559599298;3694.630536946284;613.9693015349214;643.6717274190197;663.349917081263;679.4055201698513;690.9136357955256;509.72984318311353;559.2003435087863;586.4428792647002;674.6727836999052;697.849962258117;9024.593893274818;9864.5560949756;9978.501074946224;10051.24615653829;10108.696739097839;658.3821898666761;677.1829190567216;701.123595505618;703.2405002597183;707.5330282013949;4665;4783.832565860178;4785.282207668808;4824.300476430968;4909.5090490950615;99147;104543;111854;149578;176027;142137.5786242145;142534;149270;151506;151993;117706.8229317713;120046;120822;127840;131244;8227.42408031432;8762.597984322478;8929.955350223207;9353.513020459124;9397.624095036123;66719;66909;67193;67875;70476.64761676159;75802;87505.56247218723;90703;94924;96068.51965740127;13267.601971940858;13290.601281961557;13364.665883352605;13669.248191349572;14057.789133163215;15033.849661503682;15146.394144234107;15315.387384504495;15475.535733928;15818.525444236691;12842.935785321013;13837.86162138406;13899;14088.718225635635;14771.630709232355;13587.93206034003;14070.437182512995;14092.577222683336;14328.928355358574;14391.424343026161;13486.100488395043;13572.592822215349;13687.589372318846;13851.30743462843;13965.441382344592;11136.665900023012;11146.832797508207;11471.598494052669;11710.824337635113;11970.401479925795;8394.664213431395;9769.21931609498;10424.68725938223;10846.620368287073;11814.645560633195 17:03:29 INFO - PROCESS | 1662 | __end_tp_report 17:03:29 INFO - PROCESS | 1662 | __start_cc_report 17:03:29 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,425 17:03:29 INFO - PROCESS | 1662 | __end_cc_report 17:03:29 INFO - PROCESS | 1662 | __startTimestamp1471997009265__endTimestamp 17:03:29 INFO - PROCESS | 1662 | 17:03:29 INFO - PROCESS | 1662 | ------- Summary: start ------- 17:03:29 INFO - PROCESS | 1662 | Number of tests: 6 17:03:29 INFO - PROCESS | 1662 | 17:03:29 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5847.20 Median:6099.39 stddev:649.33 (10.6%) stddev-sans-first:623.20 17:03:29 INFO - PROCESS | 1662 | Values: 3437.7 3458.1 3470.4 3481.0 3517.8 5837.7 5865.6 5867.7 5924.6 5941.3 5870.4 5930.9 5951.2 5964.2 6000.0 5317.7 5373.4 5431.3 5451.8 5463.4 5234.2 5274.8 5347.9 5375.3 5377.4 5314.1 5354.9 5358.8 5366.6 5388.8 5322.4 5368.0 5374.1 5378.9 5432.6 4731.3 5234.8 5289.8 5318.7 5321.2 5849.6 5942.8 5948.2 5968.7 6014.6 5282.0 6152.8 6169.2 6251.1 6259.7 6144.0 6196.2 6203.3 6310.7 6325.2 5982.1 6041.6 6052.2 6073.1 6090.8 6382.1 6400.3 6456.2 6483.9 6484.6 6112.0 6135.0 6155.3 6235.0 6238.0 6263.3 6286.6 6291.0 6292.6 6301.9 6177.6 6200.2 6211.9 6234.8 6245.5 6010.1 6060.9 6160.7 6210.9 6220.6 4335.8 4945.2 5056.2 5075.2 5114.1 3887.3 4514.0 4517.8 4556.6 4572.0 5785.4 5981.7 5983.7 6004.1 6020.1 6287.3 6300.1 6307.8 6319.4 6325.6 6010.3 6011.9 6023.9 6029.7 6043.0 5480.5 5524.7 5527.1 5562.7 5638.1 6450.5 6501.2 6519.0 6563.5 6572.9 6201.0 6313.7 6316.8 6325.8 6345.7 6312.8 6577.7 6581.6 6585.1 6603.0 6163.0 6198.5 6204.9 6270.9 6291.0 6283.0 6296.2 6298.8 6308.8 6314.9 5140.3 6112.2 6124.3 6147.9 6170.8 6182.1 6193.4 6197.4 6199.1 6212.7 6043.9 6061.4 6099.4 6166.4 6167.0 5959.4 6104.1 6139.8 6151.4 6213.1 6110.0 6117.6 6123.6 6131.0 6147.5 17:03:29 INFO - PROCESS | 1662 | 17:03:29 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:70798.35 Median:39977.40 stddev:157160.85 (393.1%) stddev-sans-first:157512.97 17:03:29 INFO - PROCESS | 1662 | Values: 449.8 474.8 535.7 544.9 570.5 38185.2 40785.4 40932.8 40964.8 41037.8 41964.6 42413.0 42445.0 42456.8 42566.8 9772.8 9943.1 9986.2 9991.4 9998.0 9834.1 9889.7 9923.8 9954.7 9990.3 9946.0 9962.7 9966.0 9995.6 10012.4 9899.0 9920.5 9939.8 9953.6 9976.8 9862.8 9890.3 9924.3 9934.3 9936.3 39982.0 40074.8 40104.8 40418.0 40572.4 3209.1 3272.5 3294.0 3313.3 3357.3 31638.0 31885.5 32143.7 32458.8 33175.2 3288.5 3294.8 3344.5 3434.9 3440.1 425695.0 515648.0 515705.0 516152.0 516201.0 59311.0 59713.5 59858.0 59876.4 59935.7 30412.8 31561.7 34627.7 35171.5 35753.6 12974.9 13055.5 16356.6 16398.2 16440.4 12595.2 12634.0 12723.8 12733.3 12743.9 18983.1 18988.8 18996.0 19043.9 19151.9 6716.4 7927.6 7933.5 7970.9 8045.2 839.7 963.9 1000.9 1047.2 1090.4 28614.7 30304.1 30376.1 30437.8 30561.2 998.3 1020.9 1069.3 1141.6 1145.0 15428.8 15747.7 15942.0 15986.4 16343.5 641725.0 645103.0 645748.0 646167.0 649679.0 58847.0 59208.7 59291.1 59454.7 60712.0 1375.0 1389.7 1410.6 1417.2 1419.0 24882.1 28269.4 28886.0 30236.2 30519.8 50479.0 50877.5 50963.2 51008.5 51135.5 603189.0 603867.0 605957.0 608197.0 616301.0 26325.0 27165.9 27415.2 27470.0 27510.7 46907.1 47304.8 48343.5 48557.0 49004.3 27863.7 39319.0 39552.0 39972.8 40567.4 34113.8 39105.4 39566.0 40255.6 40336.2 37232.4 37968.6 38377.4 38579.2 38893.0 34212.3 35079.6 35273.5 35537.1 35655.8 24434.8 24584.7 24791.5 24844.9 25337.7 17:03:29 INFO - PROCESS | 1662 | 17:03:29 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:36064.40 Median:21652.45 stddev:104115.31 (480.8%) stddev-sans-first:104372.80 17:03:29 INFO - PROCESS | 1662 | Values: 328.0 374.9 384.0 389.2 405.2 20210.4 21042.6 21889.2 21898.9 21934.1 20985.2 21386.0 21412.9 21770.0 22064.4 5939.7 5970.8 6137.0 6199.0 6212.6 4217.3 6069.1 6171.3 6587.8 6838.7 6888.1 6905.4 6911.1 6916.3 6930.8 6416.7 6750.9 6770.7 6811.3 6819.0 4411.8 4935.2 4970.6 5816.9 5967.9 13817.2 13999.4 14002.9 14140.0 26051.3 2034.7 2220.4 2303.9 2414.9 2471.3 8344.0 10570.4 10830.4 11224.8 12278.4 1570.5 1936.5 1951.1 2023.0 2024.1 122360.0 127142.0 132678.0 135878.0 137236.0 10907.7 11546.4 11600.9 11625.8 11762.5 14491.7 14503.8 14595.6 14598.3 14638.0 8455.0 8586.4 8643.8 8731.6 8766.8 8698.6 8702.8 8744.5 8892.7 8941.8 4483.3 4550.1 4562.7 4596.4 4616.3 1702.7 1771.8 1814.5 1841.0 1913.9 634.4 679.6 689.8 780.5 798.6 20774.6 21191.6 21508.6 21534.9 21793.0 813.3 849.0 849.3 860.4 875.0 10688.6 11143.8 11209.5 11232.6 11357.4 605729.6 614049.0 624554.0 638024.0 638460.0 97589.5 110359.0 121243.0 126943.0 130148.0 411.4 433.1 433.6 436.3 437.3 9340.0 10735.5 11156.7 11159.7 11464.0 54043.7 57013.9 57595.7 57935.4 57946.0 82549.0 82820.0 83320.6 85146.6 85464.7 11341.5 11391.3 11971.6 12161.8 12260.2 12569.8 13417.7 13516.9 14001.6 14108.9 11474.2 11568.8 11623.6 11784.1 11800.2 11347.4 11433.8 11760.2 11793.5 11880.8 11662.8 11870.6 11874.9 11993.7 12066.8 11650.4 12077.8 12207.5 12288.8 12357.8 11675.0 11713.3 11937.3 11979.2 11989.7 17:03:29 INFO - PROCESS | 1662 | 17:03:29 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5689.28 Median:4757.87 stddev:3240.49 (68.1%) stddev-sans-first:3233.43 17:03:29 INFO - PROCESS | 1662 | Values: 1384.6 1402.8 1574.3 1577.9 1803.0 7373.2 8239.6 8524.0 8607.9 9072.2 8738.4 8843.1 8846.0 8853.0 8854.7 2315.0 2346.1 2358.8 2359.0 2363.2 2300.3 2336.6 2338.1 2343.2 2349.1 2315.8 2334.2 2351.8 2355.4 2357.2 2301.5 2317.9 2322.0 2331.6 2332.2 2312.5 2318.8 2321.5 2322.4 2336.2 8793.8 8913.0 8966.3 8978.3 9027.8 5144.9 5270.7 5277.3 5304.4 5317.2 2863.7 3435.8 3535.7 3629.7 3696.3 1085.7 1108.6 1120.0 1129.1 1142.5 11500.3 11528.6 11653.1 11659.4 11670.4 4116.0 4239.2 4591.9 4695.2 4705.2 9649.2 9727.2 9741.0 9750.7 9760.1 5195.8 5230.6 5233.8 5248.6 5252.4 4320.6 4569.3 4666.5 4701.5 4810.6 3647.1 3721.0 3773.9 3784.2 3820.9 1291.7 1293.1 1293.4 1303.9 1314.3 908.0 921.7 923.9 929.8 936.4 5847.9 6061.0 6084.9 6124.3 6276.4 416.3 422.0 422.3 423.2 429.8 4046.6 4070.0 4073.6 4145.1 4145.3 10359.4 10833.2 10863.4 10998.9 11018.4 10938.7 10943.0 10945.2 10946.6 10952.9 8123.4 8164.1 8341.7 8355.0 8365.2 4118.0 4976.8 5980.6 6103.4 6155.1 9898.6 9933.4 10001.2 10048.5 10091.3 9635.7 9962.6 10169.4 10184.4 10307.4 6697.6 6784.3 7492.4 7609.0 7670.6 8363.7 8450.8 8493.5 8525.7 8546.2 7402.7 7504.2 7548.4 7605.4 7634.4 7312.3 7350.4 7361.8 7480.3 7514.8 6842.3 6974.7 6981.1 6981.2 6986.3 4992.5 5005.1 5156.6 5157.0 5178.2 5075.9 5176.0 5176.3 5209.3 5269.2 17:03:29 INFO - PROCESS | 1662 | 17:03:29 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4409.42 Median:4832.61 stddev:1381.98 (28.6%) stddev-sans-first:1350.95 17:03:29 INFO - PROCESS | 1662 | Values: 297.2 299.3 309.1 311.5 313.7 5298.3 5339.9 5486.5 5546.3 5597.0 4833.8 4995.5 5302.4 5338.7 5485.2 3335.9 3682.6 3858.7 4235.7 4243.6 3888.8 4030.5 4197.8 4250.7 4268.5 3814.6 4192.8 4206.4 4221.0 4239.4 3828.6 4199.2 4207.5 4224.5 4228.9 3148.5 3545.2 3646.2 3656.5 3670.8 4494.0 4945.7 5032.5 5296.5 5322.7 4650.4 4741.0 4750.5 4751.8 4787.7 5026.3 5750.8 5776.0 5784.9 5832.0 3603.6 3746.3 3840.7 3896.9 3914.3 5241.2 5622.7 6080.0 6135.3 6153.4 3650.8 3761.5 3967.1 3998.8 4007.2 3143.7 3542.0 3714.2 3756.6 4003.4 3693.0 4388.5 4654.2 4697.0 4751.5 5800.4 5890.6 5900.0 5932.2 5956.9 1115.6 1153.2 1189.8 1255.0 1288.7 850.9 889.0 900.6 903.2 920.7 4703.0 4852.0 4868.5 5019.3 5312.0 5386.4 5863.9 5865.4 5867.5 5870.5 4963.1 5267.6 5275.3 5319.9 5364.6 2376.5 2421.6 2467.7 2535.6 2669.5 4222.6 4291.2 5118.4 5170.7 5252.0 4338.9 4379.1 4532.9 4601.2 4885.5 4057.7 4268.0 4764.8 4917.5 4993.0 4125.3 4426.9 4831.5 4997.8 5031.6 3759.0 4589.0 4843.2 4955.6 4980.9 4826.8 4850.3 4893.0 4986.7 5050.9 2820.6 3391.3 3411.9 3486.6 3524.3 4688.7 4783.0 4794.0 4878.9 5029.8 4851.3 5283.8 5569.4 5744.8 5873.9 5810.8 5811.3 5850.5 5854.2 5872.6 4714.5 5439.0 5676.0 5692.3 5719.2 5041.9 5855.7 5860.6 5895.6 5937.7 5565.3 5750.3 5761.9 5791.8 5819.7 17:03:29 INFO - PROCESS | 1662 | 17:03:29 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:25857.43 Median:3609.00 stddev:41710.62 (1155.7%) stddev-sans-first:41784.88 17:03:29 INFO - PROCESS | 1662 | Values: 706.5 737.5 753.2 810.8 860.9 15670.6 16477.1 16500.6 16549.4 16580.8 14796.9 14930.3 14934.4 14936.0 14939.2 820.6 834.3 863.8 867.6 869.8 856.9 866.1 871.5 871.6 873.2 877.7 904.7 912.8 913.0 913.3 904.9 907.4 908.3 908.4 909.7 667.3 671.8 675.9 676.2 676.5 15333.5 15659.8 15718.3 15754.8 15779.0 11004.3 12362.0 13699.3 13760.4 14507.9 10255.9 11219.7 11423.3 11483.5 11960.4 3458.5 3646.7 3870.8 3897.2 3992.6 125728.0 126123.0 126669.4 128129.4 129315.7 11077.7 11112.4 11133.7 11296.9 11559.3 22125.3 22301.7 22313.9 22328.7 22484.9 6932.5 7883.6 8010.2 8308.1 8309.3 4585.3 4645.5 4652.0 4705.3 4821.1 3571.3 3685.6 3689.8 3691.3 3694.6 614.0 643.7 663.3 679.4 690.9 509.7 559.2 586.4 674.7 697.8 9024.6 9864.6 9978.5 10051.2 10108.7 658.4 677.2 701.1 703.2 707.5 4665.0 4783.8 4785.3 4824.3 4909.5 99147.0 104543.0 111854.0 149578.0 176027.0 142137.6 142534.0 149270.0 151506.0 151993.0 117706.8 120046.0 120822.0 127840.0 131244.0 8227.4 8762.6 8930.0 9353.5 9397.6 66719.0 66909.0 67193.0 67875.0 70476.6 75802.0 87505.6 90703.0 94924.0 96068.5 13267.6 13290.6 13364.7 13669.2 14057.8 15033.8 15146.4 15315.4 15475.5 15818.5 12842.9 13837.9 13899.0 14088.7 14771.6 13587.9 14070.4 14092.6 14328.9 14391.4 13486.1 13572.6 13687.6 13851.3 13965.4 11136.7 11146.8 11471.6 11710.8 11970.4 8394.7 9769.2 10424.7 10846.6 11814.6 17:03:29 INFO - PROCESS | 1662 | -------- Summary: end -------- 17:03:29 INFO - PROCESS | 1662 | 17:03:29 INFO - TEST-INFO | 1662: exit 0 17:03:29 INFO - TEST-OK | dromaeo_css | took 1114321ms 17:03:29 INFO - TEST-START | kraken 17:03:29 INFO - operating with platform_type : mac_ 17:03:29 INFO - Initialising browser for kraken test... 17:03:29 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpdIDdlL/profile http://localhost:49270/getInfo.html) 17:03:32 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 17:03:32 INFO - PROCESS | 1670 | colorDepth:24 17:03:32 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 17:03:32 INFO - PROCESS | 1670 | __metrics 17:03:32 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 17:03:33 INFO - TEST-INFO | 1670: exit 0 17:03:33 INFO - Browser initialized. 17:03:33 INFO - Running cycle 1/1 for kraken test... 17:03:33 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpdIDdlL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:45 INFO - PROCESS | 1672 | RSS: Main: 246996992 17:03:45 INFO - PROCESS | 1672 | 17:03:48 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 17:03:49 INFO - PROCESS | 1672 | RSS: Main: 259928064 17:03:49 INFO - PROCESS | 1672 | 17:03:51 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 17:03:52 INFO - PROCESS | 1672 | RSS: Main: 268500992 17:03:52 INFO - PROCESS | 1672 | 17:03:55 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 17:03:56 INFO - PROCESS | 1672 | RSS: Main: 265158656 17:03:56 INFO - PROCESS | 1672 | 17:03:58 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 17:03:58 INFO - PROCESS | 1672 | RSS: Main: 267599872 17:03:58 INFO - PROCESS | 1672 | 17:04:00 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:04:01 INFO - PROCESS | 1672 | RSS: Main: 268881920 17:04:01 INFO - PROCESS | 1672 | 17:04:04 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 17:04:04 INFO - PROCESS | 1672 | RSS: Main: 268967936 17:04:04 INFO - PROCESS | 1672 | 17:04:07 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 17:04:08 INFO - PROCESS | 1672 | RSS: Main: 268734464 17:04:08 INFO - PROCESS | 1672 | 17:04:11 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 17:04:11 INFO - PROCESS | 1672 | RSS: Main: 269139968 17:04:11 INFO - PROCESS | 1672 | 17:04:13 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:04:14 INFO - PROCESS | 1672 | RSS: Main: 269565952 17:04:14 INFO - PROCESS | 1672 | 17:04:16 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:04:16 INFO - PROCESS | 1672 | RSS: Main: 269070336 17:04:16 INFO - PROCESS | 1672 | 17:04:18 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:04:19 INFO - PROCESS | 1672 | RSS: Main: 269144064 17:04:19 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:04:23 INFO - PROCESS | 1672 | RSS: Main: 269021184 17:04:23 INFO - PROCESS | 1672 | 17:04:26 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:04:26 INFO - PROCESS | 1672 | RSS: Main: 269398016 17:04:26 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 17:04:28 INFO - PROCESS | 1672 | RSS: Main: 271433728 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | __start_tp_report 17:04:28 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 17:04:28 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 17:04:28 INFO - PROCESS | 1672 | |i|pagename|runs| 17:04:28 INFO - PROCESS | 1672 | |0;ai-astar;108;115;115;114;118;138;118;117;117;132 17:04:28 INFO - PROCESS | 1672 | |1;audio-beat-detection;146;111;146;200;111;128;110;167;181;110 17:04:28 INFO - PROCESS | 1672 | |2;audio-dft;201;202;215;213;199;196;198;194;198;190 17:04:28 INFO - PROCESS | 1672 | |3;audio-fft;68;83;75;141;60;59;67;86;156;82 17:04:28 INFO - PROCESS | 1672 | |4;audio-oscillator;71;72;119;70;73;87;115;71;72;112 17:04:28 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;89;87;88;86;88;85;89;86;88;85 17:04:28 INFO - PROCESS | 1672 | |6;imaging-darkroom;93;95;93;94;96;94;118;95;93;94 17:04:28 INFO - PROCESS | 1672 | |7;imaging-desaturate;93;95;91;97;95;90;90;90;91;91 17:04:28 INFO - PROCESS | 1672 | |8;json-parse-financial;57;61;58;57;58;62;60;59;58;58 17:04:28 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;79;107;61;89;108;62;96;110;103;84 17:04:28 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;89;86;89;80;86;89;87;90;88;88 17:04:28 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;137;139;136;139;139;138;140;142;148;124 17:04:28 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;172;172;168;169;173;174;169;173;200;174 17:04:28 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;68;71;69;67;70;66;69;68;69;82 17:04:28 INFO - PROCESS | 1672 | __end_tp_report 17:04:28 INFO - PROCESS | 1672 | __start_cc_report 17:04:28 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1071 17:04:28 INFO - PROCESS | 1672 | __end_cc_report 17:04:28 INFO - PROCESS | 1672 | __startTimestamp1471997068639__endTimestamp 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | ------- Summary: start ------- 17:04:28 INFO - PROCESS | 1672 | Number of tests: 14 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:119.20 Median:117.50 stddev:8.93 (7.6%) stddev-sans-first:8.50 17:04:28 INFO - PROCESS | 1672 | Values: 108.0 115.0 115.0 114.0 118.0 138.0 118.0 117.0 117.0 132.0 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:146.00 stddev:32.83 (22.5%) stddev-sans-first:34.77 17:04:28 INFO - PROCESS | 1672 | Values: 146.0 111.0 146.0 200.0 111.0 128.0 110.0 167.0 181.0 110.0 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:200.60 Median:200.00 stddev:7.86 (3.9%) stddev-sans-first:8.34 17:04:28 INFO - PROCESS | 1672 | Values: 201.0 202.0 215.0 213.0 199.0 196.0 198.0 194.0 198.0 190.0 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:87.70 Median:71.50 stddev:33.55 (46.9%) stddev-sans-first:34.82 17:04:28 INFO - PROCESS | 1672 | Values: 68.0 83.0 75.0 141.0 60.0 59.0 67.0 86.0 156.0 82.0 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:86.20 Median:71.50 stddev:20.75 (29.0%) stddev-sans-first:21.26 17:04:28 INFO - PROCESS | 1672 | Values: 71.0 72.0 119.0 70.0 73.0 87.0 115.0 71.0 72.0 112.0 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:88.00 stddev:1.52 (1.7%) stddev-sans-first:1.45 17:04:28 INFO - PROCESS | 1672 | Values: 89.0 87.0 88.0 86.0 88.0 85.0 89.0 86.0 88.0 85.0 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:96.50 Median:94.00 stddev:7.62 (8.1%) stddev-sans-first:7.98 17:04:28 INFO - PROCESS | 1672 | Values: 93.0 95.0 93.0 94.0 96.0 94.0 118.0 95.0 93.0 94.0 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:92.30 Median:92.00 stddev:2.54 (2.8%) stddev-sans-first:2.68 17:04:28 INFO - PROCESS | 1672 | Values: 93.0 95.0 91.0 97.0 95.0 90.0 90.0 90.0 91.0 91.0 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:58.50 stddev:1.69 (2.9%) stddev-sans-first:1.66 17:04:28 INFO - PROCESS | 1672 | Values: 57.0 61.0 58.0 57.0 58.0 62.0 60.0 59.0 58.0 58.0 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:89.90 Median:70.50 stddev:18.26 (25.9%) stddev-sans-first:18.94 17:04:28 INFO - PROCESS | 1672 | Values: 79.0 107.0 61.0 89.0 108.0 62.0 96.0 110.0 103.0 84.0 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:88.50 stddev:2.86 (3.2%) stddev-sans-first:2.96 17:04:28 INFO - PROCESS | 1672 | Values: 89.0 86.0 89.0 80.0 86.0 89.0 87.0 90.0 88.0 88.0 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:139.00 stddev:6.00 (4.3%) stddev-sans-first:6.34 17:04:28 INFO - PROCESS | 1672 | Values: 137.0 139.0 136.0 139.0 139.0 138.0 140.0 142.0 148.0 124.0 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:173.00 stddev:9.25 (5.3%) stddev-sans-first:9.77 17:04:28 INFO - PROCESS | 1672 | Values: 172.0 172.0 168.0 169.0 173.0 174.0 169.0 173.0 200.0 174.0 17:04:28 INFO - PROCESS | 1672 | 17:04:28 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:69.00 stddev:4.48 (6.5%) stddev-sans-first:4.70 17:04:28 INFO - PROCESS | 1672 | Values: 68.0 71.0 69.0 67.0 70.0 66.0 69.0 68.0 69.0 82.0 17:04:28 INFO - PROCESS | 1672 | -------- Summary: end -------- 17:04:28 INFO - PROCESS | 1672 | 17:04:29 INFO - TEST-INFO | 1672: exit 0 17:04:29 INFO - TEST-OK | kraken | took 59583ms 17:04:29 INFO - SUITE-END | took 1173s 17:04:29 INFO - Completed test suite (00:19:34) 17:04:29 INFO - javascript benchmark 17:04:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7330.26628804131, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3437.72498200144, 3458.0836078439233, 3470.4273794823857, 3481.042713253855, 3517.824108794561, 5837.678927658977, 5865.648061116331, 5867.677277749722, 5924.58527903047, 5941.346451890288, 5870.442307980746, 5930.911036334448, 5951.22634057573, 5964.194833697449, 6000.009998350267, 5317.73411329432, 5373.382061062969, 5431.293931788881, 5451.781928722866, 5463.426340234278, 5234.162533994561, 5274.789008439658, 5347.946520534803, 5375.274337964383, 5377.4084850666395, 5314.096603577382, 5354.946450535484, 5358.785648574052, 5366.597505187126, 5388.757505912224, 5322.3879253885525, 5368.0, 5374.059539580558, 5378.8924221515745, 5432.565394768409, 4731.313959475891, 5234.81678141267, 5289.841304760864, 5318.680879147263, 5321.175217841241, 5849.61977471463, 5942.821715348547, 5948.226730525047, 5968.70156492178, 6014.578979471439, 5282.0, 6152.784652537184, 6169.167162433104, 6251.12484252205, 6259.6870156492, 6144.003198960311, 6196.1944947157035, 6203.2556093269095, 6310.747570097191, 6325.209348831396, 5982.102684597258, 6041.577089603686, 6052.243469566304, 6073.1497590337385, 6090.817275481742, 6382.074599183093, 6400.295967443578, 6456.225252969673, 6483.935160648333, 6484.578502397329, 6111.95640283616, 6135.01831721223, 6155.322914479404, 6235.0, 6238.001919692827, 6263.342349053284, 6286.591371560834, 6290.968545157245, 6292.590981586274, 6301.936980630227, 6177.567570270128, 6200.224971878515, 6211.937880621226, 6234.844128896814, 6245.469135123565, 6010.098485227251, 6060.909036373495, 6160.722767475385, 6210.875782484325, 6220.595661282002, 4335.848245311462, 4945.166481000124, 5056.241563765465, 5075.213341932006, 5114.130597798383, 3887.280853042196, 4513.977430112828, 4517.796699148546, 4556.6126879215635, 4571.954280457219, 5785.363610002896, 5981.671008094597, 5983.6708981005595, 6004.1294012368835, 6020.096985452217, 6287.339829317856, 6300.117983482316, 6307.810765677037, 6319.431251187415, 6325.557210995278, 6010.278766547955, 6011.879762404815, 6023.879522409615, 6029.6683682397015, 6043.0, 5480.506754392124, 5524.723763811793, 5527.088030474926, 5562.749676264497, 5638.126090455986, 6450.5484616077365, 6501.187351581052, 6518.967405162944, 6563.507736919845, 6572.934270657423, 6200.976838821544, 6313.715882785194, 6316.842078948063, 6325.77859774924, 6345.714442850175, 6312.842178945563, 6577.704003319958, 6581.605103693793, 6585.1439312889015, 6603.0, 6163.013917773134, 6198.535109866688, 6204.937950620617, 6270.874582508415, 6291.0, 6283.02613094971, 6296.150019747275, 6298.779542715983, 6308.842278943063, 6314.905276420765, 5140.306058682179, 6112.1748563945075, 6124.2588809726185, 6147.877042459037, 6170.845728856814, 6182.072689096492, 6193.380661933951, 6197.442230199304, 6199.1011303361665, 6212.658303793335, 6043.879122417615, 6061.36355682647, 6099.3900609938655, 6166.383361663798, 6167.044108163242, 5959.433853783884, 6104.125697713769, 6139.768135342541, 6151.400635834626, 6213.068039793886, 6109.95128740435, 6117.579072698688, 6123.598586248296, 6131.013867888357, 6147.538934580014], "value": 5806.076965939234, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.842555105713, 474.80295677293924, 535.7160704826443, 544.945505449455, 570.5435651478816, 38185.23629527408, 40785.3882191767, 40932.7720168395, 40964.795176024076, 41037.7948110259, 41964.58035419645, 42413.0, 42445.0, 42456.78771606138, 42566.787166064205, 9772.8045439091, 9943.10512053915, 9986.201103911706, 9991.350562213433, 9998.000199980017, 9834.114929656329, 9889.653862114792, 9923.801523969516, 9954.701358959206, 9990.300678952477, 9945.955674654166, 9962.701118966443, 9965.950170249174, 9995.55020024097, 10012.449315287657, 9899.0, 9920.503974801268, 9939.801203975952, 9953.601855925754, 9976.750581235454, 9862.753431164278, 9890.30767846251, 9924.255680823895, 9934.304598678096, 9936.304458687895, 39982.0, 40074.79962600168, 40104.79947600243, 40417.98955026118, 40572.39141412881, 3209.133533945845, 3272.5091236314743, 3293.950590741141, 3313.3207692422993, 3357.3117510910206, 31638.0, 31885.521717174262, 32143.678563214304, 32458.837705811555, 33175.17062073443, 3288.490284005983, 3294.8352582370785, 3344.5484859543894, 3434.862605495777, 3440.1055725511546, 425695.0, 515648.0, 515705.0, 516152.0, 516201.0, 59311.0, 59713.507162321286, 59858.0, 59876.401235987956, 59935.70032149899, 30412.847935760623, 31561.684383155876, 34627.65372346294, 35171.4724279136, 35753.642463575554, 12974.870251297367, 13055.543055992996, 16356.591085222964, 16398.18009099564, 16440.424585139463, 12595.24428534291, 12634.0, 12723.809142862865, 12733.29966851832, 12743.936280318725, 18983.145758440904, 18988.81011189898, 18996.0, 19043.857368557652, 19151.904240478987, 6716.3955244028275, 7927.603619818986, 7933.484323518953, 7970.92392527013, 8045.15525869787, 839.6935118681637, 963.9469829159324, 1000.8899021107673, 1047.2041248650928, 1090.36758679967, 28614.713852861205, 30304.090877273717, 30376.088717338072, 30437.847810760806, 30561.235969100504, 998.32612986234, 1020.8928062553473, 1069.2515239332342, 1141.6004398460473, 1144.9866867822038, 15428.84571154274, 15747.68504629901, 15941.96377235476, 15986.440474583334, 16343.509694709177, 641725.0, 645103.0, 645748.0, 646167.0, 649679.0, 58847.0, 59208.70395647994, 59291.11063334053, 59454.70272648609, 60712.0, 1374.9518766843112, 1389.7290028444559, 1410.6261840612042, 1417.1922004457567, 1419.0, 24882.129125480522, 28269.43461130807, 28886.0, 30236.24409389695, 30519.779208831398, 50479.0, 50877.49122508727, 50963.235551466016, 51008.48991510038, 51135.48864511456, 603189.0, 603867.0, 605957.0, 608197.0, 616301.0, 26325.0, 27165.86417067902, 27415.17754467369, 27470.0, 27510.724892750815, 46907.061858763314, 47304.7634761824, 48343.5165648339, 48557.02885942332, 49004.264936025276, 27863.721362786113, 39319.0, 39552.01119972024, 39972.800136000296, 40567.3914891271, 34113.82943085269, 39105.41341879931, 39566.0, 40255.59105431296, 40336.1932761349, 37232.44151337786, 37968.620313796506, 38377.42433863439, 38579.228415432095, 38893.0, 34212.31575368528, 35079.64920350764, 35273.47089793706, 35537.1115722109, 35655.82172089123, 24434.755652443248, 24584.68441011458, 24791.50416991686, 24844.875775621007, 25337.746622533537], "value": 19848.586849817166, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.9979662132186, 374.91939233064886, 383.992320153597, 389.2021356219749, 405.1653593597188, 20210.39368818936, 21042.579148417022, 21889.233876814335, 21898.89050554749, 21934.122635094576, 20985.160593576238, 21386.0, 21412.8929355353, 21770.0, 22064.44838879029, 5939.67331796751, 5970.820875373745, 6137.0, 6198.977168767148, 6212.596181248205, 4217.325227963526, 6069.1199776032445, 6171.290301615304, 6587.769428070019, 6838.7264509419565, 6888.138982627172, 6905.378515933565, 6911.136107986502, 6916.308369163068, 6930.757423490179, 6416.743330266807, 6750.898736518931, 6770.72917083316, 6811.25076241613, 6818.965905170492, 4411.757353345564, 4935.210366341368, 4970.602351811846, 5816.854578635525, 5967.850803729898, 13817.240051797147, 13999.440022399092, 14002.859971400258, 14140.0, 26051.348716282057, 2034.7049677796786, 2220.378294077661, 2303.884805759722, 2414.8913298901416, 2471.308033750535, 8343.95828020862, 10570.365778053265, 10830.40432776197, 11224.831627525593, 12278.38608069593, 1570.458191923796, 1936.4771511691765, 1951.1024928532893, 2022.9595408091757, 2024.1498570600236, 122360.0, 127142.0, 132678.0, 135878.0, 137236.0, 10907.672769816918, 11546.364949927667, 11600.94199528997, 11625.76748465026, 11762.470688818852, 14491.710165796625, 14503.782443263359, 14595.635109122357, 14598.270086495633, 14638.048526845721, 8454.957725211334, 8586.356023298278, 8643.827123457622, 8731.563421828883, 8766.780830479289, 8698.608562614698, 8702.825943481095, 8744.475331480131, 8892.688755893512, 8941.821163576822, 4483.32750087483, 4550.067236216634, 4562.703424277412, 4596.4254468191475, 4616.330632058332, 1702.7229577816638, 1771.8405343518887, 1814.4738025972583, 1840.9966568220084, 1913.9233931184542, 634.3624657219465, 679.5956405938458, 689.7723751162105, 780.5433821214654, 798.6006996501749, 20774.58450830975, 21191.576168476546, 21508.569151056072, 21534.892325538585, 21793.029639392247, 813.3241635020834, 848.9702860399856, 849.2781136034322, 860.423516244118, 875.0156074416282, 10688.625898093529, 11143.777124457465, 11209.495572699248, 11232.55069797199, 11357.432128393548, 605729.5702822306, 614049.0, 624554.0, 638024.0, 638460.0, 97589.51205243928, 110359.0, 121243.0, 126943.0, 130148.0, 411.4075730947486, 433.1013147718497, 433.57726216938863, 436.3040949685247, 437.34180059010987, 9339.953300233727, 10735.46322683847, 11156.721081973015, 11159.660840699167, 11464.0, 54043.72978135084, 57013.85972280614, 57595.71202143963, 57935.420645793005, 57946.0, 82549.0, 82820.0, 83320.58339708262, 85146.57426712826, 85464.71802922837, 11341.489632966372, 11391.259568128045, 11971.64085077449, 12161.81757273624, 12260.203086799685, 12569.811452828031, 13417.731645367234, 13516.93241533786, 14001.649958751113, 14108.929455352658, 11474.246180916352, 11568.768624627628, 11623.59317423886, 11784.116191285859, 11800.232984855957, 11347.432628368384, 11433.771324573629, 11760.235584686969, 11793.52825886955, 11880.821787673365, 11662.76674466489, 11870.643880683594, 11874.881251187722, 11993.700157496132, 12066.75866482683, 11650.359230242419, 12077.839174928487, 12207.511699531919, 12288.815667764811, 12357.75284494323, 11675.0, 11713.297202167556, 11937.28376297425, 11979.221350612183, 11989.700257493632], "value": 9467.931611013511, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.550021243096, 1402.8176337076181, 1574.3073047858934, 1577.8875892495792, 1802.9909850450745, 7373.152087509925, 8239.629216685249, 8524.0, 8607.870881936777, 9072.228860546853, 8738.432001919871, 8843.115688431153, 8846.0, 8852.955735221314, 8854.690085846996, 2315.0, 2346.061575369857, 2358.84667496613, 2358.988205058972, 2363.2201373546773, 2300.332903457995, 2336.6261398176293, 2338.1348900906605, 2343.1798870395396, 2349.142562964514, 2315.78000089992, 2334.206369834256, 2351.835371523994, 2355.4346956730433, 2357.1985524921524, 2301.5051763870765, 2317.8841057947034, 2322.036354912718, 2331.6269396896414, 2332.172078911996, 2312.479692069288, 2318.7565305643, 2321.4892723600783, 2322.3729593009793, 2336.1706594159, 8793.824123517557, 8913.0, 8966.327525435554, 8978.281737460988, 9027.819443611092, 5144.897102057937, 5270.710110943896, 5277.287566178555, 5304.389995150568, 5317.202419637047, 2863.7422631963013, 3435.845386957593, 3535.681788639035, 3629.709623230135, 3696.2607478504137, 1085.6905781852213, 1108.6009036746764, 1120.0423637789736, 1129.091081679248, 1142.4630423700846, 11500.25248358854, 11528.59649912249, 11653.126015548867, 11659.417029148508, 11670.416479176092, 4115.97942010288, 4239.1521695660995, 4591.897944493365, 4695.22528782747, 4705.1765940960195, 9649.228061755042, 9727.173190278905, 9740.95129524362, 9750.707478775648, 9760.072793084646, 5195.844124676266, 5230.607704422184, 5233.842984710464, 5248.63259571834, 5252.44849290819, 4320.611144996902, 4569.2689169732685, 4666.533346665306, 4701.529847015339, 4810.5670489656095, 3647.0699971507097, 3721.0, 3773.8867833965023, 3784.2053168834304, 3820.904477388032, 1291.7222797098668, 1293.1336004876755, 1293.4244261303818, 1303.8696130386886, 1314.309987256698, 908.0102688070035, 921.6728061538191, 923.9027407784292, 929.7815013471828, 936.4147407870081, 5847.853803654858, 6061.0, 6084.939150608526, 6124.265088189357, 6276.435120839146, 416.26113648274554, 421.9662427005832, 422.2989836870841, 423.18325631530826, 429.7722207230173, 4046.615571520701, 4070.0, 4073.551909289976, 4145.108801607669, 4145.253854306254, 10359.430231337348, 10833.241673082808, 10863.40251286171, 10998.900109988937, 11018.39398833072, 10938.726531836768, 10943.0, 10945.179111566664, 10946.616868409568, 10952.945235273774, 8123.4313598047565, 8164.061132969785, 8341.66633334672, 8355.039170495349, 8365.24712775853, 4118.032262418389, 4976.776045078052, 5980.581359304807, 6103.42017508336, 6155.1382806406245, 9898.554565044735, 9933.3543319684, 10001.199904007808, 10048.538108163546, 10091.344062635904, 9635.699180610527, 9962.55168517404, 10169.389836609827, 10184.439855808001, 10307.433091180057, 6697.631630260383, 6784.2876497967, 7492.400607951242, 7609.0, 7670.616469176631, 8363.707270245512, 8450.830983380421, 8493.532855692996, 8525.658973641233, 8546.188112129337, 7402.740904068547, 7504.249575042452, 7548.358389536951, 7605.429592780453, 7634.351080158027, 7312.341889229995, 7350.375218106521, 7361.8159546011775, 7480.326770590673, 7514.812129696801, 6842.281560436082, 6974.6861391238535, 6981.0924579804305, 6981.219788953785, 6986.336298051677, 4992.450830408579, 5005.099082165245, 5156.5616922562, 5156.9742151289, 5178.223266510054, 5075.87310317245, 5175.9741201293755, 5176.275321454924, 5209.322788037531, 5269.235960785742], "value": 4480.244549657313, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.1753384358405, 299.30113185711366, 309.05583442582906, 311.52647975077895, 313.72078849823663, 5298.337707786527, 5339.905319409521, 5486.47878451547, 5546.334439867216, 5596.972015139923, 4833.75831208439, 4995.525425084611, 5302.443243459439, 5338.733063346836, 5485.204645326426, 3335.949960750591, 3682.558093028827, 3858.6527212550864, 4235.7246778959425, 4243.596858298457, 3888.786116763591, 4030.476038115041, 4197.81109850056, 4250.724782565234, 4268.530461649216, 3814.5803961564206, 4192.790360481979, 4206.411102445645, 4220.97889510552, 4239.448871646681, 3828.55971563271, 4199.181159673864, 4207.474065741798, 4224.493060832689, 4228.9154216915485, 3148.511980643004, 3545.166885781839, 3646.179609587848, 3656.524651795276, 3670.8164591770305, 4493.955060449419, 4945.714114330264, 5032.547070763612, 5296.470352964711, 5322.654027488201, 4650.372199753024, 4740.976295118537, 4750.477447480775, 4751.786169622375, 4787.688800228009, 5026.346574945233, 5750.827475175752, 5775.971120144372, 5784.929787989236, 5831.970840145772, 3603.6036036036267, 3746.2775461584224, 3840.711946604016, 3896.941545876814, 3914.2954268231993, 5241.213817927303, 5622.690752008638, 6080.0, 6135.349467067088, 6153.353897840751, 3650.762700424464, 3761.4545890845675, 3967.147063381329, 3998.820053097618, 4007.218592374459, 3143.685631436838, 3541.9551232385993, 3714.2200137971327, 3756.6055564165918, 4003.4395184674167, 3692.981535092361, 4388.542416246912, 4654.162250794821, 4697.0, 4751.4535828379485, 5800.39095894925, 5890.5568135807, 5900.0, 5932.249986254065, 5956.910646340309, 1115.6039605939775, 1153.1985270237105, 1189.7739429508365, 1254.9686257843628, 1288.7486940046788, 850.8978922529212, 889.0398369760643, 900.5677274907949, 903.2367649336301, 920.6961702638114, 4702.9764851176205, 4851.95148048515, 4868.519008908576, 5019.322391477177, 5311.9734401328515, 5386.407495175527, 5863.941360586425, 5865.442782935615, 5867.501262392744, 5870.471657550841, 4963.131451995886, 5267.552258058108, 5275.340582427197, 5319.893602127936, 5364.570834333244, 2376.5484557933937, 2421.6488609151575, 2467.703875534947, 2535.6069809179608, 2669.519486492411, 4222.556631553704, 4291.184674911757, 5118.436971933084, 5170.699038927641, 5252.0, 4338.913221735547, 4379.1241751649795, 4532.914859164755, 4601.194790911577, 4885.5358740919555, 4057.6524367397014, 4267.997020700133, 4764.809407623657, 4917.5082491751255, 4992.975035124801, 4125.2986992212, 4426.933595996127, 4831.4685384608365, 4997.8255110048385, 5031.572316353151, 3759.0, 4588.977055114703, 4843.200871856246, 4955.603551715782, 4980.9329128412755, 4826.8069277228515, 4850.320955066364, 4893.0, 4986.7257300848805, 5050.91405347852, 2820.562812764025, 3391.3386889557287, 3411.94882076774, 3486.633903440102, 3524.3303772283184, 4688.742119183477, 4783.0, 4793.952060479351, 4878.853634390974, 5029.84910452687, 4851.345068415719, 5283.762230699551, 5569.384878385223, 5744.798932037359, 5873.882522349443, 5810.820942146695, 5811.331696854916, 5850.5027072699295, 5854.209681692917, 5872.588918775816, 4714.457837348612, 5439.0, 5675.971620142038, 5692.31692196939, 5719.199312096227, 5041.899162016813, 5855.677937713466, 5860.589758716849, 5895.64626122434, 5937.673427961331, 5565.30433695788, 5750.30996280449, 5761.91357129635, 5791.814502023954, 5819.738111785065], "value": 3970.7668989255144, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.5019161491149, 737.469022303941, 753.1639879733494, 810.841885832263, 860.9311255099591, 15670.608234794121, 16477.093759843203, 16500.587485312873, 16549.420770273056, 16580.8393412461, 14796.890233232496, 14930.253487325645, 14934.40262389506, 14936.0, 14939.17834519101, 820.5938060659967, 834.2950207075012, 863.8272345530887, 867.6095756909416, 869.7869022089566, 856.9357298202628, 866.0646501778097, 871.4684042733927, 871.5990644303628, 873.2184694698241, 877.714742708619, 904.6652738486769, 912.7946212102257, 913.0367462327242, 913.2693844924067, 904.8642703594447, 907.3875134284365, 908.2506931781273, 908.3596064774318, 909.6634245329237, 667.3093348384448, 671.8219671786981, 675.8682056998887, 676.1548064918851, 676.4824908944661, 15333.463328783551, 15659.843401565953, 15718.29267682957, 15754.842451575452, 15778.97436666613, 11004.339739615649, 12362.0, 13699.315034248348, 13760.380782864795, 14507.911906606942, 10255.897441025569, 11219.709733380603, 11423.314601123877, 11483.540658373655, 11960.40197990097, 3458.4985177149424, 3646.705419576065, 3870.825812838429, 3897.162110146304, 3992.5608183099835, 125728.0, 126123.0, 126669.36665316706, 128129.35935320357, 129315.70684293225, 11077.667669969915, 11112.388818614892, 11133.721656958478, 11296.887031129749, 11559.306441613362, 22125.336239912827, 22301.665475017886, 22313.88843055807, 22328.665070023962, 22484.887575562017, 6932.48006399512, 7883.645235964395, 8010.158933312035, 8308.12764659714, 8309.335253179732, 4585.28928016158, 4645.5354464553275, 4652.0, 4705.270683044134, 4821.059893320768, 3571.2857428514403, 3685.631436856293, 3689.763929083787, 3691.335559599298, 3694.630536946284, 613.9693015349214, 643.6717274190197, 663.349917081263, 679.4055201698513, 690.9136357955256, 509.72984318311353, 559.2003435087863, 586.4428792647002, 674.6727836999052, 697.849962258117, 9024.593893274818, 9864.5560949756, 9978.501074946224, 10051.24615653829, 10108.696739097839, 658.3821898666761, 677.1829190567216, 701.123595505618, 703.2405002597183, 707.5330282013949, 4665.0, 4783.832565860178, 4785.282207668808, 4824.300476430968, 4909.5090490950615, 99147.0, 104543.0, 111854.0, 149578.0, 176027.0, 142137.5786242145, 142534.0, 149270.0, 151506.0, 151993.0, 117706.8229317713, 120046.0, 120822.0, 127840.0, 131244.0, 8227.42408031432, 8762.597984322478, 8929.955350223207, 9353.513020459124, 9397.624095036123, 66719.0, 66909.0, 67193.0, 67875.0, 70476.64761676159, 75802.0, 87505.56247218723, 90703.0, 94924.0, 96068.51965740127, 13267.601971940858, 13290.601281961557, 13364.665883352605, 13669.248191349572, 14057.789133163215, 15033.849661503682, 15146.394144234107, 15315.387384504495, 15475.535733928, 15818.525444236691, 12842.935785321013, 13837.86162138406, 13899.0, 14088.718225635635, 14771.630709232355, 13587.93206034003, 14070.437182512995, 14092.577222683336, 14328.928355358574, 14391.424343026161, 13486.100488395043, 13572.592822215349, 13687.589372318846, 13851.30743462843, 13965.441382344592, 11136.665900023012, 11146.832797508207, 11471.598494052669, 11710.824337635113, 11970.401479925795, 8394.664213431395, 9769.21931609498, 10424.68725938223, 10846.620368287073, 11814.645560633195], "value": 7991.4795811885515, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 115.0, 114.0, 118.0, 138.0, 118.0, 117.0, 117.0, 132.0], "value": 119.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 146.0, 200.0, 111.0, 128.0, 110.0, 167.0, 181.0, 110.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 202.0, 215.0, 213.0, 199.0, 196.0, 198.0, 194.0, 198.0, 190.0], "value": 200.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 83.0, 75.0, 141.0, 60.0, 59.0, 67.0, 86.0, 156.0, 82.0], "value": 87.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 119.0, 70.0, 73.0, 87.0, 115.0, 71.0, 72.0, 112.0], "value": 86.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 86.0, 88.0, 85.0, 89.0, 86.0, 88.0, 85.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 93.0, 94.0, 96.0, 94.0, 118.0, 95.0, 93.0, 94.0], "value": 96.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 91.0, 97.0, 95.0, 90.0, 90.0, 90.0, 91.0, 91.0], "value": 92.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 58.0, 57.0, 58.0, 62.0, 60.0, 59.0, 58.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 107.0, 61.0, 89.0, 108.0, 62.0, 96.0, 110.0, 103.0, 84.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 80.0, 86.0, 89.0, 87.0, 90.0, 88.0, 88.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 136.0, 139.0, 139.0, 138.0, 140.0, 142.0, 148.0, 124.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 168.0, 169.0, 173.0, 174.0, 169.0, 173.0, 200.0, 174.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 69.0, 67.0, 70.0, 66.0, 69.0, 68.0, 69.0, 82.0], "value": 69.9, "unit": "score"}]}]} 17:04:29 INFO - Return code: 0 17:04:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:04:29 ERROR - # TBPL SUCCESS # 17:04:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:04:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:04:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:04:29 INFO - 2016-08-23 17:04:29.937 screenresolution[1677:11681] starting screenresolution argv=screenresolution get 17:04:29 INFO - 2016-08-23 17:04:29.939 screenresolution[1677:11681] Display 0: 1600x1200x32@60 17:04:29 INFO - 2016-08-23 17:04:29.945 screenresolution[1678:11684] starting screenresolution argv=screenresolution list 17:04:29 INFO - Available Modes on Display 0 17:04:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:04:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:04:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:04:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:04:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:04:30 INFO - Intel Iris: 17:04:30 INFO - Chipset Model: Intel Iris 17:04:30 INFO - Type: GPU 17:04:30 INFO - Bus: Built-In 17:04:30 INFO - VRAM (Dynamic, Max): 1536 MB 17:04:30 INFO - Vendor: Intel (0x8086) 17:04:30 INFO - Device ID: 0x0a2e 17:04:30 INFO - Revision ID: 0x0009 17:04:30 INFO - Displays: 17:04:30 INFO - Display: 17:04:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:04:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:04:30 INFO - Display Serial Number: 1600x1200 60 17:04:30 INFO - Main Display: Yes 17:04:30 INFO - Mirror: Off 17:04:30 INFO - Online: Yes 17:04:30 INFO - Rotation: Supported 17:04:30 INFO - Return code: 0 17:04:30 INFO - Running post-action listener: _resource_record_post_action 17:04:30 INFO - [mozharness: 2016-08-24 00:04:30.187297Z] Finished run-tests step (success) 17:04:30 INFO - Running post-run listener: _resource_record_post_run 17:04:30 INFO - Total resource usage - Wall time: 1208s; CPU: 55.0%; Read bytes: 32803840; Write bytes: 706430976; Read time: 310; Write time: 2212 17:04:30 INFO - TinderboxPrint: CPU usage
54.5% 17:04:30 INFO - TinderboxPrint: I/O read bytes / time
32,803,840 / 310 17:04:30 INFO - TinderboxPrint: I/O write bytes / time
706,430,976 / 2,212 17:04:30 INFO - TinderboxPrint: CPU idle
2,197.8 (45.5%) 17:04:30 INFO - TinderboxPrint: CPU system
975.6 (20.2%) 17:04:30 INFO - TinderboxPrint: CPU user
1,660.4 (34.3%) 17:04:30 INFO - TinderboxPrint: Swap in / out
435,265,536 / 0 17:04:30 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 406614528; Write bytes: 409094144; Read time: 29934; Write time: 898 17:04:30 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 28912640; Write bytes: 295821312; Read time: 279; Write time: 1307 17:04:30 INFO - Running post-run listener: _upload_blobber_files 17:04:30 INFO - Blob upload gear active. 17:04:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:04:30 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 17:04:30 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'] 17:04:30 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 17:04:31 INFO - (blobuploader) - INFO - Open directory for files ... 17:04:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:04:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:04:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:32 INFO - (blobuploader) - INFO - Done attempting. 17:04:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:04:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:04:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:33 INFO - (blobuploader) - INFO - Done attempting. 17:04:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:04:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:04:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:35 INFO - (blobuploader) - INFO - Done attempting. 17:04:35 INFO - (blobuploader) - INFO - Iteration through files over. 17:04:35 INFO - Return code: 0 17:04:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:04:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:04:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9875353a1584ecd07dc46acd92c96e6e5d0dc65dabda41255ec79e8a3b675f78dbfd8c4ccc553bf63259ab53da601995ba81aa9846f36ae29626a29e144bbb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4799be18ac8441a2f49bd8a08e4318123ac5e4960846d35c8288b65262eb7cb2b2510a88ff7c531b7a3b1635727a7762b69170940330810683bd28dffe68f31e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18062d8cb664c902bd03311bd299809a0ffff5935f5b27286af25c0743d4f203b642ef4816029e2ab665a67451d98953be3a978557c0754d30b61acd05128da6"} 17:04:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:04:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:04:35 INFO - Contents: 17:04:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9875353a1584ecd07dc46acd92c96e6e5d0dc65dabda41255ec79e8a3b675f78dbfd8c4ccc553bf63259ab53da601995ba81aa9846f36ae29626a29e144bbb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4799be18ac8441a2f49bd8a08e4318123ac5e4960846d35c8288b65262eb7cb2b2510a88ff7c531b7a3b1635727a7762b69170940330810683bd28dffe68f31e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18062d8cb664c902bd03311bd299809a0ffff5935f5b27286af25c0743d4f203b642ef4816029e2ab665a67451d98953be3a978557c0754d30b61acd05128da6"} 17:04:35 INFO - Running post-run listener: copy_logs_to_upload_dir 17:04:35 INFO - Copying logs to upload dir... 17:04:35 INFO - mkdir: /builds/slave/test/build/upload/logs 17:04:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.894158 ========= master_lag: 3.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-23 17:04:39.004456) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 17:04:39.007830) ========= 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.lsMhZL8HmI/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.O4XHgHCP13/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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/e9875353a1584ecd07dc46acd92c96e6e5d0dc65dabda41255ec79e8a3b675f78dbfd8c4ccc553bf63259ab53da601995ba81aa9846f36ae29626a29e144bbb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4799be18ac8441a2f49bd8a08e4318123ac5e4960846d35c8288b65262eb7cb2b2510a88ff7c531b7a3b1635727a7762b69170940330810683bd28dffe68f31e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18062d8cb664c902bd03311bd299809a0ffff5935f5b27286af25c0743d4f203b642ef4816029e2ab665a67451d98953be3a978557c0754d30b61acd05128da6"} build_url:https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011132 build_url: 'https://queue.taskcluster.net/v1/task/b_gtrB5-RKiNSAeI7wLiqg/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/e9875353a1584ecd07dc46acd92c96e6e5d0dc65dabda41255ec79e8a3b675f78dbfd8c4ccc553bf63259ab53da601995ba81aa9846f36ae29626a29e144bbb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4799be18ac8441a2f49bd8a08e4318123ac5e4960846d35c8288b65262eb7cb2b2510a88ff7c531b7a3b1635727a7762b69170940330810683bd28dffe68f31e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18062d8cb664c902bd03311bd299809a0ffff5935f5b27286af25c0743d4f203b642ef4816029e2ab665a67451d98953be3a978557c0754d30b61acd05128da6"}' ========= master_lag: 0.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 17:04:39.183882) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-08-23 17:04:39.184224) ========= 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.lsMhZL8HmI/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.O4XHgHCP13/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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.005340 ========= master_lag: 3.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-08-23 17:04:42.292862) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-08-23 17:04:42.293186) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-08-23 17:04:45.822069) ========= ========= Total master_lag: 6.54 =========