builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0366 starttime: 1472050481.92 results: success (0) buildid: 20160824061126 builduid: 9d0ac505609944a8a137b4ee03328f7e revision: cfe0aca91c8a5c6625ea5b09b1b0114bfd817199 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 07:54:41.922014) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 07:54:41.922421) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 07:54:41.923012) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 07:54:42.709948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:54:42.710205) ========= 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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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-24 07:54:42-- 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% 21.4M=0.001s 2016-08-24 07:54:42 (21.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158702 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:54:42.911757) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:54:42.912072) ========= 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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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.020337 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 07:54:42.972206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 07:54:42.972564) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cfe0aca91c8a5c6625ea5b09b1b0114bfd817199 --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 cfe0aca91c8a5c6625ea5b09b1b0114bfd817199 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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-24 07:54:43,061 truncating revision to first 12 chars 2016-08-24 07:54:43,061 Setting DEBUG logging. 2016-08-24 07:54:43,061 attempt 1/10 2016-08-24 07:54:43,061 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cfe0aca91c8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 07:54:43,800 unpacking tar archive at: fx-team-cfe0aca91c8a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.993343 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 07:54:43.990491) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 07:54:43.990823) ========= script_repo_revision: cfe0aca91c8a5c6625ea5b09b1b0114bfd817199 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 07:54:43.991669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 07:54:43.991943) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 07:54:44.010446) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-24 07:54:44.010797) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 07:54:44 INFO - MultiFileLogger online at 20160824 07:54:44 in /builds/slave/test 07:54:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:54:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:54:44 INFO - {'append_to_log': False, 07:54:44 INFO - 'base_work_dir': '/builds/slave/test', 07:54:44 INFO - 'blob_upload_branch': 'Fx-Team', 07:54:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:54:44 INFO - 'branch': 'Fx-Team', 07:54:44 INFO - 'buildbot_json_path': 'buildprops.json', 07:54:44 INFO - 'config_files': ('talos/mac_config.py',), 07:54:44 INFO - 'default_actions': ('clobber', 07:54:44 INFO - 'read-buildbot-config', 07:54:44 INFO - 'download-and-extract', 07:54:44 INFO - 'populate-webroot', 07:54:44 INFO - 'create-virtualenv', 07:54:44 INFO - 'install', 07:54:44 INFO - 'run-tests'), 07:54:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:54:44 INFO - 'download_minidump_stackwalk': True, 07:54:44 INFO - 'download_symbols': 'ondemand', 07:54:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:54:44 INFO - 'tooltool.py': '/tools/tooltool.py', 07:54:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:54:44 INFO - '/tools/misc-python/virtualenv.py')}, 07:54:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:54:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:54:44 INFO - 'installer_path': 'installer.exe', 07:54:44 INFO - 'log_level': 'info', 07:54:44 INFO - 'log_name': 'talos', 07:54:44 INFO - 'log_to_console': True, 07:54:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:54:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:54:44 INFO - 'opt_config_files': (), 07:54:44 INFO - 'pip_index': False, 07:54:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:54:44 INFO - 'cmd': ('bash', 07:54:44 INFO - '-c', 07:54:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:54:44 INFO - 'enabled': True, 07:54:44 INFO - 'halt_on_failure': False, 07:54:44 INFO - 'name': 'check_screen_resolution'},), 07:54:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:54:44 INFO - 'cmd': ('bash', 07:54:44 INFO - '-c', 07:54:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:54:44 INFO - 'enabled': True, 07:54:44 INFO - 'halt_on_failure': False, 07:54:44 INFO - 'name': 'check_screen_resolution'},), 07:54:44 INFO - 'run_cmd_checks_enabled': True, 07:54:44 INFO - 'sps_profile': False, 07:54:44 INFO - 'sps_profile_interval': 0, 07:54:44 INFO - 'suite': 'dromaeojs', 07:54:44 INFO - 'system_bits': '32', 07:54:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:54:44 INFO - 'title': 't-yosemite-r7-0366', 07:54:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:54:44 INFO - 'use_talos_json': True, 07:54:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:54:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:54:44 INFO - 'work_dir': 'build'} 07:54:44 INFO - [mozharness: 2016-08-24 14:54:44.210107Z] Running clobber step. 07:54:44 INFO - Running pre-action listener: _resource_record_pre_action 07:54:44 INFO - Running main action method: clobber 07:54:44 INFO - rmtree: /builds/slave/test/build 07:54:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:54:45 INFO - Running post-action listener: _resource_record_post_action 07:54:45 INFO - [mozharness: 2016-08-24 14:54:45.136135Z] Finished clobber step (success) 07:54:45 INFO - [mozharness: 2016-08-24 14:54:45.136261Z] Running read-buildbot-config step. 07:54:45 INFO - Running pre-action listener: _resource_record_pre_action 07:54:45 INFO - Running main action method: read_buildbot_config 07:54:45 INFO - Using buildbot properties: 07:54:45 INFO - { 07:54:45 INFO - "project": "", 07:54:45 INFO - "product": "firefox", 07:54:45 INFO - "script_repo_revision": "production", 07:54:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:54:45 INFO - "repository": "", 07:54:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:54:45 INFO - "buildid": "20160824061126", 07:54:45 INFO - "pgo_build": "False", 07:54:45 INFO - "basedir": "/builds/slave/test", 07:54:45 INFO - "buildnumber": 127, 07:54:45 INFO - "slavename": "t-yosemite-r7-0366", 07:54:45 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 07:54:45 INFO - "platform": "yosemite_r7", 07:54:45 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:54:45 INFO - "branch": "fx-team", 07:54:45 INFO - "repo_path": "integration/fx-team", 07:54:45 INFO - "revision": "cfe0aca91c8a5c6625ea5b09b1b0114bfd817199", 07:54:45 INFO - "stage_platform": "macosx64", 07:54:45 INFO - "builduid": "9d0ac505609944a8a137b4ee03328f7e", 07:54:45 INFO - "slavebuilddir": "test" 07:54:45 INFO - } 07:54:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 07:54:45 INFO - Running post-action listener: _resource_record_post_action 07:54:45 INFO - [mozharness: 2016-08-24 14:54:45.139461Z] Finished read-buildbot-config step (success) 07:54:45 INFO - [mozharness: 2016-08-24 14:54:45.139559Z] Running download-and-extract step. 07:54:45 INFO - Running pre-action listener: _resource_record_pre_action 07:54:45 INFO - Running main action method: download_and_extract 07:54:45 INFO - mkdir: /builds/slave/test/build/tests 07:54:45 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')]} 07:54:45 INFO - trying https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 07:54:45 INFO - Downloading https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/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 07:54:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/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 07:54:46 INFO - Downloaded 1199 bytes. 07:54:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 07:54:46 INFO - Using the following test package requirements: 07:54:46 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:54:46 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:54:46 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 07:54:46 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:54:46 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 07:54:46 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:54:46 INFO - u'jsshell-mac.zip'], 07:54:46 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:54:46 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 07:54:46 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:54:46 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:54:46 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 07:54:46 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:54:46 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 07:54:46 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:54:46 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 07:54:46 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:54:46 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 07:54:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:54: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')]} 07:54:46 INFO - trying https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:54:46 INFO - Downloading https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/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 07:54:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/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 07:54:47 INFO - Downloaded 16346099 bytes. 07:54:47 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 07:54:54 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 07:54:54 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')]} 07:54:54 INFO - trying https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:54:54 INFO - Downloading https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/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 07:54:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/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 07:54:55 INFO - Downloaded 16346099 bytes. 07:54:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 07:55: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')]} 07:55:01 INFO - trying https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 07:55:01 INFO - Downloading https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/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 07:55:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/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 07:55:03 INFO - Downloaded 14413981 bytes. 07:55:03 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 07:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:04 INFO - trying https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:55:04 INFO - Downloading https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 07:55:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/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 07:55:06 INFO - Downloaded 111394546 bytes. 07:55:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:55:06 INFO - mkdir: /builds/slave/test/properties 07:55:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:55:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:55:06 INFO - Contents: 07:55:06 INFO - build_url:https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:55:07 INFO - Running post-action listener: _resource_record_post_action 07:55:07 INFO - Running post-action listener: set_extra_try_arguments 07:55:07 INFO - [mozharness: 2016-08-24 14:55:07.529949Z] Finished download-and-extract step (success) 07:55:07 INFO - [mozharness: 2016-08-24 14:55:07.530111Z] Running populate-webroot step. 07:55:07 INFO - Running pre-action listener: _resource_record_pre_action 07:55:07 INFO - Running main action method: populate_webroot 07:55:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:55:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:55:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:55:07 INFO - '--tppagecycles', 07:55:07 INFO - '7'], 07:55:07 INFO - 'tests': ['tsvgm']}}, 07:55:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:55:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:55:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:55:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:55:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:55:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:55:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:07 INFO - 'talos_options': ['--disable-e10s'], 07:55:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:55:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:55:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:07 INFO - 'talos_options': ['--disable-e10s'], 07:55:07 INFO - 'tests': ['damp', 'tps']}, 07:55:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:07 INFO - 'tests': ['damp', 'tps']}, 07:55:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:55:07 INFO - 'tests': ['dromaeo_dom']}, 07:55:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:55:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:55:07 INFO - 'tests': ['basic_compositor_video']}, 07:55:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:55:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:55:07 INFO - 'tests': ['a11yr', 07:55:07 INFO - 'ts_paint', 07:55:07 INFO - 'tpaint', 07:55:07 INFO - 'sessionrestore', 07:55:07 INFO - 'sessionrestore_no_auto_restore', 07:55:07 INFO - 'tabpaint']}, 07:55:07 INFO - 'other-e10s': {'tests': ['a11yr', 07:55:07 INFO - 'ts_paint', 07:55:07 INFO - 'tpaint', 07:55:07 INFO - 'sessionrestore', 07:55:07 INFO - 'sessionrestore_no_auto_restore', 07:55:07 INFO - 'tabpaint']}, 07:55:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:55:07 INFO - 'ts_paint', 07:55:07 INFO - 'tpaint', 07:55:07 INFO - 'sessionrestore', 07:55:07 INFO - 'sessionrestore_no_auto_restore', 07:55:07 INFO - 'tabpaint']}, 07:55:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:55:07 INFO - 'ts_paint', 07:55:07 INFO - 'tpaint', 07:55:07 INFO - 'sessionrestore', 07:55:07 INFO - 'sessionrestore_no_auto_restore', 07:55:07 INFO - 'tabpaint']}, 07:55:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:55:07 INFO - 'tests': ['a11yr', 07:55:07 INFO - 'ts_paint', 07:55:07 INFO - 'tpaint', 07:55:07 INFO - 'sessionrestore', 07:55:07 INFO - 'sessionrestore_no_auto_restore', 07:55:07 INFO - 'tabpaint']}, 07:55:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:55:07 INFO - 'tests': ['a11yr', 07:55:07 INFO - 'ts_paint', 07:55:07 INFO - 'tpaint', 07:55:07 INFO - 'sessionrestore', 07:55:07 INFO - 'sessionrestore_no_auto_restore', 07:55:07 INFO - 'tabpaint']}, 07:55:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:55:07 INFO - 'tests': ['tsvgx', 07:55:07 INFO - 'tsvgr_opacity', 07:55:07 INFO - 'tart', 07:55:07 INFO - 'tscrollx', 07:55:07 INFO - 'cart']}, 07:55:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:55:07 INFO - 'tsvgr_opacity', 07:55:07 INFO - 'tart', 07:55:07 INFO - 'tscrollx', 07:55:07 INFO - 'cart']}, 07:55:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:07 INFO - 'talos_options': ['--disable-e10s'], 07:55:07 INFO - 'tests': ['tp5o']}, 07:55:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:07 INFO - 'tests': ['tp5o']}, 07:55:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:07 INFO - 'talos_options': ['--disable-e10s', 07:55:07 INFO - '--xperf_path', 07:55:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:55:07 INFO - 'tests': ['tp5n']}, 07:55:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:07 INFO - 'talos_options': ['--xperf_path', 07:55:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:55:07 INFO - 'tests': ['tp5n']}}, 07:55:07 INFO - 'talos.zip': {'path': '', 07:55:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:55:07 INFO - Running post-action listener: _resource_record_post_action 07:55:07 INFO - [mozharness: 2016-08-24 14:55:07.548847Z] Finished populate-webroot step (success) 07:55:07 INFO - [mozharness: 2016-08-24 14:55:07.548983Z] Running create-virtualenv step. 07:55:07 INFO - Running pre-action listener: _resource_record_pre_action 07:55:07 INFO - Running main action method: create_virtualenv 07:55:07 INFO - Creating virtualenv /builds/slave/test/build/venv 07:55:07 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 07:55:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:55:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:55:07 INFO - Using real prefix '/tools/python27' 07:55:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:55:08 INFO - Installing distribute.............................................................................................................................................................................................done. 07:55:11 INFO - Installing pip.................done. 07:55:11 INFO - Return code: 0 07:55:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b07aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b10f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fc0d7bde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afded30>, '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 0x10ad43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afd6b20>, '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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 07:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:55:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gyOwOiVzQ/Render', 07:55:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:11 INFO - 'HOME': '/Users/cltbld', 07:55:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:11 INFO - 'LOGNAME': 'cltbld', 07:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:11 INFO - 'MOZ_NO_REMOTE': '1', 07:55:11 INFO - 'NO_EM_RESTART': '1', 07:55:11 INFO - 'PAGER': '/bin/cat', 07:55:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:11 INFO - 'PWD': '/builds/slave/test', 07:55:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:11 INFO - 'SHELL': '/bin/bash', 07:55:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qq2UyVLEgO/Listeners', 07:55:11 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 07:55:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:11 INFO - 'USER': 'cltbld', 07:55:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:11 INFO - 'XPC_FLAGS': '0x0', 07:55:11 INFO - 'XPC_SERVICE_NAME': '0', 07:55:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:11 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 07:55:11 INFO - Cleaning up... 07:55:11 INFO - Return code: 0 07:55:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b07aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b10f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fc0d7bde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afded30>, '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 0x10ad43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afd6b20>, '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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 07:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:55:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gyOwOiVzQ/Render', 07:55:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:11 INFO - 'HOME': '/Users/cltbld', 07:55:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:11 INFO - 'LOGNAME': 'cltbld', 07:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:11 INFO - 'MOZ_NO_REMOTE': '1', 07:55:11 INFO - 'NO_EM_RESTART': '1', 07:55:11 INFO - 'PAGER': '/bin/cat', 07:55:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:11 INFO - 'PWD': '/builds/slave/test', 07:55:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:11 INFO - 'SHELL': '/bin/bash', 07:55:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qq2UyVLEgO/Listeners', 07:55:11 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 07:55:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:11 INFO - 'USER': 'cltbld', 07:55:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:11 INFO - 'XPC_FLAGS': '0x0', 07:55:11 INFO - 'XPC_SERVICE_NAME': '0', 07:55:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:11 INFO - Downloading/unpacking psutil>=3.1.1 07:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:55:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:15 INFO - Installing collected packages: psutil 07:55:15 INFO - Running setup.py install for psutil 07:55:15 INFO - building 'psutil._psutil_osx' extension 07:55:15 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 07:55:15 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 07:55:15 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 07:55:15 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 07:55:15 INFO - building 'psutil._psutil_posix' extension 07:55:15 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 07:55:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:55:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:55:15 INFO - ^ 07:55:15 INFO - 1 warning generated. 07:55:15 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 07:55:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:15 INFO - Successfully installed psutil 07:55:15 INFO - Cleaning up... 07:55:16 INFO - Return code: 0 07:55:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:55:16 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')]} 07:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:16 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')]} 07:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:16 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 0x10b07aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b10f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fc0d7bde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afded30>, '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 0x10ad43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afd6b20>, '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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 07:55:16 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 07:55:16 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 07:55:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gyOwOiVzQ/Render', 07:55:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:16 INFO - 'HOME': '/Users/cltbld', 07:55:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:16 INFO - 'LOGNAME': 'cltbld', 07:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:16 INFO - 'MOZ_NO_REMOTE': '1', 07:55:16 INFO - 'NO_EM_RESTART': '1', 07:55:16 INFO - 'PAGER': '/bin/cat', 07:55:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:16 INFO - 'PWD': '/builds/slave/test', 07:55:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:16 INFO - 'SHELL': '/bin/bash', 07:55:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qq2UyVLEgO/Listeners', 07:55:16 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 07:55:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:16 INFO - 'USER': 'cltbld', 07:55:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:16 INFO - 'XPC_FLAGS': '0x0', 07:55:16 INFO - 'XPC_SERVICE_NAME': '0', 07:55:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:55:18 INFO - Installing collected packages: mozsystemmonitor 07:55:18 INFO - Running setup.py install for mozsystemmonitor 07:55:18 INFO - Successfully installed mozsystemmonitor 07:55:18 INFO - Cleaning up... 07:55:19 INFO - Return code: 0 07:55:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:19 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 0x10b07aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b10f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fc0d7bde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afded30>, '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 0x10ad43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afd6b20>, '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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 07:55:19 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 07:55:19 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 07:55:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gyOwOiVzQ/Render', 07:55:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:19 INFO - 'HOME': '/Users/cltbld', 07:55:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:19 INFO - 'LOGNAME': 'cltbld', 07:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:19 INFO - 'MOZ_NO_REMOTE': '1', 07:55:19 INFO - 'NO_EM_RESTART': '1', 07:55:19 INFO - 'PAGER': '/bin/cat', 07:55:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:19 INFO - 'PWD': '/builds/slave/test', 07:55:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:19 INFO - 'SHELL': '/bin/bash', 07:55:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qq2UyVLEgO/Listeners', 07:55:19 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 07:55:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:19 INFO - 'USER': 'cltbld', 07:55:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:19 INFO - 'XPC_FLAGS': '0x0', 07:55:19 INFO - 'XPC_SERVICE_NAME': '0', 07:55:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:19 INFO - Downloading/unpacking jsonschema==2.5.1 07:55:19 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 07:55:19 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 07:55:19 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 07:55:19 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 07:55:19 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 07:55:19 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 07:55:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:55:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:55:21 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 07:55:21 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 07:55:21 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 07:55:21 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 07:55:21 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 07:55:21 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 07:55:22 INFO - Downloading functools32-3.2.3-2.tar.gz 07:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:55:22 INFO - warning: no files found matching '*.txt' 07:55:22 INFO - no previously-included directories found matching 'build' 07:55:22 INFO - no previously-included directories found matching 'dist' 07:55:22 INFO - no previously-included directories found matching '.git*' 07:55:22 INFO - Installing collected packages: jsonschema, functools32 07:55:22 INFO - Running setup.py install for functools32 07:55:22 INFO - warning: no files found matching '*.txt' 07:55:22 INFO - no previously-included directories found matching 'build' 07:55:22 INFO - no previously-included directories found matching 'dist' 07:55:22 INFO - no previously-included directories found matching '.git*' 07:55:22 INFO - Successfully installed jsonschema functools32 07:55:22 INFO - Cleaning up... 07:55:22 INFO - Return code: 0 07:55:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:55:22 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')]} 07:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:22 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')]} 07:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:22 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 0x10b07aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b10f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fc0d7bde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afded30>, '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 0x10ad43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afd6b20>, '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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 07:55:22 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 07:55:22 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 07:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gyOwOiVzQ/Render', 07:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:22 INFO - 'HOME': '/Users/cltbld', 07:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:22 INFO - 'LOGNAME': 'cltbld', 07:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:22 INFO - 'MOZ_NO_REMOTE': '1', 07:55:22 INFO - 'NO_EM_RESTART': '1', 07:55:22 INFO - 'PAGER': '/bin/cat', 07:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:22 INFO - 'PWD': '/builds/slave/test', 07:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:22 INFO - 'SHELL': '/bin/bash', 07:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qq2UyVLEgO/Listeners', 07:55:22 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 07:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:22 INFO - 'USER': 'cltbld', 07:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:22 INFO - 'XPC_FLAGS': '0x0', 07:55:22 INFO - 'XPC_SERVICE_NAME': '0', 07:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:55:22 INFO - Cleaning up... 07:55:22 INFO - Return code: 0 07:55:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:55:22 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')]} 07:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:22 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')]} 07:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:22 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 0x10b07aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b10f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fc0d7bde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afded30>, '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 0x10ad43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afd6b20>, '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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 07:55:22 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 07:55:22 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 07:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gyOwOiVzQ/Render', 07:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:22 INFO - 'HOME': '/Users/cltbld', 07:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:22 INFO - 'LOGNAME': 'cltbld', 07:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:22 INFO - 'MOZ_NO_REMOTE': '1', 07:55:22 INFO - 'NO_EM_RESTART': '1', 07:55:22 INFO - 'PAGER': '/bin/cat', 07:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:22 INFO - 'PWD': '/builds/slave/test', 07:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:22 INFO - 'SHELL': '/bin/bash', 07:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qq2UyVLEgO/Listeners', 07:55:22 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 07:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:22 INFO - 'USER': 'cltbld', 07:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:22 INFO - 'XPC_FLAGS': '0x0', 07:55:22 INFO - 'XPC_SERVICE_NAME': '0', 07:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:22 INFO - Downloading/unpacking blobuploader==1.2.4 07:55:22 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 07:55:22 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 07:55:22 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 07:55:22 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 07:55:22 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 07:55:22 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 07:55:25 INFO - Downloading blobuploader-1.2.4.tar.gz 07:55:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:55:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:55:25 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 07:55:25 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 07:55:25 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 07:55:25 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 07:55:25 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 07:55:25 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 07:55:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:55:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:26 INFO - Downloading docopt-0.6.1.tar.gz 07:55:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:55:26 INFO - Installing collected packages: blobuploader, requests, docopt 07:55:26 INFO - Running setup.py install for blobuploader 07:55:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:55:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:55:26 INFO - Running setup.py install for requests 07:55:27 INFO - Running setup.py install for docopt 07:55:27 INFO - Successfully installed blobuploader requests docopt 07:55:27 INFO - Cleaning up... 07:55:27 INFO - Return code: 0 07:55:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55:27 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')]} 07:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:27 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')]} 07:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:27 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 0x10b07aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b10f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fc0d7bde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afded30>, '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 0x10ad43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afd6b20>, '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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 07:55:27 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 07:55:27 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 07:55:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gyOwOiVzQ/Render', 07:55:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:27 INFO - 'HOME': '/Users/cltbld', 07:55:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:27 INFO - 'LOGNAME': 'cltbld', 07:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:27 INFO - 'MOZ_NO_REMOTE': '1', 07:55:27 INFO - 'NO_EM_RESTART': '1', 07:55:27 INFO - 'PAGER': '/bin/cat', 07:55:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:27 INFO - 'PWD': '/builds/slave/test', 07:55:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:27 INFO - 'SHELL': '/bin/bash', 07:55:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qq2UyVLEgO/Listeners', 07:55:27 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 07:55:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:27 INFO - 'USER': 'cltbld', 07:55:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:27 INFO - 'XPC_FLAGS': '0x0', 07:55:27 INFO - 'XPC_SERVICE_NAME': '0', 07:55:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:55:27 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-xpRj2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:55:27 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-5MrsFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:55:27 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-o0Y8IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:55:28 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Ffkr84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:55:28 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-8ccK6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:55:28 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-fYZZYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:55:28 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-zaJG9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:55:28 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-yvTzQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:55:28 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-5pkFwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:55:28 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-l1qHgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:55:28 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-_km71N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:55:28 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-hDbJQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:55:29 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-kIJL7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:55:29 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-jOq7yL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:29 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Lg3G7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:55:29 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Eg9waj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:55:29 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-SoEYWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:55:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:55:29 INFO - Running setup.py install for manifestparser 07:55:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:55:29 INFO - Running setup.py install for mozcrash 07:55:29 INFO - Running setup.py install for mozdebug 07:55:29 INFO - Running setup.py install for mozdevice 07:55:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:55:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:55:30 INFO - Running setup.py install for mozfile 07:55:30 INFO - Running setup.py install for mozhttpd 07:55:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:55:30 INFO - Running setup.py install for mozinfo 07:55:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:55:30 INFO - Running setup.py install for mozInstall 07:55:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:55:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:55:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:55:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:55:30 INFO - Running setup.py install for mozleak 07:55:30 INFO - Running setup.py install for mozlog 07:55:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:55:31 INFO - Running setup.py install for moznetwork 07:55:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:55:31 INFO - Running setup.py install for mozprocess 07:55:31 INFO - Running setup.py install for mozprofile 07:55:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:55:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:55:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:55:31 INFO - Running setup.py install for mozrunner 07:55:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:55:31 INFO - Running setup.py install for mozscreenshot 07:55:31 INFO - Running setup.py install for moztest 07:55:31 INFO - Running setup.py install for mozversion 07:55:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:55:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:55:32 INFO - Cleaning up... 07:55:32 INFO - Return code: 0 07:55:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b07aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b10f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fc0d7bde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afded30>, '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 0x10ad43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afd6b20>, '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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 07:55:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gyOwOiVzQ/Render', 07:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:32 INFO - 'HOME': '/Users/cltbld', 07:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:32 INFO - 'LOGNAME': 'cltbld', 07:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:32 INFO - 'MOZ_NO_REMOTE': '1', 07:55:32 INFO - 'NO_EM_RESTART': '1', 07:55:32 INFO - 'PAGER': '/bin/cat', 07:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:32 INFO - 'PWD': '/builds/slave/test', 07:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:32 INFO - 'SHELL': '/bin/bash', 07:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qq2UyVLEgO/Listeners', 07:55:32 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 07:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:32 INFO - 'USER': 'cltbld', 07:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:32 INFO - 'XPC_FLAGS': '0x0', 07:55:32 INFO - 'XPC_SERVICE_NAME': '0', 07:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:55:32 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Vh7quL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:55:32 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)) 07:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:55:32 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-t8ZySB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:55:32 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)) 07:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:55:32 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-94d8rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:55:32 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)) 07:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:55:32 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Kjp_Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:55:32 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)) 07:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:55:32 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-_5xx_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:55:32 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)) 07:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:55:32 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-_2Qac5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:55:32 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)) 07:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:55:32 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-7bLRw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:55:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:55:33 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-HJU8ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:55:33 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)) 07:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:55:33 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-Av8IEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:55:33 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)) 07:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:55:33 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-n1WZr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:55:33 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)) 07:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:55:33 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-EGz_8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:55:33 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)) 07:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:55:33 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-ncdPMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:55:33 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)) 07:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:55:33 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-XVYxQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:55:33 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)) 07:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:55:33 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-mmO6ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:55:33 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)) 07:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:33 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-SQr4jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:33 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)) 07:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:55:33 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-mx3A5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:55:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:55:34 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-s4b30E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:55:34 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)) 07:55:34 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)) 07:55:34 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)) 07:55:34 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)) 07:55:34 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)) 07:55:34 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)) 07:55:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:55:34 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 07:55:34 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 07:55:34 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 07:55:34 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 07:55:34 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 07:55:34 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 07:55:36 INFO - Downloading blessings-1.6.tar.gz 07:55:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:55:36 INFO - Installing collected packages: blessings 07:55:36 INFO - Running setup.py install for blessings 07:55:36 INFO - Successfully installed blessings 07:55:36 INFO - Cleaning up... 07:55:36 INFO - Return code: 0 07:55:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:55:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:55:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:55:37 INFO - Reading from file tmpfile_stdout 07:55:37 INFO - Current package versions: 07:55:37 INFO - blessings == 1.6 07:55:37 INFO - blobuploader == 1.2.4 07:55:37 INFO - docopt == 0.6.1 07:55:37 INFO - functools32 == 3.2.3-2 07:55:37 INFO - jsonschema == 2.5.1 07:55:37 INFO - manifestparser == 1.1 07:55:37 INFO - mozInstall == 1.12 07:55:37 INFO - mozcrash == 0.17 07:55:37 INFO - mozdebug == 0.1 07:55:37 INFO - mozdevice == 0.48 07:55:37 INFO - mozfile == 1.2 07:55:37 INFO - mozhttpd == 0.7 07:55:37 INFO - mozinfo == 0.9 07:55:37 INFO - mozleak == 0.1 07:55:37 INFO - mozlog == 3.3 07:55:37 INFO - moznetwork == 0.27 07:55:37 INFO - mozprocess == 0.23 07:55:37 INFO - mozprofile == 0.28 07:55:37 INFO - mozrunner == 6.12 07:55:37 INFO - mozscreenshot == 0.1 07:55:37 INFO - mozsystemmonitor == 0.3 07:55:37 INFO - moztest == 0.7 07:55:37 INFO - mozversion == 1.4 07:55:37 INFO - psutil == 3.1.1 07:55:37 INFO - requests == 1.2.3 07:55:37 INFO - wsgiref == 0.1.2 07:55:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55: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')]} 07:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55: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')]} 07:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:37 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 0x10b07aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b10f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fc0d7bde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afded30>, '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 0x10ad43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afd6b20>, '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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 07:55:37 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 07:55:37 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 07:55:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gyOwOiVzQ/Render', 07:55:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:37 INFO - 'HOME': '/Users/cltbld', 07:55:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:37 INFO - 'LOGNAME': 'cltbld', 07:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:37 INFO - 'MOZ_NO_REMOTE': '1', 07:55:37 INFO - 'NO_EM_RESTART': '1', 07:55:37 INFO - 'PAGER': '/bin/cat', 07:55:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:37 INFO - 'PWD': '/builds/slave/test', 07:55:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:37 INFO - 'SHELL': '/bin/bash', 07:55:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qq2UyVLEgO/Listeners', 07:55:37 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 07:55:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:37 INFO - 'USER': 'cltbld', 07:55:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:37 INFO - 'XPC_FLAGS': '0x0', 07:55:37 INFO - 'XPC_SERVICE_NAME': '0', 07:55:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:37 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)) 07:55:37 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)) 07:55:37 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)) 07:55:37 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)) 07:55:37 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)) 07:55:37 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)) 07:55:37 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)) 07:55:37 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)) 07:55:37 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)) 07:55:37 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)) 07:55:37 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)) 07:55:37 INFO - Cleaning up... 07:55:37 INFO - Return code: 0 07:55:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:55: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')]} 07:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55: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')]} 07:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b07aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b10f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fc0d7bde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afded30>, '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 0x10ad43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afd6b20>, '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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 07:55:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:55:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gyOwOiVzQ/Render', 07:55:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:37 INFO - 'HOME': '/Users/cltbld', 07:55:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:37 INFO - 'LOGNAME': 'cltbld', 07:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:37 INFO - 'MOZ_NO_REMOTE': '1', 07:55:37 INFO - 'NO_EM_RESTART': '1', 07:55:37 INFO - 'PAGER': '/bin/cat', 07:55:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:37 INFO - 'PWD': '/builds/slave/test', 07:55:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:37 INFO - 'SHELL': '/bin/bash', 07:55:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qq2UyVLEgO/Listeners', 07:55:37 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 07:55:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:37 INFO - 'USER': 'cltbld', 07:55:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:37 INFO - 'XPC_FLAGS': '0x0', 07:55:37 INFO - 'XPC_SERVICE_NAME': '0', 07:55:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:55:37 INFO - Cleaning up... 07:55:37 INFO - Return code: 0 07:55:37 INFO - Running post-action listener: _resource_record_post_action 07:55:37 INFO - Running post-action listener: _start_resource_monitoring 07:55:37 INFO - Starting resource monitoring. 07:55:37 INFO - [mozharness: 2016-08-24 14:55:37.736655Z] Finished create-virtualenv step (success) 07:55:37 INFO - [mozharness: 2016-08-24 14:55:37.737693Z] Running install step. 07:55:37 INFO - Running pre-action listener: _resource_record_pre_action 07:55:37 INFO - Running main action method: install 07:55:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:55:37 INFO - Reading from file tmpfile_stdout 07:55:37 INFO - Detecting whether we're running mozinstall >=1.0... 07:55:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:55:38 INFO - Reading from file tmpfile_stdout 07:55:38 INFO - Output received: 07:55:38 INFO - Usage: mozinstall [options] installer 07:55:38 INFO - Options: 07:55:38 INFO - -h, --help show this help message and exit 07:55:38 INFO - -d DEST, --destination=DEST 07:55:38 INFO - Directory to install application into. [default: 07:55:38 INFO - "/builds/slave/test"] 07:55:38 INFO - --app=APP Application being installed. [default: firefox] 07:55:38 INFO - mkdir: /builds/slave/test/build/application 07:55:38 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'] 07:55:38 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 07:56:12 INFO - Reading from file tmpfile_stdout 07:56:12 INFO - Output received: 07:56:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:56:12 INFO - Running post-action listener: _resource_record_post_action 07:56:12 INFO - [mozharness: 2016-08-24 14:56:12.452633Z] Finished install step (success) 07:56:12 INFO - [mozharness: 2016-08-24 14:56:12.452746Z] Running run-tests step. 07:56:12 INFO - Running pre-action listener: _resource_record_pre_action 07:56:12 INFO - Running main action method: run_tests 07:56:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:56:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:56:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:56:12 INFO - 2016-08-24 07:56:12.465 screenresolution[1927:11570] starting screenresolution argv=screenresolution get 07:56:12 INFO - 2016-08-24 07:56:12.467 screenresolution[1927:11570] Display 0: 1600x1200x32@60 07:56:12 INFO - 2016-08-24 07:56:12.473 screenresolution[1928:11573] starting screenresolution argv=screenresolution list 07:56:12 INFO - Available Modes on Display 0 07:56:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:56:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:56:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:56:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:56:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:56:12 INFO - Intel Iris: 07:56:12 INFO - Chipset Model: Intel Iris 07:56:12 INFO - Type: GPU 07:56:12 INFO - Bus: Built-In 07:56:12 INFO - VRAM (Dynamic, Max): 1536 MB 07:56:12 INFO - Vendor: Intel (0x8086) 07:56:12 INFO - Device ID: 0x0a2e 07:56:12 INFO - Revision ID: 0x0009 07:56:12 INFO - Displays: 07:56:12 INFO - Display: 07:56:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:56:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:56:12 INFO - Display Serial Number: 1600x1200 60 07:56:12 INFO - Main Display: Yes 07:56:12 INFO - Mirror: Off 07:56:12 INFO - Online: Yes 07:56:12 INFO - Rotation: Supported 07:56:12 INFO - Return code: 0 07:56:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:56:12 INFO - Python 2.7.3 07:56:12 INFO - Return code: 0 07:56:12 INFO - grabbing minidump binary from tooltool 07:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:12 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 0x10afded30>, '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 0x10ad43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afd6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:56:12 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 07:56:12 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 07:56:12 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 07:56:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:56:12 INFO - Return code: 0 07:56:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:56:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:56:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:56:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:56:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:56:12 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0366', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:56:12 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0366 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:56:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gyOwOiVzQ/Render', 07:56:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:12 INFO - 'HOME': '/Users/cltbld', 07:56:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:12 INFO - 'LOGNAME': 'cltbld', 07:56:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:56:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:12 INFO - 'MOZ_NO_REMOTE': '1', 07:56:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:56:12 INFO - 'NO_EM_RESTART': '1', 07:56:12 INFO - 'PAGER': '/bin/cat', 07:56:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:12 INFO - 'PWD': '/builds/slave/test', 07:56:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:56:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:12 INFO - 'SHELL': '/bin/bash', 07:56:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qq2UyVLEgO/Listeners', 07:56:12 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 07:56:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:12 INFO - 'USER': 'cltbld', 07:56:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:12 INFO - 'XPC_FLAGS': '0x0', 07:56:12 INFO - 'XPC_SERVICE_NAME': '0', 07:56:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0366', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:56:13 INFO - mozversion application_buildid: 20160824061126 07:56:13 INFO - mozversion application_changeset: cfe0aca91c8a5c6625ea5b09b1b0114bfd817199 07:56:13 INFO - mozversion application_display_name: Nightly 07:56:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:56:13 INFO - mozversion application_name: Firefox 07:56:13 INFO - mozversion application_remotingname: firefox 07:56:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:56:13 INFO - mozversion application_vendor: Mozilla 07:56:13 INFO - mozversion application_version: 51.0a1 07:56:13 INFO - mozversion platform_buildid: 20160824061126 07:56:13 INFO - mozversion platform_changeset: cfe0aca91c8a5c6625ea5b09b1b0114bfd817199 07:56:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:56:13 INFO - mozversion platform_version: 51.0a1 07:56:13 INFO - using testdate: 1472050573 07:56:13 INFO - actual date: 1472050573 07:56:13 INFO - starting webserver on 'localhost:49777' 07:56:13 INFO - SUITE-START | Running 2 tests 07:56:13 INFO - TEST-START | dromaeo_css 07:56:13 INFO - operating with platform_type : mac_ 07:56:13 INFO - Initialising browser for dromaeo_css test... 07:56:13 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmpYZTvnc/profile http://localhost:49777/getInfo.html) 07:56:15 INFO - PROCESS | 1938 | __metrics Screen width/height:1600/1200 07:56:15 INFO - PROCESS | 1938 | colorDepth:24 07:56:15 INFO - PROCESS | 1938 | Browser inner width/height: 1024/689 07:56:15 INFO - PROCESS | 1938 | __metrics 07:56:15 INFO - PROCESS | 1938 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:56:15 INFO - PROCESS | 1938 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:56:16 INFO - TEST-INFO | 1938: exit 0 07:56:16 INFO - Browser initialized. 07:56:16 INFO - Running cycle 1/1 for dromaeo_css test... 07:56:16 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmpYZTvnc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:28 INFO - PROCESS | 1940 | RSS: Main: 233992192 07:56:28 INFO - PROCESS | 1940 | 07:57:20 INFO - PROCESS | 1940 | 1472050640713 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] 07:59:30 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49777/tests/dromaeo/cssquery-ext.html) 07:59:32 INFO - PROCESS | 1940 | RSS: Main: 380964864 07:59:32 INFO - PROCESS | 1940 | 08:02:35 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-ext.html (next: http://localhost:49777/tests/dromaeo/cssquery-jquery.html) 08:02:35 INFO - PROCESS | 1940 | RSS: Main: 371294208 08:02:35 INFO - PROCESS | 1940 | 08:05:38 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49777/tests/dromaeo/cssquery-mootools.html) 08:05:38 INFO - PROCESS | 1940 | RSS: Main: 361971712 08:05:38 INFO - PROCESS | 1940 | 08:08:41 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49777/tests/dromaeo/cssquery-prototype.html) 08:08:41 INFO - PROCESS | 1940 | RSS: Main: 346439680 08:08:41 INFO - PROCESS | 1940 | 08:11:45 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49777/tests/dromaeo/cssquery-yui.html) 08:11:46 INFO - PROCESS | 1940 | RSS: Main: 326897664 08:11:46 INFO - PROCESS | 1940 | 08:14:49 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-yui.html (next: http://localhost:49777/tests/dromaeo/cssquery-dojo.html) 08:14:49 INFO - PROCESS | 1940 | RSS: Main: 392585216 08:14:49 INFO - PROCESS | 1940 | 08:14:49 INFO - PROCESS | 1940 | __start_tp_report 08:14:49 INFO - PROCESS | 1940 | _x_x_mozilla_page_load 08:14:49 INFO - PROCESS | 1940 | _x_x_mozilla_page_load_details 08:14:49 INFO - PROCESS | 1940 | |i|pagename|runs| 08:14:49 INFO - PROCESS | 1940 | |0;dojo.html;3293.1273212598667;3310.0400883743714;3321.63462019178;3347.7489188310883;3381.9492707609375;5659.915101273484;5731.971340143298;5780.786034932658;5813.2442782438275;5861.413858614142;5792.275965504312;5874.618149820259;5884.4409781070835;5902.291724993007;5928.466438020578;5148.099082660538;5237.973810130944;5267.130923397634;5290.0477913975465;5388.0570900092525;5312.787488500456;5315.202719592054;5373.435789242112;5379.246905433242;5388.7305634718305;473.5426425343041;5383.031054410205;5387.78448862045;5396.055690254209;5401.43284955078;5245.396779370383;5333.599980001515;5342.813001544966;5348.465153484659;5350.839474815762;5275.024120537674;5281.656692314988;5287.312649355597;5292.285541451894;5294.973525132388;5702.201691763156;5788.04497257952;5808.88382232353;5823.628943963389;5911;6148.985417406123;6166.321704612489;6219.906701399483;6230.657313847737;6243.531735119839;5190.896182076375;6238.095476155932;6280.811575652738;6289.7169627366875;6299.149614801989;5941.079132734433;5954.10688396744;5956.97021514894;5991.310999235056;5998.850028749316;6199.101130336076;6209.472194863397;6237.719302631393;6247.843803904939;6278.372162783685;5892.528597712173;6209.379062093754;6265.937340626627;6279.183706118175;6290.276618188876;6244.75020999164;6320.5891617044745;6338.112664227012;6340.080688300171;6341.207349081365;6147.754089836446;6181.103739957681;6273;6297.874042519215;6305.4009869062365;5870.236869206976;6279.843003924939;6284.151639528696;6317.020861766342;6340.968295158587;5023.271625614266;5066.240063990431;5066.518680725325;5073.873153171126;5091.287219789232;4422.911541769146;4472.530384309665;4502.009557897258;4550.726956382628;4574.08518296342;5715.657060576379;5740.253767010262;5740.598158128891;5744.569157313218;5746.482816546531;6224.502039836802;6245.781397651061;6284.214473190851;6305.684715764193;6316.621002739758;5153.330067091254;5469.906018796257;5769.221155144001;5769.624974376652;5812.128180772918;4665.2302370108555;5351.25082488452;5481.808136715196;5511.173324001432;5513.117901135879;6233.407826256498;6259.780907668301;6261.7182226799905;6337.683115844097;6363.3000369958345;6294.559380843297;6308.27454842699;6316.210473690789;6332;6333.081703153109;6216.44052035319;6234.625922444668;6360.840978975562;6378.138951241523;6384.489240860813;6169.784057557964;6197.163382943245;6211.844703882259;6305.369463053658;6310.558260921692;6294.118823364641;6294.748210071546;6299;6317.399847014526;6318.747250110128;6031.396860314109;6220.937790622036;6254;6259.123722678738;6267.9373206267355;6060.606060606046;6099.847503812262;6142.6314421134875;6182.6599537025895;6190.071489276645;5827.621204621855;5973.402659733992;5995.970020149872;6003.939960600513;6009.789657361971;6054.243219597551;6137.508999279958;6189.783357582463;6204.348543402878;6216.098665693358;5988.520918326611;6021.458068773832;6068.939310606837;6075.1798507200965;6129.448349648553 08:14:49 INFO - PROCESS | 1940 | |1;ext.html;456.7168355619514;464.7885212228438;511.3276042004764;511.8106300668752;528.3738769558072;30449.84775076127;32587.83706081469;34786.65213347866;40226;40292.39561406574;36758.816205918934;42695.78652106735;42700.359494607605;42744.57255427445;42922.356164657554;9801.509924503764;9982;9984.850227246598;9994.350367226143;10007.849882251772;8933.55332233389;9093.909060909406;9959.352642078278;11857.229280096766;12111.757764844699;12146.514139434456;12211.389430528483;12214.816777748341;12220.96121829641;12241.143119981605;10097.949510252474;11172.888271117346;11268.211225214238;11314.830277545761;11355.545778168864;10689.931006899325;11155.27490713101;11914.166008379418;11926.821097683542;11928.165028448013;39929;40352.192956140716;40380.59619403798;40399;40478;3487.9825600872086;3682.263547290526;3708.35103856824;3922.627350401707;4081.9793352918923;26126.954921803106;30971.380572388425;31623.683763162306;31932;32063;3282.3599398117376;3295.1762059485127;3311.8344082795766;3338.7662863599558;3402.302527981758;508231;509173;511600;512736;520386.39806801104;56451.435485644615;56750.86498270011;56825;56841.18961560965;56882.14676779851;33550.664493355245;34498.48252276218;59327.40672593219;59453;59598.40401596015;16236.59408514773;16634.833651663328;16635.6672866542;16687.082210478296;16752.078635675156;11555.88444115565;12772.978161747038;12847.48610055606;12859.42132604035;12895.613131606067;15809.446669366516;17988.64022719538;18284.817151828578;18443.907780461013;18955.715664265048;6615.66921653925;7756.263155000266;7814.570198639016;7878.763637090897;7912.604369781603;715.1168307140678;908.5956749246654;1036.849656799775;1051.9684409467727;1063.0963680871198;26353.341166470993;30092.548611770842;30240.69759302423;30520;31365.686343136276;1081.1512962324696;1095.0746619106842;1103.4041617526445;1169.473736818435;1176.353005846781;16187.514374568782;16189.433369832235;16765.24556394965;16823.747643785355;16926.661466770594;686645;692024;692489;692930;693721;59028.40971590229;59224;59320;59444.40555594475;59455.10817337743;1232.0944106082202;1272.6818295426328;1315.3489022933709;1369.4179973511218;1393.2754967416886;26269;30671.539926900667;30877.228069298446;31088.13421675466;31702.682973170897;40905.38641920433;49001.5099848997;49551.25673114834;49560.76098097576;49702;571032;579177.1041144767;580808;582454;583747;25331.366715831515;26069.348266293495;26740.8662956684;26891.327716807235;28011.859940700167;46827.53172468232;47101.528984709716;47671.80820479516;48051;48275.79310517265;38809.80595097006;38871.22257554776;38892.80553597214;40478;40572;37845.67540136192;38250.617493824706;39450.80274598609;40305.53583747446;40519.59480405276;37249.06877328089;38685;39529.80235098921;39534.40698389584;39579.406308904814;33725;34522.65477345194;35469.22653867245;35629.82185089058;35797;25388.365290867878;25626.87186564055;25759.871200643876;25788.742112578635;25856.741432585433 08:14:49 INFO - PROCESS | 1940 | |2;jquery.html;347.91476088358354;365.4919661670279;369.9574548926873;375.77453527883273;397.49518111997764;16049.83950160498;16664.75002874958;20436.386908392735;21021.369358919255;21202.787972120273;19726;20012.799872001277;21176.788232117673;21906;22068.448288792788;5764.7982320618785;6009.4291042351015;6105.297890742577;6281.874362512747;6286.025666021751;6094.238220222473;6131.386861313856;6138.7237574309265;6141.477974372184;6152.077188421727;3900.258950799339;5131.307273518083;6768.052472653832;6782.8304292392595;6855.520113592051;6048;6538.986457099158;6808.523403361766;6813.591184528944;6823.38589526945;5959.374265702126;5973.910391344133;5986.610870293461;5994.220751302303;6003.519718422515;13260.46958121674;13284.734305313936;13309.334533273297;13345.866541334559;13545.661358466117;2221.2780846224878;2390.8451751732887;2491.4145175883655;2587.4954383895147;2811.044244956704;15070.397184112622;15775.605609859731;15818.446354377656;15869;15893.92053039739;1814.355903654197;1849.3527265457117;1940.5827747034314;1950.151684017457;1971.0243429502345;116346.83653163444;127605.7239427603;127719.36140319332;128211;128949.35525322407;9819.16537094355;10010.49947502622;11366.829497557543;11374.94312528432;11517.25137866036;14333.56999290023;14338.641533961734;14341.211233382264;14349.85650143506;14354.712905742035;8230.135835737281;8499.575021249037;8506.76494595471;8600.913990860137;8610.569471526398;8540.23137917578;8543.530105844238;8565.143485651384;8726.301895848444;8746.169113934166;4384.671149663788;4430.579094985971;4447.555244475527;4528.773561321921;4541.250693635513;1662.5594217532364;1743.886647367917;1843.9170237339351;1897.3074827687794;1906.8665193436327;859.7893516088599;907.4011152639358;967.6274634265858;973.8587904753771;988.5749127875083;20328.491787705425;21162;21916.671249931263;21941.451463713216;21972.230971915906;911.48956584313;941.7786820097272;951.4006176109007;952.1763674421713;1008.1984822066474;10866.61966831157;11374.374409407563;11401.258918170292;11409.25839820409;11419.885801141882;611557;622963;624739;636788;643881;136849.31575342058;138970;141515.29242353927;142696.2865185688;143831;951.9809603808023;963.9277054220961;996.4818294486971;1019.1897441533998;1020.8468729690458;15072.54782356531;16324.428644997368;16596.668066638358;18448.169832357846;19388;55698;56902.57743556444;57967.71016144892;58323.4167658335;58880.99999999828;78059.60970195112;82003.58998204971;82876.17123828684;84599;86648.1008354613;6760.594364338155;7128.111050571499;7853.489523180975;7995.640196191069;8451;11129.554817807197;12953.158044727063;13398.129121607064;13688.726225475633;13855;7417.629118543943;9288;10024.699259022242;11581.363025033705;11823.172377933462;9386;11276.097912166842;11283.830742539032;11835.053195744493;11852.822207666719;11583.305001699924;11598.826017609574;11683.065354771428;12006.63980080599;12049.457774399998;7298.403257809325;7511.098668159856;7551.848963020819;7596.240375962359;7670.8082297943;11204.383758893338;11383.089352851917;11503.712407189887;11693.824592630946;11798.764024719629 08:14:49 INFO - PROCESS | 1940 | |3;mootools.html;1334.7197088611392;1503.759398496241;1653.6279337149142;1792.1397729090029;1859.972100418494;8413.915860841389;8960.283177345813;8967.955160224206;8970.50662213578;8972.50651214183;7763.223677632234;8012.998375203099;8501.277391421736;8733.519656418894;8735.781605459866;2360.728516220631;2393.4614711689906;2394.2577800881695;2397.244867866625;2397.6283676030243;1963.58764659421;2375.809935205188;2410.1082599438146;2412.1798588479915;2417.2023232333286;2379.179183181808;2391.701037370329;2396.580598395283;2406.783389494945;2409.819263555232;2364.18435639704;2382.988085059581;2383.0825132324007;2388.2238272561485;2393.234165067179;2341;2361.397843549884;2363.869987150706;2371.098982386682;2371.537550177716;8872.778180545474;8877.378583499158;8967.820643587156;8983.910160898438;8989.056149104315;5178.508041736029;5317.973410132963;5324.361076670824;5325.281087053276;5332.68003919766;3114.408262430131;3616.65641764032;3632.763870348419;3711.480392745018;3716.089558058293;962.6197651927449;1092.2190633696866;1102.6361300770727;1109.2512554026;1116.944152792357;9885.802283954281;11487.655370338904;11627.244229125079;11652.825207621892;11661.88338116625;4467.374567560479;4567.2920697291975;4735.195016847076;4741.596964258008;4752.405949256343;9875.111239988435;9883.159931405911;9893.703188904345;9907.058829411195;9927.404355738534;5295.7352132394;5297.470252974749;5309.681419114865;5310.60170487215;5312.840614781563;4349.325854492558;4510.120526497301;4706.8117275308605;4831.637627177975;4899.58353539946;3836.1176929306416;3854.7494412863075;3932.174243408859;3970.146418520032;3989.045367769772;1126.971825704364;1230.9905877180804;1263.7030297879992;1265.6962329040964;1275.6810797300675;843.6291027080994;853.5604163855619;898.8427025270552;912.1972664055588;926.4024704065974;4777.522247775264;5628.465295796893;5939.613925094942;5958.255218097738;6026.397360263939;762.5310434082999;868.5917618719192;911.6444586611227;948.4262021476907;965.8840939087354;3723.255348930171;3950.8419663213726;4076.673866090706;4081.6122468365456;4091.6522095622204;10568;10802.621908233174;10958.397288149068;10979.011888930034;10992.835107473395;10913.344029749964;10915.836262456069;10919.290246133976;10929.180311476672;10943.124550035978;7817;8159.388045896581;8216.34269258458;8303.543305118277;8319.126491718403;5884.882302354014;6004.699765011645;6007.429294217042;6093.329733729198;6134.754609815557;9765.609375624896;10140.492975351055;10159.492025398848;10294.897051029393;10336.793264134525;8207.95896020516;10218.948905255425;10412.895871041193;10423.635172768916;10426.739331516772;6979.127609048869;7267.273272672691;7301.306375894282;7428.182899880901;7544.509606875536;8389.874151887849;8440;8569.400141990001;8573.22840944318;8588.957055214683;7516.887246691414;7648.694052237848;7674.6185686576955;7759.534427934342;7790;7350.448716346188;7421;7424.925750742424;7467.066616672916;7602.847943041219;6987.510874238755;7150.177729561167;7158.606276654834;7164.820879478055;7176.605286709281;4917.459079501324;5056.924146137737;5092.108880945893;5133.92299115521;5143.7428128594165;4992.550670439678;5028.622853285945;5183.792648294177;5199.376074871039;5285.339332583427 08:14:49 INFO - PROCESS | 1940 | |4;prototype.html;294.42440029741846;295.5758486571769;305.6530837499438;310.49389495122944;311.2716243989065;5551.583631227659;5572.916406253904;5588.050031494646;5605.299337582802;5610.326760788711;5033;5175.8188463403785;5246.501582349671;5398.91901621476;5549.445055494449;4150.937735933956;4169.833206671729;4194.475690538683;4203.684723645723;4219.346001369792;3847.5190601174854;4182.33082706767;4226.218149642311;4228.894277643053;4232.873013809591;3232.997770691093;3698.9827797355674;3963.628808042036;4094.7133700640966;4129.8967525811795;3480.303939212155;3986.083200863803;4138.730982486129;4159.587439285207;4186.853460128881;3631.963680363215;3637.290728307981;3641.217138315275;3645.198056427582;3650.2152037312107;5134.383873935151;5429.647072940246;5437.211604317352;5459.3994660587305;5496.560275177976;4711.693739906929;4713.6229101672125;4721.905561888777;4746.311784791221;4781.4419285682;5714.342850572196;5715.3141623005085;5745.368009518949;5778.88442231153;5797.536197104264;3683.852645894188;3928.742802303264;3936.6063393660693;3946.3291240488898;3973.423853541249;5483.506484416382;5997.970010149921;6017.939820601781;6126.663033533198;6137.5703700741415;3520;3646.6717995380545;3719;3993.1431884173417;4019.577944315805;4054.8378064877666;4059.188162367538;4062.6390159296375;4076.3885417187657;4086.7547947123267;4450.35469856869;4687.094001718956;4702.106599746037;4772.472808701252;4778.300260352959;5826.82519524415;5837.3870743571315;5923.49650279731;5930.1535263073965;5967.462928336384;1046.8168070587617;1159.3449700919123;1294.851092124399;1357.9932100339436;1363.9659008524866;732.963351832417;782.85517179322;915.2037727177399;919.090100800203;921.8202450522218;4361.542038086019;5364.704941228192;5378.489043540857;5424.606069084055;5442.564594832483;5875.882482350329;5881.529477641779;5897.528197744256;5941.524678025748;5990.341062483123;5043.041212648053;5305.65513241638;5350.438203988603;5370.167624018283;5418.83743487696;2865.885364585435;3081.8921337753072;3082.5376193570696;3107.244406910134;3110.133919648193;4474.574915383034;5146.224552529371;5639.379668236573;6095.725692343855;6138.662373569497;5114.079465696211;5942.732577034044;6266.45681880642;6286.717097730521;6291.256702262147;6249.1563638908165;6325.272593651697;6329.398707122816;6384.297727250092;6393.392627700361;5197.402298735694;5756.30924289088;6041.577089603686;6064.787732429344;6065.362352164979;5030.622703297194;5522.3649280331665;5658;5991.670458124845;6074.696265186812;4923.426538879529;6099.207103076572;6164.845878852885;6239.844003899939;6362.745490180341;3977.7016723745255;3989.1024519482885;4005.6995725320135;4027.36207783902;4039.2527382434346;5999.850003749942;6032.406065391923;6103.9694801527485;6136.7852125175405;6163.260408750799;5629.607712602082;5822.563307752021;5841.575746065335;5917.881642367214;5919.911201331897;4844.685095468924;5456.208849716848;5808.244928159481;5814.186013958134;5835.854103647443;4291.463567054118;4856;5235.1623740201385;5686.516646085129;5823.534117270693;5598.528912074377;5607.719614019365;5810.82567522975;5857.58996870215;5924.60053678261;4772.451168115572;5268.868278293074;5429.728513574384;5685.374608792947;5716.256886604715 08:14:49 INFO - PROCESS | 1940 | |5;yui.html;661.5005670718609;697.8255436140968;720.5640587444595;773.5242825662219;841.9433610818423;14269;15607.843921560781;16158.676826463477;16178.676426471464;16826.0745658989;12619;14646.26768661568;15136.167510786903;15162.6967460651;15168;678.6165816313792;699.6361891816252;836.9246767790913;861.0485413617956;862.5299211929482;828.0642873552907;845.4842546046906;855.3841234311317;858.2190206911712;861.0700443520982;902.715644571961;905.2576886952702;905.551751882819;907.9966636866267;909.6270529083077;713.7573225103438;871.1680345270252;899.4558292233236;902.6299217320933;904.3669431398015;669.0466085827725;669.6785542939367;669.718718138383;670.5607826873405;670.6412069542771;15273.61815954599;15306.311215995307;15313.61715957099;15323.31045102973;15324.233788310652;13834.723305533833;13915.860841391659;14117.71764564703;14154.150750954872;14340.713185736227;12669.429875655618;12841.67895802603;12863.807042894365;12923.483060677656;13317.800232996513;4560.384348113029;4632.2819962905805;4679.508651591568;4841.862162391835;4842.2736589511505;124273;126141.36929315295;129634;130461.69538304591;132651;10955.671329860117;11053;11104.833427498594;11121.110311175087;11458.026067784165;21625.459363516038;21652.4586885326;21660.56678866414;21674.241401551186;21681.457963551038;7997.920020799717;8060.516369017878;8159.428839981263;8218.589070546448;8325.875111873327;3771.340015497277;4398.3402489626815;4615.676902616785;4642.396488456479;4654.557817007379;3352.446846270338;3463.6536346365665;3466.5666791651042;3467.8266086696067;3467.9479807802904;640.1901594482982;645.8643684826145;669.4543946683535;670.9496787740841;671.0370618162951;512.2751306900768;562.221323466993;606.4329851588778;615.6675395286585;650.8145178624069;7421.443391745533;8616.439931404564;9157.81684366309;9828.705138845846;10269.537870795832;586.3374386942812;589.9410058994066;659.1365311442026;677.3159109299643;694.4930200953231;4568.246239370533;4688.874670079156;4695.765211739399;4697.976510117427;4737.573618374363;98098.509507452;99902.50048749709;117453;136966.6303336954;148128;93972;108695;110774;127802;137049;103487.48256258671;108284;109503.45248273548;113245.73508529783;113563;9451.432914025181;9712.368696034735;9880.950595246977;9882.75293117649;9952.25358098131;58138.4186158133;59579.404205957384;64648.70702586016;65229;66861;84306.62773489238;88026;91410;91981;93079.53460232656;12976.870231297944;13034.934825325812;13178.736425271632;13423.530176443777;13736.038477306492;14768.556943291718;15064.774028389364;15110.697786044437;15259.694806104038;15703.136327502098;13808.761345779467;14012.229327387091;14016.299185040503;14454.494092706705;14472.565823025327;13819.723605528034;14181.716365672835;14201.715965680422;14239.074460160056;14323;13340.666483337995;13354.131981421177;13377.598672039854;13435.932820336227;13469.797953030908;10748.677539673823;11624;11679.240849344766;11731.530738770354;11960.64118076459;10786.784264314827;11164.832527512257;11368.658940231806;11505.884941150482;11608.593699220486 08:14:49 INFO - PROCESS | 1940 | __end_tp_report 08:14:49 INFO - PROCESS | 1940 | __start_cc_report 08:14:49 INFO - PROCESS | 1940 | _x_x_mozilla_cycle_collect,1276 08:14:49 INFO - PROCESS | 1940 | __end_cc_report 08:14:49 INFO - PROCESS | 1940 | __startTimestamp1472051689603__endTimestamp 08:14:49 INFO - PROCESS | 1940 | 08:14:49 INFO - PROCESS | 1940 | ------- Summary: start ------- 08:14:49 INFO - PROCESS | 1940 | Number of tests: 6 08:14:49 INFO - PROCESS | 1940 | 08:14:49 INFO - PROCESS | 1940 | [#0] dojo.html Cycles:165 Average:5767.26 Median:6003.94 stddev:761.48 (12.7%) stddev-sans-first:738.67 08:14:49 INFO - PROCESS | 1940 | Values: 3293.1 3310.0 3321.6 3347.7 3381.9 5659.9 5732.0 5780.8 5813.2 5861.4 5792.3 5874.6 5884.4 5902.3 5928.5 5148.1 5238.0 5267.1 5290.0 5388.1 5312.8 5315.2 5373.4 5379.2 5388.7 473.5 5383.0 5387.8 5396.1 5401.4 5245.4 5333.6 5342.8 5348.5 5350.8 5275.0 5281.7 5287.3 5292.3 5295.0 5702.2 5788.0 5808.9 5823.6 5911.0 6149.0 6166.3 6219.9 6230.7 6243.5 5190.9 6238.1 6280.8 6289.7 6299.1 5941.1 5954.1 5957.0 5991.3 5998.9 6199.1 6209.5 6237.7 6247.8 6278.4 5892.5 6209.4 6265.9 6279.2 6290.3 6244.8 6320.6 6338.1 6340.1 6341.2 6147.8 6181.1 6273.0 6297.9 6305.4 5870.2 6279.8 6284.2 6317.0 6341.0 5023.3 5066.2 5066.5 5073.9 5091.3 4422.9 4472.5 4502.0 4550.7 4574.1 5715.7 5740.3 5740.6 5744.6 5746.5 6224.5 6245.8 6284.2 6305.7 6316.6 5153.3 5469.9 5769.2 5769.6 5812.1 4665.2 5351.3 5481.8 5511.2 5513.1 6233.4 6259.8 6261.7 6337.7 6363.3 6294.6 6308.3 6316.2 6332.0 6333.1 6216.4 6234.6 6360.8 6378.1 6384.5 6169.8 6197.2 6211.8 6305.4 6310.6 6294.1 6294.7 6299.0 6317.4 6318.7 6031.4 6220.9 6254.0 6259.1 6267.9 6060.6 6099.8 6142.6 6182.7 6190.1 5827.6 5973.4 5996.0 6003.9 6009.8 6054.2 6137.5 6189.8 6204.3 6216.1 5988.5 6021.5 6068.9 6075.2 6129.4 08:14:49 INFO - PROCESS | 1940 | 08:14:49 INFO - PROCESS | 1940 | [#1] ext.html Cycles:180 Average:72066.79 Median:35713.41 stddev:160295.97 (448.8%) stddev-sans-first:160655.47 08:14:49 INFO - PROCESS | 1940 | Values: 456.7 464.8 511.3 511.8 528.4 30449.8 32587.8 34786.7 40226.0 40292.4 36758.8 42695.8 42700.4 42744.6 42922.4 9801.5 9982.0 9984.9 9994.4 10007.8 8933.6 9093.9 9959.4 11857.2 12111.8 12146.5 12211.4 12214.8 12221.0 12241.1 10097.9 11172.9 11268.2 11314.8 11355.5 10689.9 11155.3 11914.2 11926.8 11928.2 39929.0 40352.2 40380.6 40399.0 40478.0 3488.0 3682.3 3708.4 3922.6 4082.0 26127.0 30971.4 31623.7 31932.0 32063.0 3282.4 3295.2 3311.8 3338.8 3402.3 508231.0 509173.0 511600.0 512736.0 520386.4 56451.4 56750.9 56825.0 56841.2 56882.1 33550.7 34498.5 59327.4 59453.0 59598.4 16236.6 16634.8 16635.7 16687.1 16752.1 11555.9 12773.0 12847.5 12859.4 12895.6 15809.4 17988.6 18284.8 18443.9 18955.7 6615.7 7756.3 7814.6 7878.8 7912.6 715.1 908.6 1036.8 1052.0 1063.1 26353.3 30092.5 30240.7 30520.0 31365.7 1081.2 1095.1 1103.4 1169.5 1176.4 16187.5 16189.4 16765.2 16823.7 16926.7 686645.0 692024.0 692489.0 692930.0 693721.0 59028.4 59224.0 59320.0 59444.4 59455.1 1232.1 1272.7 1315.3 1369.4 1393.3 26269.0 30671.5 30877.2 31088.1 31702.7 40905.4 49001.5 49551.3 49560.8 49702.0 571032.0 579177.1 580808.0 582454.0 583747.0 25331.4 26069.3 26740.9 26891.3 28011.9 46827.5 47101.5 47671.8 48051.0 48275.8 38809.8 38871.2 38892.8 40478.0 40572.0 37845.7 38250.6 39450.8 40305.5 40519.6 37249.1 38685.0 39529.8 39534.4 39579.4 33725.0 34522.7 35469.2 35629.8 35797.0 25388.4 25626.9 25759.9 25788.7 25856.7 08:14:49 INFO - PROCESS | 1940 | 08:14:49 INFO - PROCESS | 1940 | [#2] jquery.html Cycles:180 Average:36485.07 Median:2441.13 stddev:105176.00 (4308.5%) stddev-sans-first:105436.05 08:14:49 INFO - PROCESS | 1940 | Values: 347.9 365.5 370.0 375.8 397.5 16049.8 16664.8 20436.4 21021.4 21202.8 19726.0 20012.8 21176.8 21906.0 22068.4 5764.8 6009.4 6105.3 6281.9 6286.0 6094.2 6131.4 6138.7 6141.5 6152.1 3900.3 5131.3 6768.1 6782.8 6855.5 6048.0 6539.0 6808.5 6813.6 6823.4 5959.4 5973.9 5986.6 5994.2 6003.5 13260.5 13284.7 13309.3 13345.9 13545.7 2221.3 2390.8 2491.4 2587.5 2811.0 15070.4 15775.6 15818.4 15869.0 15893.9 1814.4 1849.4 1940.6 1950.2 1971.0 116346.8 127605.7 127719.4 128211.0 128949.4 9819.2 10010.5 11366.8 11374.9 11517.3 14333.6 14338.6 14341.2 14349.9 14354.7 8230.1 8499.6 8506.8 8600.9 8610.6 8540.2 8543.5 8565.1 8726.3 8746.2 4384.7 4430.6 4447.6 4528.8 4541.3 1662.6 1743.9 1843.9 1897.3 1906.9 859.8 907.4 967.6 973.9 988.6 20328.5 21162.0 21916.7 21941.5 21972.2 911.5 941.8 951.4 952.2 1008.2 10866.6 11374.4 11401.3 11409.3 11419.9 611557.0 622963.0 624739.0 636788.0 643881.0 136849.3 138970.0 141515.3 142696.3 143831.0 952.0 963.9 996.5 1019.2 1020.8 15072.5 16324.4 16596.7 18448.2 19388.0 55698.0 56902.6 57967.7 58323.4 58881.0 78059.6 82003.6 82876.2 84599.0 86648.1 6760.6 7128.1 7853.5 7995.6 8451.0 11129.6 12953.2 13398.1 13688.7 13855.0 7417.6 9288.0 10024.7 11581.4 11823.2 9386.0 11276.1 11283.8 11835.1 11852.8 11583.3 11598.8 11683.1 12006.6 12049.5 7298.4 7511.1 7551.8 7596.2 7670.8 11204.4 11383.1 11503.7 11693.8 11798.8 08:14:49 INFO - PROCESS | 1940 | 08:14:49 INFO - PROCESS | 1940 | [#3] mootools.html Cycles:180 Average:5728.82 Median:5074.52 stddev:3210.20 (63.3%) stddev-sans-first:3202.22 08:14:49 INFO - PROCESS | 1940 | Values: 1334.7 1503.8 1653.6 1792.1 1860.0 8413.9 8960.3 8968.0 8970.5 8972.5 7763.2 8013.0 8501.3 8733.5 8735.8 2360.7 2393.5 2394.3 2397.2 2397.6 1963.6 2375.8 2410.1 2412.2 2417.2 2379.2 2391.7 2396.6 2406.8 2409.8 2364.2 2383.0 2383.1 2388.2 2393.2 2341.0 2361.4 2363.9 2371.1 2371.5 8872.8 8877.4 8967.8 8983.9 8989.1 5178.5 5318.0 5324.4 5325.3 5332.7 3114.4 3616.7 3632.8 3711.5 3716.1 962.6 1092.2 1102.6 1109.3 1116.9 9885.8 11487.7 11627.2 11652.8 11661.9 4467.4 4567.3 4735.2 4741.6 4752.4 9875.1 9883.2 9893.7 9907.1 9927.4 5295.7 5297.5 5309.7 5310.6 5312.8 4349.3 4510.1 4706.8 4831.6 4899.6 3836.1 3854.7 3932.2 3970.1 3989.0 1127.0 1231.0 1263.7 1265.7 1275.7 843.6 853.6 898.8 912.2 926.4 4777.5 5628.5 5939.6 5958.3 6026.4 762.5 868.6 911.6 948.4 965.9 3723.3 3950.8 4076.7 4081.6 4091.7 10568.0 10802.6 10958.4 10979.0 10992.8 10913.3 10915.8 10919.3 10929.2 10943.1 7817.0 8159.4 8216.3 8303.5 8319.1 5884.9 6004.7 6007.4 6093.3 6134.8 9765.6 10140.5 10159.5 10294.9 10336.8 8208.0 10218.9 10412.9 10423.6 10426.7 6979.1 7267.3 7301.3 7428.2 7544.5 8389.9 8440.0 8569.4 8573.2 8589.0 7516.9 7648.7 7674.6 7759.5 7790.0 7350.4 7421.0 7424.9 7467.1 7602.8 6987.5 7150.2 7158.6 7164.8 7176.6 4917.5 5056.9 5092.1 5133.9 5143.7 4992.6 5028.6 5183.8 5199.4 5285.3 08:14:49 INFO - PROCESS | 1940 | 08:14:49 INFO - PROCESS | 1940 | [#4] prototype.html Cycles:180 Average:4713.91 Median:5367.44 stddev:1482.55 (27.6%) stddev-sans-first:1449.12 08:14:49 INFO - PROCESS | 1940 | Values: 294.4 295.6 305.7 310.5 311.3 5551.6 5572.9 5588.1 5605.3 5610.3 5033.0 5175.8 5246.5 5398.9 5549.4 4150.9 4169.8 4194.5 4203.7 4219.3 3847.5 4182.3 4226.2 4228.9 4232.9 3233.0 3699.0 3963.6 4094.7 4129.9 3480.3 3986.1 4138.7 4159.6 4186.9 3632.0 3637.3 3641.2 3645.2 3650.2 5134.4 5429.6 5437.2 5459.4 5496.6 4711.7 4713.6 4721.9 4746.3 4781.4 5714.3 5715.3 5745.4 5778.9 5797.5 3683.9 3928.7 3936.6 3946.3 3973.4 5483.5 5998.0 6017.9 6126.7 6137.6 3520.0 3646.7 3719.0 3993.1 4019.6 4054.8 4059.2 4062.6 4076.4 4086.8 4450.4 4687.1 4702.1 4772.5 4778.3 5826.8 5837.4 5923.5 5930.2 5967.5 1046.8 1159.3 1294.9 1358.0 1364.0 733.0 782.9 915.2 919.1 921.8 4361.5 5364.7 5378.5 5424.6 5442.6 5875.9 5881.5 5897.5 5941.5 5990.3 5043.0 5305.7 5350.4 5370.2 5418.8 2865.9 3081.9 3082.5 3107.2 3110.1 4474.6 5146.2 5639.4 6095.7 6138.7 5114.1 5942.7 6266.5 6286.7 6291.3 6249.2 6325.3 6329.4 6384.3 6393.4 5197.4 5756.3 6041.6 6064.8 6065.4 5030.6 5522.4 5658.0 5991.7 6074.7 4923.4 6099.2 6164.8 6239.8 6362.7 3977.7 3989.1 4005.7 4027.4 4039.3 5999.9 6032.4 6104.0 6136.8 6163.3 5629.6 5822.6 5841.6 5917.9 5919.9 4844.7 5456.2 5808.2 5814.2 5835.9 4291.5 4856.0 5235.2 5686.5 5823.5 5598.5 5607.7 5810.8 5857.6 5924.6 4772.5 5268.9 5429.7 5685.4 5716.3 08:14:49 INFO - PROCESS | 1940 | 08:14:49 INFO - PROCESS | 1940 | [#5] yui.html Cycles:180 Average:24334.76 Median:3467.20 stddev:37727.58 (1088.1%) stddev-sans-first:37791.54 08:14:49 INFO - PROCESS | 1940 | Values: 661.5 697.8 720.6 773.5 841.9 14269.0 15607.8 16158.7 16178.7 16826.1 12619.0 14646.3 15136.2 15162.7 15168.0 678.6 699.6 836.9 861.0 862.5 828.1 845.5 855.4 858.2 861.1 902.7 905.3 905.6 908.0 909.6 713.8 871.2 899.5 902.6 904.4 669.0 669.7 669.7 670.6 670.6 15273.6 15306.3 15313.6 15323.3 15324.2 13834.7 13915.9 14117.7 14154.2 14340.7 12669.4 12841.7 12863.8 12923.5 13317.8 4560.4 4632.3 4679.5 4841.9 4842.3 124273.0 126141.4 129634.0 130461.7 132651.0 10955.7 11053.0 11104.8 11121.1 11458.0 21625.5 21652.5 21660.6 21674.2 21681.5 7997.9 8060.5 8159.4 8218.6 8325.9 3771.3 4398.3 4615.7 4642.4 4654.6 3352.4 3463.7 3466.6 3467.8 3467.9 640.2 645.9 669.5 670.9 671.0 512.3 562.2 606.4 615.7 650.8 7421.4 8616.4 9157.8 9828.7 10269.5 586.3 589.9 659.1 677.3 694.5 4568.2 4688.9 4695.8 4698.0 4737.6 98098.5 99902.5 117453.0 136966.6 148128.0 93972.0 108695.0 110774.0 127802.0 137049.0 103487.5 108284.0 109503.5 113245.7 113563.0 9451.4 9712.4 9881.0 9882.8 9952.3 58138.4 59579.4 64648.7 65229.0 66861.0 84306.6 88026.0 91410.0 91981.0 93079.5 12976.9 13034.9 13178.7 13423.5 13736.0 14768.6 15064.8 15110.7 15259.7 15703.1 13808.8 14012.2 14016.3 14454.5 14472.6 13819.7 14181.7 14201.7 14239.1 14323.0 13340.7 13354.1 13377.6 13435.9 13469.8 10748.7 11624.0 11679.2 11731.5 11960.6 10786.8 11164.8 11368.7 11505.9 11608.6 08:14:49 INFO - PROCESS | 1940 | -------- Summary: end -------- 08:14:49 INFO - PROCESS | 1940 | 08:14:50 INFO - TEST-INFO | 1940: exit 0 08:14:50 INFO - TEST-OK | dromaeo_css | took 1117155ms 08:14:50 INFO - TEST-START | kraken 08:14:50 INFO - operating with platform_type : mac_ 08:14:50 INFO - Initialising browser for kraken test... 08:14:50 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmpMbpnV7/profile http://localhost:49777/getInfo.html) 08:14:52 INFO - PROCESS | 1943 | __metrics Screen width/height:1600/1200 08:14:52 INFO - PROCESS | 1943 | colorDepth:24 08:14:52 INFO - PROCESS | 1943 | Browser inner width/height: 1024/689 08:14:52 INFO - PROCESS | 1943 | __metrics 08:14:52 INFO - PROCESS | 1943 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:14:52 INFO - PROCESS | 1943 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:14:53 INFO - TEST-INFO | 1943: exit 0 08:14:53 INFO - Browser initialized. 08:14:53 INFO - Running cycle 1/1 for kraken test... 08:14:53 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmpMbpnV7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:05 INFO - PROCESS | 1944 | RSS: Main: 234029056 08:15:05 INFO - PROCESS | 1944 | 08:15:07 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49777/tests/kraken/driver.html?testName=audio-beat-detection) 08:15:08 INFO - PROCESS | 1944 | RSS: Main: 292446208 08:15:08 INFO - PROCESS | 1944 | 08:15:11 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49777/tests/kraken/driver.html?testName=audio-dft) 08:15:12 INFO - PROCESS | 1944 | RSS: Main: 289402880 08:15:12 INFO - PROCESS | 1944 | 08:15:15 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49777/tests/kraken/driver.html?testName=audio-fft) 08:15:16 INFO - PROCESS | 1944 | RSS: Main: 381263872 08:15:16 INFO - PROCESS | 1944 | 08:15:18 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49777/tests/kraken/driver.html?testName=audio-oscillator) 08:15:19 INFO - PROCESS | 1944 | RSS: Main: 282157056 08:15:19 INFO - PROCESS | 1944 | 08:15:21 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49777/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:15:22 INFO - PROCESS | 1944 | RSS: Main: 284430336 08:15:22 INFO - PROCESS | 1944 | 08:15:24 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49777/tests/kraken/driver.html?testName=imaging-darkroom) 08:15:25 INFO - PROCESS | 1944 | RSS: Main: 323428352 08:15:25 INFO - PROCESS | 1944 | 08:15:28 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49777/tests/kraken/driver.html?testName=imaging-desaturate) 08:15:29 INFO - PROCESS | 1944 | RSS: Main: 324452352 08:15:29 INFO - PROCESS | 1944 | 08:15:32 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49777/tests/kraken/driver.html?testName=json-parse-financial) 08:15:32 INFO - PROCESS | 1944 | RSS: Main: 322711552 08:15:32 INFO - PROCESS | 1944 | 08:15:34 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49777/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:15:34 INFO - PROCESS | 1944 | RSS: Main: 297013248 08:15:34 INFO - PROCESS | 1944 | 08:15:36 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:15:37 INFO - PROCESS | 1944 | RSS: Main: 303796224 08:15:37 INFO - PROCESS | 1944 | 08:15:39 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:15:40 INFO - PROCESS | 1944 | RSS: Main: 299286528 08:15:40 INFO - PROCESS | 1944 | 08:15:43 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:15:44 INFO - PROCESS | 1944 | RSS: Main: 308944896 08:15:44 INFO - PROCESS | 1944 | 08:15:47 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:15:47 INFO - PROCESS | 1944 | RSS: Main: 311799808 08:15:47 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49777/tests/kraken/driver.html?testName=ai-astar) 08:15:49 INFO - PROCESS | 1944 | RSS: Main: 354807808 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | __start_tp_report 08:15:49 INFO - PROCESS | 1944 | _x_x_mozilla_page_load 08:15:49 INFO - PROCESS | 1944 | _x_x_mozilla_page_load_details 08:15:49 INFO - PROCESS | 1944 | |i|pagename|runs| 08:15:49 INFO - PROCESS | 1944 | |0;ai-astar;113;112;127;113;113;114;112;111;113;112 08:15:49 INFO - PROCESS | 1944 | |1;audio-beat-detection;147;115;128;165;135;155;116;124;201;136 08:15:49 INFO - PROCESS | 1944 | |2;audio-dft;185;187;184;186;186;185;195;181;251;260 08:15:49 INFO - PROCESS | 1944 | |3;audio-fft;78;78;91;181;83;81;79;51;158;81 08:15:49 INFO - PROCESS | 1944 | |4;audio-oscillator;83;84;130;69;71;97;152;100;100;121 08:15:49 INFO - PROCESS | 1944 | |5;imaging-gaussian-blur;87;85;87;85;86;84;88;84;87;82 08:15:49 INFO - PROCESS | 1944 | |6;imaging-darkroom;93;93;94;94;108;148;117;95;94;100 08:15:49 INFO - PROCESS | 1944 | |7;imaging-desaturate;85;87;87;85;97;87;83;84;87;126 08:15:49 INFO - PROCESS | 1944 | |8;json-parse-financial;56;55;55;55;53;56;55;56;55;52 08:15:49 INFO - PROCESS | 1944 | |9;json-stringify-tinderbox;65;68;66;81;73;74;74;70;70;70 08:15:49 INFO - PROCESS | 1944 | |10;stanford-crypto-aes;86;106;103;104;86;84;82;86;85;86 08:15:49 INFO - PROCESS | 1944 | |11;stanford-crypto-ccm;140;149;144;149;140;145;148;140;211;139 08:15:49 INFO - PROCESS | 1944 | |12;stanford-crypto-pbkdf2;170;168;226;219;166;168;169;169;166;162 08:15:49 INFO - PROCESS | 1944 | |13;stanford-crypto-sha256-iterative;67;71;64;89;67;66;67;69;68;65 08:15:49 INFO - PROCESS | 1944 | __end_tp_report 08:15:49 INFO - PROCESS | 1944 | __start_cc_report 08:15:49 INFO - PROCESS | 1944 | _x_x_mozilla_cycle_collect,2066 08:15:49 INFO - PROCESS | 1944 | __end_cc_report 08:15:49 INFO - PROCESS | 1944 | __startTimestamp1472051749656__endTimestamp 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | ------- Summary: start ------- 08:15:49 INFO - PROCESS | 1944 | Number of tests: 14 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | [#0] ai-astar Cycles:10 Average:114.00 Median:113.00 stddev:4.64 (4.1%) stddev-sans-first:4.91 08:15:49 INFO - PROCESS | 1944 | Values: 113.0 112.0 127.0 113.0 113.0 114.0 112.0 111.0 113.0 112.0 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:141.50 stddev:26.28 (18.6%) stddev-sans-first:27.81 08:15:49 INFO - PROCESS | 1944 | Values: 147.0 115.0 128.0 165.0 135.0 155.0 116.0 124.0 201.0 136.0 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | [#2] audio-dft Cycles:10 Average:200.00 Median:186.50 stddev:29.54 (15.8%) stddev-sans-first:30.83 08:15:49 INFO - PROCESS | 1944 | Values: 185.0 187.0 184.0 186.0 186.0 185.0 195.0 181.0 251.0 260.0 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | [#3] audio-fft Cycles:10 Average:96.10 Median:80.00 stddev:40.38 (50.5%) stddev-sans-first:42.29 08:15:49 INFO - PROCESS | 1944 | Values: 78.0 78.0 91.0 181.0 83.0 81.0 79.0 51.0 158.0 81.0 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:70.00 stddev:26.66 (38.1%) stddev-sans-first:27.50 08:15:49 INFO - PROCESS | 1944 | Values: 83.0 84.0 130.0 69.0 71.0 97.0 152.0 100.0 100.0 121.0 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.50 stddev:1.84 (2.1%) stddev-sans-first:1.87 08:15:49 INFO - PROCESS | 1944 | Values: 87.0 85.0 87.0 85.0 86.0 84.0 88.0 84.0 87.0 82.0 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | [#6] imaging-darkroom Cycles:10 Average:103.60 Median:93.50 stddev:17.51 (18.7%) stddev-sans-first:18.14 08:15:49 INFO - PROCESS | 1944 | Values: 93.0 93.0 94.0 94.0 108.0 148.0 117.0 95.0 94.0 100.0 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | [#7] imaging-desaturate Cycles:10 Average:90.80 Median:87.00 stddev:12.95 (14.9%) stddev-sans-first:13.57 08:15:49 INFO - PROCESS | 1944 | Values: 85.0 87.0 87.0 85.0 97.0 87.0 83.0 84.0 87.0 126.0 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.32 (2.4%) stddev-sans-first:1.32 08:15:49 INFO - PROCESS | 1944 | Values: 56.0 55.0 55.0 55.0 53.0 56.0 55.0 56.0 55.0 52.0 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.50 stddev:4.65 (6.5%) stddev-sans-first:4.38 08:15:49 INFO - PROCESS | 1944 | Values: 65.0 68.0 66.0 81.0 73.0 74.0 74.0 70.0 70.0 70.0 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:85.50 stddev:9.45 (11.1%) stddev-sans-first:9.86 08:15:49 INFO - PROCESS | 1944 | Values: 86.0 106.0 103.0 104.0 86.0 84.0 82.0 86.0 85.0 86.0 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:146.50 stddev:21.62 (14.8%) stddev-sans-first:22.59 08:15:49 INFO - PROCESS | 1944 | Values: 140.0 149.0 144.0 149.0 140.0 145.0 148.0 140.0 211.0 139.0 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:169.00 stddev:23.46 (13.9%) stddev-sans-first:24.69 08:15:49 INFO - PROCESS | 1944 | Values: 170.0 168.0 226.0 219.0 166.0 168.0 169.0 169.0 166.0 162.0 08:15:49 INFO - PROCESS | 1944 | 08:15:49 INFO - PROCESS | 1944 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:67.50 stddev:7.20 (10.7%) stddev-sans-first:7.58 08:15:49 INFO - PROCESS | 1944 | Values: 67.0 71.0 64.0 89.0 67.0 66.0 67.0 69.0 68.0 65.0 08:15:49 INFO - PROCESS | 1944 | -------- Summary: end -------- 08:15:49 INFO - PROCESS | 1944 | 08:15:50 INFO - TEST-INFO | 1944: exit 0 08:15:50 INFO - TEST-OK | kraken | took 60335ms 08:15:50 INFO - SUITE-END | took 1177s 08:15:50 INFO - Completed test suite (00:19:37) 08:15:50 INFO - javascript benchmark 08:15:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.1273212598667, 3310.0400883743714, 3321.63462019178, 3347.7489188310883, 3381.9492707609375, 5659.915101273484, 5731.971340143298, 5780.786034932658, 5813.2442782438275, 5861.413858614142, 5792.275965504312, 5874.618149820259, 5884.4409781070835, 5902.291724993007, 5928.466438020578, 5148.099082660538, 5237.973810130944, 5267.130923397634, 5290.0477913975465, 5388.0570900092525, 5312.787488500456, 5315.202719592054, 5373.435789242112, 5379.246905433242, 5388.7305634718305, 473.5426425343041, 5383.031054410205, 5387.78448862045, 5396.055690254209, 5401.43284955078, 5245.396779370383, 5333.599980001515, 5342.813001544966, 5348.465153484659, 5350.839474815762, 5275.024120537674, 5281.656692314988, 5287.312649355597, 5292.285541451894, 5294.973525132388, 5702.201691763156, 5788.04497257952, 5808.88382232353, 5823.628943963389, 5911.0, 6148.985417406123, 6166.321704612489, 6219.906701399483, 6230.657313847737, 6243.531735119839, 5190.896182076375, 6238.095476155932, 6280.811575652738, 6289.7169627366875, 6299.149614801989, 5941.079132734433, 5954.10688396744, 5956.97021514894, 5991.310999235056, 5998.850028749316, 6199.101130336076, 6209.472194863397, 6237.719302631393, 6247.843803904939, 6278.372162783685, 5892.528597712173, 6209.379062093754, 6265.937340626627, 6279.183706118175, 6290.276618188876, 6244.75020999164, 6320.5891617044745, 6338.112664227012, 6340.080688300171, 6341.207349081365, 6147.754089836446, 6181.103739957681, 6273.0, 6297.874042519215, 6305.4009869062365, 5870.236869206976, 6279.843003924939, 6284.151639528696, 6317.020861766342, 6340.968295158587, 5023.271625614266, 5066.240063990431, 5066.518680725325, 5073.873153171126, 5091.287219789232, 4422.911541769146, 4472.530384309665, 4502.009557897258, 4550.726956382628, 4574.08518296342, 5715.657060576379, 5740.253767010262, 5740.598158128891, 5744.569157313218, 5746.482816546531, 6224.502039836802, 6245.781397651061, 6284.214473190851, 6305.684715764193, 6316.621002739758, 5153.330067091254, 5469.906018796257, 5769.221155144001, 5769.624974376652, 5812.128180772918, 4665.2302370108555, 5351.25082488452, 5481.808136715196, 5511.173324001432, 5513.117901135879, 6233.407826256498, 6259.780907668301, 6261.7182226799905, 6337.683115844097, 6363.3000369958345, 6294.559380843297, 6308.27454842699, 6316.210473690789, 6332.0, 6333.081703153109, 6216.44052035319, 6234.625922444668, 6360.840978975562, 6378.138951241523, 6384.489240860813, 6169.784057557964, 6197.163382943245, 6211.844703882259, 6305.369463053658, 6310.558260921692, 6294.118823364641, 6294.748210071546, 6299.0, 6317.399847014526, 6318.747250110128, 6031.396860314109, 6220.937790622036, 6254.0, 6259.123722678738, 6267.9373206267355, 6060.606060606046, 6099.847503812262, 6142.6314421134875, 6182.6599537025895, 6190.071489276645, 5827.621204621855, 5973.402659733992, 5995.970020149872, 6003.939960600513, 6009.789657361971, 6054.243219597551, 6137.508999279958, 6189.783357582463, 6204.348543402878, 6216.098665693358, 5988.520918326611, 6021.458068773832, 6068.939310606837, 6075.1798507200965, 6129.448349648553], "value": 5720.96470266082, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.7168355619514, 464.7885212228438, 511.3276042004764, 511.8106300668752, 528.3738769558072, 30449.84775076127, 32587.83706081469, 34786.65213347866, 40226.0, 40292.39561406574, 36758.816205918934, 42695.78652106735, 42700.359494607605, 42744.57255427445, 42922.356164657554, 9801.509924503764, 9982.0, 9984.850227246598, 9994.350367226143, 10007.849882251772, 8933.55332233389, 9093.909060909406, 9959.352642078278, 11857.229280096766, 12111.757764844699, 12146.514139434456, 12211.389430528483, 12214.816777748341, 12220.96121829641, 12241.143119981605, 10097.949510252474, 11172.888271117346, 11268.211225214238, 11314.830277545761, 11355.545778168864, 10689.931006899325, 11155.27490713101, 11914.166008379418, 11926.821097683542, 11928.165028448013, 39929.0, 40352.192956140716, 40380.59619403798, 40399.0, 40478.0, 3487.9825600872086, 3682.263547290526, 3708.35103856824, 3922.627350401707, 4081.9793352918923, 26126.954921803106, 30971.380572388425, 31623.683763162306, 31932.0, 32063.0, 3282.3599398117376, 3295.1762059485127, 3311.8344082795766, 3338.7662863599558, 3402.302527981758, 508231.0, 509173.0, 511600.0, 512736.0, 520386.39806801104, 56451.435485644615, 56750.86498270011, 56825.0, 56841.18961560965, 56882.14676779851, 33550.664493355245, 34498.48252276218, 59327.40672593219, 59453.0, 59598.40401596015, 16236.59408514773, 16634.833651663328, 16635.6672866542, 16687.082210478296, 16752.078635675156, 11555.88444115565, 12772.978161747038, 12847.48610055606, 12859.42132604035, 12895.613131606067, 15809.446669366516, 17988.64022719538, 18284.817151828578, 18443.907780461013, 18955.715664265048, 6615.66921653925, 7756.263155000266, 7814.570198639016, 7878.763637090897, 7912.604369781603, 715.1168307140678, 908.5956749246654, 1036.849656799775, 1051.9684409467727, 1063.0963680871198, 26353.341166470993, 30092.548611770842, 30240.69759302423, 30520.0, 31365.686343136276, 1081.1512962324696, 1095.0746619106842, 1103.4041617526445, 1169.473736818435, 1176.353005846781, 16187.514374568782, 16189.433369832235, 16765.24556394965, 16823.747643785355, 16926.661466770594, 686645.0, 692024.0, 692489.0, 692930.0, 693721.0, 59028.40971590229, 59224.0, 59320.0, 59444.40555594475, 59455.10817337743, 1232.0944106082202, 1272.6818295426328, 1315.3489022933709, 1369.4179973511218, 1393.2754967416886, 26269.0, 30671.539926900667, 30877.228069298446, 31088.13421675466, 31702.682973170897, 40905.38641920433, 49001.5099848997, 49551.25673114834, 49560.76098097576, 49702.0, 571032.0, 579177.1041144767, 580808.0, 582454.0, 583747.0, 25331.366715831515, 26069.348266293495, 26740.8662956684, 26891.327716807235, 28011.859940700167, 46827.53172468232, 47101.528984709716, 47671.80820479516, 48051.0, 48275.79310517265, 38809.80595097006, 38871.22257554776, 38892.80553597214, 40478.0, 40572.0, 37845.67540136192, 38250.617493824706, 39450.80274598609, 40305.53583747446, 40519.59480405276, 37249.06877328089, 38685.0, 39529.80235098921, 39534.40698389584, 39579.406308904814, 33725.0, 34522.65477345194, 35469.22653867245, 35629.82185089058, 35797.0, 25388.365290867878, 25626.87186564055, 25759.871200643876, 25788.742112578635, 25856.741432585433], "value": 20321.62184604391, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.91476088358354, 365.4919661670279, 369.9574548926873, 375.77453527883273, 397.49518111997764, 16049.83950160498, 16664.75002874958, 20436.386908392735, 21021.369358919255, 21202.787972120273, 19726.0, 20012.799872001277, 21176.788232117673, 21906.0, 22068.448288792788, 5764.7982320618785, 6009.4291042351015, 6105.297890742577, 6281.874362512747, 6286.025666021751, 6094.238220222473, 6131.386861313856, 6138.7237574309265, 6141.477974372184, 6152.077188421727, 3900.258950799339, 5131.307273518083, 6768.052472653832, 6782.8304292392595, 6855.520113592051, 6048.0, 6538.986457099158, 6808.523403361766, 6813.591184528944, 6823.38589526945, 5959.374265702126, 5973.910391344133, 5986.610870293461, 5994.220751302303, 6003.519718422515, 13260.46958121674, 13284.734305313936, 13309.334533273297, 13345.866541334559, 13545.661358466117, 2221.2780846224878, 2390.8451751732887, 2491.4145175883655, 2587.4954383895147, 2811.044244956704, 15070.397184112622, 15775.605609859731, 15818.446354377656, 15869.0, 15893.92053039739, 1814.355903654197, 1849.3527265457117, 1940.5827747034314, 1950.151684017457, 1971.0243429502345, 116346.83653163444, 127605.7239427603, 127719.36140319332, 128211.0, 128949.35525322407, 9819.16537094355, 10010.49947502622, 11366.829497557543, 11374.94312528432, 11517.25137866036, 14333.56999290023, 14338.641533961734, 14341.211233382264, 14349.85650143506, 14354.712905742035, 8230.135835737281, 8499.575021249037, 8506.76494595471, 8600.913990860137, 8610.569471526398, 8540.23137917578, 8543.530105844238, 8565.143485651384, 8726.301895848444, 8746.169113934166, 4384.671149663788, 4430.579094985971, 4447.555244475527, 4528.773561321921, 4541.250693635513, 1662.5594217532364, 1743.886647367917, 1843.9170237339351, 1897.3074827687794, 1906.8665193436327, 859.7893516088599, 907.4011152639358, 967.6274634265858, 973.8587904753771, 988.5749127875083, 20328.491787705425, 21162.0, 21916.671249931263, 21941.451463713216, 21972.230971915906, 911.48956584313, 941.7786820097272, 951.4006176109007, 952.1763674421713, 1008.1984822066474, 10866.61966831157, 11374.374409407563, 11401.258918170292, 11409.25839820409, 11419.885801141882, 611557.0, 622963.0, 624739.0, 636788.0, 643881.0, 136849.31575342058, 138970.0, 141515.29242353927, 142696.2865185688, 143831.0, 951.9809603808023, 963.9277054220961, 996.4818294486971, 1019.1897441533998, 1020.8468729690458, 15072.54782356531, 16324.428644997368, 16596.668066638358, 18448.169832357846, 19388.0, 55698.0, 56902.57743556444, 57967.71016144892, 58323.4167658335, 58880.99999999828, 78059.60970195112, 82003.58998204971, 82876.17123828684, 84599.0, 86648.1008354613, 6760.594364338155, 7128.111050571499, 7853.489523180975, 7995.640196191069, 8451.0, 11129.554817807197, 12953.158044727063, 13398.129121607064, 13688.726225475633, 13855.0, 7417.629118543943, 9288.0, 10024.699259022242, 11581.363025033705, 11823.172377933462, 9386.0, 11276.097912166842, 11283.830742539032, 11835.053195744493, 11852.822207666719, 11583.305001699924, 11598.826017609574, 11683.065354771428, 12006.63980080599, 12049.457774399998, 7298.403257809325, 7511.098668159856, 7551.848963020819, 7596.240375962359, 7670.8082297943, 11204.383758893338, 11383.089352851917, 11503.712407189887, 11693.824592630946, 11798.764024719629], "value": 9636.457688869716, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.7197088611392, 1503.759398496241, 1653.6279337149142, 1792.1397729090029, 1859.972100418494, 8413.915860841389, 8960.283177345813, 8967.955160224206, 8970.50662213578, 8972.50651214183, 7763.223677632234, 8012.998375203099, 8501.277391421736, 8733.519656418894, 8735.781605459866, 2360.728516220631, 2393.4614711689906, 2394.2577800881695, 2397.244867866625, 2397.6283676030243, 1963.58764659421, 2375.809935205188, 2410.1082599438146, 2412.1798588479915, 2417.2023232333286, 2379.179183181808, 2391.701037370329, 2396.580598395283, 2406.783389494945, 2409.819263555232, 2364.18435639704, 2382.988085059581, 2383.0825132324007, 2388.2238272561485, 2393.234165067179, 2341.0, 2361.397843549884, 2363.869987150706, 2371.098982386682, 2371.537550177716, 8872.778180545474, 8877.378583499158, 8967.820643587156, 8983.910160898438, 8989.056149104315, 5178.508041736029, 5317.973410132963, 5324.361076670824, 5325.281087053276, 5332.68003919766, 3114.408262430131, 3616.65641764032, 3632.763870348419, 3711.480392745018, 3716.089558058293, 962.6197651927449, 1092.2190633696866, 1102.6361300770727, 1109.2512554026, 1116.944152792357, 9885.802283954281, 11487.655370338904, 11627.244229125079, 11652.825207621892, 11661.88338116625, 4467.374567560479, 4567.2920697291975, 4735.195016847076, 4741.596964258008, 4752.405949256343, 9875.111239988435, 9883.159931405911, 9893.703188904345, 9907.058829411195, 9927.404355738534, 5295.7352132394, 5297.470252974749, 5309.681419114865, 5310.60170487215, 5312.840614781563, 4349.325854492558, 4510.120526497301, 4706.8117275308605, 4831.637627177975, 4899.58353539946, 3836.1176929306416, 3854.7494412863075, 3932.174243408859, 3970.146418520032, 3989.045367769772, 1126.971825704364, 1230.9905877180804, 1263.7030297879992, 1265.6962329040964, 1275.6810797300675, 843.6291027080994, 853.5604163855619, 898.8427025270552, 912.1972664055588, 926.4024704065974, 4777.522247775264, 5628.465295796893, 5939.613925094942, 5958.255218097738, 6026.397360263939, 762.5310434082999, 868.5917618719192, 911.6444586611227, 948.4262021476907, 965.8840939087354, 3723.255348930171, 3950.8419663213726, 4076.673866090706, 4081.6122468365456, 4091.6522095622204, 10568.0, 10802.621908233174, 10958.397288149068, 10979.011888930034, 10992.835107473395, 10913.344029749964, 10915.836262456069, 10919.290246133976, 10929.180311476672, 10943.124550035978, 7817.0, 8159.388045896581, 8216.34269258458, 8303.543305118277, 8319.126491718403, 5884.882302354014, 6004.699765011645, 6007.429294217042, 6093.329733729198, 6134.754609815557, 9765.609375624896, 10140.492975351055, 10159.492025398848, 10294.897051029393, 10336.793264134525, 8207.95896020516, 10218.948905255425, 10412.895871041193, 10423.635172768916, 10426.739331516772, 6979.127609048869, 7267.273272672691, 7301.306375894282, 7428.182899880901, 7544.509606875536, 8389.874151887849, 8440.0, 8569.400141990001, 8573.22840944318, 8588.957055214683, 7516.887246691414, 7648.694052237848, 7674.6185686576955, 7759.534427934342, 7790.0, 7350.448716346188, 7421.0, 7424.925750742424, 7467.066616672916, 7602.847943041219, 6987.510874238755, 7150.177729561167, 7158.606276654834, 7164.820879478055, 7176.605286709281, 4917.459079501324, 5056.924146137737, 5092.108880945893, 5133.92299115521, 5143.7428128594165, 4992.550670439678, 5028.622853285945, 5183.792648294177, 5199.376074871039, 5285.339332583427], "value": 4596.045617789471, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.42440029741846, 295.5758486571769, 305.6530837499438, 310.49389495122944, 311.2716243989065, 5551.583631227659, 5572.916406253904, 5588.050031494646, 5605.299337582802, 5610.326760788711, 5033.0, 5175.8188463403785, 5246.501582349671, 5398.91901621476, 5549.445055494449, 4150.937735933956, 4169.833206671729, 4194.475690538683, 4203.684723645723, 4219.346001369792, 3847.5190601174854, 4182.33082706767, 4226.218149642311, 4228.894277643053, 4232.873013809591, 3232.997770691093, 3698.9827797355674, 3963.628808042036, 4094.7133700640966, 4129.8967525811795, 3480.303939212155, 3986.083200863803, 4138.730982486129, 4159.587439285207, 4186.853460128881, 3631.963680363215, 3637.290728307981, 3641.217138315275, 3645.198056427582, 3650.2152037312107, 5134.383873935151, 5429.647072940246, 5437.211604317352, 5459.3994660587305, 5496.560275177976, 4711.693739906929, 4713.6229101672125, 4721.905561888777, 4746.311784791221, 4781.4419285682, 5714.342850572196, 5715.3141623005085, 5745.368009518949, 5778.88442231153, 5797.536197104264, 3683.852645894188, 3928.742802303264, 3936.6063393660693, 3946.3291240488898, 3973.423853541249, 5483.506484416382, 5997.970010149921, 6017.939820601781, 6126.663033533198, 6137.5703700741415, 3520.0, 3646.6717995380545, 3719.0, 3993.1431884173417, 4019.577944315805, 4054.8378064877666, 4059.188162367538, 4062.6390159296375, 4076.3885417187657, 4086.7547947123267, 4450.35469856869, 4687.094001718956, 4702.106599746037, 4772.472808701252, 4778.300260352959, 5826.82519524415, 5837.3870743571315, 5923.49650279731, 5930.1535263073965, 5967.462928336384, 1046.8168070587617, 1159.3449700919123, 1294.851092124399, 1357.9932100339436, 1363.9659008524866, 732.963351832417, 782.85517179322, 915.2037727177399, 919.090100800203, 921.8202450522218, 4361.542038086019, 5364.704941228192, 5378.489043540857, 5424.606069084055, 5442.564594832483, 5875.882482350329, 5881.529477641779, 5897.528197744256, 5941.524678025748, 5990.341062483123, 5043.041212648053, 5305.65513241638, 5350.438203988603, 5370.167624018283, 5418.83743487696, 2865.885364585435, 3081.8921337753072, 3082.5376193570696, 3107.244406910134, 3110.133919648193, 4474.574915383034, 5146.224552529371, 5639.379668236573, 6095.725692343855, 6138.662373569497, 5114.079465696211, 5942.732577034044, 6266.45681880642, 6286.717097730521, 6291.256702262147, 6249.1563638908165, 6325.272593651697, 6329.398707122816, 6384.297727250092, 6393.392627700361, 5197.402298735694, 5756.30924289088, 6041.577089603686, 6064.787732429344, 6065.362352164979, 5030.622703297194, 5522.3649280331665, 5658.0, 5991.670458124845, 6074.696265186812, 4923.426538879529, 6099.207103076572, 6164.845878852885, 6239.844003899939, 6362.745490180341, 3977.7016723745255, 3989.1024519482885, 4005.6995725320135, 4027.36207783902, 4039.2527382434346, 5999.850003749942, 6032.406065391923, 6103.9694801527485, 6136.7852125175405, 6163.260408750799, 5629.607712602082, 5822.563307752021, 5841.575746065335, 5917.881642367214, 5919.911201331897, 4844.685095468924, 5456.208849716848, 5808.244928159481, 5814.186013958134, 5835.854103647443, 4291.463567054118, 4856.0, 5235.1623740201385, 5686.516646085129, 5823.534117270693, 5598.528912074377, 5607.719614019365, 5810.82567522975, 5857.58996870215, 5924.60053678261, 4772.451168115572, 5268.868278293074, 5429.728513574384, 5685.374608792947, 5716.256886604715], "value": 4225.9711726531605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.5005670718609, 697.8255436140968, 720.5640587444595, 773.5242825662219, 841.9433610818423, 14269.0, 15607.843921560781, 16158.676826463477, 16178.676426471464, 16826.0745658989, 12619.0, 14646.26768661568, 15136.167510786903, 15162.6967460651, 15168.0, 678.6165816313792, 699.6361891816252, 836.9246767790913, 861.0485413617956, 862.5299211929482, 828.0642873552907, 845.4842546046906, 855.3841234311317, 858.2190206911712, 861.0700443520982, 902.715644571961, 905.2576886952702, 905.551751882819, 907.9966636866267, 909.6270529083077, 713.7573225103438, 871.1680345270252, 899.4558292233236, 902.6299217320933, 904.3669431398015, 669.0466085827725, 669.6785542939367, 669.718718138383, 670.5607826873405, 670.6412069542771, 15273.61815954599, 15306.311215995307, 15313.61715957099, 15323.31045102973, 15324.233788310652, 13834.723305533833, 13915.860841391659, 14117.71764564703, 14154.150750954872, 14340.713185736227, 12669.429875655618, 12841.67895802603, 12863.807042894365, 12923.483060677656, 13317.800232996513, 4560.384348113029, 4632.2819962905805, 4679.508651591568, 4841.862162391835, 4842.2736589511505, 124273.0, 126141.36929315295, 129634.0, 130461.69538304591, 132651.0, 10955.671329860117, 11053.0, 11104.833427498594, 11121.110311175087, 11458.026067784165, 21625.459363516038, 21652.4586885326, 21660.56678866414, 21674.241401551186, 21681.457963551038, 7997.920020799717, 8060.516369017878, 8159.428839981263, 8218.589070546448, 8325.875111873327, 3771.340015497277, 4398.3402489626815, 4615.676902616785, 4642.396488456479, 4654.557817007379, 3352.446846270338, 3463.6536346365665, 3466.5666791651042, 3467.8266086696067, 3467.9479807802904, 640.1901594482982, 645.8643684826145, 669.4543946683535, 670.9496787740841, 671.0370618162951, 512.2751306900768, 562.221323466993, 606.4329851588778, 615.6675395286585, 650.8145178624069, 7421.443391745533, 8616.439931404564, 9157.81684366309, 9828.705138845846, 10269.537870795832, 586.3374386942812, 589.9410058994066, 659.1365311442026, 677.3159109299643, 694.4930200953231, 4568.246239370533, 4688.874670079156, 4695.765211739399, 4697.976510117427, 4737.573618374363, 98098.509507452, 99902.50048749709, 117453.0, 136966.6303336954, 148128.0, 93972.0, 108695.0, 110774.0, 127802.0, 137049.0, 103487.48256258671, 108284.0, 109503.45248273548, 113245.73508529783, 113563.0, 9451.432914025181, 9712.368696034735, 9880.950595246977, 9882.75293117649, 9952.25358098131, 58138.4186158133, 59579.404205957384, 64648.70702586016, 65229.0, 66861.0, 84306.62773489238, 88026.0, 91410.0, 91981.0, 93079.53460232656, 12976.870231297944, 13034.934825325812, 13178.736425271632, 13423.530176443777, 13736.038477306492, 14768.556943291718, 15064.774028389364, 15110.697786044437, 15259.694806104038, 15703.136327502098, 13808.761345779467, 14012.229327387091, 14016.299185040503, 14454.494092706705, 14472.565823025327, 13819.723605528034, 14181.716365672835, 14201.715965680422, 14239.074460160056, 14323.0, 13340.666483337995, 13354.131981421177, 13377.598672039854, 13435.932820336227, 13469.797953030908, 10748.677539673823, 11624.0, 11679.240849344766, 11731.530738770354, 11960.64118076459, 10786.784264314827, 11164.832527512257, 11368.658940231806, 11505.884941150482, 11608.593699220486], "value": 7880.838874318712, "unit": "score"}], "name": "dromaeo_css", "value": 7453.820219503153, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 127.0, 113.0, 113.0, 114.0, 112.0, 111.0, 113.0, 112.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 115.0, 128.0, 165.0, 135.0, 155.0, 116.0, 124.0, 201.0, 136.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 184.0, 186.0, 186.0, 185.0, 195.0, 181.0, 251.0, 260.0], "value": 200.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 91.0, 181.0, 83.0, 81.0, 79.0, 51.0, 158.0, 81.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 130.0, 69.0, 71.0, 97.0, 152.0, 100.0, 100.0, 121.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 86.0, 84.0, 88.0, 84.0, 87.0, 82.0], "value": 85.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 108.0, 148.0, 117.0, 95.0, 94.0, 100.0], "value": 103.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 87.0, 85.0, 97.0, 87.0, 83.0, 84.0, 87.0, 126.0], "value": 90.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 53.0, 56.0, 55.0, 56.0, 55.0, 52.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 66.0, 81.0, 73.0, 74.0, 74.0, 70.0, 70.0, 70.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 106.0, 103.0, 104.0, 86.0, 84.0, 82.0, 86.0, 85.0, 86.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 149.0, 144.0, 149.0, 140.0, 145.0, 148.0, 140.0, 211.0, 139.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 226.0, 219.0, 166.0, 168.0, 169.0, 169.0, 166.0, 162.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 64.0, 89.0, 67.0, 66.0, 67.0, 69.0, 68.0, 65.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1547.6999999999998, "alertThreshold": 2.0}]} 08:15:50 INFO - Return code: 0 08:15:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:15:50 INFO - # TBPL SUCCESS # 08:15:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:15:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:15:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:15:50 INFO - 2016-08-24 08:15:50.991 screenresolution[1948:13532] starting screenresolution argv=screenresolution get 08:15:50 INFO - 2016-08-24 08:15:50.993 screenresolution[1948:13532] Display 0: 1600x1200x32@60 08:15:51 INFO - 2016-08-24 08:15:50.999 screenresolution[1949:13535] starting screenresolution argv=screenresolution list 08:15:51 INFO - Available Modes on Display 0 08:15:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:15:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:15:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:15:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:15:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:15:51 INFO - Intel Iris: 08:15:51 INFO - Chipset Model: Intel Iris 08:15:51 INFO - Type: GPU 08:15:51 INFO - Bus: Built-In 08:15:51 INFO - VRAM (Dynamic, Max): 1536 MB 08:15:51 INFO - Vendor: Intel (0x8086) 08:15:51 INFO - Device ID: 0x0a2e 08:15:51 INFO - Revision ID: 0x0009 08:15:51 INFO - Displays: 08:15:51 INFO - Display: 08:15:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:15:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:15:51 INFO - Display Serial Number: 1600x1200 60 08:15:51 INFO - Main Display: Yes 08:15:51 INFO - Mirror: Off 08:15:51 INFO - Online: Yes 08:15:51 INFO - Rotation: Supported 08:15:51 INFO - Return code: 0 08:15:51 INFO - Running post-action listener: _resource_record_post_action 08:15:51 INFO - [mozharness: 2016-08-24 15:15:51.234857Z] Finished run-tests step (success) 08:15:51 INFO - Running post-run listener: _resource_record_post_run 08:15:51 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 102400; Write bytes: 705278464; Read time: 4; Write time: 2011 08:15:51 INFO - TinderboxPrint: CPU usage
53.5% 08:15:51 INFO - TinderboxPrint: I/O read bytes / time
102,400 / 4 08:15:51 INFO - TinderboxPrint: I/O write bytes / time
705,278,464 / 2,011 08:15:51 INFO - TinderboxPrint: CPU idle
2,259.1 (46.5%) 08:15:51 INFO - TinderboxPrint: CPU system
972.3 (20.0%) 08:15:51 INFO - TinderboxPrint: CPU user
1,622.3 (33.4%) 08:15:51 INFO - TinderboxPrint: Swap in / out
405,520,384 / 0 08:15:51 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 390410752; Write bytes: 386213888; Read time: 29682; Write time: 851 08:15:51 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 102400; Write bytes: 295832064; Read time: 4; Write time: 1106 08:15:51 INFO - Running post-run listener: _upload_blobber_files 08:15:51 INFO - Blob upload gear active. 08:15:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:15:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:15:52 INFO - (blobuploader) - INFO - Open directory for files ... 08:15:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:15:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:15:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:52 INFO - (blobuploader) - INFO - Done attempting. 08:15:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:15:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:15:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:54 INFO - (blobuploader) - INFO - Done attempting. 08:15:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:15:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:15:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:57 INFO - (blobuploader) - INFO - Done attempting. 08:15:57 INFO - (blobuploader) - INFO - Iteration through files over. 08:15:57 INFO - Return code: 0 08:15:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:15:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:15:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aad71f61dce6dc44d1af50729821c8e9476dd07675e5efecd0b0ee0f4cde394192c214e3207fe590a089d5f07ffb000391b71bee2f6fd82d106c136932d16264", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ea107dafc68de49f246b243f067822f407c85d42c03660bed967e60bbb29f359a801299e1745d0e0931bc55491b2b948cd28eb6b97592136be19b4bee5e90c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ac7b0e3c58d8b1b00fbc6617205c240447e1ed50d04d44e677a80de0b6491a0245ccd5d6df1c257debde3f48a161d409077b366ee05495c36e5a9bf7afab73f"} 08:15:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:15:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:15:57 INFO - Contents: 08:15:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aad71f61dce6dc44d1af50729821c8e9476dd07675e5efecd0b0ee0f4cde394192c214e3207fe590a089d5f07ffb000391b71bee2f6fd82d106c136932d16264", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ea107dafc68de49f246b243f067822f407c85d42c03660bed967e60bbb29f359a801299e1745d0e0931bc55491b2b948cd28eb6b97592136be19b4bee5e90c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ac7b0e3c58d8b1b00fbc6617205c240447e1ed50d04d44e677a80de0b6491a0245ccd5d6df1c257debde3f48a161d409077b366ee05495c36e5a9bf7afab73f"} 08:15:57 INFO - Running post-run listener: copy_logs_to_upload_dir 08:15:57 INFO - Copying logs to upload dir... 08:15:57 INFO - mkdir: /builds/slave/test/build/upload/logs 08:15:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.789939 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-24 08:15:57.838224) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 08:15:57.841813) ========= 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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aad71f61dce6dc44d1af50729821c8e9476dd07675e5efecd0b0ee0f4cde394192c214e3207fe590a089d5f07ffb000391b71bee2f6fd82d106c136932d16264", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ea107dafc68de49f246b243f067822f407c85d42c03660bed967e60bbb29f359a801299e1745d0e0931bc55491b2b948cd28eb6b97592136be19b4bee5e90c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ac7b0e3c58d8b1b00fbc6617205c240447e1ed50d04d44e677a80de0b6491a0245ccd5d6df1c257debde3f48a161d409077b366ee05495c36e5a9bf7afab73f"} build_url:https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010983 build_url: 'https://queue.taskcluster.net/v1/task/JWgTfA1eTAiW8L0ppZ_1iA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aad71f61dce6dc44d1af50729821c8e9476dd07675e5efecd0b0ee0f4cde394192c214e3207fe590a089d5f07ffb000391b71bee2f6fd82d106c136932d16264", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ea107dafc68de49f246b243f067822f407c85d42c03660bed967e60bbb29f359a801299e1745d0e0931bc55491b2b948cd28eb6b97592136be19b4bee5e90c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ac7b0e3c58d8b1b00fbc6617205c240447e1ed50d04d44e677a80de0b6491a0245ccd5d6df1c257debde3f48a161d409077b366ee05495c36e5a9bf7afab73f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 08:15:57.874488) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:15:57.874804) ========= 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.4gyOwOiVzQ/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.Qq2UyVLEgO/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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.005099 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:15:57.923461) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 08:15:57.923873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 08:15:57.924164) ========= ========= Total master_lag: 0.21 =========