builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0167 starttime: 1471973771.15 results: success (0) buildid: 20160823080458 builduid: a2b4d81c2c674d329bffc448498cd257 revision: 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 10:36:11.154127) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 10:36:11.154785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 10:36:11.155240) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 10:36:11.193775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 10:36:11.194160) ========= 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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-23 10:36:11-- 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% 9.51M=0.001s 2016-08-23 10:36:11 (9.51 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098243 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 10:36:11.316478) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 10:36:11.316797) ========= 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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.029092 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 10:36:11.368732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-23 10:36:11.369110) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 --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 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ssBO6QHNuX/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.PuqKLOYr3e/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-23 10:36:11,445 truncating revision to first 12 chars 2016-08-23 10:36:11,445 Setting DEBUG logging. 2016-08-23 10:36:11,445 attempt 1/10 2016-08-23 10:36:11,445 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8381bc7a4681?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 10:36:13,244 unpacking tar archive at: fx-team-8381bc7a4681/testing/mozharness/ program finished with exit code 0 elapsedTime=2.067590 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-23 10:36:13.459229) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 10:36:13.459558) ========= script_repo_revision: 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 10:36:13.459963) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 10:36:13.460245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 10:36:13.479073) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-08-23 10:36:13.479504) ========= /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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 10:36:13 INFO - MultiFileLogger online at 20160823 10:36:13 in /builds/slave/test 10:36:13 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 10:36:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:36:13 INFO - {'append_to_log': False, 10:36:13 INFO - 'base_work_dir': '/builds/slave/test', 10:36:13 INFO - 'blob_upload_branch': 'Fx-Team', 10:36:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:36:13 INFO - 'branch': 'Fx-Team', 10:36:13 INFO - 'buildbot_json_path': 'buildprops.json', 10:36:13 INFO - 'config_files': ('talos/mac_config.py',), 10:36:13 INFO - 'default_actions': ('clobber', 10:36:13 INFO - 'read-buildbot-config', 10:36:13 INFO - 'download-and-extract', 10:36:13 INFO - 'populate-webroot', 10:36:13 INFO - 'create-virtualenv', 10:36:13 INFO - 'install', 10:36:13 INFO - 'run-tests'), 10:36:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:36:13 INFO - 'download_minidump_stackwalk': True, 10:36:13 INFO - 'download_symbols': 'ondemand', 10:36:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:36:13 INFO - 'tooltool.py': '/tools/tooltool.py', 10:36:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:36:13 INFO - '/tools/misc-python/virtualenv.py')}, 10:36:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:36:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:36:13 INFO - 'installer_path': 'installer.exe', 10:36:13 INFO - 'log_level': 'info', 10:36:13 INFO - 'log_name': 'talos', 10:36:13 INFO - 'log_to_console': True, 10:36:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:36:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:36:13 INFO - 'opt_config_files': (), 10:36:13 INFO - 'pip_index': False, 10:36:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:36:13 INFO - 'cmd': ('bash', 10:36:13 INFO - '-c', 10:36:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:36:13 INFO - 'enabled': True, 10:36:13 INFO - 'halt_on_failure': False, 10:36:13 INFO - 'name': 'check_screen_resolution'},), 10:36:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:36:13 INFO - 'cmd': ('bash', 10:36:13 INFO - '-c', 10:36:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:36:13 INFO - 'enabled': True, 10:36:13 INFO - 'halt_on_failure': False, 10:36:13 INFO - 'name': 'check_screen_resolution'},), 10:36:13 INFO - 'run_cmd_checks_enabled': True, 10:36:13 INFO - 'sps_profile': False, 10:36:13 INFO - 'sps_profile_interval': 0, 10:36:13 INFO - 'suite': 'dromaeojs', 10:36:13 INFO - 'system_bits': '32', 10:36:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:36:13 INFO - 'title': 't-yosemite-r7-0167', 10:36:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:36:13 INFO - 'use_talos_json': True, 10:36:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:36:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:36:13 INFO - 'work_dir': 'build'} 10:36:13 INFO - [mozharness: 2016-08-23 17:36:13.677354Z] Running clobber step. 10:36:13 INFO - Running pre-action listener: _resource_record_pre_action 10:36:13 INFO - Running main action method: clobber 10:36:13 INFO - rmtree: /builds/slave/test/build 10:36:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:36:15 INFO - Running post-action listener: _resource_record_post_action 10:36:15 INFO - [mozharness: 2016-08-23 17:36:15.837561Z] Finished clobber step (success) 10:36:15 INFO - [mozharness: 2016-08-23 17:36:15.837695Z] Running read-buildbot-config step. 10:36:15 INFO - Running pre-action listener: _resource_record_pre_action 10:36:15 INFO - Running main action method: read_buildbot_config 10:36:15 INFO - Using buildbot properties: 10:36:15 INFO - { 10:36:15 INFO - "project": "", 10:36:15 INFO - "product": "firefox", 10:36:15 INFO - "script_repo_revision": "production", 10:36:15 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:36:15 INFO - "repository": "", 10:36:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:36:15 INFO - "buildid": "20160823080458", 10:36:15 INFO - "pgo_build": "False", 10:36:15 INFO - "basedir": "/builds/slave/test", 10:36:15 INFO - "buildnumber": 820, 10:36:15 INFO - "slavename": "t-yosemite-r7-0167", 10:36:15 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:36:15 INFO - "platform": "yosemite_r7", 10:36:15 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 10:36:15 INFO - "branch": "fx-team", 10:36:15 INFO - "repo_path": "integration/fx-team", 10:36:15 INFO - "revision": "8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2", 10:36:15 INFO - "stage_platform": "macosx64", 10:36:15 INFO - "builduid": "a2b4d81c2c674d329bffc448498cd257", 10:36:15 INFO - "slavebuilddir": "test" 10:36:15 INFO - } 10:36:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 10:36:15 INFO - Running post-action listener: _resource_record_post_action 10:36:15 INFO - [mozharness: 2016-08-23 17:36:15.841085Z] Finished read-buildbot-config step (success) 10:36:15 INFO - [mozharness: 2016-08-23 17:36:15.841191Z] Running download-and-extract step. 10:36:15 INFO - Running pre-action listener: _resource_record_pre_action 10:36:15 INFO - Running main action method: download_and_extract 10:36:15 INFO - mkdir: /builds/slave/test/build/tests 10:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:36:15 INFO - trying https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 10:36:15 INFO - Downloading https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/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 10:36:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/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 10:36:16 INFO - Downloaded 1199 bytes. 10:36:16 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:36:16 INFO - Using the following test package requirements: 10:36:16 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:36:16 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:36:16 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 10:36:16 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:36:16 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 10:36:16 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:36:16 INFO - u'jsshell-mac.zip'], 10:36:16 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:36:16 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 10:36:16 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:36:16 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:36:16 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 10:36:16 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:36:16 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 10:36:16 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:36:16 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 10:36:16 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:36:16 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 10:36:16 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:36: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')]} 10:36:16 INFO - trying https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:36:16 INFO - Downloading https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/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 10:36:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/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 10:36:18 INFO - Downloaded 16346129 bytes. 10:36:18 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:36:24 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 10:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:36:24 INFO - trying https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:36:24 INFO - Downloading https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/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 10:36:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/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 10:36:25 INFO - Downloaded 16346129 bytes. 10:36:25 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:36: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')]} 10:36:32 INFO - trying https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:36:32 INFO - Downloading https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/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 10:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/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 10:36:33 INFO - Downloaded 14413981 bytes. 10:36:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 10:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:36:34 INFO - trying https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:36:34 INFO - Downloading https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 10:36:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/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 10:36:39 INFO - Downloaded 111488993 bytes. 10:36:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:36:39 INFO - mkdir: /builds/slave/test/properties 10:36:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:36:39 INFO - Writing to file /builds/slave/test/properties/build_url 10:36:39 INFO - Contents: 10:36:39 INFO - build_url:https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:36:40 INFO - Running post-action listener: _resource_record_post_action 10:36:40 INFO - Running post-action listener: set_extra_try_arguments 10:36:40 INFO - [mozharness: 2016-08-23 17:36:40.609680Z] Finished download-and-extract step (success) 10:36:40 INFO - [mozharness: 2016-08-23 17:36:40.609800Z] Running populate-webroot step. 10:36:40 INFO - Running pre-action listener: _resource_record_pre_action 10:36:40 INFO - Running main action method: populate_webroot 10:36:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:36:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:36:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:36:40 INFO - '--tppagecycles', 10:36:40 INFO - '7'], 10:36:40 INFO - 'tests': ['tsvgm']}}, 10:36:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:36:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:36:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:36:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:36:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:36:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:36:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:40 INFO - 'talos_options': ['--disable-e10s'], 10:36:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:36:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:36:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:40 INFO - 'talos_options': ['--disable-e10s'], 10:36:40 INFO - 'tests': ['damp', 'tps']}, 10:36:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:40 INFO - 'tests': ['damp', 'tps']}, 10:36:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:36:40 INFO - 'tests': ['dromaeo_dom']}, 10:36:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:36:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:36:40 INFO - 'tests': ['basic_compositor_video']}, 10:36:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:36:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:36:40 INFO - 'tests': ['a11yr', 10:36:40 INFO - 'ts_paint', 10:36:40 INFO - 'tpaint', 10:36:40 INFO - 'sessionrestore', 10:36:40 INFO - 'sessionrestore_no_auto_restore', 10:36:40 INFO - 'tabpaint']}, 10:36:40 INFO - 'other-e10s': {'tests': ['a11yr', 10:36:40 INFO - 'ts_paint', 10:36:40 INFO - 'tpaint', 10:36:40 INFO - 'sessionrestore', 10:36:40 INFO - 'sessionrestore_no_auto_restore', 10:36:40 INFO - 'tabpaint']}, 10:36:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:36:40 INFO - 'ts_paint', 10:36:40 INFO - 'tpaint', 10:36:40 INFO - 'sessionrestore', 10:36:40 INFO - 'sessionrestore_no_auto_restore', 10:36:40 INFO - 'tabpaint']}, 10:36:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:36:40 INFO - 'ts_paint', 10:36:40 INFO - 'tpaint', 10:36:40 INFO - 'sessionrestore', 10:36:40 INFO - 'sessionrestore_no_auto_restore', 10:36:40 INFO - 'tabpaint']}, 10:36:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:36:40 INFO - 'tests': ['a11yr', 10:36:40 INFO - 'ts_paint', 10:36:40 INFO - 'tpaint', 10:36:40 INFO - 'sessionrestore', 10:36:40 INFO - 'sessionrestore_no_auto_restore', 10:36:40 INFO - 'tabpaint']}, 10:36:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:36:40 INFO - 'tests': ['a11yr', 10:36:40 INFO - 'ts_paint', 10:36:40 INFO - 'tpaint', 10:36:40 INFO - 'sessionrestore', 10:36:40 INFO - 'sessionrestore_no_auto_restore', 10:36:40 INFO - 'tabpaint']}, 10:36:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:36:40 INFO - 'tests': ['tsvgx', 10:36:40 INFO - 'tsvgr_opacity', 10:36:40 INFO - 'tart', 10:36:40 INFO - 'tscrollx', 10:36:40 INFO - 'cart']}, 10:36:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:36:40 INFO - 'tsvgr_opacity', 10:36:40 INFO - 'tart', 10:36:40 INFO - 'tscrollx', 10:36:40 INFO - 'cart']}, 10:36:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:40 INFO - 'talos_options': ['--disable-e10s'], 10:36:40 INFO - 'tests': ['tp5o']}, 10:36:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:40 INFO - 'tests': ['tp5o']}, 10:36:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:40 INFO - 'talos_options': ['--disable-e10s', 10:36:40 INFO - '--xperf_path', 10:36:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:36:40 INFO - 'tests': ['tp5n']}, 10:36:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:40 INFO - 'talos_options': ['--xperf_path', 10:36:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:36:40 INFO - 'tests': ['tp5n']}}, 10:36:40 INFO - 'talos.zip': {'path': '', 10:36:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:36:40 INFO - Running post-action listener: _resource_record_post_action 10:36:40 INFO - [mozharness: 2016-08-23 17:36:40.628773Z] Finished populate-webroot step (success) 10:36:40 INFO - [mozharness: 2016-08-23 17:36:40.628905Z] Running create-virtualenv step. 10:36:40 INFO - Running pre-action listener: _resource_record_pre_action 10:36:40 INFO - Running main action method: create_virtualenv 10:36:40 INFO - Creating virtualenv /builds/slave/test/build/venv 10:36:40 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 10:36:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:36:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:36:40 INFO - Using real prefix '/tools/python27' 10:36:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:36:41 INFO - Installing distribute.............................................................................................................................................................................................done. 10:36:44 INFO - Installing pip.................done. 10:36:44 INFO - Return code: 0 10:36:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:44 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 0x1050c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f50cb2750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10502cd30>, '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 0x104d91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105024b20>, '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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 10:36:44 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 10:36:44 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 10:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssBO6QHNuX/Render', 10:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:44 INFO - 'HOME': '/Users/cltbld', 10:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:44 INFO - 'LOGNAME': 'cltbld', 10:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:44 INFO - 'MOZ_NO_REMOTE': '1', 10:36:44 INFO - 'NO_EM_RESTART': '1', 10:36:44 INFO - 'PAGER': '/bin/cat', 10:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:44 INFO - 'PWD': '/builds/slave/test', 10:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:44 INFO - 'SHELL': '/bin/bash', 10:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PuqKLOYr3e/Listeners', 10:36:44 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 10:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:44 INFO - 'USER': 'cltbld', 10:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:44 INFO - 'XPC_FLAGS': '0x0', 10:36:44 INFO - 'XPC_SERVICE_NAME': '0', 10:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:44 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 10:36:44 INFO - Cleaning up... 10:36:44 INFO - Return code: 0 10:36:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:44 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 0x1050c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f50cb2750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10502cd30>, '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 0x104d91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105024b20>, '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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 10:36:44 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 10:36:44 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 10:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssBO6QHNuX/Render', 10:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:44 INFO - 'HOME': '/Users/cltbld', 10:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:44 INFO - 'LOGNAME': 'cltbld', 10:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:44 INFO - 'MOZ_NO_REMOTE': '1', 10:36:44 INFO - 'NO_EM_RESTART': '1', 10:36:44 INFO - 'PAGER': '/bin/cat', 10:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:44 INFO - 'PWD': '/builds/slave/test', 10:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:44 INFO - 'SHELL': '/bin/bash', 10:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PuqKLOYr3e/Listeners', 10:36:44 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 10:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:44 INFO - 'USER': 'cltbld', 10:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:44 INFO - 'XPC_FLAGS': '0x0', 10:36:44 INFO - 'XPC_SERVICE_NAME': '0', 10:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:44 INFO - Downloading/unpacking psutil>=3.1.1 10:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:36:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:47 INFO - Installing collected packages: psutil 10:36:47 INFO - Running setup.py install for psutil 10:36:47 INFO - building 'psutil._psutil_osx' extension 10:36:47 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 10:36:48 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 10:36:48 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 10:36:48 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 10:36:48 INFO - building 'psutil._psutil_posix' extension 10:36:48 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 10:36:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:36:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:36:48 INFO - ^ 10:36:48 INFO - 1 warning generated. 10:36:48 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 10:36:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:49 INFO - Successfully installed psutil 10:36:49 INFO - Cleaning up... 10:36:49 INFO - Return code: 0 10:36:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:36:49 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')]} 10:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:49 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')]} 10:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:49 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 0x1050c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f50cb2750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10502cd30>, '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 0x104d91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105024b20>, '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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 10:36:49 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 10:36:49 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 10:36:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssBO6QHNuX/Render', 10:36:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:49 INFO - 'HOME': '/Users/cltbld', 10:36:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:49 INFO - 'LOGNAME': 'cltbld', 10:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:49 INFO - 'MOZ_NO_REMOTE': '1', 10:36:49 INFO - 'NO_EM_RESTART': '1', 10:36:49 INFO - 'PAGER': '/bin/cat', 10:36:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:49 INFO - 'PWD': '/builds/slave/test', 10:36:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:49 INFO - 'SHELL': '/bin/bash', 10:36:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PuqKLOYr3e/Listeners', 10:36:49 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 10:36:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:49 INFO - 'USER': 'cltbld', 10:36:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:49 INFO - 'XPC_FLAGS': '0x0', 10:36:49 INFO - 'XPC_SERVICE_NAME': '0', 10:36:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:36:49 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 10:36:49 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 10:36:49 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 10:36:49 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 10:36:49 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 10:36:49 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 10:36:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:36:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:36:51 INFO - Installing collected packages: mozsystemmonitor 10:36:51 INFO - Running setup.py install for mozsystemmonitor 10:36:52 INFO - Successfully installed mozsystemmonitor 10:36:52 INFO - Cleaning up... 10:36:52 INFO - Return code: 0 10:36:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:36:52 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')]} 10:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:52 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')]} 10:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:52 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 0x1050c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f50cb2750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10502cd30>, '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 0x104d91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105024b20>, '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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 10:36:52 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 10:36:52 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 10:36:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssBO6QHNuX/Render', 10:36:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:52 INFO - 'HOME': '/Users/cltbld', 10:36:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:52 INFO - 'LOGNAME': 'cltbld', 10:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:52 INFO - 'MOZ_NO_REMOTE': '1', 10:36:52 INFO - 'NO_EM_RESTART': '1', 10:36:52 INFO - 'PAGER': '/bin/cat', 10:36:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:52 INFO - 'PWD': '/builds/slave/test', 10:36:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:52 INFO - 'SHELL': '/bin/bash', 10:36:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PuqKLOYr3e/Listeners', 10:36:52 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 10:36:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:52 INFO - 'USER': 'cltbld', 10:36:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:52 INFO - 'XPC_FLAGS': '0x0', 10:36:52 INFO - 'XPC_SERVICE_NAME': '0', 10:36:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:52 INFO - Downloading/unpacking jsonschema==2.5.1 10:36:52 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 10:36:52 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 10:36:52 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 10:36:52 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 10:36:52 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 10:36:52 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 10:36:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:36:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:36:54 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 10:36:54 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 10:36:54 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 10:36:54 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 10:36:54 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 10:36:54 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 10:36:55 INFO - Downloading functools32-3.2.3-2.tar.gz 10:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:36:55 INFO - warning: no files found matching '*.txt' 10:36:55 INFO - no previously-included directories found matching 'build' 10:36:55 INFO - no previously-included directories found matching 'dist' 10:36:55 INFO - no previously-included directories found matching '.git*' 10:36:55 INFO - Installing collected packages: jsonschema, functools32 10:36:55 INFO - Running setup.py install for functools32 10:36:55 INFO - warning: no files found matching '*.txt' 10:36:55 INFO - no previously-included directories found matching 'build' 10:36:55 INFO - no previously-included directories found matching 'dist' 10:36:55 INFO - no previously-included directories found matching '.git*' 10:36:55 INFO - Successfully installed jsonschema functools32 10:36:55 INFO - Cleaning up... 10:36:55 INFO - Return code: 0 10:36:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:55 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 0x1050c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f50cb2750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10502cd30>, '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 0x104d91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105024b20>, '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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 10:36:55 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 10:36:55 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 10:36:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssBO6QHNuX/Render', 10:36:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:55 INFO - 'HOME': '/Users/cltbld', 10:36:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:55 INFO - 'LOGNAME': 'cltbld', 10:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:55 INFO - 'MOZ_NO_REMOTE': '1', 10:36:55 INFO - 'NO_EM_RESTART': '1', 10:36:55 INFO - 'PAGER': '/bin/cat', 10:36:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:55 INFO - 'PWD': '/builds/slave/test', 10:36:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:55 INFO - 'SHELL': '/bin/bash', 10:36:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PuqKLOYr3e/Listeners', 10:36:55 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 10:36:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:55 INFO - 'USER': 'cltbld', 10:36:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:55 INFO - 'XPC_FLAGS': '0x0', 10:36:55 INFO - 'XPC_SERVICE_NAME': '0', 10:36:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:36:55 INFO - Cleaning up... 10:36:55 INFO - Return code: 0 10:36:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:55 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 0x1050c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f50cb2750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10502cd30>, '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 0x104d91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105024b20>, '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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 10:36:55 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 10:36:55 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 10:36:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssBO6QHNuX/Render', 10:36:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:55 INFO - 'HOME': '/Users/cltbld', 10:36:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:55 INFO - 'LOGNAME': 'cltbld', 10:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:55 INFO - 'MOZ_NO_REMOTE': '1', 10:36:55 INFO - 'NO_EM_RESTART': '1', 10:36:55 INFO - 'PAGER': '/bin/cat', 10:36:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:55 INFO - 'PWD': '/builds/slave/test', 10:36:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:55 INFO - 'SHELL': '/bin/bash', 10:36:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PuqKLOYr3e/Listeners', 10:36:55 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 10:36:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:55 INFO - 'USER': 'cltbld', 10:36:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:55 INFO - 'XPC_FLAGS': '0x0', 10:36:55 INFO - 'XPC_SERVICE_NAME': '0', 10:36:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:56 INFO - Downloading/unpacking blobuploader==1.2.4 10:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:58 INFO - Downloading blobuploader-1.2.4.tar.gz 10:36:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:36:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:36:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:59 INFO - Downloading docopt-0.6.1.tar.gz 10:36:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:36:59 INFO - Installing collected packages: blobuploader, requests, docopt 10:36:59 INFO - Running setup.py install for blobuploader 10:37:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:37:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:37:00 INFO - Running setup.py install for requests 10:37:00 INFO - Running setup.py install for docopt 10:37:00 INFO - Successfully installed blobuploader requests docopt 10:37:00 INFO - Cleaning up... 10:37:00 INFO - Return code: 0 10:37:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:37:00 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')]} 10:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:00 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')]} 10:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:00 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 0x1050c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f50cb2750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10502cd30>, '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 0x104d91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105024b20>, '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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 10:37:00 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 10:37:00 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 10:37:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssBO6QHNuX/Render', 10:37:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:37:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:37:00 INFO - 'HOME': '/Users/cltbld', 10:37:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:37:00 INFO - 'LOGNAME': 'cltbld', 10:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:00 INFO - 'MOZ_NO_REMOTE': '1', 10:37:00 INFO - 'NO_EM_RESTART': '1', 10:37:00 INFO - 'PAGER': '/bin/cat', 10:37:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:00 INFO - 'PWD': '/builds/slave/test', 10:37:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:37:00 INFO - 'SHELL': '/bin/bash', 10:37:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PuqKLOYr3e/Listeners', 10:37:00 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 10:37:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:37:00 INFO - 'USER': 'cltbld', 10:37:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:37:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:00 INFO - 'XPC_FLAGS': '0x0', 10:37:00 INFO - 'XPC_SERVICE_NAME': '0', 10:37:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:37:01 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-owXJuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:37:01 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-1tO5uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:37:01 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-ylNkMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:37:01 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-omJaHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:37:01 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-7F0e_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:37:01 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-1QtqsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:37:01 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-bJZSZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:37:01 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-9W2pqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:37:01 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Ee1fIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:37:02 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-aU57bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:37:02 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-TtGv8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:37:02 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-axPjXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:37:02 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-h8NN8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:37:02 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Ie7fBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:02 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-uXtsBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:37:02 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-7mbEud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:37:02 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-QFiQYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:37:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:37:02 INFO - Running setup.py install for manifestparser 10:37:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:37:03 INFO - Running setup.py install for mozcrash 10:37:03 INFO - Running setup.py install for mozdebug 10:37:03 INFO - Running setup.py install for mozdevice 10:37:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:37:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:37:03 INFO - Running setup.py install for mozfile 10:37:03 INFO - Running setup.py install for mozhttpd 10:37:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:37:03 INFO - Running setup.py install for mozinfo 10:37:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:37:03 INFO - Running setup.py install for mozInstall 10:37:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Running setup.py install for mozleak 10:37:04 INFO - Running setup.py install for mozlog 10:37:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Running setup.py install for moznetwork 10:37:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Running setup.py install for mozprocess 10:37:04 INFO - Running setup.py install for mozprofile 10:37:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Running setup.py install for mozrunner 10:37:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Running setup.py install for mozscreenshot 10:37:05 INFO - Running setup.py install for moztest 10:37:05 INFO - Running setup.py install for mozversion 10:37:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:37:05 INFO - Cleaning up... 10:37:05 INFO - Return code: 0 10:37:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:05 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 0x1050c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f50cb2750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10502cd30>, '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 0x104d91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105024b20>, '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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 10:37:05 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 10:37:05 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 10:37:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssBO6QHNuX/Render', 10:37:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:37:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:37:05 INFO - 'HOME': '/Users/cltbld', 10:37:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:37:05 INFO - 'LOGNAME': 'cltbld', 10:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:05 INFO - 'MOZ_NO_REMOTE': '1', 10:37:05 INFO - 'NO_EM_RESTART': '1', 10:37:05 INFO - 'PAGER': '/bin/cat', 10:37:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:05 INFO - 'PWD': '/builds/slave/test', 10:37:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:37:05 INFO - 'SHELL': '/bin/bash', 10:37:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PuqKLOYr3e/Listeners', 10:37:05 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 10:37:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:37:05 INFO - 'USER': 'cltbld', 10:37:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:37:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:05 INFO - 'XPC_FLAGS': '0x0', 10:37:05 INFO - 'XPC_SERVICE_NAME': '0', 10:37:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:37:05 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-ALHNl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:37:05 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)) 10:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:37:05 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-90p07m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:37:05 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)) 10:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:37:05 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-CX2l9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:37:06 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-OQuxi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:37:06 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-we0twM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:37:06 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-In5XCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:37:06 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Ni32UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:37:06 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-VYp6jO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:37:06 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-RKBmjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:37:06 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-TPePxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:37:06 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-T3ySwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:37:06 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-6q849P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:37:07 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)) 10:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:37:07 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-VdWlU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:37:07 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)) 10:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:37:07 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-zi0PQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:37:07 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)) 10:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:07 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-nT7GjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:07 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)) 10:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:37:07 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-2LbgRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:37:07 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)) 10:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:37:07 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-5p3wfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:37:07 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)) 10:37:07 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)) 10:37:07 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)) 10:37:07 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)) 10:37:07 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)) 10:37:07 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)) 10:37:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:37:07 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 10:37:07 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 10:37:07 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 10:37:07 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 10:37:07 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 10:37:07 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 10:37:10 INFO - Downloading blessings-1.6.tar.gz 10:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:37:10 INFO - Installing collected packages: blessings 10:37:10 INFO - Running setup.py install for blessings 10:37:10 INFO - Successfully installed blessings 10:37:10 INFO - Cleaning up... 10:37:10 INFO - Return code: 0 10:37:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:37:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:37:11 INFO - Reading from file tmpfile_stdout 10:37:11 INFO - Current package versions: 10:37:11 INFO - blessings == 1.6 10:37:11 INFO - blobuploader == 1.2.4 10:37:11 INFO - docopt == 0.6.1 10:37:11 INFO - functools32 == 3.2.3-2 10:37:11 INFO - jsonschema == 2.5.1 10:37:11 INFO - manifestparser == 1.1 10:37:11 INFO - mozInstall == 1.12 10:37:11 INFO - mozcrash == 0.17 10:37:11 INFO - mozdebug == 0.1 10:37:11 INFO - mozdevice == 0.48 10:37:11 INFO - mozfile == 1.2 10:37:11 INFO - mozhttpd == 0.7 10:37:11 INFO - mozinfo == 0.9 10:37:11 INFO - mozleak == 0.1 10:37:11 INFO - mozlog == 3.3 10:37:11 INFO - moznetwork == 0.27 10:37:11 INFO - mozprocess == 0.23 10:37:11 INFO - mozprofile == 0.28 10:37:11 INFO - mozrunner == 6.12 10:37:11 INFO - mozscreenshot == 0.1 10:37:11 INFO - mozsystemmonitor == 0.3 10:37:11 INFO - moztest == 0.7 10:37:11 INFO - mozversion == 1.4 10:37:11 INFO - psutil == 3.1.1 10:37:11 INFO - requests == 1.2.3 10:37:11 INFO - wsgiref == 0.1.2 10:37:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:37: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')]} 10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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')]} 10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:11 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 0x1050c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f50cb2750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10502cd30>, '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 0x104d91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105024b20>, '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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 10:37:11 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 10:37:11 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 10:37:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssBO6QHNuX/Render', 10:37:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:37:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:37:11 INFO - 'HOME': '/Users/cltbld', 10:37:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:37:11 INFO - 'LOGNAME': 'cltbld', 10:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:11 INFO - 'MOZ_NO_REMOTE': '1', 10:37:11 INFO - 'NO_EM_RESTART': '1', 10:37:11 INFO - 'PAGER': '/bin/cat', 10:37:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:11 INFO - 'PWD': '/builds/slave/test', 10:37:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:37:11 INFO - 'SHELL': '/bin/bash', 10:37:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PuqKLOYr3e/Listeners', 10:37:11 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 10:37:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:37:11 INFO - 'USER': 'cltbld', 10:37:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:37:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:11 INFO - 'XPC_FLAGS': '0x0', 10:37:11 INFO - 'XPC_SERVICE_NAME': '0', 10:37:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:11 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)) 10:37:11 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)) 10:37:11 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)) 10:37:11 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)) 10:37:11 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)) 10:37:11 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)) 10:37:11 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)) 10:37:11 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)) 10:37:11 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)) 10:37:11 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)) 10:37:11 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)) 10:37:11 INFO - Cleaning up... 10:37:11 INFO - Return code: 0 10:37:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:37: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')]} 10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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')]} 10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1050c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10515d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f50cb2750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10502cd30>, '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 0x104d91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105024b20>, '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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 10:37: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', 'jsonschema'] in /builds/slave/test/build 10:37: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 jsonschema 10:37:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssBO6QHNuX/Render', 10:37:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:37:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:37:11 INFO - 'HOME': '/Users/cltbld', 10:37:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:37:11 INFO - 'LOGNAME': 'cltbld', 10:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:11 INFO - 'MOZ_NO_REMOTE': '1', 10:37:11 INFO - 'NO_EM_RESTART': '1', 10:37:11 INFO - 'PAGER': '/bin/cat', 10:37:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:11 INFO - 'PWD': '/builds/slave/test', 10:37:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:37:11 INFO - 'SHELL': '/bin/bash', 10:37:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PuqKLOYr3e/Listeners', 10:37:11 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 10:37:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:37:11 INFO - 'USER': 'cltbld', 10:37:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:37:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:11 INFO - 'XPC_FLAGS': '0x0', 10:37:11 INFO - 'XPC_SERVICE_NAME': '0', 10:37:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:37:11 INFO - Cleaning up... 10:37:11 INFO - Return code: 0 10:37:11 INFO - Running post-action listener: _resource_record_post_action 10:37:11 INFO - Running post-action listener: _start_resource_monitoring 10:37:11 INFO - Starting resource monitoring. 10:37:11 INFO - [mozharness: 2016-08-23 17:37:11.931828Z] Finished create-virtualenv step (success) 10:37:11 INFO - [mozharness: 2016-08-23 17:37:11.932843Z] Running install step. 10:37:11 INFO - Running pre-action listener: _resource_record_pre_action 10:37:11 INFO - Running main action method: install 10:37:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:37:12 INFO - Reading from file tmpfile_stdout 10:37:12 INFO - Detecting whether we're running mozinstall >=1.0... 10:37:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:37:12 INFO - Reading from file tmpfile_stdout 10:37:12 INFO - Output received: 10:37:12 INFO - Usage: mozinstall [options] installer 10:37:12 INFO - Options: 10:37:12 INFO - -h, --help show this help message and exit 10:37:12 INFO - -d DEST, --destination=DEST 10:37:12 INFO - Directory to install application into. [default: 10:37:12 INFO - "/builds/slave/test"] 10:37:12 INFO - --app=APP Application being installed. [default: firefox] 10:37:12 INFO - mkdir: /builds/slave/test/build/application 10:37:12 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'] 10:37:12 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 10:37:46 INFO - Reading from file tmpfile_stdout 10:37:46 INFO - Output received: 10:37:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:37:46 INFO - Running post-action listener: _resource_record_post_action 10:37:46 INFO - [mozharness: 2016-08-23 17:37:46.623426Z] Finished install step (success) 10:37:46 INFO - [mozharness: 2016-08-23 17:37:46.623571Z] Running run-tests step. 10:37:46 INFO - Running pre-action listener: _resource_record_pre_action 10:37:46 INFO - Running main action method: run_tests 10:37:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:37:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:37:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:37:46 INFO - 2016-08-23 10:37:46.638 screenresolution[1631:7288] starting screenresolution argv=screenresolution get 10:37:46 INFO - 2016-08-23 10:37:46.640 screenresolution[1631:7288] Display 0: 1600x1200x32@60 10:37:46 INFO - 2016-08-23 10:37:46.646 screenresolution[1632:7290] starting screenresolution argv=screenresolution list 10:37:46 INFO - Available Modes on Display 0 10:37:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:37:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:37:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:37:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:37:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:37:46 INFO - Intel Iris: 10:37:46 INFO - Chipset Model: Intel Iris 10:37:46 INFO - Type: GPU 10:37:46 INFO - Bus: Built-In 10:37:46 INFO - VRAM (Dynamic, Max): 1536 MB 10:37:46 INFO - Vendor: Intel (0x8086) 10:37:46 INFO - Device ID: 0x0a2e 10:37:46 INFO - Revision ID: 0x0009 10:37:46 INFO - Displays: 10:37:46 INFO - Display: 10:37:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:37:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:37:46 INFO - Display Serial Number: 1600x1200 60 10:37:46 INFO - Main Display: Yes 10:37:46 INFO - Mirror: Off 10:37:46 INFO - Online: Yes 10:37:46 INFO - Rotation: Supported 10:37:46 INFO - Return code: 0 10:37:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:37:46 INFO - Python 2.7.3 10:37:46 INFO - Return code: 0 10:37:46 INFO - grabbing minidump binary from tooltool 10:37: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')]} 10:37:46 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 0x10502cd30>, '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 0x104d91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105024b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:37:46 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 10:37:46 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 10:37:46 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 10:37:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:37:47 INFO - Return code: 0 10:37:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:37:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:37:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:37:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:37:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:37:47 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/ciy2_amzQTyYvGSZQbzLXQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 10:37:47 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/ciy2_amzQTyYvGSZQbzLXQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0167 --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 10:37:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ssBO6QHNuX/Render', 10:37:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:37:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:37:47 INFO - 'HOME': '/Users/cltbld', 10:37:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:37:47 INFO - 'LOGNAME': 'cltbld', 10:37:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:37:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:47 INFO - 'MOZ_NO_REMOTE': '1', 10:37:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:37:47 INFO - 'NO_EM_RESTART': '1', 10:37:47 INFO - 'PAGER': '/bin/cat', 10:37:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:47 INFO - 'PWD': '/builds/slave/test', 10:37:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:37:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:37:47 INFO - 'SHELL': '/bin/bash', 10:37:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PuqKLOYr3e/Listeners', 10:37:47 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 10:37:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:37:47 INFO - 'USER': 'cltbld', 10:37:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:37:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:47 INFO - 'XPC_FLAGS': '0x0', 10:37:47 INFO - 'XPC_SERVICE_NAME': '0', 10:37:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:37:47 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/ciy2_amzQTyYvGSZQbzLXQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 10:37:47 INFO - mozversion application_buildid: 20160823080458 10:37:47 INFO - mozversion application_changeset: 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 10:37:47 INFO - mozversion application_display_name: Nightly 10:37:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:37:47 INFO - mozversion application_name: Firefox 10:37:47 INFO - mozversion application_remotingname: firefox 10:37:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:37:47 INFO - mozversion application_vendor: Mozilla 10:37:47 INFO - mozversion application_version: 51.0a1 10:37:47 INFO - mozversion platform_buildid: 20160823080458 10:37:47 INFO - mozversion platform_changeset: 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 10:37:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:37:47 INFO - mozversion platform_version: 51.0a1 10:37:47 INFO - using testdate: 1471973867 10:37:47 INFO - actual date: 1471973867 10:37:47 INFO - starting webserver on 'localhost:49270' 10:37:47 INFO - SUITE-START | Running 2 tests 10:37:47 INFO - TEST-START | dromaeo_css 10:37:47 INFO - operating with platform_type : mac_ 10:37:47 INFO - Initialising browser for dromaeo_css test... 10:37:47 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpRlcgoJ/profile http://localhost:49270/getInfo.html) 10:37:49 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 10:37:49 INFO - PROCESS | 1642 | colorDepth:24 10:37:49 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 10:37:49 INFO - PROCESS | 1642 | __metrics 10:37:49 INFO - PROCESS | 1642 | 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" 10:37:49 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:37:50 INFO - TEST-INFO | 1642: exit 0 10:37:50 INFO - Browser initialized. 10:37:50 INFO - Running cycle 1/1 for dromaeo_css test... 10:37:50 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpRlcgoJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:02 INFO - PROCESS | 1644 | RSS: Main: 234655744 10:38:02 INFO - PROCESS | 1644 | 10:38:53 INFO - PROCESS | 1644 | 1471973933875 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] 10:41:05 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 10:41:06 INFO - PROCESS | 1644 | RSS: Main: 393220096 10:41:06 INFO - PROCESS | 1644 | 10:44:10 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 10:44:10 INFO - PROCESS | 1644 | RSS: Main: 371359744 10:44:10 INFO - PROCESS | 1644 | 10:47:13 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 10:47:13 INFO - PROCESS | 1644 | RSS: Main: 354775040 10:47:13 INFO - PROCESS | 1644 | 10:50:16 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 10:50:16 INFO - PROCESS | 1644 | RSS: Main: 352301056 10:50:16 INFO - PROCESS | 1644 | 10:53:19 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 10:53:20 INFO - PROCESS | 1644 | RSS: Main: 324837376 10:53:20 INFO - PROCESS | 1644 | 10:56:23 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 10:56:24 INFO - PROCESS | 1644 | RSS: Main: 563408896 10:56:24 INFO - PROCESS | 1644 | 10:56:24 INFO - PROCESS | 1644 | __start_tp_report 10:56:24 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 10:56:24 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 10:56:24 INFO - PROCESS | 1644 | |i|pagename|runs| 10:56:24 INFO - PROCESS | 1644 | |0;dojo.html;2795.958060629091;3367.3770352484794;3369.5451114099587;3416.2142707177363;3442.569678790151;5657.3494048184475;5702.800401985921;5722.513586345161;5797.739101740426;5822.650640961545;5662.37713851476;5741.62679425837;5796.710164491769;5806.274215723035;5846.941530584693;5207.609429292799;5229.869253268661;5244.318238628973;5265.394479634833;5344.331958505187;5366.758495867695;5369.382521010095;5369.865753356158;5384.461553844623;5407.972960135214;5197.48025197481;5250.212468129773;5251.68489890604;5296.285001524802;5326.147816349366;5292.841214763564;5304.946950530484;5308.92036619451;5311.150215965466;5312.9734351328;5214.530692237717;5221.738913054332;5254.894902101974;5269.446708095633;5287.365516138049;5745.655260684331;5775.1337299405;5819.476247137778;5840.941590584082;5848.766049358021;6081.847953801146;6335.5248356372995;6340.080688300217;6357.4914006879335;6362.491000719931;5493.368262649807;6228.408301211378;6247.500199983991;6276.309605943343;6351.650659213741;5873.500752436005;5880.647161170258;5889.146073819272;5892.35184129754;5900.675462849498;6262.6868656566985;6353.841153971188;6375.681215939185;6379.425851673279;6387.744490220432;6110.26676798787;6144.910730351612;6181.660008699565;6257.155284036688;6265.96867015662;6345.8730825384155;6353.396427339488;6356.078368636614;6364;6365.36346365369;6143.754249829957;6247.937520624827;6310.337414571404;6323.336049714806;6332.810015699536;6131.193168498116;6158.291796443376;6185.103160041769;6234.625922444668;6293.2762732285455;4956.8760780980765;4969.726665033386;4972.627052971042;4982.60139188864;5001.674891132137;4459.843905463358;4464.374987501752;4474.7762611869275;4484.708493947883;4508.504064552896;5668.348139963874;5708.914366284509;5722.7710891563875;5782.855428614234;5786.94213057864;6307.148534947815;6339.778107766206;6372.617642941345;6373.171487706569;6374.936250637527;5719.48524632785;5774.942250577525;5776.5089967352405;5793.420895996143;5796.3913789052385;5337.466253374631;5434.809781657623;5469.07025805614;5469.726513674301;5545.362283337387;6388.329225431263;6439.710213040518;6440.549161558646;6445.226572811199;6464.482841372773;6354.6822658867795;6364.490840732823;6377.23473183221;6392.776252831314;6403.455706265019;6269.780557680459;6283.2460104787715;6317.494600432046;6322.525810564134;6419.6790160490855;6140.5394595406415;6236.688165591611;6286.811395658137;6292.182016337847;6294.622322660655;6281.371862813865;6339.207599050119;6341.524385671185;6354.142190804182;6365.363463653597;6008.24896887889;6112.755489780359;6113.9932453606225;6142.161149281699;6218;6188.566800323934;6199.56603037783;6204.069389591597;6206.503479721521;6207.565470417027;5651.745671444713;6049.485793707408;6052.909206361996;6067.575269731076;6070.119832624333;4857.077155340474;5456.181572763959;5989.131575921554;6100.974805932192;6160.969195153995;6049.213602231682;6049.637021778707;6063.454289114001;6064.757409703562;6077.4226448487325 10:56:24 INFO - PROCESS | 1644 | |1;ext.html;492.7216122890567;494.6364422149717;521.1271120872539;529.1797713544006;533.7838175538908;25372;31036;32290.515642265385;32374.67625323746;32375.67624323762;32993.34013319732;41752.373714394234;42507.57492425075;42606.57393426065;44369.55630443695;9744.464054477;9901.851472227887;9903;9907.900920990805;9917.355371900803;9756.804863902718;9879.753006174831;9880.950595247014;9884.505774711271;9888.406695598287;8894.28845692343;9094.590743416562;12045.156839021272;12298.385080745971;12331.876681233207;12215.083868709838;12292.754144917097;12296.323702196376;12319.568815091518;12323.938380308131;12042.458089385911;12087.758244835055;12087.879121208764;12098.334591597459;12101.455434505468;31211.37577248465;31690.524642130385;31706.04881853548;32489.675103249137;39528;3519.436890097598;3577.7853328800097;3843.903902402434;3949.111449923744;4219;30264.697353026408;30488;31518.684813152035;31591.842040789878;31600.893968711214;2713.755761981431;2856.2859285178706;3250.4799232122746;3289.753268504872;3319;376130;376190;378168;381934;382675;55949.88100237973;56365.436345636015;56382.43617563772;56439.71780141073;56580.15129773057;34112.65887341095;34386.140346491535;34442.31115377678;35633.93098207058;35650;16411.91794041022;16597.170141492876;16599.83400165983;16605.6678866422;16640.16799160037;12489.375531223584;12505;12511;12539.435725392379;12547.686307842194;16345.509634710977;18813.529661758566;18839.81160188408;18853.811461885205;18870.622587548172;6685.866282674319;8027.638756255982;8049.498468166366;8130.552819594861;8132.796680083045;869.4696235296464;1012.5949620151998;1015.8933312002281;1099.0163803396076;1113.9584488503276;27784.722152778213;28894.855525722236;29982.70017299799;30064.24839379033;30388.392232155675;1058.1851973979992;1059.750958524746;1065.238354576466;1092.5411327242577;1122.7193201699574;14188.581141885728;15044.924775376054;15342.693146137239;15649.921750391175;15911.761323580156;693167;701743;704776;704821;704841;50258;57228;57702.4229757697;57834;58249.4175058244;1377.80710700502;1389.7081612861411;1420.1337184317558;1421.7440860644977;1424.608232736006;25804.35489112787;29366.55950160792;30906.53640195444;31153.8442307787;32030.35939281248;40564.79717601511;55507.44492555184;56738.43261567497;56981.86036279334;60066.79866402735;625177;629147;692405;699552;700025;39125.6087439122;39900.60099398969;40013.599864000986;40896.38655420112;41231.381529277685;45244;45672;45811;46048.539514604425;46277.30584041309;36515.81742091379;36538.8173059133;37510;38065.61934380621;38304.42543361908;31806.84096579502;35118.29763404769;35202.41589128547;37451.625483744814;38204.80897595494;35878.64121358753;36593.634063659025;36629.63370366262;37256.44115338218;37333.62666373301;26104.202613990623;32806.34387312193;32833.179170520925;32935.835320824204;33286.50070248997;24694.50610987806;24860.37849053788;24890.377740555905;24966.126185583416;25091 10:56:24 INFO - PROCESS | 1644 | |2;jquery.html;356.4314917706261;374.9625037496249;375.12408526091576;386.6520131881306;407.4845320669354;15604.375824967003;16007.519774406772;20693.379198624065;21067.57864842706;21098.789012109894;20792.06435710393;21020.474488137766;21086.156553737834;21162.788372116273;21163.835989020597;5878.323992740847;5916.674582897928;6170.074488826689;6171.567990240685;6172.814815555541;6194.7831825886105;6219.378062193789;6223.564350495467;6231.470325022378;6241;5960.850978725523;6133.17202177707;6211.037289220156;6214.26000719797;6216.067589861512;6163.260408750956;6195.287541932667;6196.225471816023;6208.006718924973;6284.957388848642;4468.329750537413;5053.393592768854;5059.772310246011;5897.52819774417;5971.880562388771;13207.735845283136;13484.932575337061;21643.134274628996;26016.739832601623;26178.214653560422;2158.6546152615665;2163.296928498244;2445.3886528367907;2477.4054226985572;2791.5533514637764;10121.139703125244;11874.940625296904;11975.862293082231;16294.592635184097;16456.42402515918;1927.7012063130237;1950.7268982342484;1971.7929617390112;2007.1268997985776;2023.7976202379791;82936.17063829405;115447.42276288565;125969.74030259672;128495.71504285025;128662.35668821596;9406.576704048335;11198.832017519744;11446;11543.76912461746;11710.94144529272;14409.495667651581;14422.350994205286;14422.783658245135;14436.639084022983;14443.277836108153;7037.612931288726;8452.408331416742;8612.052674205832;8648.697295594624;8709.520976346235;8567.443116197428;8600.22597966186;8612.311015118776;8730.607122679494;8794.988576313806;4549.909001819945;4556.65825063115;4556.908861822745;4573.268277075718;4618.35343051973;1626.9337940815099;1804.8014718380969;1897.1747289928926;1909.6467153576632;1919.0884329943165;865.3380164174412;931.6971984105193;936.1434287626745;951.3435729346867;985.3053597213947;20842.583148337253;21624;21720;21767.020484078254;21767.67348489774;799.2846402469758;916.5463095767637;957.8275910336067;967.4098799732158;1006.4665727164614;11121.888781112086;11452.312861228353;11463.254888432226;11504.367259800623;11569.942150289195;594663;603140;611867;621137.8374189372;621426;97365.28583426066;103884;113507.43246283715;134244;141249;851.7913111287651;967.2262190247774;1006.1799633298984;1041.9166466682648;1043.410473082706;19352.516187095436;19525.92607406606;19645.607087857876;19796.802031979496;19919.701204482233;38487;57968.71015644895;59270.627640163664;59950.100748489676;60371.020230648865;82772.34455310981;86003.56998214968;86281.56859215663;87969;89363;6643.800685979429;7925.167857374892;8034.15641357649;8393.286570641563;8410;11121.777564448828;12647.557335493213;13396.598102056954;13423.865761342653;13541.86458135406;11261.042811361127;11407.859214078526;11472.770544589228;11579.710507237387;11585.884141158818;11192.272502287326;11218.887811121784;11413.315201087962;11519.942400287944;11564.42177891119;11356.106477779034;11675.591354302558;11778.587749428729;11796.70508237301;11844.170908036354;7884.329831964118;7911;8007.279344858991;8370.037445693823;8381.371397145116;8321.583920803814;9393.483358415353;10091.545880435546;11157.832632510681;11594.710132246424 10:56:24 INFO - PROCESS | 1644 | |3;mootools.html;1505.834358220596;1538.3231378193593;1692.7545505901644;1810.737443070754;1855.396995976308;8395.91604083959;8928.598213080411;8935.642574297037;8936.910630893706;8950.373473856833;7833.37333013359;8043.396745244116;8451.492910425379;8703.129687031294;8763.56182190891;2377.8811059447044;2413.263954493879;2413.2880800163994;2417.5406672732124;2422.3701837522194;2382.511585125054;2396.496735685508;2398.0527691561824;2418.0811291709124;2430.927072187837;2397.352714767012;2420.854748715074;2426;2427.7329493755674;2429.283361408389;1976.2786582897138;2380.071772008918;2383.7020372453444;2384.6661467394665;2387.8209134315;2345.7654234576576;2390.8685022323766;2398.7721166489155;2406.8435551689086;2408;8913.910860891372;8979.416337938013;8980.146886045815;8985.415947963362;8989.41568798026;5167;5328.6269961102735;5343.251944727741;5343.465653434664;5367.812126575551;3486.5990411102794;3547.467879818048;3701.1117331840433;3705.888823335304;3715.2383761329133;1079.8218293981483;1114.4929057279;1116.547798141754;1140.1733743036316;1141.1840534018133;10082.24383171265;10811.297265677706;11159.442027898573;11262.943685281522;11264.887351126466;4495.348174514677;4580.541945805459;4753.881152971134;4768.523147685273;4775.5224477551965;9738.172255358233;9743.415395076176;9749.220062394992;9750.90249097514;9761.170300524534;5315.521603055666;5326.866828329323;5328.36059672834;5335.1730481775385;5339.626226164209;3845.8269377878064;4181.790910454465;4579.931301030487;4906.754662266872;4910.607151427877;3329.517220003086;3875.3336065491544;3927.430522574268;4026.838926442968;4034.5561988181275;1277.7636137314626;1281.2824818101706;1288.606974872673;1292.4442489729317;1304.9673758156123;886.2201262888617;927.0405130689704;931.7577429868147;945.8246034121493;986.6842610364614;5812.505936995402;5972.357601659492;6051.878962420727;6142.662153581507;6167.180681698909;433.41272575660156;436.16474451425165;446.76321549578773;452.2944207037033;454.56588957545466;3941.192055628647;3993.5806740292433;4029.6776257899296;4074.409210664437;4109.630133288018;10019.79960400788;10921.781564368668;11039.282446640942;11040.227184097035;11041.613543525938;10818;10865.565377384974;10995.780084398268;10996.23026388145;11009.009189173014;8075.232852878967;8279.668813247403;8282.958585207036;8300.916990830136;8301.8339633207;5808.5643576732755;5857.970710146593;5913.29040515141;5977.282726072899;5996.640201587918;9709.271804614824;10100.89899101029;10158.03498667655;10168.796624067329;10177.694669159937;9325.440473571607;10314.742131446774;10338.224633152393;10340.069393754598;10342.431166285927;6134.4172303631085;7094.893576596252;7512.286332798375;7629.160792312952;7731.652075656497;7385.29839665231;8276.048254450574;8401.075881653136;8431.19903609156;8449.493030418194;7553.509021913558;7601.201873803171;7610.657520411484;7645.88531172044;7669.386449083949;7444.181140074479;7518.736844210426;7571.962140189264;7587.848243035219;7609.923900760921;7115.324044215791;7135.785926422215;7151.2491188424465;7186.964065179641;7220.602866842164;5014.247862820606;5059.139946209079;5070.391553013662;5089;5245.580353571629;4483.708558943658;4551.908961820679;4561.885952851205;4582.33556134352;4726.818295426144 10:56:24 INFO - PROCESS | 1644 | |4;prototype.html;246.676853322148;303.641702790707;312.383043489109;313.08266778339487;314.3430230817591;5224.4775522447735;5381.784728610861;5421;5471.452854714526;5510.228568000478;5141.82003629873;5304.336957880265;5315.255864179008;5330.946690533094;5354.437784032679;4120.670346372298;4126.29852925002;4135.1316223593085;4144.70987030908;4151.875443736685;3889.863854765084;4008.4968136948646;4081.755034730901;4127.422160897462;4141.254574176647;3851.7289294532875;4076.388541718751;4089.8364065437495;4096.610821971908;4107.876763697094;4067.9186416271805;4070.9467899075694;4073.6130067643526;4092.9795351023354;4104.240715467648;3581.298883030566;3586.2110335726097;3587.2287458196615;3605.278944211142;3621.8370173342264;4572.7942242599165;4941.703497790144;5231.279734538057;5244.632875698702;5258.763355649005;3915.0799562102884;4066.9832541864535;4135.234981528427;4523.928464382049;4693.967327188013;5509.669419834822;5598.356189038272;5621.409751976024;5621.7751289948765;5630.408807075239;3201.8559164837407;3546.6098729139776;3859.2281543691374;3889.4554762333296;3897.707671924589;5282.894342113174;5985.491233245136;6020.849478763066;6023.728932198062;6072;3308.652591477908;3622.8913132606062;3941.5664276929515;3949.0522274653877;3970.6029397060643;3329.93340133196;3672.254300613359;3862.9613703863165;3955.4462375267485;3999.900002499961;3883.825227864753;4611.855487198469;4613.976930115395;4626.976865115653;4641.187792136363;5153.917677287812;5358.866028349323;5581.358143813513;5613.607047506717;5710.371859095496;1042.358949246208;1267.4423253768311;1309.5220244610648;1309.8952083833271;1356.5455572383362;766.2529034191618;874.3966663002508;887.2813021452644;910.3400034974591;912.4388501071793;5268.418474947248;5273.947260527346;5277.944411117792;5290.391604965402;5293.602979776532;4987.875303117378;5302.28419163408;5627.887442251132;5747.885042299131;5755.9424405756245;4252.702310838274;5179.109624986928;5196.792128314901;5214.765335559909;5221.295125158055;2210.154520975004;2388.820838437124;2529.571611253181;2569.8201125921005;2608.739126087376;4200.445835041054;4494.438195225597;5022.221555658879;5077.898442031139;5078.568321692624;3875.399313106473;4294.613484786384;4396.802143903468;4740.431148262231;4976.751162441863;4292.420523229386;4341.804618792099;4809.567138957511;4845.442774080955;4926.950730492721;4322.502912165141;4391.3193455014525;4650.279206722963;4813.975930120467;4876.390451193601;3727.8508859646395;4529.867533116721;4736.063640542748;4758.881027974328;4803.543663351976;5038.571721403721;5041.621878359065;5053.343065401475;5065.505675825567;5083.46623604531;3139.3721255748483;3198.7205117952076;3397.8980630581123;3406.8977930662118;3411.3454974336933;4777.928331075106;4805.9038819224115;4823.27650852375;4837.782299796448;4915.778789954532;4723.858284251478;5070.569001634903;5218.034663587248;5246.658967167122;5687.3459552152035;4974.602031837372;5463;5660.830175094754;5676.77292908279;5751.568632352507;5090.338256026693;5283.39240987276;5524.712795886441;5544.916826247529;5581.218629391969;5345.54562862161;5729.71351432435;5737.512311453574;5767.452092051249;5795.449432303924;4917.557419832232;5639.266895303748;5643.181738647955;5644.520215781705;5680.233168522197 10:56:24 INFO - PROCESS | 1644 | |5;yui.html;719.208870242733;739.4195556488161;779.3830380073181;780.4146889832625;814.4624547798454;15778.605534861634;16989.57526061846;17016.914915425437;17033.574160645974;17033.65932681347;12643.55747548836;15210.695786084272;15320.463783767571;15337.69324613507;15348.155851428168;688.944884409246;712.5653351455608;845.7462761171655;846.3144852669342;861.577826864838;845.2603971524916;845.8435189489933;847.2798121596625;850.2900078434515;864.1013346120028;900.4147304252223;901.1304091551651;903.0382642485764;903.3315346643469;904.0146240597747;722.0505035877804;886.849235629938;897.8339007283673;899.8290324838259;900.9774755631129;675.2437270257343;676.7157793726647;677.2381071294793;677.3666621708718;681.6489507903434;15656.217189140498;15665.843341566553;15672.216389180609;15692.372305107781;15722.37110515578;12193.634190974284;14118.633242854838;14608.34262458192;14616.853831461656;14652.047616904974;13173.802392964113;13209.339533023407;13256.46974121034;13327.26700031498;13432.32838358088;4624.449470301142;4794.976025119887;4813.181759100961;4815.398075240595;4822.807087716487;120858;124077;124465;124607.3769631146;127135.72864271331;11394.772104557862;11575.247608905394;11922.761544769057;11962.40187990597;12030.458629361525;22357.99389027498;22919.312420627073;22973.655395169088;23009.53980920372;23049.078036878673;7979.16218797018;8151.184881511801;8178.67285308581;8209.876851847228;8361.874571881426;4443.755593442327;4520.344550040226;4523.932141017887;4712.434507859079;4725.385699858996;3510.526078979356;3609.205974685565;3619.4751760995036;3621.728370372233;3633.854645814191;641.0960545630638;648.4261428635691;661.7551505942832;670.3598063849109;677.7797215904851;616.2481772237862;616.6115347331153;635.3773302163905;644.2784081828289;644.2944975252092;8306.460080094774;8867.68963086289;9364.20404265645;10215.795684086424;10762.631219701738;602.8335171443272;630.2846269484169;662.1292999705372;663.2935923241732;695.2109355881112;4220.303649897794;4721.952780472151;4725.480197178307;4735.928961065587;4760.381150450419;108064.4596777011;128632;131398;134557;137610.62389375977;110840;115703;116666;116747;117351.41324293324;98389;99019;99238.5038074805;100832.99167008382;102135.4893225544;8403.789905252417;9120.133587309196;9131.178193962574;9220.538973051187;9287.582058807506;45121.54878451305;54734;56812;58337.70831145817;59156.81686366335;56053.01037375259;60939.39060609515;64091;77066.61466692631;80393.58819235432;13456.5290214842;13471.259080750653;13692.726145477234;13786.517471888837;14146.717065658835;15021.24893755286;15225.847741522442;15373.1544765039;15634.687306253583;15893.761593575875;13984.580462586138;14117.152970821784;14202.218877961397;14421.78367324512;14792.260386980393;14052.297385130498;14103.224322662352;14327.713445730818;14496.347664354918;14827.639388467062;13902.791458128338;14001.649958751113;14100.79702762628;14187;14582.270886455846;11033.662777736557;11342.319460832046;11415.429228538374;11658.53365865356;11915.940420297842;9266;9982.900170998488;11386;11397.658070257905;11641.708957276136 10:56:24 INFO - PROCESS | 1644 | __end_tp_report 10:56:24 INFO - PROCESS | 1644 | __start_cc_report 10:56:24 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,1591 10:56:24 INFO - PROCESS | 1644 | __end_cc_report 10:56:24 INFO - PROCESS | 1644 | __startTimestamp1471974984124__endTimestamp 10:56:24 INFO - PROCESS | 1644 | 10:56:24 INFO - PROCESS | 1644 | ------- Summary: start ------- 10:56:24 INFO - PROCESS | 1644 | Number of tests: 6 10:56:24 INFO - PROCESS | 1644 | 10:56:24 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5796.69 Median:6049.49 stddev:662.48 (11.0%) stddev-sans-first:621.28 10:56:24 INFO - PROCESS | 1644 | Values: 2796.0 3367.4 3369.5 3416.2 3442.6 5657.3 5702.8 5722.5 5797.7 5822.7 5662.4 5741.6 5796.7 5806.3 5846.9 5207.6 5229.9 5244.3 5265.4 5344.3 5366.8 5369.4 5369.9 5384.5 5408.0 5197.5 5250.2 5251.7 5296.3 5326.1 5292.8 5304.9 5308.9 5311.2 5313.0 5214.5 5221.7 5254.9 5269.4 5287.4 5745.7 5775.1 5819.5 5840.9 5848.8 6081.8 6335.5 6340.1 6357.5 6362.5 5493.4 6228.4 6247.5 6276.3 6351.7 5873.5 5880.6 5889.1 5892.4 5900.7 6262.7 6353.8 6375.7 6379.4 6387.7 6110.3 6144.9 6181.7 6257.2 6266.0 6345.9 6353.4 6356.1 6364.0 6365.4 6143.8 6247.9 6310.3 6323.3 6332.8 6131.2 6158.3 6185.1 6234.6 6293.3 4956.9 4969.7 4972.6 4982.6 5001.7 4459.8 4464.4 4474.8 4484.7 4508.5 5668.3 5708.9 5722.8 5782.9 5786.9 6307.1 6339.8 6372.6 6373.2 6374.9 5719.5 5774.9 5776.5 5793.4 5796.4 5337.5 5434.8 5469.1 5469.7 5545.4 6388.3 6439.7 6440.5 6445.2 6464.5 6354.7 6364.5 6377.2 6392.8 6403.5 6269.8 6283.2 6317.5 6322.5 6419.7 6140.5 6236.7 6286.8 6292.2 6294.6 6281.4 6339.2 6341.5 6354.1 6365.4 6008.2 6112.8 6114.0 6142.2 6218.0 6188.6 6199.6 6204.1 6206.5 6207.6 5651.7 6049.5 6052.9 6067.6 6070.1 4857.1 5456.2 5989.1 6101.0 6161.0 6049.2 6049.6 6063.5 6064.8 6077.4 10:56:24 INFO - PROCESS | 1644 | 10:56:24 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:70429.18 Median:34780.30 stddev:161600.68 (464.6%) stddev-sans-first:161968.71 10:56:24 INFO - PROCESS | 1644 | Values: 492.7 494.6 521.1 529.2 533.8 25372.0 31036.0 32290.5 32374.7 32375.7 32993.3 41752.4 42507.6 42606.6 44369.6 9744.5 9901.9 9903.0 9907.9 9917.4 9756.8 9879.8 9881.0 9884.5 9888.4 8894.3 9094.6 12045.2 12298.4 12331.9 12215.1 12292.8 12296.3 12319.6 12323.9 12042.5 12087.8 12087.9 12098.3 12101.5 31211.4 31690.5 31706.0 32489.7 39528.0 3519.4 3577.8 3843.9 3949.1 4219.0 30264.7 30488.0 31518.7 31591.8 31600.9 2713.8 2856.3 3250.5 3289.8 3319.0 376130.0 376190.0 378168.0 381934.0 382675.0 55949.9 56365.4 56382.4 56439.7 56580.2 34112.7 34386.1 34442.3 35633.9 35650.0 16411.9 16597.2 16599.8 16605.7 16640.2 12489.4 12505.0 12511.0 12539.4 12547.7 16345.5 18813.5 18839.8 18853.8 18870.6 6685.9 8027.6 8049.5 8130.6 8132.8 869.5 1012.6 1015.9 1099.0 1114.0 27784.7 28894.9 29982.7 30064.2 30388.4 1058.2 1059.8 1065.2 1092.5 1122.7 14188.6 15044.9 15342.7 15649.9 15911.8 693167.0 701743.0 704776.0 704821.0 704841.0 50258.0 57228.0 57702.4 57834.0 58249.4 1377.8 1389.7 1420.1 1421.7 1424.6 25804.4 29366.6 30906.5 31153.8 32030.4 40564.8 55507.4 56738.4 56981.9 60066.8 625177.0 629147.0 692405.0 699552.0 700025.0 39125.6 39900.6 40013.6 40896.4 41231.4 45244.0 45672.0 45811.0 46048.5 46277.3 36515.8 36538.8 37510.0 38065.6 38304.4 31806.8 35118.3 35202.4 37451.6 38204.8 35878.6 36593.6 36629.6 37256.4 37333.6 26104.2 32806.3 32833.2 32935.8 33286.5 24694.5 24860.4 24890.4 24966.1 25091.0 10:56:24 INFO - PROCESS | 1644 | 10:56:24 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:35342.74 Median:14247.07 stddev:101708.52 (713.9%) stddev-sans-first:101959.91 10:56:24 INFO - PROCESS | 1644 | Values: 356.4 375.0 375.1 386.7 407.5 15604.4 16007.5 20693.4 21067.6 21098.8 20792.1 21020.5 21086.2 21162.8 21163.8 5878.3 5916.7 6170.1 6171.6 6172.8 6194.8 6219.4 6223.6 6231.5 6241.0 5960.9 6133.2 6211.0 6214.3 6216.1 6163.3 6195.3 6196.2 6208.0 6285.0 4468.3 5053.4 5059.8 5897.5 5971.9 13207.7 13484.9 21643.1 26016.7 26178.2 2158.7 2163.3 2445.4 2477.4 2791.6 10121.1 11874.9 11975.9 16294.6 16456.4 1927.7 1950.7 1971.8 2007.1 2023.8 82936.2 115447.4 125969.7 128495.7 128662.4 9406.6 11198.8 11446.0 11543.8 11710.9 14409.5 14422.4 14422.8 14436.6 14443.3 7037.6 8452.4 8612.1 8648.7 8709.5 8567.4 8600.2 8612.3 8730.6 8795.0 4549.9 4556.7 4556.9 4573.3 4618.4 1626.9 1804.8 1897.2 1909.6 1919.1 865.3 931.7 936.1 951.3 985.3 20842.6 21624.0 21720.0 21767.0 21767.7 799.3 916.5 957.8 967.4 1006.5 11121.9 11452.3 11463.3 11504.4 11569.9 594663.0 603140.0 611867.0 621137.8 621426.0 97365.3 103884.0 113507.4 134244.0 141249.0 851.8 967.2 1006.2 1041.9 1043.4 19352.5 19525.9 19645.6 19796.8 19919.7 38487.0 57968.7 59270.6 59950.1 60371.0 82772.3 86003.6 86281.6 87969.0 89363.0 6643.8 7925.2 8034.2 8393.3 8410.0 11121.8 12647.6 13396.6 13423.9 13541.9 11261.0 11407.9 11472.8 11579.7 11585.9 11192.3 11218.9 11413.3 11519.9 11564.4 11356.1 11675.6 11778.6 11796.7 11844.2 7884.3 7911.0 8007.3 8370.0 8381.4 8321.6 9393.5 10091.5 11157.8 11594.7 10:56:24 INFO - PROCESS | 1644 | 10:56:24 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5696.11 Median:4581.44 stddev:3198.37 (69.8%) stddev-sans-first:3191.84 10:56:24 INFO - PROCESS | 1644 | Values: 1505.8 1538.3 1692.8 1810.7 1855.4 8395.9 8928.6 8935.6 8936.9 8950.4 7833.4 8043.4 8451.5 8703.1 8763.6 2377.9 2413.3 2413.3 2417.5 2422.4 2382.5 2396.5 2398.1 2418.1 2430.9 2397.4 2420.9 2426.0 2427.7 2429.3 1976.3 2380.1 2383.7 2384.7 2387.8 2345.8 2390.9 2398.8 2406.8 2408.0 8913.9 8979.4 8980.1 8985.4 8989.4 5167.0 5328.6 5343.3 5343.5 5367.8 3486.6 3547.5 3701.1 3705.9 3715.2 1079.8 1114.5 1116.5 1140.2 1141.2 10082.2 10811.3 11159.4 11262.9 11264.9 4495.3 4580.5 4753.9 4768.5 4775.5 9738.2 9743.4 9749.2 9750.9 9761.2 5315.5 5326.9 5328.4 5335.2 5339.6 3845.8 4181.8 4579.9 4906.8 4910.6 3329.5 3875.3 3927.4 4026.8 4034.6 1277.8 1281.3 1288.6 1292.4 1305.0 886.2 927.0 931.8 945.8 986.7 5812.5 5972.4 6051.9 6142.7 6167.2 433.4 436.2 446.8 452.3 454.6 3941.2 3993.6 4029.7 4074.4 4109.6 10019.8 10921.8 11039.3 11040.2 11041.6 10818.0 10865.6 10995.8 10996.2 11009.0 8075.2 8279.7 8283.0 8300.9 8301.8 5808.6 5858.0 5913.3 5977.3 5996.6 9709.3 10100.9 10158.0 10168.8 10177.7 9325.4 10314.7 10338.2 10340.1 10342.4 6134.4 7094.9 7512.3 7629.2 7731.7 7385.3 8276.0 8401.1 8431.2 8449.5 7553.5 7601.2 7610.7 7645.9 7669.4 7444.2 7518.7 7572.0 7587.8 7609.9 7115.3 7135.8 7151.2 7187.0 7220.6 5014.2 5059.1 5070.4 5089.0 5245.6 4483.7 4551.9 4561.9 4582.3 4726.8 10:56:24 INFO - PROCESS | 1644 | 10:56:24 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4352.54 Median:4807.74 stddev:1338.55 (27.8%) stddev-sans-first:1306.35 10:56:24 INFO - PROCESS | 1644 | Values: 246.7 303.6 312.4 313.1 314.3 5224.5 5381.8 5421.0 5471.5 5510.2 5141.8 5304.3 5315.3 5330.9 5354.4 4120.7 4126.3 4135.1 4144.7 4151.9 3889.9 4008.5 4081.8 4127.4 4141.3 3851.7 4076.4 4089.8 4096.6 4107.9 4067.9 4070.9 4073.6 4093.0 4104.2 3581.3 3586.2 3587.2 3605.3 3621.8 4572.8 4941.7 5231.3 5244.6 5258.8 3915.1 4067.0 4135.2 4523.9 4694.0 5509.7 5598.4 5621.4 5621.8 5630.4 3201.9 3546.6 3859.2 3889.5 3897.7 5282.9 5985.5 6020.8 6023.7 6072.0 3308.7 3622.9 3941.6 3949.1 3970.6 3329.9 3672.3 3863.0 3955.4 3999.9 3883.8 4611.9 4614.0 4627.0 4641.2 5153.9 5358.9 5581.4 5613.6 5710.4 1042.4 1267.4 1309.5 1309.9 1356.5 766.3 874.4 887.3 910.3 912.4 5268.4 5273.9 5277.9 5290.4 5293.6 4987.9 5302.3 5627.9 5747.9 5755.9 4252.7 5179.1 5196.8 5214.8 5221.3 2210.2 2388.8 2529.6 2569.8 2608.7 4200.4 4494.4 5022.2 5077.9 5078.6 3875.4 4294.6 4396.8 4740.4 4976.8 4292.4 4341.8 4809.6 4845.4 4927.0 4322.5 4391.3 4650.3 4814.0 4876.4 3727.9 4529.9 4736.1 4758.9 4803.5 5038.6 5041.6 5053.3 5065.5 5083.5 3139.4 3198.7 3397.9 3406.9 3411.3 4777.9 4805.9 4823.3 4837.8 4915.8 4723.9 5070.6 5218.0 5246.7 5687.3 4974.6 5463.0 5660.8 5676.8 5751.6 5090.3 5283.4 5524.7 5544.9 5581.2 5345.5 5729.7 5737.5 5767.5 5795.4 4917.6 5639.3 5643.2 5644.5 5680.2 10:56:24 INFO - PROCESS | 1644 | 10:56:24 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:23462.53 Median:3627.79 stddev:36057.72 (993.9%) stddev-sans-first:36118.43 10:56:24 INFO - PROCESS | 1644 | Values: 719.2 739.4 779.4 780.4 814.5 15778.6 16989.6 17016.9 17033.6 17033.7 12643.6 15210.7 15320.5 15337.7 15348.2 688.9 712.6 845.7 846.3 861.6 845.3 845.8 847.3 850.3 864.1 900.4 901.1 903.0 903.3 904.0 722.1 886.8 897.8 899.8 901.0 675.2 676.7 677.2 677.4 681.6 15656.2 15665.8 15672.2 15692.4 15722.4 12193.6 14118.6 14608.3 14616.9 14652.0 13173.8 13209.3 13256.5 13327.3 13432.3 4624.4 4795.0 4813.2 4815.4 4822.8 120858.0 124077.0 124465.0 124607.4 127135.7 11394.8 11575.2 11922.8 11962.4 12030.5 22358.0 22919.3 22973.7 23009.5 23049.1 7979.2 8151.2 8178.7 8209.9 8361.9 4443.8 4520.3 4523.9 4712.4 4725.4 3510.5 3609.2 3619.5 3621.7 3633.9 641.1 648.4 661.8 670.4 677.8 616.2 616.6 635.4 644.3 644.3 8306.5 8867.7 9364.2 10215.8 10762.6 602.8 630.3 662.1 663.3 695.2 4220.3 4722.0 4725.5 4735.9 4760.4 108064.5 128632.0 131398.0 134557.0 137610.6 110840.0 115703.0 116666.0 116747.0 117351.4 98389.0 99019.0 99238.5 100833.0 102135.5 8403.8 9120.1 9131.2 9220.5 9287.6 45121.5 54734.0 56812.0 58337.7 59156.8 56053.0 60939.4 64091.0 77066.6 80393.6 13456.5 13471.3 13692.7 13786.5 14146.7 15021.2 15225.8 15373.2 15634.7 15893.8 13984.6 14117.2 14202.2 14421.8 14792.3 14052.3 14103.2 14327.7 14496.3 14827.6 13902.8 14001.6 14100.8 14187.0 14582.3 11033.7 11342.3 11415.4 11658.5 11915.9 9266.0 9982.9 11386.0 11397.7 11641.7 10:56:24 INFO - PROCESS | 1644 | -------- Summary: end -------- 10:56:24 INFO - PROCESS | 1644 | 10:56:24 INFO - TEST-INFO | 1644: exit 0 10:56:24 INFO - TEST-OK | dromaeo_css | took 1117558ms 10:56:24 INFO - TEST-START | kraken 10:56:24 INFO - operating with platform_type : mac_ 10:56:24 INFO - Initialising browser for kraken test... 10:56:24 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpjDNsJn/profile http://localhost:49270/getInfo.html) 10:56:26 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 10:56:26 INFO - PROCESS | 1653 | colorDepth:24 10:56:26 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 10:56:26 INFO - PROCESS | 1653 | __metrics 10:56:27 INFO - PROCESS | 1653 | 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" 10:56:27 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:56:27 INFO - TEST-INFO | 1653: exit 0 10:56:27 INFO - Browser initialized. 10:56:27 INFO - Running cycle 1/1 for kraken test... 10:56:27 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpjDNsJn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:56:39 INFO - PROCESS | 1654 | RSS: Main: 234856448 10:56:39 INFO - PROCESS | 1654 | 10:56:42 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 10:56:43 INFO - PROCESS | 1654 | RSS: Main: 294518784 10:56:43 INFO - PROCESS | 1654 | 10:56:45 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 10:56:46 INFO - PROCESS | 1654 | RSS: Main: 290414592 10:56:46 INFO - PROCESS | 1654 | 10:56:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 10:56:50 INFO - PROCESS | 1654 | RSS: Main: 379166720 10:56:50 INFO - PROCESS | 1654 | 10:56:52 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 10:56:53 INFO - PROCESS | 1654 | RSS: Main: 280809472 10:56:53 INFO - PROCESS | 1654 | 10:56:55 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:56:56 INFO - PROCESS | 1654 | RSS: Main: 284045312 10:56:56 INFO - PROCESS | 1654 | 10:56:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 10:56:59 INFO - PROCESS | 1654 | RSS: Main: 323870720 10:56:59 INFO - PROCESS | 1654 | 10:57:02 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 10:57:03 INFO - PROCESS | 1654 | RSS: Main: 324116480 10:57:03 INFO - PROCESS | 1654 | 10:57:05 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 10:57:06 INFO - PROCESS | 1654 | RSS: Main: 325001216 10:57:06 INFO - PROCESS | 1654 | 10:57:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:57:08 INFO - PROCESS | 1654 | RSS: Main: 300150784 10:57:08 INFO - PROCESS | 1654 | 10:57:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:57:11 INFO - PROCESS | 1654 | RSS: Main: 305844224 10:57:11 INFO - PROCESS | 1654 | 10:57:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:57:14 INFO - PROCESS | 1654 | RSS: Main: 310464512 10:57:14 INFO - PROCESS | 1654 | 10:57:17 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:57:18 INFO - PROCESS | 1654 | RSS: Main: 315412480 10:57:18 INFO - PROCESS | 1654 | 10:57:21 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:57:21 INFO - PROCESS | 1654 | RSS: Main: 317968384 10:57:21 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 10:57:23 INFO - PROCESS | 1654 | RSS: Main: 361877504 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | __start_tp_report 10:57:23 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 10:57:23 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 10:57:23 INFO - PROCESS | 1654 | |i|pagename|runs| 10:57:23 INFO - PROCESS | 1654 | |0;ai-astar;113;111;117;114;112;113;113;113;112;121 10:57:23 INFO - PROCESS | 1654 | |1;audio-beat-detection;143;113;127;162;108;128;128;107;160;108 10:57:23 INFO - PROCESS | 1654 | |2;audio-dft;184;188;186;183;184;183;181;184;182;182 10:57:23 INFO - PROCESS | 1654 | |3;audio-fft;81;72;80;151;58;57;57;67;137;57 10:57:23 INFO - PROCESS | 1654 | |4;audio-oscillator;84;82;137;70;71;74;121;72;92;151 10:57:23 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;88;84;87;85;88;84;88;85;88;84 10:57:23 INFO - PROCESS | 1654 | |6;imaging-darkroom;93;93;93;94;93;93;93;93;93;93 10:57:23 INFO - PROCESS | 1654 | |7;imaging-desaturate;84;85;118;137;113;85;85;82;84;85 10:57:23 INFO - PROCESS | 1654 | |8;json-parse-financial;55;55;54;53;54;55;54;55;53;54 10:57:23 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;63;69;102;108;95;72;71;69;68;73 10:57:23 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;100;106;88;86;88;88;88;91;91;91 10:57:23 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;143;131;135;147;138;135;138;139;205;145 10:57:23 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;169;170;170;166;227;222;168;170;167;167 10:57:23 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;69;72;85;85;84;72;66;67;66;66 10:57:23 INFO - PROCESS | 1654 | __end_tp_report 10:57:23 INFO - PROCESS | 1654 | __start_cc_report 10:57:23 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2148 10:57:23 INFO - PROCESS | 1654 | __end_cc_report 10:57:23 INFO - PROCESS | 1654 | __startTimestamp1471975043763__endTimestamp 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | ------- Summary: start ------- 10:57:23 INFO - PROCESS | 1654 | Number of tests: 14 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:113.90 Median:113.00 stddev:2.96 (2.6%) stddev-sans-first:3.12 10:57:23 INFO - PROCESS | 1654 | Values: 113.0 111.0 117.0 114.0 112.0 113.0 113.0 113.0 112.0 121.0 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:128.00 stddev:20.74 (16.2%) stddev-sans-first:21.31 10:57:23 INFO - PROCESS | 1654 | Values: 143.0 113.0 127.0 162.0 108.0 128.0 128.0 107.0 160.0 108.0 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:2.06 (1.1%) stddev-sans-first:2.18 10:57:23 INFO - PROCESS | 1654 | Values: 184.0 188.0 186.0 183.0 184.0 183.0 181.0 184.0 182.0 182.0 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:81.70 Median:62.50 stddev:34.26 (54.8%) stddev-sans-first:36.34 10:57:23 INFO - PROCESS | 1654 | Values: 81.0 72.0 80.0 151.0 58.0 57.0 57.0 67.0 137.0 57.0 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:73.00 stddev:29.90 (41.0%) stddev-sans-first:31.42 10:57:23 INFO - PROCESS | 1654 | Values: 84.0 82.0 137.0 70.0 71.0 74.0 121.0 72.0 92.0 151.0 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:87.50 stddev:1.85 (2.1%) stddev-sans-first:1.83 10:57:23 INFO - PROCESS | 1654 | Values: 88.0 84.0 87.0 85.0 88.0 84.0 88.0 85.0 88.0 84.0 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:57:23 INFO - PROCESS | 1654 | Values: 93.0 93.0 93.0 94.0 93.0 93.0 93.0 93.0 93.0 93.0 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:84.50 stddev:19.50 (23.1%) stddev-sans-first:20.21 10:57:23 INFO - PROCESS | 1654 | Values: 84.0 85.0 118.0 137.0 113.0 85.0 85.0 82.0 84.0 85.0 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:0.79 (1.4%) stddev-sans-first:0.78 10:57:23 INFO - PROCESS | 1654 | Values: 55.0 55.0 54.0 53.0 54.0 55.0 54.0 55.0 53.0 54.0 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:79.00 Median:70.00 stddev:16.17 (23.1%) stddev-sans-first:16.08 10:57:23 INFO - PROCESS | 1654 | Values: 63.0 69.0 102.0 108.0 95.0 72.0 71.0 69.0 68.0 73.0 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:88.00 stddev:6.34 (7.2%) stddev-sans-first:5.97 10:57:23 INFO - PROCESS | 1654 | Values: 100.0 106.0 88.0 86.0 88.0 88.0 88.0 91.0 91.0 91.0 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:141.00 stddev:21.43 (15.2%) stddev-sans-first:22.71 10:57:23 INFO - PROCESS | 1654 | Values: 143.0 131.0 135.0 147.0 138.0 135.0 138.0 139.0 205.0 145.0 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:170.00 stddev:23.74 (14.0%) stddev-sans-first:24.86 10:57:23 INFO - PROCESS | 1654 | Values: 169.0 170.0 170.0 166.0 227.0 222.0 168.0 170.0 167.0 167.0 10:57:23 INFO - PROCESS | 1654 | 10:57:23 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:72.00 stddev:8.23 (11.4%) stddev-sans-first:8.59 10:57:23 INFO - PROCESS | 1654 | Values: 69.0 72.0 85.0 85.0 84.0 72.0 66.0 67.0 66.0 66.0 10:57:23 INFO - PROCESS | 1654 | -------- Summary: end -------- 10:57:23 INFO - PROCESS | 1654 | 10:57:24 INFO - TEST-INFO | 1654: exit 0 10:57:24 INFO - TEST-OK | kraken | took 59824ms 10:57:24 INFO - SUITE-END | took 1177s 10:57:24 INFO - Completed test suite (00:19:37) 10:57:24 INFO - javascript benchmark 10:57:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2795.958060629091, 3367.3770352484794, 3369.5451114099587, 3416.2142707177363, 3442.569678790151, 5657.3494048184475, 5702.800401985921, 5722.513586345161, 5797.739101740426, 5822.650640961545, 5662.37713851476, 5741.62679425837, 5796.710164491769, 5806.274215723035, 5846.941530584693, 5207.609429292799, 5229.869253268661, 5244.318238628973, 5265.394479634833, 5344.331958505187, 5366.758495867695, 5369.382521010095, 5369.865753356158, 5384.461553844623, 5407.972960135214, 5197.48025197481, 5250.212468129773, 5251.68489890604, 5296.285001524802, 5326.147816349366, 5292.841214763564, 5304.946950530484, 5308.92036619451, 5311.150215965466, 5312.9734351328, 5214.530692237717, 5221.738913054332, 5254.894902101974, 5269.446708095633, 5287.365516138049, 5745.655260684331, 5775.1337299405, 5819.476247137778, 5840.941590584082, 5848.766049358021, 6081.847953801146, 6335.5248356372995, 6340.080688300217, 6357.4914006879335, 6362.491000719931, 5493.368262649807, 6228.408301211378, 6247.500199983991, 6276.309605943343, 6351.650659213741, 5873.500752436005, 5880.647161170258, 5889.146073819272, 5892.35184129754, 5900.675462849498, 6262.6868656566985, 6353.841153971188, 6375.681215939185, 6379.425851673279, 6387.744490220432, 6110.26676798787, 6144.910730351612, 6181.660008699565, 6257.155284036688, 6265.96867015662, 6345.8730825384155, 6353.396427339488, 6356.078368636614, 6364.0, 6365.36346365369, 6143.754249829957, 6247.937520624827, 6310.337414571404, 6323.336049714806, 6332.810015699536, 6131.193168498116, 6158.291796443376, 6185.103160041769, 6234.625922444668, 6293.2762732285455, 4956.8760780980765, 4969.726665033386, 4972.627052971042, 4982.60139188864, 5001.674891132137, 4459.843905463358, 4464.374987501752, 4474.7762611869275, 4484.708493947883, 4508.504064552896, 5668.348139963874, 5708.914366284509, 5722.7710891563875, 5782.855428614234, 5786.94213057864, 6307.148534947815, 6339.778107766206, 6372.617642941345, 6373.171487706569, 6374.936250637527, 5719.48524632785, 5774.942250577525, 5776.5089967352405, 5793.420895996143, 5796.3913789052385, 5337.466253374631, 5434.809781657623, 5469.07025805614, 5469.726513674301, 5545.362283337387, 6388.329225431263, 6439.710213040518, 6440.549161558646, 6445.226572811199, 6464.482841372773, 6354.6822658867795, 6364.490840732823, 6377.23473183221, 6392.776252831314, 6403.455706265019, 6269.780557680459, 6283.2460104787715, 6317.494600432046, 6322.525810564134, 6419.6790160490855, 6140.5394595406415, 6236.688165591611, 6286.811395658137, 6292.182016337847, 6294.622322660655, 6281.371862813865, 6339.207599050119, 6341.524385671185, 6354.142190804182, 6365.363463653597, 6008.24896887889, 6112.755489780359, 6113.9932453606225, 6142.161149281699, 6218.0, 6188.566800323934, 6199.56603037783, 6204.069389591597, 6206.503479721521, 6207.565470417027, 5651.745671444713, 6049.485793707408, 6052.909206361996, 6067.575269731076, 6070.119832624333, 4857.077155340474, 5456.181572763959, 5989.131575921554, 6100.974805932192, 6160.969195153995, 6049.213602231682, 6049.637021778707, 6063.454289114001, 6064.757409703562, 6077.4226448487325], "value": 5752.589106044233, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.7216122890567, 494.6364422149717, 521.1271120872539, 529.1797713544006, 533.7838175538908, 25372.0, 31036.0, 32290.515642265385, 32374.67625323746, 32375.67624323762, 32993.34013319732, 41752.373714394234, 42507.57492425075, 42606.57393426065, 44369.55630443695, 9744.464054477, 9901.851472227887, 9903.0, 9907.900920990805, 9917.355371900803, 9756.804863902718, 9879.753006174831, 9880.950595247014, 9884.505774711271, 9888.406695598287, 8894.28845692343, 9094.590743416562, 12045.156839021272, 12298.385080745971, 12331.876681233207, 12215.083868709838, 12292.754144917097, 12296.323702196376, 12319.568815091518, 12323.938380308131, 12042.458089385911, 12087.758244835055, 12087.879121208764, 12098.334591597459, 12101.455434505468, 31211.37577248465, 31690.524642130385, 31706.04881853548, 32489.675103249137, 39528.0, 3519.436890097598, 3577.7853328800097, 3843.903902402434, 3949.111449923744, 4219.0, 30264.697353026408, 30488.0, 31518.684813152035, 31591.842040789878, 31600.893968711214, 2713.755761981431, 2856.2859285178706, 3250.4799232122746, 3289.753268504872, 3319.0, 376130.0, 376190.0, 378168.0, 381934.0, 382675.0, 55949.88100237973, 56365.436345636015, 56382.43617563772, 56439.71780141073, 56580.15129773057, 34112.65887341095, 34386.140346491535, 34442.31115377678, 35633.93098207058, 35650.0, 16411.91794041022, 16597.170141492876, 16599.83400165983, 16605.6678866422, 16640.16799160037, 12489.375531223584, 12505.0, 12511.0, 12539.435725392379, 12547.686307842194, 16345.509634710977, 18813.529661758566, 18839.81160188408, 18853.811461885205, 18870.622587548172, 6685.866282674319, 8027.638756255982, 8049.498468166366, 8130.552819594861, 8132.796680083045, 869.4696235296464, 1012.5949620151998, 1015.8933312002281, 1099.0163803396076, 1113.9584488503276, 27784.722152778213, 28894.855525722236, 29982.70017299799, 30064.24839379033, 30388.392232155675, 1058.1851973979992, 1059.750958524746, 1065.238354576466, 1092.5411327242577, 1122.7193201699574, 14188.581141885728, 15044.924775376054, 15342.693146137239, 15649.921750391175, 15911.761323580156, 693167.0, 701743.0, 704776.0, 704821.0, 704841.0, 50258.0, 57228.0, 57702.4229757697, 57834.0, 58249.4175058244, 1377.80710700502, 1389.7081612861411, 1420.1337184317558, 1421.7440860644977, 1424.608232736006, 25804.35489112787, 29366.55950160792, 30906.53640195444, 31153.8442307787, 32030.35939281248, 40564.79717601511, 55507.44492555184, 56738.43261567497, 56981.86036279334, 60066.79866402735, 625177.0, 629147.0, 692405.0, 699552.0, 700025.0, 39125.6087439122, 39900.60099398969, 40013.599864000986, 40896.38655420112, 41231.381529277685, 45244.0, 45672.0, 45811.0, 46048.539514604425, 46277.30584041309, 36515.81742091379, 36538.8173059133, 37510.0, 38065.61934380621, 38304.42543361908, 31806.84096579502, 35118.29763404769, 35202.41589128547, 37451.625483744814, 38204.80897595494, 35878.64121358753, 36593.634063659025, 36629.63370366262, 37256.44115338218, 37333.62666373301, 26104.202613990623, 32806.34387312193, 32833.179170520925, 32935.835320824204, 33286.50070248997, 24694.50610987806, 24860.37849053788, 24890.377740555905, 24966.126185583416, 25091.0], "value": 19905.888661535373, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.4314917706261, 374.9625037496249, 375.12408526091576, 386.6520131881306, 407.4845320669354, 15604.375824967003, 16007.519774406772, 20693.379198624065, 21067.57864842706, 21098.789012109894, 20792.06435710393, 21020.474488137766, 21086.156553737834, 21162.788372116273, 21163.835989020597, 5878.323992740847, 5916.674582897928, 6170.074488826689, 6171.567990240685, 6172.814815555541, 6194.7831825886105, 6219.378062193789, 6223.564350495467, 6231.470325022378, 6241.0, 5960.850978725523, 6133.17202177707, 6211.037289220156, 6214.26000719797, 6216.067589861512, 6163.260408750956, 6195.287541932667, 6196.225471816023, 6208.006718924973, 6284.957388848642, 4468.329750537413, 5053.393592768854, 5059.772310246011, 5897.52819774417, 5971.880562388771, 13207.735845283136, 13484.932575337061, 21643.134274628996, 26016.739832601623, 26178.214653560422, 2158.6546152615665, 2163.296928498244, 2445.3886528367907, 2477.4054226985572, 2791.5533514637764, 10121.139703125244, 11874.940625296904, 11975.862293082231, 16294.592635184097, 16456.42402515918, 1927.7012063130237, 1950.7268982342484, 1971.7929617390112, 2007.1268997985776, 2023.7976202379791, 82936.17063829405, 115447.42276288565, 125969.74030259672, 128495.71504285025, 128662.35668821596, 9406.576704048335, 11198.832017519744, 11446.0, 11543.76912461746, 11710.94144529272, 14409.495667651581, 14422.350994205286, 14422.783658245135, 14436.639084022983, 14443.277836108153, 7037.612931288726, 8452.408331416742, 8612.052674205832, 8648.697295594624, 8709.520976346235, 8567.443116197428, 8600.22597966186, 8612.311015118776, 8730.607122679494, 8794.988576313806, 4549.909001819945, 4556.65825063115, 4556.908861822745, 4573.268277075718, 4618.35343051973, 1626.9337940815099, 1804.8014718380969, 1897.1747289928926, 1909.6467153576632, 1919.0884329943165, 865.3380164174412, 931.6971984105193, 936.1434287626745, 951.3435729346867, 985.3053597213947, 20842.583148337253, 21624.0, 21720.0, 21767.020484078254, 21767.67348489774, 799.2846402469758, 916.5463095767637, 957.8275910336067, 967.4098799732158, 1006.4665727164614, 11121.888781112086, 11452.312861228353, 11463.254888432226, 11504.367259800623, 11569.942150289195, 594663.0, 603140.0, 611867.0, 621137.8374189372, 621426.0, 97365.28583426066, 103884.0, 113507.43246283715, 134244.0, 141249.0, 851.7913111287651, 967.2262190247774, 1006.1799633298984, 1041.9166466682648, 1043.410473082706, 19352.516187095436, 19525.92607406606, 19645.607087857876, 19796.802031979496, 19919.701204482233, 38487.0, 57968.71015644895, 59270.627640163664, 59950.100748489676, 60371.020230648865, 82772.34455310981, 86003.56998214968, 86281.56859215663, 87969.0, 89363.0, 6643.800685979429, 7925.167857374892, 8034.15641357649, 8393.286570641563, 8410.0, 11121.777564448828, 12647.557335493213, 13396.598102056954, 13423.865761342653, 13541.86458135406, 11261.042811361127, 11407.859214078526, 11472.770544589228, 11579.710507237387, 11585.884141158818, 11192.272502287326, 11218.887811121784, 11413.315201087962, 11519.942400287944, 11564.42177891119, 11356.106477779034, 11675.591354302558, 11778.587749428729, 11796.70508237301, 11844.170908036354, 7884.329831964118, 7911.0, 8007.279344858991, 8370.037445693823, 8381.371397145116, 8321.583920803814, 9393.483358415353, 10091.545880435546, 11157.832632510681, 11594.710132246424], "value": 9667.362367133763, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1505.834358220596, 1538.3231378193593, 1692.7545505901644, 1810.737443070754, 1855.396995976308, 8395.91604083959, 8928.598213080411, 8935.642574297037, 8936.910630893706, 8950.373473856833, 7833.37333013359, 8043.396745244116, 8451.492910425379, 8703.129687031294, 8763.56182190891, 2377.8811059447044, 2413.263954493879, 2413.2880800163994, 2417.5406672732124, 2422.3701837522194, 2382.511585125054, 2396.496735685508, 2398.0527691561824, 2418.0811291709124, 2430.927072187837, 2397.352714767012, 2420.854748715074, 2426.0, 2427.7329493755674, 2429.283361408389, 1976.2786582897138, 2380.071772008918, 2383.7020372453444, 2384.6661467394665, 2387.8209134315, 2345.7654234576576, 2390.8685022323766, 2398.7721166489155, 2406.8435551689086, 2408.0, 8913.910860891372, 8979.416337938013, 8980.146886045815, 8985.415947963362, 8989.41568798026, 5167.0, 5328.6269961102735, 5343.251944727741, 5343.465653434664, 5367.812126575551, 3486.5990411102794, 3547.467879818048, 3701.1117331840433, 3705.888823335304, 3715.2383761329133, 1079.8218293981483, 1114.4929057279, 1116.547798141754, 1140.1733743036316, 1141.1840534018133, 10082.24383171265, 10811.297265677706, 11159.442027898573, 11262.943685281522, 11264.887351126466, 4495.348174514677, 4580.541945805459, 4753.881152971134, 4768.523147685273, 4775.5224477551965, 9738.172255358233, 9743.415395076176, 9749.220062394992, 9750.90249097514, 9761.170300524534, 5315.521603055666, 5326.866828329323, 5328.36059672834, 5335.1730481775385, 5339.626226164209, 3845.8269377878064, 4181.790910454465, 4579.931301030487, 4906.754662266872, 4910.607151427877, 3329.517220003086, 3875.3336065491544, 3927.430522574268, 4026.838926442968, 4034.5561988181275, 1277.7636137314626, 1281.2824818101706, 1288.606974872673, 1292.4442489729317, 1304.9673758156123, 886.2201262888617, 927.0405130689704, 931.7577429868147, 945.8246034121493, 986.6842610364614, 5812.505936995402, 5972.357601659492, 6051.878962420727, 6142.662153581507, 6167.180681698909, 433.41272575660156, 436.16474451425165, 446.76321549578773, 452.2944207037033, 454.56588957545466, 3941.192055628647, 3993.5806740292433, 4029.6776257899296, 4074.409210664437, 4109.630133288018, 10019.79960400788, 10921.781564368668, 11039.282446640942, 11040.227184097035, 11041.613543525938, 10818.0, 10865.565377384974, 10995.780084398268, 10996.23026388145, 11009.009189173014, 8075.232852878967, 8279.668813247403, 8282.958585207036, 8300.916990830136, 8301.8339633207, 5808.5643576732755, 5857.970710146593, 5913.29040515141, 5977.282726072899, 5996.640201587918, 9709.271804614824, 10100.89899101029, 10158.03498667655, 10168.796624067329, 10177.694669159937, 9325.440473571607, 10314.742131446774, 10338.224633152393, 10340.069393754598, 10342.431166285927, 6134.4172303631085, 7094.893576596252, 7512.286332798375, 7629.160792312952, 7731.652075656497, 7385.29839665231, 8276.048254450574, 8401.075881653136, 8431.19903609156, 8449.493030418194, 7553.509021913558, 7601.201873803171, 7610.657520411484, 7645.88531172044, 7669.386449083949, 7444.181140074479, 7518.736844210426, 7571.962140189264, 7587.848243035219, 7609.923900760921, 7115.324044215791, 7135.785926422215, 7151.2491188424465, 7186.964065179641, 7220.602866842164, 5014.247862820606, 5059.139946209079, 5070.391553013662, 5089.0, 5245.580353571629, 4483.708558943658, 4551.908961820679, 4561.885952851205, 4582.33556134352, 4726.818295426144], "value": 4514.840376145011, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [246.676853322148, 303.641702790707, 312.383043489109, 313.08266778339487, 314.3430230817591, 5224.4775522447735, 5381.784728610861, 5421.0, 5471.452854714526, 5510.228568000478, 5141.82003629873, 5304.336957880265, 5315.255864179008, 5330.946690533094, 5354.437784032679, 4120.670346372298, 4126.29852925002, 4135.1316223593085, 4144.70987030908, 4151.875443736685, 3889.863854765084, 4008.4968136948646, 4081.755034730901, 4127.422160897462, 4141.254574176647, 3851.7289294532875, 4076.388541718751, 4089.8364065437495, 4096.610821971908, 4107.876763697094, 4067.9186416271805, 4070.9467899075694, 4073.6130067643526, 4092.9795351023354, 4104.240715467648, 3581.298883030566, 3586.2110335726097, 3587.2287458196615, 3605.278944211142, 3621.8370173342264, 4572.7942242599165, 4941.703497790144, 5231.279734538057, 5244.632875698702, 5258.763355649005, 3915.0799562102884, 4066.9832541864535, 4135.234981528427, 4523.928464382049, 4693.967327188013, 5509.669419834822, 5598.356189038272, 5621.409751976024, 5621.7751289948765, 5630.408807075239, 3201.8559164837407, 3546.6098729139776, 3859.2281543691374, 3889.4554762333296, 3897.707671924589, 5282.894342113174, 5985.491233245136, 6020.849478763066, 6023.728932198062, 6072.0, 3308.652591477908, 3622.8913132606062, 3941.5664276929515, 3949.0522274653877, 3970.6029397060643, 3329.93340133196, 3672.254300613359, 3862.9613703863165, 3955.4462375267485, 3999.900002499961, 3883.825227864753, 4611.855487198469, 4613.976930115395, 4626.976865115653, 4641.187792136363, 5153.917677287812, 5358.866028349323, 5581.358143813513, 5613.607047506717, 5710.371859095496, 1042.358949246208, 1267.4423253768311, 1309.5220244610648, 1309.8952083833271, 1356.5455572383362, 766.2529034191618, 874.3966663002508, 887.2813021452644, 910.3400034974591, 912.4388501071793, 5268.418474947248, 5273.947260527346, 5277.944411117792, 5290.391604965402, 5293.602979776532, 4987.875303117378, 5302.28419163408, 5627.887442251132, 5747.885042299131, 5755.9424405756245, 4252.702310838274, 5179.109624986928, 5196.792128314901, 5214.765335559909, 5221.295125158055, 2210.154520975004, 2388.820838437124, 2529.571611253181, 2569.8201125921005, 2608.739126087376, 4200.445835041054, 4494.438195225597, 5022.221555658879, 5077.898442031139, 5078.568321692624, 3875.399313106473, 4294.613484786384, 4396.802143903468, 4740.431148262231, 4976.751162441863, 4292.420523229386, 4341.804618792099, 4809.567138957511, 4845.442774080955, 4926.950730492721, 4322.502912165141, 4391.3193455014525, 4650.279206722963, 4813.975930120467, 4876.390451193601, 3727.8508859646395, 4529.867533116721, 4736.063640542748, 4758.881027974328, 4803.543663351976, 5038.571721403721, 5041.621878359065, 5053.343065401475, 5065.505675825567, 5083.46623604531, 3139.3721255748483, 3198.7205117952076, 3397.8980630581123, 3406.8977930662118, 3411.3454974336933, 4777.928331075106, 4805.9038819224115, 4823.27650852375, 4837.782299796448, 4915.778789954532, 4723.858284251478, 5070.569001634903, 5218.034663587248, 5246.658967167122, 5687.3459552152035, 4974.602031837372, 5463.0, 5660.830175094754, 5676.77292908279, 5751.568632352507, 5090.338256026693, 5283.39240987276, 5524.712795886441, 5544.916826247529, 5581.218629391969, 5345.54562862161, 5729.71351432435, 5737.512311453574, 5767.452092051249, 5795.449432303924, 4917.557419832232, 5639.266895303748, 5643.181738647955, 5644.520215781705, 5680.233168522197], "value": 3926.034914092103, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.208870242733, 739.4195556488161, 779.3830380073181, 780.4146889832625, 814.4624547798454, 15778.605534861634, 16989.57526061846, 17016.914915425437, 17033.574160645974, 17033.65932681347, 12643.55747548836, 15210.695786084272, 15320.463783767571, 15337.69324613507, 15348.155851428168, 688.944884409246, 712.5653351455608, 845.7462761171655, 846.3144852669342, 861.577826864838, 845.2603971524916, 845.8435189489933, 847.2798121596625, 850.2900078434515, 864.1013346120028, 900.4147304252223, 901.1304091551651, 903.0382642485764, 903.3315346643469, 904.0146240597747, 722.0505035877804, 886.849235629938, 897.8339007283673, 899.8290324838259, 900.9774755631129, 675.2437270257343, 676.7157793726647, 677.2381071294793, 677.3666621708718, 681.6489507903434, 15656.217189140498, 15665.843341566553, 15672.216389180609, 15692.372305107781, 15722.37110515578, 12193.634190974284, 14118.633242854838, 14608.34262458192, 14616.853831461656, 14652.047616904974, 13173.802392964113, 13209.339533023407, 13256.46974121034, 13327.26700031498, 13432.32838358088, 4624.449470301142, 4794.976025119887, 4813.181759100961, 4815.398075240595, 4822.807087716487, 120858.0, 124077.0, 124465.0, 124607.3769631146, 127135.72864271331, 11394.772104557862, 11575.247608905394, 11922.761544769057, 11962.40187990597, 12030.458629361525, 22357.99389027498, 22919.312420627073, 22973.655395169088, 23009.53980920372, 23049.078036878673, 7979.16218797018, 8151.184881511801, 8178.67285308581, 8209.876851847228, 8361.874571881426, 4443.755593442327, 4520.344550040226, 4523.932141017887, 4712.434507859079, 4725.385699858996, 3510.526078979356, 3609.205974685565, 3619.4751760995036, 3621.728370372233, 3633.854645814191, 641.0960545630638, 648.4261428635691, 661.7551505942832, 670.3598063849109, 677.7797215904851, 616.2481772237862, 616.6115347331153, 635.3773302163905, 644.2784081828289, 644.2944975252092, 8306.460080094774, 8867.68963086289, 9364.20404265645, 10215.795684086424, 10762.631219701738, 602.8335171443272, 630.2846269484169, 662.1292999705372, 663.2935923241732, 695.2109355881112, 4220.303649897794, 4721.952780472151, 4725.480197178307, 4735.928961065587, 4760.381150450419, 108064.4596777011, 128632.0, 131398.0, 134557.0, 137610.62389375977, 110840.0, 115703.0, 116666.0, 116747.0, 117351.41324293324, 98389.0, 99019.0, 99238.5038074805, 100832.99167008382, 102135.4893225544, 8403.789905252417, 9120.133587309196, 9131.178193962574, 9220.538973051187, 9287.582058807506, 45121.54878451305, 54734.0, 56812.0, 58337.70831145817, 59156.81686366335, 56053.01037375259, 60939.39060609515, 64091.0, 77066.61466692631, 80393.58819235432, 13456.5290214842, 13471.259080750653, 13692.726145477234, 13786.517471888837, 14146.717065658835, 15021.24893755286, 15225.847741522442, 15373.1544765039, 15634.687306253583, 15893.761593575875, 13984.580462586138, 14117.152970821784, 14202.218877961397, 14421.78367324512, 14792.260386980393, 14052.297385130498, 14103.224322662352, 14327.713445730818, 14496.347664354918, 14827.639388467062, 13902.791458128338, 14001.649958751113, 14100.79702762628, 14187.0, 14582.270886455846, 11033.662777736557, 11342.319460832046, 11415.429228538374, 11658.53365865356, 11915.940420297842, 9266.0, 9982.900170998488, 11386.0, 11397.658070257905, 11641.708957276136], "value": 7884.031719921863, "unit": "score"}], "name": "dromaeo_css", "value": 7326.969559659611, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 117.0, 114.0, 112.0, 113.0, 113.0, 113.0, 112.0, 121.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 113.0, 127.0, 162.0, 108.0, 128.0, 128.0, 107.0, 160.0, 108.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 188.0, 186.0, 183.0, 184.0, 183.0, 181.0, 184.0, 182.0, 182.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 72.0, 80.0, 151.0, 58.0, 57.0, 57.0, 67.0, 137.0, 57.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 137.0, 70.0, 71.0, 74.0, 121.0, 72.0, 92.0, 151.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 85.0, 88.0, 84.0, 88.0, 85.0, 88.0, 84.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 94.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0], "value": 93.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 118.0, 137.0, 113.0, 85.0, 85.0, 82.0, 84.0, 85.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 53.0, 54.0, 55.0, 54.0, 55.0, 53.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 102.0, 108.0, 95.0, 72.0, 71.0, 69.0, 68.0, 73.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 106.0, 88.0, 86.0, 88.0, 88.0, 88.0, 91.0, 91.0, 91.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 131.0, 135.0, 147.0, 138.0, 135.0, 138.0, 139.0, 205.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 170.0, 166.0, 227.0, 222.0, 168.0, 170.0, 167.0, 167.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 85.0, 85.0, 84.0, 72.0, 66.0, 67.0, 66.0, 66.0], "value": 73.2, "unit": "score"}], "name": "kraken", "value": 1501.3999999999999, "alertThreshold": 2.0}]} 10:57:25 INFO - Return code: 0 10:57:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:57:25 INFO - # TBPL SUCCESS # 10:57:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:57:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:57:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:57:25 INFO - 2016-08-23 10:57:25.100 screenresolution[1658:9573] starting screenresolution argv=screenresolution get 10:57:25 INFO - 2016-08-23 10:57:25.102 screenresolution[1658:9573] Display 0: 1600x1200x32@60 10:57:25 INFO - 2016-08-23 10:57:25.108 screenresolution[1659:9576] starting screenresolution argv=screenresolution list 10:57:25 INFO - Available Modes on Display 0 10:57:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:57:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:57:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:57:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:57:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:57:25 INFO - Intel Iris: 10:57:25 INFO - Chipset Model: Intel Iris 10:57:25 INFO - Type: GPU 10:57:25 INFO - Bus: Built-In 10:57:25 INFO - VRAM (Dynamic, Max): 1536 MB 10:57:25 INFO - Vendor: Intel (0x8086) 10:57:25 INFO - Device ID: 0x0a2e 10:57:25 INFO - Revision ID: 0x0009 10:57:25 INFO - Displays: 10:57:25 INFO - Display: 10:57:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:57:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:57:25 INFO - Display Serial Number: 1600x1200 60 10:57:25 INFO - Main Display: Yes 10:57:25 INFO - Mirror: Off 10:57:25 INFO - Online: Yes 10:57:25 INFO - Rotation: Supported 10:57:25 INFO - Return code: 0 10:57:25 INFO - Running post-action listener: _resource_record_post_action 10:57:25 INFO - [mozharness: 2016-08-23 17:57:25.343188Z] Finished run-tests step (success) 10:57:25 INFO - Running post-run listener: _resource_record_post_run 10:57:25 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 38134784; Write bytes: 701560320; Read time: 398; Write time: 2169 10:57:25 INFO - TinderboxPrint: CPU usage
53.5% 10:57:25 INFO - TinderboxPrint: I/O read bytes / time
38,134,784 / 398 10:57:25 INFO - TinderboxPrint: I/O write bytes / time
701,560,320 / 2,169 10:57:25 INFO - TinderboxPrint: CPU idle
2,253.8 (46.5%) 10:57:25 INFO - TinderboxPrint: CPU system
966.9 (19.9%) 10:57:25 INFO - TinderboxPrint: CPU user
1,628.9 (33.6%) 10:57:25 INFO - TinderboxPrint: Swap in / out
443,396,096 / 0 10:57:25 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 393105920; Write bytes: 386950656; Read time: 29674; Write time: 749 10:57:25 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 36959232; Write bytes: 293298176; Read time: 372; Write time: 1371 10:57:25 INFO - Running post-run listener: _upload_blobber_files 10:57:25 INFO - Blob upload gear active. 10:57:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:57:25 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 10:57:25 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'] 10:57:25 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 10:57:26 INFO - (blobuploader) - INFO - Open directory for files ... 10:57:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:57:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:57:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:27 INFO - (blobuploader) - INFO - Done attempting. 10:57:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:57:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:57:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:28 INFO - (blobuploader) - INFO - Done attempting. 10:57:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:57:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:57:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:30 INFO - (blobuploader) - INFO - Done attempting. 10:57:30 INFO - (blobuploader) - INFO - Iteration through files over. 10:57:30 INFO - Return code: 0 10:57:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:57:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:57:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99c70a1a229a1c7c8c8973f5049d68092a9cbdc2be83ba153c913a820da97ee3130d1079033caf67cf4a0a86d90695e02983b085cbed7c48d19177951433fc3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99a9e69271460922c39515ce3f7d6fe8019b1d769ff1bb13fb18637d0582040a39e2545aede2a1d38ed730f91c3482b3e1f8c6f379668caebdc45aa424197bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d9d1d73819e671cc82ca0c4db734e266da3590c4e7b989625b6817b1c844118112a18774f21b19bd5c697598b9075e03d6264792a2c86507c3b01d09452678e"} 10:57:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:57:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:57:30 INFO - Contents: 10:57:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99c70a1a229a1c7c8c8973f5049d68092a9cbdc2be83ba153c913a820da97ee3130d1079033caf67cf4a0a86d90695e02983b085cbed7c48d19177951433fc3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99a9e69271460922c39515ce3f7d6fe8019b1d769ff1bb13fb18637d0582040a39e2545aede2a1d38ed730f91c3482b3e1f8c6f379668caebdc45aa424197bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d9d1d73819e671cc82ca0c4db734e266da3590c4e7b989625b6817b1c844118112a18774f21b19bd5c697598b9075e03d6264792a2c86507c3b01d09452678e"} 10:57:30 INFO - Running post-run listener: copy_logs_to_upload_dir 10:57:30 INFO - Copying logs to upload dir... 10:57:30 INFO - mkdir: /builds/slave/test/build/upload/logs 10:57:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.191439 ========= master_lag: 2.79 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-08-23 10:57:33.465852) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-08-23 10:57:33.469781) ========= 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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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/99c70a1a229a1c7c8c8973f5049d68092a9cbdc2be83ba153c913a820da97ee3130d1079033caf67cf4a0a86d90695e02983b085cbed7c48d19177951433fc3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99a9e69271460922c39515ce3f7d6fe8019b1d769ff1bb13fb18637d0582040a39e2545aede2a1d38ed730f91c3482b3e1f8c6f379668caebdc45aa424197bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d9d1d73819e671cc82ca0c4db734e266da3590c4e7b989625b6817b1c844118112a18774f21b19bd5c697598b9075e03d6264792a2c86507c3b01d09452678e"} build_url:https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011026 build_url: 'https://queue.taskcluster.net/v1/task/ciy2_amzQTyYvGSZQbzLXQ/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/99c70a1a229a1c7c8c8973f5049d68092a9cbdc2be83ba153c913a820da97ee3130d1079033caf67cf4a0a86d90695e02983b085cbed7c48d19177951433fc3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99a9e69271460922c39515ce3f7d6fe8019b1d769ff1bb13fb18637d0582040a39e2545aede2a1d38ed730f91c3482b3e1f8c6f379668caebdc45aa424197bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d9d1d73819e671cc82ca0c4db734e266da3590c4e7b989625b6817b1c844118112a18774f21b19bd5c697598b9075e03d6264792a2c86507c3b01d09452678e"}' ========= master_lag: 1.63 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-08-23 10:57:35.108090) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 10:57:35.108397) ========= 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.ssBO6QHNuX/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.PuqKLOYr3e/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.005026 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 10:57:35.135306) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 10:57:35.135610) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 10:57:35.136783) ========= ========= Total master_lag: 4.51 =========