builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0241 starttime: 1470402642.55 results: success (0) buildid: 20160805030823 builduid: 00c37a42008c4868a8c214e282d1dab7 revision: 2c234f5a191673f6a4b0490435851e61852a54e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 06:10:42.546408) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 06:10:42.546845) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 06:10:42.547137) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 06:10:42.572442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 06:10:42.572833) ========= 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.03V9UO5uhp/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.CDjJ680tlD/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-05 06:10:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.7M=0.001s 2016-08-05 06:10:42 (18.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123554 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 06:10:42.719971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 06:10:42.720433) ========= 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.03V9UO5uhp/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.CDjJ680tlD/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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.025326 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 06:10:42.770071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 06:10:42.770424) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2c234f5a191673f6a4b0490435851e61852a54e8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2c234f5a191673f6a4b0490435851e61852a54e8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.03V9UO5uhp/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.CDjJ680tlD/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-05 06:10:42,853 truncating revision to first 12 chars 2016-08-05 06:10:42,853 Setting DEBUG logging. 2016-08-05 06:10:42,853 attempt 1/10 2016-08-05 06:10:42,853 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2c234f5a1916?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 06:10:43,535 unpacking tar archive at: fx-team-2c234f5a1916/testing/mozharness/ program finished with exit code 0 elapsedTime=0.971918 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 06:10:43.764483) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 06:10:43.764827) ========= script_repo_revision: 2c234f5a191673f6a4b0490435851e61852a54e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 06:10:43.765243) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 06:10:43.765511) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 06:10:43.785076) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-05 06:10:43.785484) ========= /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.03V9UO5uhp/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.CDjJ680tlD/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:10:43 INFO - MultiFileLogger online at 20160805 06:10:43 in /builds/slave/test 06:10:43 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 06:10:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:10:43 INFO - {'append_to_log': False, 06:10:43 INFO - 'base_work_dir': '/builds/slave/test', 06:10:43 INFO - 'blob_upload_branch': 'Fx-Team', 06:10:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:10:43 INFO - 'branch': 'Fx-Team', 06:10:43 INFO - 'buildbot_json_path': 'buildprops.json', 06:10:43 INFO - 'config_files': ('talos/mac_config.py',), 06:10:43 INFO - 'default_actions': ('clobber', 06:10:43 INFO - 'read-buildbot-config', 06:10:43 INFO - 'download-and-extract', 06:10:43 INFO - 'populate-webroot', 06:10:43 INFO - 'create-virtualenv', 06:10:43 INFO - 'install', 06:10:43 INFO - 'run-tests'), 06:10:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:10:43 INFO - 'download_minidump_stackwalk': True, 06:10:43 INFO - 'download_symbols': 'ondemand', 06:10:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:10:43 INFO - 'tooltool.py': '/tools/tooltool.py', 06:10:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:10:43 INFO - '/tools/misc-python/virtualenv.py')}, 06:10:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:10:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:10:43 INFO - 'installer_path': 'installer.exe', 06:10:43 INFO - 'log_level': 'info', 06:10:43 INFO - 'log_name': 'talos', 06:10:43 INFO - 'log_to_console': True, 06:10:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:10:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:10:43 INFO - 'opt_config_files': (), 06:10:43 INFO - 'pip_index': False, 06:10:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:10:43 INFO - 'cmd': ('bash', 06:10:43 INFO - '-c', 06:10:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:10:43 INFO - 'enabled': True, 06:10:43 INFO - 'halt_on_failure': False, 06:10:43 INFO - 'name': 'check_screen_resolution'},), 06:10:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:10:43 INFO - 'cmd': ('bash', 06:10:43 INFO - '-c', 06:10:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:10:43 INFO - 'enabled': True, 06:10:43 INFO - 'halt_on_failure': False, 06:10:43 INFO - 'name': 'check_screen_resolution'},), 06:10:43 INFO - 'run_cmd_checks_enabled': True, 06:10:43 INFO - 'sps_profile': False, 06:10:43 INFO - 'sps_profile_interval': 0, 06:10:43 INFO - 'suite': 'dromaeojs', 06:10:43 INFO - 'system_bits': '32', 06:10:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:10:43 INFO - 'title': 't-yosemite-r7-0241', 06:10:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:10:43 INFO - 'use_talos_json': True, 06:10:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:10:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:10:43 INFO - 'work_dir': 'build'} 06:10:44 INFO - [mozharness: 2016-08-05 13:10:44.000099Z] Running clobber step. 06:10:44 INFO - Running pre-action listener: _resource_record_pre_action 06:10:44 INFO - Running main action method: clobber 06:10:44 INFO - rmtree: /builds/slave/test/build 06:10:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:10:46 INFO - Running post-action listener: _resource_record_post_action 06:10:46 INFO - [mozharness: 2016-08-05 13:10:46.135855Z] Finished clobber step (success) 06:10:46 INFO - [mozharness: 2016-08-05 13:10:46.136027Z] Running read-buildbot-config step. 06:10:46 INFO - Running pre-action listener: _resource_record_pre_action 06:10:46 INFO - Running main action method: read_buildbot_config 06:10:46 INFO - Using buildbot properties: 06:10:46 INFO - { 06:10:46 INFO - "project": "", 06:10:46 INFO - "product": "firefox", 06:10:46 INFO - "script_repo_revision": "production", 06:10:46 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:10:46 INFO - "repository": "", 06:10:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:10:46 INFO - "buildid": "20160805030823", 06:10:46 INFO - "pgo_build": "False", 06:10:46 INFO - "basedir": "/builds/slave/test", 06:10:46 INFO - "buildnumber": 125, 06:10:46 INFO - "slavename": "t-yosemite-r7-0241", 06:10:46 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 06:10:46 INFO - "platform": "yosemite_r7", 06:10:46 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 06:10:46 INFO - "branch": "fx-team", 06:10:46 INFO - "repo_path": "integration/fx-team", 06:10:46 INFO - "revision": "2c234f5a191673f6a4b0490435851e61852a54e8", 06:10:46 INFO - "stage_platform": "macosx64", 06:10:46 INFO - "builduid": "00c37a42008c4868a8c214e282d1dab7", 06:10:46 INFO - "slavebuilddir": "test" 06:10:46 INFO - } 06:10:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 06:10:46 INFO - Running post-action listener: _resource_record_post_action 06:10:46 INFO - [mozharness: 2016-08-05 13:10:46.139240Z] Finished read-buildbot-config step (success) 06:10:46 INFO - [mozharness: 2016-08-05 13:10:46.139352Z] Running download-and-extract step. 06:10:46 INFO - Running pre-action listener: _resource_record_pre_action 06:10:46 INFO - Running main action method: download_and_extract 06:10:46 INFO - mkdir: /builds/slave/test/build/tests 06:10: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')]} 06:10:46 INFO - trying https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 06:10:46 INFO - Downloading https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 06:10:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 06:10:47 INFO - Downloaded 1199 bytes. 06:10:47 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 06:10:47 INFO - Using the following test package requirements: 06:10:47 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 06:10:47 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:10:47 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 06:10:47 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:10:47 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 06:10:47 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:10:47 INFO - u'jsshell-mac.zip'], 06:10:47 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:10:47 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 06:10:47 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 06:10:47 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:10:47 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 06:10:47 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:10:47 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 06:10:47 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:10:47 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 06:10:47 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:10:47 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 06:10:47 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:47 INFO - trying https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:10:47 INFO - Downloading https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:10:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:10:48 INFO - Downloaded 16320543 bytes. 06:10:48 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 06:10:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:10: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')]} 06:10:55 INFO - trying https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:10:55 INFO - Downloading https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:10:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:10:56 INFO - Downloaded 16320543 bytes. 06:10:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 06:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:02 INFO - trying https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 06:11:02 INFO - Downloading https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 06:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:11:04 INFO - Downloaded 14413723 bytes. 06:11:04 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 06:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:04 INFO - trying https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:11:04 INFO - Downloading https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 06:11:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 06:11:07 INFO - Downloaded 111464649 bytes. 06:11:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:11:07 INFO - mkdir: /builds/slave/test/properties 06:11:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:11:07 INFO - Writing to file /builds/slave/test/properties/build_url 06:11:07 INFO - Contents: 06:11:07 INFO - build_url:https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:11:07 INFO - Running post-action listener: _resource_record_post_action 06:11:07 INFO - Running post-action listener: set_extra_try_arguments 06:11:07 INFO - [mozharness: 2016-08-05 13:11:07.996042Z] Finished download-and-extract step (success) 06:11:07 INFO - [mozharness: 2016-08-05 13:11:07.996177Z] Running populate-webroot step. 06:11:07 INFO - Running pre-action listener: _resource_record_pre_action 06:11:07 INFO - Running main action method: populate_webroot 06:11:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:11:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:11:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:11:08 INFO - '--tppagecycles', 06:11:08 INFO - '7'], 06:11:08 INFO - 'tests': ['tsvgm']}}, 06:11:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:11:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:11:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:11:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:11:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:11:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:11:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:08 INFO - 'talos_options': ['--disable-e10s'], 06:11:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:11:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:11:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:08 INFO - 'talos_options': ['--disable-e10s'], 06:11:08 INFO - 'tests': ['damp', 'tps']}, 06:11:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:08 INFO - 'tests': ['damp', 'tps']}, 06:11:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:11:08 INFO - 'tests': ['dromaeo_dom']}, 06:11:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:11:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:11:08 INFO - 'tests': ['basic_compositor_video']}, 06:11:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:11:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:11:08 INFO - 'tests': ['a11yr', 06:11:08 INFO - 'ts_paint', 06:11:08 INFO - 'tpaint', 06:11:08 INFO - 'sessionrestore', 06:11:08 INFO - 'sessionrestore_no_auto_restore', 06:11:08 INFO - 'tabpaint']}, 06:11:08 INFO - 'other-e10s': {'tests': ['a11yr', 06:11:08 INFO - 'ts_paint', 06:11:08 INFO - 'tpaint', 06:11:08 INFO - 'sessionrestore', 06:11:08 INFO - 'sessionrestore_no_auto_restore', 06:11:08 INFO - 'tabpaint']}, 06:11:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:11:08 INFO - 'ts_paint', 06:11:08 INFO - 'tpaint', 06:11:08 INFO - 'sessionrestore', 06:11:08 INFO - 'sessionrestore_no_auto_restore', 06:11:08 INFO - 'tabpaint']}, 06:11:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:11:08 INFO - 'ts_paint', 06:11:08 INFO - 'tpaint', 06:11:08 INFO - 'sessionrestore', 06:11:08 INFO - 'sessionrestore_no_auto_restore', 06:11:08 INFO - 'tabpaint']}, 06:11:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:11:08 INFO - 'tests': ['a11yr', 06:11:08 INFO - 'ts_paint', 06:11:08 INFO - 'tpaint', 06:11:08 INFO - 'sessionrestore', 06:11:08 INFO - 'sessionrestore_no_auto_restore', 06:11:08 INFO - 'tabpaint']}, 06:11:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:11:08 INFO - 'tests': ['a11yr', 06:11:08 INFO - 'ts_paint', 06:11:08 INFO - 'tpaint', 06:11:08 INFO - 'sessionrestore', 06:11:08 INFO - 'sessionrestore_no_auto_restore', 06:11:08 INFO - 'tabpaint']}, 06:11:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:11:08 INFO - 'tests': ['tsvgx', 06:11:08 INFO - 'tsvgr_opacity', 06:11:08 INFO - 'tart', 06:11:08 INFO - 'tscrollx', 06:11:08 INFO - 'cart']}, 06:11:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:11:08 INFO - 'tsvgr_opacity', 06:11:08 INFO - 'tart', 06:11:08 INFO - 'tscrollx', 06:11:08 INFO - 'cart']}, 06:11:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:08 INFO - 'talos_options': ['--disable-e10s'], 06:11:08 INFO - 'tests': ['tp5o']}, 06:11:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:08 INFO - 'tests': ['tp5o']}, 06:11:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:08 INFO - 'talos_options': ['--disable-e10s', 06:11:08 INFO - '--xperf_path', 06:11:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:11:08 INFO - 'tests': ['tp5n']}, 06:11:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:08 INFO - 'talos_options': ['--xperf_path', 06:11:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:11:08 INFO - 'tests': ['tp5n']}}, 06:11:08 INFO - 'talos.zip': {'path': '', 06:11:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:11:08 INFO - Running post-action listener: _resource_record_post_action 06:11:08 INFO - [mozharness: 2016-08-05 13:11:08.014986Z] Finished populate-webroot step (success) 06:11:08 INFO - [mozharness: 2016-08-05 13:11:08.015133Z] Running create-virtualenv step. 06:11:08 INFO - Running pre-action listener: _resource_record_pre_action 06:11:08 INFO - Running main action method: create_virtualenv 06:11:08 INFO - Creating virtualenv /builds/slave/test/build/venv 06:11:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:11:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:11:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:11:08 INFO - Using real prefix '/tools/python27' 06:11:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:11:08 INFO - Installing distribute.............................................................................................................................................................................................done. 06:11:11 INFO - Installing pip.................done. 06:11:11 INFO - Return code: 0 06:11:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:11: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')]} 06:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11: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')]} 06:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e24a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4bc98a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e119d30>, '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 0x10de7edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e111b20>, '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.03V9UO5uhp/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.CDjJ680tlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:11:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:11:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03V9UO5uhp/Render', 06:11:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:11 INFO - 'HOME': '/Users/cltbld', 06:11:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:11 INFO - 'LOGNAME': 'cltbld', 06:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:11 INFO - 'MOZ_NO_REMOTE': '1', 06:11:11 INFO - 'NO_EM_RESTART': '1', 06:11:11 INFO - 'PAGER': '/bin/cat', 06:11:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:11 INFO - 'PWD': '/builds/slave/test', 06:11:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:11 INFO - 'SHELL': '/bin/bash', 06:11:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDjJ680tlD/Listeners', 06:11:11 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 06:11:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:11 INFO - 'USER': 'cltbld', 06:11:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:11 INFO - 'XPC_FLAGS': '0x0', 06:11:11 INFO - 'XPC_SERVICE_NAME': '0', 06:11:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:11:12 INFO - Cleaning up... 06:11:12 INFO - Return code: 0 06:11:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:12 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 0x10e1b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e24a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4bc98a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e119d30>, '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 0x10de7edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e111b20>, '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.03V9UO5uhp/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.CDjJ680tlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:11:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03V9UO5uhp/Render', 06:11:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:12 INFO - 'HOME': '/Users/cltbld', 06:11:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:12 INFO - 'LOGNAME': 'cltbld', 06:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:12 INFO - 'MOZ_NO_REMOTE': '1', 06:11:12 INFO - 'NO_EM_RESTART': '1', 06:11:12 INFO - 'PAGER': '/bin/cat', 06:11:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:12 INFO - 'PWD': '/builds/slave/test', 06:11:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:12 INFO - 'SHELL': '/bin/bash', 06:11:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDjJ680tlD/Listeners', 06:11:12 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 06:11:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:12 INFO - 'USER': 'cltbld', 06:11:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:12 INFO - 'XPC_FLAGS': '0x0', 06:11:12 INFO - 'XPC_SERVICE_NAME': '0', 06:11:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:12 INFO - Downloading/unpacking psutil>=3.1.1 06:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:11:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:11:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:11:14 INFO - Installing collected packages: psutil 06:11:14 INFO - Running setup.py install for psutil 06:11:14 INFO - building 'psutil._psutil_osx' extension 06:11:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:11:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:11:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:11:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:11:15 INFO - building 'psutil._psutil_posix' extension 06:11:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:11:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:11:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:11:15 INFO - ^ 06:11:15 INFO - 1 warning generated. 06:11:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:11:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:11:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:11:15 INFO - Successfully installed psutil 06:11:15 INFO - Cleaning up... 06:11:16 INFO - Return code: 0 06:11:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:11: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')]} 06:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11: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')]} 06:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e24a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4bc98a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e119d30>, '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 0x10de7edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e111b20>, '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.03V9UO5uhp/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.CDjJ680tlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:11:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:11:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:11:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03V9UO5uhp/Render', 06:11:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:16 INFO - 'HOME': '/Users/cltbld', 06:11:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:16 INFO - 'LOGNAME': 'cltbld', 06:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:16 INFO - 'MOZ_NO_REMOTE': '1', 06:11:16 INFO - 'NO_EM_RESTART': '1', 06:11:16 INFO - 'PAGER': '/bin/cat', 06:11:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:16 INFO - 'PWD': '/builds/slave/test', 06:11:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:16 INFO - 'SHELL': '/bin/bash', 06:11:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDjJ680tlD/Listeners', 06:11:16 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 06:11:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:16 INFO - 'USER': 'cltbld', 06:11:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:16 INFO - 'XPC_FLAGS': '0x0', 06:11:16 INFO - 'XPC_SERVICE_NAME': '0', 06:11:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:11:18 INFO - Installing collected packages: mozsystemmonitor 06:11:18 INFO - Running setup.py install for mozsystemmonitor 06:11:18 INFO - Successfully installed mozsystemmonitor 06:11:18 INFO - Cleaning up... 06:11:19 INFO - Return code: 0 06:11:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e24a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4bc98a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e119d30>, '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 0x10de7edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e111b20>, '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.03V9UO5uhp/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.CDjJ680tlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:11:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:11:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03V9UO5uhp/Render', 06:11:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:19 INFO - 'HOME': '/Users/cltbld', 06:11:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:19 INFO - 'LOGNAME': 'cltbld', 06:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:19 INFO - 'MOZ_NO_REMOTE': '1', 06:11:19 INFO - 'NO_EM_RESTART': '1', 06:11:19 INFO - 'PAGER': '/bin/cat', 06:11:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:19 INFO - 'PWD': '/builds/slave/test', 06:11:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:19 INFO - 'SHELL': '/bin/bash', 06:11:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDjJ680tlD/Listeners', 06:11:19 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 06:11:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:19 INFO - 'USER': 'cltbld', 06:11:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:19 INFO - 'XPC_FLAGS': '0x0', 06:11:19 INFO - 'XPC_SERVICE_NAME': '0', 06:11:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:19 INFO - Downloading/unpacking jsonschema==2.5.1 06:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:11:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:22 INFO - Downloading functools32-3.2.3-2.tar.gz 06:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:11:22 INFO - warning: no files found matching '*.txt' 06:11:22 INFO - no previously-included directories found matching 'build' 06:11:22 INFO - no previously-included directories found matching 'dist' 06:11:22 INFO - no previously-included directories found matching '.git*' 06:11:22 INFO - Installing collected packages: jsonschema, functools32 06:11:22 INFO - Running setup.py install for functools32 06:11:22 INFO - warning: no files found matching '*.txt' 06:11:22 INFO - no previously-included directories found matching 'build' 06:11:22 INFO - no previously-included directories found matching 'dist' 06:11:22 INFO - no previously-included directories found matching '.git*' 06:11:22 INFO - Successfully installed jsonschema functools32 06:11:22 INFO - Cleaning up... 06:11:22 INFO - Return code: 0 06:11:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e24a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4bc98a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e119d30>, '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 0x10de7edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e111b20>, '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.03V9UO5uhp/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.CDjJ680tlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:11:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:11:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03V9UO5uhp/Render', 06:11:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:22 INFO - 'HOME': '/Users/cltbld', 06:11:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:22 INFO - 'LOGNAME': 'cltbld', 06:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:22 INFO - 'MOZ_NO_REMOTE': '1', 06:11:22 INFO - 'NO_EM_RESTART': '1', 06:11:22 INFO - 'PAGER': '/bin/cat', 06:11:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:22 INFO - 'PWD': '/builds/slave/test', 06:11:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:22 INFO - 'SHELL': '/bin/bash', 06:11:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDjJ680tlD/Listeners', 06:11:22 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 06:11:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:22 INFO - 'USER': 'cltbld', 06:11:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:22 INFO - 'XPC_FLAGS': '0x0', 06:11:22 INFO - 'XPC_SERVICE_NAME': '0', 06:11:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:11:22 INFO - Cleaning up... 06:11:22 INFO - Return code: 0 06:11:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e24a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4bc98a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e119d30>, '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 0x10de7edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e111b20>, '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.03V9UO5uhp/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.CDjJ680tlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:11:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:11:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03V9UO5uhp/Render', 06:11:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:22 INFO - 'HOME': '/Users/cltbld', 06:11:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:22 INFO - 'LOGNAME': 'cltbld', 06:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:22 INFO - 'MOZ_NO_REMOTE': '1', 06:11:22 INFO - 'NO_EM_RESTART': '1', 06:11:22 INFO - 'PAGER': '/bin/cat', 06:11:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:22 INFO - 'PWD': '/builds/slave/test', 06:11:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:22 INFO - 'SHELL': '/bin/bash', 06:11:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDjJ680tlD/Listeners', 06:11:22 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 06:11:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:22 INFO - 'USER': 'cltbld', 06:11:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:22 INFO - 'XPC_FLAGS': '0x0', 06:11:22 INFO - 'XPC_SERVICE_NAME': '0', 06:11:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:23 INFO - Downloading/unpacking blobuploader==1.2.4 06:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:25 INFO - Downloading blobuploader-1.2.4.tar.gz 06:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:11:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:11:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:26 INFO - Downloading docopt-0.6.1.tar.gz 06:11:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:11:26 INFO - Installing collected packages: blobuploader, requests, docopt 06:11:26 INFO - Running setup.py install for blobuploader 06:11:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:11:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:11:26 INFO - Running setup.py install for requests 06:11:27 INFO - Running setup.py install for docopt 06:11:27 INFO - Successfully installed blobuploader requests docopt 06:11:27 INFO - Cleaning up... 06:11:27 INFO - Return code: 0 06:11:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e24a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4bc98a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e119d30>, '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 0x10de7edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e111b20>, '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.03V9UO5uhp/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.CDjJ680tlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:11:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:11:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03V9UO5uhp/Render', 06:11:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:27 INFO - 'HOME': '/Users/cltbld', 06:11:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:27 INFO - 'LOGNAME': 'cltbld', 06:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:27 INFO - 'MOZ_NO_REMOTE': '1', 06:11:27 INFO - 'NO_EM_RESTART': '1', 06:11:27 INFO - 'PAGER': '/bin/cat', 06:11:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:27 INFO - 'PWD': '/builds/slave/test', 06:11:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:27 INFO - 'SHELL': '/bin/bash', 06:11:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDjJ680tlD/Listeners', 06:11:27 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 06:11:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:27 INFO - 'USER': 'cltbld', 06:11:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:27 INFO - 'XPC_FLAGS': '0x0', 06:11:27 INFO - 'XPC_SERVICE_NAME': '0', 06:11:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:11:27 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-OdkTfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:11:28 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-lv6lCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:11:28 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-OQqg6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:11:28 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Yy1Zig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:11:28 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-58ZbP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:11:28 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-JgUFlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:11:28 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-jojfHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:11:28 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-1PfxLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:11:28 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Vj4axy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:11:28 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-jjAaAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:11:29 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-B_V46b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:11:29 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-ROb7mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:11:29 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-eolO4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:11:29 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-xOSyz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:29 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-G_bCHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:11:29 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-UowIds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:11:29 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-n7RbeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:11:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:11:29 INFO - Running setup.py install for manifestparser 06:11:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:11:29 INFO - Running setup.py install for mozcrash 06:11:30 INFO - Running setup.py install for mozdebug 06:11:30 INFO - Running setup.py install for mozdevice 06:11:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:11:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:11:30 INFO - Running setup.py install for mozfile 06:11:30 INFO - Running setup.py install for mozhttpd 06:11:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:11:30 INFO - Running setup.py install for mozinfo 06:11:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:11:30 INFO - Running setup.py install for mozInstall 06:11:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:11:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:11:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:11:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:11:30 INFO - Running setup.py install for mozleak 06:11:31 INFO - Running setup.py install for mozlog 06:11:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:11:31 INFO - Running setup.py install for moznetwork 06:11:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:11:31 INFO - Running setup.py install for mozprocess 06:11:31 INFO - Running setup.py install for mozprofile 06:11:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:11:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:11:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:11:31 INFO - Running setup.py install for mozrunner 06:11:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:11:31 INFO - Running setup.py install for mozscreenshot 06:11:32 INFO - Running setup.py install for moztest 06:11:32 INFO - Running setup.py install for mozversion 06:11:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:11:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:11:32 INFO - Cleaning up... 06:11:32 INFO - Return code: 0 06:11:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:11: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')]} 06:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11: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')]} 06:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e24a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4bc98a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e119d30>, '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 0x10de7edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e111b20>, '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.03V9UO5uhp/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.CDjJ680tlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:11:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:11:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03V9UO5uhp/Render', 06:11:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:32 INFO - 'HOME': '/Users/cltbld', 06:11:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:32 INFO - 'LOGNAME': 'cltbld', 06:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:32 INFO - 'MOZ_NO_REMOTE': '1', 06:11:32 INFO - 'NO_EM_RESTART': '1', 06:11:32 INFO - 'PAGER': '/bin/cat', 06:11:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:32 INFO - 'PWD': '/builds/slave/test', 06:11:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:32 INFO - 'SHELL': '/bin/bash', 06:11:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDjJ680tlD/Listeners', 06:11:32 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 06:11:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:32 INFO - 'USER': 'cltbld', 06:11:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:32 INFO - 'XPC_FLAGS': '0x0', 06:11:32 INFO - 'XPC_SERVICE_NAME': '0', 06:11:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:11:32 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-LwIL1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:11:32 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-LwD1P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:11:32 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-pA5qor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:11:32 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-odunMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:11:33 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-uiUKI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:11:33 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-a1DbVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:11:33 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-v1WDun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:11:33 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-r1DzYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:11:33 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-OUwxRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:11:33 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-WAeAu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:11:33 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-PkaMgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:11:33 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Qf4iZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:11:33 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-z8fu1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:11:34 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-YBAzkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:34 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-N9jqCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:11:34 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-4pjFaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:11:34 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-4lqth5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:11:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:36 INFO - Downloading blessings-1.6.tar.gz 06:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:11:37 INFO - Installing collected packages: blessings 06:11:37 INFO - Running setup.py install for blessings 06:11:37 INFO - Successfully installed blessings 06:11:37 INFO - Cleaning up... 06:11:37 INFO - Return code: 0 06:11:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:11:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:11:37 INFO - Reading from file tmpfile_stdout 06:11:37 INFO - Current package versions: 06:11:37 INFO - blessings == 1.6 06:11:37 INFO - blobuploader == 1.2.4 06:11:37 INFO - docopt == 0.6.1 06:11:37 INFO - functools32 == 3.2.3-2 06:11:37 INFO - jsonschema == 2.5.1 06:11:37 INFO - manifestparser == 1.1 06:11:37 INFO - mozInstall == 1.12 06:11:37 INFO - mozcrash == 0.17 06:11:37 INFO - mozdebug == 0.1 06:11:37 INFO - mozdevice == 0.48 06:11:37 INFO - mozfile == 1.2 06:11:37 INFO - mozhttpd == 0.7 06:11:37 INFO - mozinfo == 0.9 06:11:37 INFO - mozleak == 0.1 06:11:37 INFO - mozlog == 3.3 06:11:37 INFO - moznetwork == 0.27 06:11:37 INFO - mozprocess == 0.23 06:11:37 INFO - mozprofile == 0.28 06:11:37 INFO - mozrunner == 6.12 06:11:37 INFO - mozscreenshot == 0.1 06:11:37 INFO - mozsystemmonitor == 0.3 06:11:37 INFO - moztest == 0.7 06:11:37 INFO - mozversion == 1.4 06:11:37 INFO - psutil == 3.1.1 06:11:37 INFO - requests == 1.2.3 06:11:37 INFO - wsgiref == 0.1.2 06:11:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e24a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4bc98a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e119d30>, '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 0x10de7edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e111b20>, '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.03V9UO5uhp/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.CDjJ680tlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:11:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:11:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03V9UO5uhp/Render', 06:11:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:37 INFO - 'HOME': '/Users/cltbld', 06:11:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:37 INFO - 'LOGNAME': 'cltbld', 06:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:37 INFO - 'MOZ_NO_REMOTE': '1', 06:11:37 INFO - 'NO_EM_RESTART': '1', 06:11:37 INFO - 'PAGER': '/bin/cat', 06:11:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:37 INFO - 'PWD': '/builds/slave/test', 06:11:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:37 INFO - 'SHELL': '/bin/bash', 06:11:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDjJ680tlD/Listeners', 06:11:37 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 06:11:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:37 INFO - 'USER': 'cltbld', 06:11:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:37 INFO - 'XPC_FLAGS': '0x0', 06:11:37 INFO - 'XPC_SERVICE_NAME': '0', 06:11:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:11:37 INFO - Cleaning up... 06:11:37 INFO - Return code: 0 06:11:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e24a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4bc98a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e119d30>, '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 0x10de7edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e111b20>, '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.03V9UO5uhp/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.CDjJ680tlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:11:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:11:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03V9UO5uhp/Render', 06:11:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:37 INFO - 'HOME': '/Users/cltbld', 06:11:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:37 INFO - 'LOGNAME': 'cltbld', 06:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:37 INFO - 'MOZ_NO_REMOTE': '1', 06:11:37 INFO - 'NO_EM_RESTART': '1', 06:11:37 INFO - 'PAGER': '/bin/cat', 06:11:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:37 INFO - 'PWD': '/builds/slave/test', 06:11:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:37 INFO - 'SHELL': '/bin/bash', 06:11:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDjJ680tlD/Listeners', 06:11:37 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 06:11:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:37 INFO - 'USER': 'cltbld', 06:11:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:37 INFO - 'XPC_FLAGS': '0x0', 06:11:37 INFO - 'XPC_SERVICE_NAME': '0', 06:11:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:11:38 INFO - Cleaning up... 06:11:38 INFO - Return code: 0 06:11:38 INFO - Running post-action listener: _resource_record_post_action 06:11:38 INFO - Running post-action listener: _start_resource_monitoring 06:11:38 INFO - Starting resource monitoring. 06:11:38 INFO - [mozharness: 2016-08-05 13:11:38.117948Z] Finished create-virtualenv step (success) 06:11:38 INFO - [mozharness: 2016-08-05 13:11:38.118948Z] Running install step. 06:11:38 INFO - Running pre-action listener: _resource_record_pre_action 06:11:38 INFO - Running main action method: install 06:11:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:11:38 INFO - Reading from file tmpfile_stdout 06:11:38 INFO - Detecting whether we're running mozinstall >=1.0... 06:11:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:11:38 INFO - Reading from file tmpfile_stdout 06:11:38 INFO - Output received: 06:11:38 INFO - Usage: mozinstall [options] installer 06:11:38 INFO - Options: 06:11:38 INFO - -h, --help show this help message and exit 06:11:38 INFO - -d DEST, --destination=DEST 06:11:38 INFO - Directory to install application into. [default: 06:11:38 INFO - "/builds/slave/test"] 06:11:38 INFO - --app=APP Application being installed. [default: firefox] 06:11:38 INFO - mkdir: /builds/slave/test/build/application 06:11:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:12:12 INFO - Reading from file tmpfile_stdout 06:12:12 INFO - Output received: 06:12:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:12:12 INFO - Running post-action listener: _resource_record_post_action 06:12:12 INFO - [mozharness: 2016-08-05 13:12:12.425332Z] Finished install step (success) 06:12:12 INFO - [mozharness: 2016-08-05 13:12:12.425507Z] Running run-tests step. 06:12:12 INFO - Running pre-action listener: _resource_record_pre_action 06:12:12 INFO - Running main action method: run_tests 06:12:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:12:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:12:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:12:12 INFO - 2016-08-05 06:12:12.440 screenresolution[1638:7516] starting screenresolution argv=screenresolution get 06:12:12 INFO - 2016-08-05 06:12:12.442 screenresolution[1638:7516] Display 0: 1600x1200x32@60 06:12:12 INFO - 2016-08-05 06:12:12.448 screenresolution[1639:7518] starting screenresolution argv=screenresolution list 06:12:12 INFO - Available Modes on Display 0 06:12:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:12:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:12:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:12:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:12:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:12:12 INFO - Intel Iris: 06:12:12 INFO - Chipset Model: Intel Iris 06:12:12 INFO - Type: GPU 06:12:12 INFO - Bus: Built-In 06:12:12 INFO - VRAM (Dynamic, Max): 1536 MB 06:12:12 INFO - Vendor: Intel (0x8086) 06:12:12 INFO - Device ID: 0x0a2e 06:12:12 INFO - Revision ID: 0x0009 06:12:12 INFO - Displays: 06:12:12 INFO - Display: 06:12:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:12:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:12:12 INFO - Display Serial Number: 1600x1200 60 06:12:12 INFO - Main Display: Yes 06:12:12 INFO - Mirror: Off 06:12:12 INFO - Online: Yes 06:12:12 INFO - Rotation: Supported 06:12:12 INFO - Return code: 0 06:12:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:12:12 INFO - Python 2.7.3 06:12:12 INFO - Return code: 0 06:12:12 INFO - grabbing minidump binary from tooltool 06:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:12 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e119d30>, '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 0x10de7edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e111b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:12:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:12:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:12:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:12:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:12:12 INFO - Return code: 0 06:12:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:12:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:12:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:12:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:12:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:12:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0241', '--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 06:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0241 --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 06:12:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.03V9UO5uhp/Render', 06:12:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:12 INFO - 'HOME': '/Users/cltbld', 06:12:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:12 INFO - 'LOGNAME': 'cltbld', 06:12:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:12:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:12 INFO - 'MOZ_NO_REMOTE': '1', 06:12:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:12:12 INFO - 'NO_EM_RESTART': '1', 06:12:12 INFO - 'PAGER': '/bin/cat', 06:12:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:12 INFO - 'PWD': '/builds/slave/test', 06:12:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:12:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:12 INFO - 'SHELL': '/bin/bash', 06:12:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDjJ680tlD/Listeners', 06:12:12 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 06:12:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:12 INFO - 'USER': 'cltbld', 06:12:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:12 INFO - 'XPC_FLAGS': '0x0', 06:12:12 INFO - 'XPC_SERVICE_NAME': '0', 06:12:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0241', '--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 06:12:13 INFO - mozversion application_buildid: 20160805030823 06:12:13 INFO - mozversion application_changeset: 2c234f5a191673f6a4b0490435851e61852a54e8 06:12:13 INFO - mozversion application_display_name: Nightly 06:12:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:12:13 INFO - mozversion application_name: Firefox 06:12:13 INFO - mozversion application_remotingname: firefox 06:12:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:12:13 INFO - mozversion application_vendor: Mozilla 06:12:13 INFO - mozversion application_version: 51.0a1 06:12:13 INFO - mozversion platform_buildid: 20160805030823 06:12:13 INFO - mozversion platform_changeset: 2c234f5a191673f6a4b0490435851e61852a54e8 06:12:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:12:13 INFO - mozversion platform_version: 51.0a1 06:12:13 INFO - using testdate: 1470402733 06:12:13 INFO - actual date: 1470402733 06:12:13 INFO - starting webserver on 'localhost:49271' 06:12:13 INFO - SUITE-START | Running 2 tests 06:12:13 INFO - TEST-START | dromaeo_css 06:12:13 INFO - operating with platform_type : mac_ 06:12:13 INFO - Initialising browser for dromaeo_css test... 06:12:13 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpcd3Z59/profile http://localhost:49271/getInfo.html) 06:12:15 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 06:12:15 INFO - PROCESS | 1649 | colorDepth:24 06:12:15 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 06:12:15 INFO - PROCESS | 1649 | __metrics 06:12:15 INFO - PROCESS | 1649 | 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" 06:12:15 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:12:16 INFO - TEST-INFO | 1649: exit 0 06:12:16 INFO - Browser initialized. 06:12:16 INFO - Running cycle 1/1 for dromaeo_css test... 06:12:16 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpcd3Z59/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:28 INFO - PROCESS | 1651 | RSS: Main: 243220480 06:12:28 INFO - PROCESS | 1651 | 06:13:20 INFO - PROCESS | 1651 | 1470402800061 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:15:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 06:15:33 INFO - PROCESS | 1651 | RSS: Main: 362258432 06:15:33 INFO - PROCESS | 1651 | 06:18:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 06:18:37 INFO - PROCESS | 1651 | RSS: Main: 390479872 06:18:37 INFO - PROCESS | 1651 | 06:21:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 06:21:40 INFO - PROCESS | 1651 | RSS: Main: 359194624 06:21:40 INFO - PROCESS | 1651 | 06:24:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 06:24:43 INFO - PROCESS | 1651 | RSS: Main: 356143104 06:24:43 INFO - PROCESS | 1651 | 06:27:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 06:27:47 INFO - PROCESS | 1651 | RSS: Main: 352141312 06:27:47 INFO - PROCESS | 1651 | 06:30:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 06:30:50 INFO - PROCESS | 1651 | RSS: Main: 655806464 06:30:50 INFO - PROCESS | 1651 | 06:30:50 INFO - PROCESS | 1651 | __start_tp_report 06:30:50 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 06:30:50 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 06:30:50 INFO - PROCESS | 1651 | |i|pagename|runs| 06:30:50 INFO - PROCESS | 1651 | |0;dojo.html;3438.4154693702067;3442.759006869517;3456.1014136324548;3471.375152472557;3510.5085288059677;4894.143524883145;5606.691631960241;5738.254026976498;5893.292804863411;5955.225820643315;5901.203337549429;5915.704214789254;6046.304674962381;6049.848753781158;6084.604500707451;5227.869303267411;5314.495122963332;5333.386660534049;5339.946600534003;5380.24676545284;4506.278995360743;5427.755750991195;5447.564194864422;5450.018996580614;5481.917771233435;5240.947590524084;5313.282706834567;5327.866803329909;5370.140777475624;5390.245365648812;5339.733013349317;5345.385280692732;5360.383555891083;5365.3293338332705;5370;5266.578673706094;5304.36347638282;5316.362036555638;5332.146856502941;5355.036093503168;5815.621984571032;5867.647941123503;5868;5871.9412805871825;5874.295084589834;5427.647202931837;6234.064890266451;6275.623462592259;6298.149749783766;6305.432511074026;6143.569950103494;6244.687765611701;6252;6268.843278918018;6270.8118756436925;5919.3192782829665;6078.584854392223;6082.974913061355;6116.868379349835;6140.078988151813;5405.459454054641;6222.253329600387;6270.090836828635;6293.465055470245;6435.967820160869;6298.433141017239;6308.3060863305;6330.240371155399;6333.271673757485;6355.904661430082;6222.3466536013975;6314.9684251579365;6322.178116844872;6335.778247761306;6338.619682819046;6238.812835614848;6264.154339164245;6271.43557079865;6300.30696623371;6346.873062538723;6275.843103922439;6298.244210694655;6301.7164227609865;6308.148399965946;6310.400511951358;4987.102321582078;4989.351384320015;5061.772220250097;5074.162763144113;5115.769790359368;4544.318352247189;4581.931271030937;4581.991961768405;4594.058218065288;4647.790849411785;5858.970705146532;5924.496417804448;5936.8812623748145;5943.613665111754;5989.880202396015;6186.721597528032;6231.138734119068;6291.96854015727;6306.873862522724;6312.936870631327;5859;5907.586468947218;5944.583879128506;5958.314793798769;6003.6397816131175;5586.608937374426;5591.776328946878;5600.775968961196;5613.410591887793;5615.438456154434;5238.135707608202;6424.261209960728;6424.871502569922;6441.774537891151;6457.644829534421;6183.103449999815;6209.223847019122;6232.501399887908;6287.811365659038;6296.496280297657;6398.616083034846;6422.678866056585;6426.935730642821;6428.55000149985;6429.8714025720155;6146.309764814533;6287.748490060347;6296.968515157395;6309;6334.6199228044625;6187.288461826947;6202.844928876814;6234.314225435108;6258.9374106260175;6276.466500347522;6251.53113516479;6262.185915831095;6290.150829637941;6291.559590828598;6313.905291420724;6101.489633126442;6234.906476402948;6248.250209974651;6311.747530098928;6317.842053948688;6130.080487926846;6134.1610691366095;6150.876982460415;6212.81361559154;6215.502759779117;6263.718132683949;6272.466840318624;6278.089676996901;6294.276158241861;6306.842328941813;6024.87950240984;6182.227221597301;6209.316975132822;6210.937890621036;6211.254649442096 06:30:50 INFO - PROCESS | 1651 | |1;ext.html;433.50796845580265;537.8758394954544;538.6714104396317;541.9675518137949;549.714148642706;30132.99999999997;30935.38129237414;40084.398734019014;41292.79353603228;41313.58686413135;42830;43138.98027138101;43173.56826431735;43221.56778432215;43222;8278.337732981377;8913.420627659198;9689.515524223796;9702.126808587225;9713.902860971406;8675.522846243486;8860.158284962918;11527.769444611145;11680.883191168106;11729.4135293235;11736.7652646947;11845;11850.933415992558;11852.7629447411;11924.344161071138;11805.291682499077;11849.7630047399;11853.229540079867;11886.465109070112;11889.227200231957;11732.765344693144;11780.823287650692;11804.704882377924;11804.940975295069;11808.881911180864;41805.37291940623;42065.78967105145;42086;42126.57873421257;42252.577474225174;3385.373705864423;3428.919890234568;3434.6050204226585;3443.3974054540604;3487.581490221164;32520.512192317135;32802.6719732802;33116.33767324664;33316.83341583301;33397.6660233397;3243.2378391078078;3274.5579346788118;3298.6041674999155;3343.7157841583494;3406.9829650851834;411627;509127;510470;511826.440867797;512756;56070.43929560652;56354.59113522195;56414.71792641011;56522.43477565254;56715;35047.824760876545;35334.293314133574;35400.291994159976;37316;37385.81307093447;14086.506972255922;16985.320587176622;16992.490225293262;16999.91500042492;17020.404285849934;11550.249233799945;11860.406979651156;12792.424340904681;12972.610821675366;12975.286359250333;17285.752852129142;17424;17444.12779361052;17449.56376090608;18458.35395761142;6375.394337537927;7395;7903.616867048244;7909.881351779728;7972;790.9525428474195;843.5571325054395;906.0984320601044;953.323140570189;1042.2756184451732;29897.611602356188;29979.70020299769;30140;30275.545866812015;30665.540016899766;1039.3815679670583;1041.9843702344472;1059.364381371171;1060.7560261139981;1068.391017120234;15467.690646187013;15508.147051912027;15580.220988950507;15741.212939352987;15873.12697801632;720964;724260;724935;725421;727156;62005;62556.06165907515;62584;62616.68691656604;62643.373566264665;1330.7804212305055;1348.0563605476207;1361.7889227169806;1363.5023216526095;1366.9589912302647;29474;30713;30757.846210768803;30870;31500.369992600477;56425.71787141038;57361;57364.85270294654;57462.425375745705;57516.71241643765;647259;654679;654978;655266;656430;42483.575164249196;43119.13761724685;43477.13045739131;44057.77971110124;44069.55930440783;49504.25743613776;50100;50968;51112.74443627758;51241.48758512367;35999.28001440009;38598.22803543969;38890.4166437498;39290.60709392984;40562.594374057066;26932.86533567398;37556;38204.42693359546;39702.801485992386;39834;37999.430008550444;38519.2296154081;38584.6141538581;38739.612603874724;38793.80603096967;32106;34145;34975.65024349724;35133.82433087818;35134.64865351314;24451;25455;25546.361340965883;25906.870465647553;26380.8680956594 06:30:50 INFO - PROCESS | 1651 | |2;jquery.html;303.93465404937933;321.5466192668337;377.74690957058783;382.7741632436862;404.7854637042367;15542.378304867805;17753.023583702892;20590.38228853133;20730.378088657326;20744.89627551862;11769.70575735607;14479.565613031626;19584.510387240327;20281.797182028175;20419.28532501363;5426.158945363475;5633.183188437674;5648.717564121798;5651.547876169917;5656.264685590888;5335.039692855285;5528.115501519757;5534.916976245359;5579.581531385142;5594.216809646653;5581.972090139564;5586.497215250627;5587.580931430139;5595.132754423071;5597.916031259534;4612.46956599992;5778.393268706788;6070.089486577004;6122.816315510542;6177.332120327531;5756.740946657411;5993.4006599340155;6013.128096426038;6014;6017.69911504423;12782.10525263232;13182;13182.86817131826;13269.668258293523;13631.591052268448;2279.851809632385;2287.348105789842;2291.4844160064017;2325.720913490375;2374.78626923576;9739.366941148874;9752.951235243849;10358.844617330746;11241.763406025331;14755.04092234012;1831.4047934421367;1845.935392261278;1851.574137948266;1905.1807722679243;1957.1877670766614;83534;115067;124293.13560296602;127275;128112;9760.09596161541;11061.502232399562;11177.66467005991;11454.59908903201;11514.251573647685;14568.125912445286;14590;14601.634959126106;14614.269286535631;14625;8204.302634276153;8487.490750554864;8525.360597955054;8606.82786344282;8612.311015118776;8387.832243355098;8418.579071046423;8430.199131082538;8621.913780862236;8634.78413039679;3656.2815476725896;4403.603675669141;4491.752953587518;4574.130915126116;4578.839740609063;1747.6417334446662;1821.1622653579236;1854.9814501855078;1908.9140988655545;1919.740834987259;801.7314199743034;877.622622272429;925.4169872979979;939.3847030195233;1003.2726273451689;20087.497812554804;20523;21149.471263218544;21158.259460918795;21166.153353865982;928.257394084743;930.9441433514011;957.4590356448723;967.4823969176457;1049.354646892171;10707.625233116803;11102.852781698983;11259.605913793142;11273.985341319321;11307.49116289769;594296;609050;617516;618636;625482;121427;124488.37755811164;130532;133337;138469.3076534611;917.5274733512247;986.1765425869336;1011.1607365886297;1031.9742006449749;1035.8394448860438;15348.769768453705;18086.276548938422;18721.25114995385;19229;19371.031448427802;52351.73824130855;52836;53250;58828.117578235506;59874.70062649833;87927;88679;89569;90010;90865.6370154435;6098.634081955097;8031.59842007909;8229;8238.09380968105;8283.58582070906;10948.660658499235;12601.369931503572;12841.422136004088;13038.152520086163;13053.543125990545;11002.449877506253;11206.83189752138;11398.94300528492;11400.600978965696;11517.712057198301;9503.429794212369;10954.507047182737;10977.725556861142;11331.830022549504;11477.655670329903;9474.85787713171;11347.886521135013;11548.653540393801;11575.88424115748;11593.6521904343;7940.444168908121;8171.959140204261;8180.877286840821;8187.467814592271;8229.95885020571;8767.517786521803;10980.670579882617;11045.779084418427;11258.83111753308;11284.379359135326 06:30:50 INFO - PROCESS | 1651 | |3;mootools.html;1493.6937927724819;1521.0569446942893;1628.666123444694;1664.7169981103211;1709.6495218480204;8142.91857081429;8828.028916819152;8828.382013259074;8831.779205519857;8845.159709827572;7719.459637825355;7929.444938854283;8367.58162091896;8561.272291855184;8637.179467950551;2339.2046704120594;2371.1700904683307;2372.9406764830933;2373.1456675596773;2378.797802186816;2329.126577533425;2358.7759162879497;2377.2749311459997;2377.869217193054;2379.3337865397716;2336.894839732208;2347.8473899196583;2353.2234362660365;2367.6566897799808;2375.3824005758543;2299.8965046572944;2311.225739377302;2311.734150572689;2312.6762253284555;2352.717673879128;2205.0408072488517;2208.712867327253;2211.6903633491324;2213.833962452806;2216.6342553478657;8671.176238257356;8770.3422243332;8781.253593444564;8797;8803.031666516677;5157.4068982067165;5330.173823057432;5334.893302133974;5338.973305133488;5344;3393.7624366294367;3426.2804810989724;3573.249617580311;3574.5174401455993;3581.301646178996;964.363520076753;1053.4979423868313;1075.7256899490658;1095.370162156763;1109.7059279290995;11356.545738170464;11501.07991360689;11513.884861151366;11531.654050378502;11542.653720388402;4514;4603.723776573416;4756.405449318835;4788.760561971888;4793.688410253392;9847.50762461874;9862.753431164278;9870.555824987892;9874;9880.950595246977;5292.867678308073;5296.576273898079;5299.5760339172775;5304.575633949275;5308.787648494094;4308.655307575386;4470;4652.302154676758;4779.402574678165;4844.903101938012;3854.3640299350855;3898.0449789801114;3976.9602303977167;4006.5192176938954;4019.618136277049;1283.153118941494;1288.323630094208;1289.8516670583003;1301.5509649171022;1305.09948135786;748.5957582905279;796.3390385979623;920.8770162790807;934.4673536084503;970.3450171134456;5610.551155907518;5796.304443466811;5978.760849566055;5989.64062156272;6174.876502470015;433.53828172995657;442.41601086565424;445.2786485892874;453.65748859610784;454.9818007279672;3928.587498312636;3940.6059394060367;4005.5994400560294;4058.1477889643506;4091.181763647223;10173;10666.573337066586;10669.253152279422;10714.196435267386;10714.250002499906;10626.468676566295;10628.574857005633;10638.787224255626;10641.361518308926;10657.467126643636;8133.552654604054;8216.712415065444;8218.465799722879;8221.79445513867;8235.547044912588;5681.602287839812;5728.1694154348215;5931.792387266425;5956.255468066492;5957.076653118774;9876.506174691092;9916.454594997344;9949.502524873873;10002.299839011199;10049.397036177852;9892.109710126124;10190.745231369276;10198.745031374276;10207.336523125972;10265.076143147153;6834.419074378733;7065.788026359218;7223.819404514929;7471.514351567348;7579.1284002340435;7169.283071692789;8050.436469447082;8398.748037558884;8399.160083991552;8399.328053755808;7361.190269070505;7445.888311675438;7491.3632341251605;7520.473566850268;7664.156942736406;7154.499185056996;7346.449016323691;7363.337299642843;7376.520526165782;7421.4062874968795;6928.930710692828;6933.618650974043;7016.36852683261;7024.2975702431395;7038.788836334918;4813.831515896927;4944.629152813482;4973.552380285647;4992.80028798844;5128.897422051613;4425.849279187499;4704.92942605868;4930.408350997904;5118.334616499831;5200.037992971313 06:30:50 INFO - PROCESS | 1651 | |4;prototype.html;279.98644905442296;314.47011785142035;316.66591745708286;320.91370710146145;321.63012535584073;5062.519060689228;5077.64456488046;5446.482584154504;5467.425920278373;5501.312335958005;4400.515943246241;4850.927236091461;5427.701476418795;5475.945240547593;5502.386366475932;3667;3875.5349358077;3937.606239376068;4088.0393107619684;4102.610252026053;3472.2881809229175;4147.274227010261;4172.311568591194;4184;4208.263553878074;4107.507099148092;4120.361343991686;4121;4140.047789008529;4148.211839750437;3749.7562658427114;3884.6309600588042;3900.1203249768773;4149.564295748933;4153.273177193979;3571.339302229096;3571.678548930609;3577.4633804929467;3586.3006713690843;3630.2920930418577;5206.609504287194;5223.347081614798;5242.292290540767;5253;5301.628885977983;3621.692156166729;4583.381243532147;4640.559146881041;4674.322223277606;4716.268978308368;5605.355384130837;5618.185363122365;5618.943810561883;5662.348829884575;5667.716614169275;3858.266929283427;3885.1452680410266;3893.2213557288655;3901.882943511699;3902.6292502212245;5494.5054945054735;5884.176215329814;5933.376995415462;5983.940160598426;6075.817725468243;3457;3514.699561162386;3805.866794662229;3906.843726250975;3910.6284902934176;3347.782394144373;3361.562996810399;3966.3143164155117;3966.8809935701975;3970.4838371011583;3519.5248641433077;4029.0531725044593;4285.228658841438;4375.2780791169735;4602.364132335418;5617.230572369691;5676.297110866723;5706.201131841545;5790.334111577223;5810.331811841692;1096.7203363142348;1223.5534030079134;1257.2142410993129;1301.7526669932683;1349.7570437321376;698.8392669686001;736.6022347932163;743.5390058163973;760.4296777416937;819.9467034642848;4338.676703605368;4422.469303683514;5168.3539557555305;5267.762950667153;5354.955783622157;5527.226188333637;5568.888622227532;5832.416758324133;5883.823485295448;5948.910766338508;4408.58118478744;4439.689221754511;5282.022825777243;5308.867278318073;5322.361316642027;2793.2178989882864;3035.5598438226775;3052.931473984132;3053.9389212215633;3054.373853360056;5290.338707661543;5511.448855114457;5516.862078448071;5701.771929122871;5949.315828679757;5220.504052115043;5486;5608.355039170548;5964.582479226499;5976.834517269091;5716.885662286731;5936.970315148483;5942.881142377215;5947.434993675594;5959.553033522417;5506.504414602705;5512.80705175317;5796.855078623068;5811.738471768696;5816.73824677882;5693.715314234189;5702.429757024264;5711.5145212655725;5747.51146152565;5763.596548241583;4529.6602754794185;5696.860627874359;5939.703014849327;5944.375840536682;5986.730597123053;3259.1037464697397;3582.3372676055014;3654.3239500692457;3890.4553362529837;3895.5325360956867;5662.886742265049;5797.420257974169;5833.733109458717;5847.473727364558;5864.384239654945;5162.561182299547;5510.8071217507195;5684.658920464785;5715.8856822864145;5721.685307308138;4868.223098568926;5649.971750141223;5669.149627555899;5713.857153571194;5741.368449470639;5604.747786349542;5614;5631.831045068655;5639.830805075854;5654.264945557051;5431.83704488866;5550.33583879748;5674.404187560247;5755.740991655469;5783.334916484489;4643.767811609474;5587;5597.160425936142;5600.691961942132;5605.663660180402 06:30:50 INFO - PROCESS | 1651 | |5;yui.html;726.4950859152891;739.9001134846794;744.3970383988966;789.9368050555956;808.341201920435;15168.317425715843;15882.36470541177;15981.200939953014;16013.59966000849;16018.35926562936;14368.137911725304;14404;14413.207273599948;14448.349824257908;14507.564773056825;700.3486757315694;719.2447929673822;853.6542700206427;866.1468453573225;874.6982291109557;862.4738909265343;881.7266647339313;884.7257350221452;888.5468411110348;888.7111688701166;932.8367535681263;935.7473482159813;936.3258453913205;936.3585943628602;936.9786932243853;729.7810656802938;889.8709687095335;925.0887875442684;927.9814403711922;929.4748467116092;686.3856848120954;688.6659969914588;688.6797639097794;692.9237783843773;693.767587858063;14497.275136243146;14531.346089426;14546.636334091627;14547.563573092824;14549.127052376785;13671.384787684578;13838.30808459573;14029.158250505003;14072.859271407257;14170.149791012573;12672.619821405373;12793.744125117446;12843.614691559174;12988.415521301564;13391.263480508665;4521.683482156251;4596.724196548218;4609.815607375701;4620.953790462086;4770.475247722748;107755;109994;111094.77810443827;112857;113402.43298783536;10996.28524145928;11047.987309141321;11062.170337224741;11272.605458809066;11334.94332528332;21747.456313592287;21866;21876.89061554682;21883.90580471002;21895.343139705834;7694.615269236516;7729.806754831175;7776.300132988058;7798.649060792278;7966.442349035512;4273.380359847867;4397.802098905557;4447.3329000650165;4462.241418958784;4568.748718820497;3409.369266685671;3523.982380088083;3822.197338558878;3984.8406063757125;4002.9792402937064;717.8061923280685;727.6798208788116;732.9377002954702;735.9080114985627;737.9926200737924;611.6391329115843;649.7043845050491;652.5953908576713;669.4945316286173;670.2024590737008;9411.764705882271;9505.619775208914;9801.411915285105;9822.75443113928;9991.550380232908;578.8205656246577;633.4773811605444;639.6993413095837;656.7832615236961;668.4952860590223;3269.967300327014;4742.4309082909585;4804.279358096313;4805.423349198119;4847.2729090636685;115581.422092889;154275;157512;157705;158934;92730.53634731783;105300;107844.38233426349;114017.42991284991;114370.42814785872;97437;99583.50208248913;102545.46181807428;104250.47874760578;104340;9498;9543.502147637542;9888.307818452638;9920.107190352903;9939.304248702521;58877.82244355003;58983;59465;61788.69105654443;62507.687461562404;84882;87382.56308718416;88721.55639222021;90622.09377906137;91895.56731028763;12942.611721648365;13067.738645226853;13072.281024543741;13435.328233588087;13688.589342319747;12608.432620532281;14598.124112553282;14623.268836557916;14817.925910370379;15307.387704491695;13680.863191368357;13808.792868106786;13914.652133696738;14263.714725705635;14301;12098.455569499569;13677.384517696926;13913.513027044004;13936;14431.75044704939;11662.358570278717;13577.864221358055;13631.522896698569;13925.860741392456;14164.78752818688;11024;11188.66434006981;11404.48679809427;11530.135239856876;12241.571544995883;9669.564869581027;9969.950150249202;10533.78932421332;11257.15571332137;11555.2489088209 06:30:50 INFO - PROCESS | 1651 | __end_tp_report 06:30:50 INFO - PROCESS | 1651 | __start_cc_report 06:30:50 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1297 06:30:50 INFO - PROCESS | 1651 | __end_cc_report 06:30:50 INFO - PROCESS | 1651 | __startTimestamp1470403850625__endTimestamp 06:30:50 INFO - PROCESS | 1651 | 06:30:50 INFO - PROCESS | 1651 | ------- Summary: start ------- 06:30:50 INFO - PROCESS | 1651 | Number of tests: 6 06:30:50 INFO - PROCESS | 1651 | 06:30:50 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5853.16 Median:6143.57 stddev:637.49 (10.4%) stddev-sans-first:610.66 06:30:50 INFO - PROCESS | 1651 | Values: 3438.4 3442.8 3456.1 3471.4 3510.5 4894.1 5606.7 5738.3 5893.3 5955.2 5901.2 5915.7 6046.3 6049.8 6084.6 5227.9 5314.5 5333.4 5339.9 5380.2 4506.3 5427.8 5447.6 5450.0 5481.9 5240.9 5313.3 5327.9 5370.1 5390.2 5339.7 5345.4 5360.4 5365.3 5370.0 5266.6 5304.4 5316.4 5332.1 5355.0 5815.6 5867.6 5868.0 5871.9 5874.3 5427.6 6234.1 6275.6 6298.1 6305.4 6143.6 6244.7 6252.0 6268.8 6270.8 5919.3 6078.6 6083.0 6116.9 6140.1 5405.5 6222.3 6270.1 6293.5 6436.0 6298.4 6308.3 6330.2 6333.3 6355.9 6222.3 6315.0 6322.2 6335.8 6338.6 6238.8 6264.2 6271.4 6300.3 6346.9 6275.8 6298.2 6301.7 6308.1 6310.4 4987.1 4989.4 5061.8 5074.2 5115.8 4544.3 4581.9 4582.0 4594.1 4647.8 5859.0 5924.5 5936.9 5943.6 5989.9 6186.7 6231.1 6292.0 6306.9 6312.9 5859.0 5907.6 5944.6 5958.3 6003.6 5586.6 5591.8 5600.8 5613.4 5615.4 5238.1 6424.3 6424.9 6441.8 6457.6 6183.1 6209.2 6232.5 6287.8 6296.5 6398.6 6422.7 6426.9 6428.6 6429.9 6146.3 6287.7 6297.0 6309.0 6334.6 6187.3 6202.8 6234.3 6258.9 6276.5 6251.5 6262.2 6290.2 6291.6 6313.9 6101.5 6234.9 6248.3 6311.7 6317.8 6130.1 6134.2 6150.9 6212.8 6215.5 6263.7 6272.5 6278.1 6294.3 6306.8 6024.9 6182.2 6209.3 6210.9 6211.3 06:30:50 INFO - PROCESS | 1651 | 06:30:50 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:75011.58 Median:36657.64 stddev:169166.91 (461.5%) stddev-sans-first:169548.80 06:30:50 INFO - PROCESS | 1651 | Values: 433.5 537.9 538.7 542.0 549.7 30133.0 30935.4 40084.4 41292.8 41313.6 42830.0 43139.0 43173.6 43221.6 43222.0 8278.3 8913.4 9689.5 9702.1 9713.9 8675.5 8860.2 11527.8 11680.9 11729.4 11736.8 11845.0 11850.9 11852.8 11924.3 11805.3 11849.8 11853.2 11886.5 11889.2 11732.8 11780.8 11804.7 11804.9 11808.9 41805.4 42065.8 42086.0 42126.6 42252.6 3385.4 3428.9 3434.6 3443.4 3487.6 32520.5 32802.7 33116.3 33316.8 33397.7 3243.2 3274.6 3298.6 3343.7 3407.0 411627.0 509127.0 510470.0 511826.4 512756.0 56070.4 56354.6 56414.7 56522.4 56715.0 35047.8 35334.3 35400.3 37316.0 37385.8 14086.5 16985.3 16992.5 16999.9 17020.4 11550.2 11860.4 12792.4 12972.6 12975.3 17285.8 17424.0 17444.1 17449.6 18458.4 6375.4 7395.0 7903.6 7909.9 7972.0 791.0 843.6 906.1 953.3 1042.3 29897.6 29979.7 30140.0 30275.5 30665.5 1039.4 1042.0 1059.4 1060.8 1068.4 15467.7 15508.1 15580.2 15741.2 15873.1 720964.0 724260.0 724935.0 725421.0 727156.0 62005.0 62556.1 62584.0 62616.7 62643.4 1330.8 1348.1 1361.8 1363.5 1367.0 29474.0 30713.0 30757.8 30870.0 31500.4 56425.7 57361.0 57364.9 57462.4 57516.7 647259.0 654679.0 654978.0 655266.0 656430.0 42483.6 43119.1 43477.1 44057.8 44069.6 49504.3 50100.0 50968.0 51112.7 51241.5 35999.3 38598.2 38890.4 39290.6 40562.6 26932.9 37556.0 38204.4 39702.8 39834.0 37999.4 38519.2 38584.6 38739.6 38793.8 32106.0 34145.0 34975.7 35133.8 35134.6 24451.0 25455.0 25546.4 25906.9 26380.9 06:30:50 INFO - PROCESS | 1651 | 06:30:50 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:35304.26 Median:2308.60 stddev:102470.20 (4438.6%) stddev-sans-first:102723.96 06:30:50 INFO - PROCESS | 1651 | Values: 303.9 321.5 377.7 382.8 404.8 15542.4 17753.0 20590.4 20730.4 20744.9 11769.7 14479.6 19584.5 20281.8 20419.3 5426.2 5633.2 5648.7 5651.5 5656.3 5335.0 5528.1 5534.9 5579.6 5594.2 5582.0 5586.5 5587.6 5595.1 5597.9 4612.5 5778.4 6070.1 6122.8 6177.3 5756.7 5993.4 6013.1 6014.0 6017.7 12782.1 13182.0 13182.9 13269.7 13631.6 2279.9 2287.3 2291.5 2325.7 2374.8 9739.4 9753.0 10358.8 11241.8 14755.0 1831.4 1845.9 1851.6 1905.2 1957.2 83534.0 115067.0 124293.1 127275.0 128112.0 9760.1 11061.5 11177.7 11454.6 11514.3 14568.1 14590.0 14601.6 14614.3 14625.0 8204.3 8487.5 8525.4 8606.8 8612.3 8387.8 8418.6 8430.2 8621.9 8634.8 3656.3 4403.6 4491.8 4574.1 4578.8 1747.6 1821.2 1855.0 1908.9 1919.7 801.7 877.6 925.4 939.4 1003.3 20087.5 20523.0 21149.5 21158.3 21166.2 928.3 930.9 957.5 967.5 1049.4 10707.6 11102.9 11259.6 11274.0 11307.5 594296.0 609050.0 617516.0 618636.0 625482.0 121427.0 124488.4 130532.0 133337.0 138469.3 917.5 986.2 1011.2 1032.0 1035.8 15348.8 18086.3 18721.3 19229.0 19371.0 52351.7 52836.0 53250.0 58828.1 59874.7 87927.0 88679.0 89569.0 90010.0 90865.6 6098.6 8031.6 8229.0 8238.1 8283.6 10948.7 12601.4 12841.4 13038.2 13053.5 11002.4 11206.8 11398.9 11400.6 11517.7 9503.4 10954.5 10977.7 11331.8 11477.7 9474.9 11347.9 11548.7 11575.9 11593.7 7940.4 8172.0 8180.9 8187.5 8230.0 8767.5 10980.7 11045.8 11258.8 11284.4 06:30:50 INFO - PROCESS | 1651 | 06:30:50 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5655.74 Median:4803.76 stddev:3191.90 (66.4%) stddev-sans-first:3185.53 06:30:50 INFO - PROCESS | 1651 | Values: 1493.7 1521.1 1628.7 1664.7 1709.6 8142.9 8828.0 8828.4 8831.8 8845.2 7719.5 7929.4 8367.6 8561.3 8637.2 2339.2 2371.2 2372.9 2373.1 2378.8 2329.1 2358.8 2377.3 2377.9 2379.3 2336.9 2347.8 2353.2 2367.7 2375.4 2299.9 2311.2 2311.7 2312.7 2352.7 2205.0 2208.7 2211.7 2213.8 2216.6 8671.2 8770.3 8781.3 8797.0 8803.0 5157.4 5330.2 5334.9 5339.0 5344.0 3393.8 3426.3 3573.2 3574.5 3581.3 964.4 1053.5 1075.7 1095.4 1109.7 11356.5 11501.1 11513.9 11531.7 11542.7 4514.0 4603.7 4756.4 4788.8 4793.7 9847.5 9862.8 9870.6 9874.0 9881.0 5292.9 5296.6 5299.6 5304.6 5308.8 4308.7 4470.0 4652.3 4779.4 4844.9 3854.4 3898.0 3977.0 4006.5 4019.6 1283.2 1288.3 1289.9 1301.6 1305.1 748.6 796.3 920.9 934.5 970.3 5610.6 5796.3 5978.8 5989.6 6174.9 433.5 442.4 445.3 453.7 455.0 3928.6 3940.6 4005.6 4058.1 4091.2 10173.0 10666.6 10669.3 10714.2 10714.3 10626.5 10628.6 10638.8 10641.4 10657.5 8133.6 8216.7 8218.5 8221.8 8235.5 5681.6 5728.2 5931.8 5956.3 5957.1 9876.5 9916.5 9949.5 10002.3 10049.4 9892.1 10190.7 10198.7 10207.3 10265.1 6834.4 7065.8 7223.8 7471.5 7579.1 7169.3 8050.4 8398.7 8399.2 8399.3 7361.2 7445.9 7491.4 7520.5 7664.2 7154.5 7346.4 7363.3 7376.5 7421.4 6928.9 6933.6 7016.4 7024.3 7038.8 4813.8 4944.6 4973.6 4992.8 5128.9 4425.8 4704.9 4930.4 5118.3 5200.0 06:30:50 INFO - PROCESS | 1651 | 06:30:50 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4578.59 Median:5295.98 stddev:1444.36 (27.3%) stddev-sans-first:1411.92 06:30:50 INFO - PROCESS | 1651 | Values: 280.0 314.5 316.7 320.9 321.6 5062.5 5077.6 5446.5 5467.4 5501.3 4400.5 4850.9 5427.7 5475.9 5502.4 3667.0 3875.5 3937.6 4088.0 4102.6 3472.3 4147.3 4172.3 4184.0 4208.3 4107.5 4120.4 4121.0 4140.0 4148.2 3749.8 3884.6 3900.1 4149.6 4153.3 3571.3 3571.7 3577.5 3586.3 3630.3 5206.6 5223.3 5242.3 5253.0 5301.6 3621.7 4583.4 4640.6 4674.3 4716.3 5605.4 5618.2 5618.9 5662.3 5667.7 3858.3 3885.1 3893.2 3901.9 3902.6 5494.5 5884.2 5933.4 5983.9 6075.8 3457.0 3514.7 3805.9 3906.8 3910.6 3347.8 3361.6 3966.3 3966.9 3970.5 3519.5 4029.1 4285.2 4375.3 4602.4 5617.2 5676.3 5706.2 5790.3 5810.3 1096.7 1223.6 1257.2 1301.8 1349.8 698.8 736.6 743.5 760.4 819.9 4338.7 4422.5 5168.4 5267.8 5355.0 5527.2 5568.9 5832.4 5883.8 5948.9 4408.6 4439.7 5282.0 5308.9 5322.4 2793.2 3035.6 3052.9 3053.9 3054.4 5290.3 5511.4 5516.9 5701.8 5949.3 5220.5 5486.0 5608.4 5964.6 5976.8 5716.9 5937.0 5942.9 5947.4 5959.6 5506.5 5512.8 5796.9 5811.7 5816.7 5693.7 5702.4 5711.5 5747.5 5763.6 4529.7 5696.9 5939.7 5944.4 5986.7 3259.1 3582.3 3654.3 3890.5 3895.5 5662.9 5797.4 5833.7 5847.5 5864.4 5162.6 5510.8 5684.7 5715.9 5721.7 4868.2 5650.0 5669.1 5713.9 5741.4 5604.7 5614.0 5631.8 5639.8 5654.3 5431.8 5550.3 5674.4 5755.7 5783.3 4643.8 5587.0 5597.2 5600.7 5605.7 06:30:50 INFO - PROCESS | 1651 | 06:30:50 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:24006.26 Median:4138.18 stddev:37554.17 (907.5%) stddev-sans-first:37618.84 06:30:50 INFO - PROCESS | 1651 | Values: 726.5 739.9 744.4 789.9 808.3 15168.3 15882.4 15981.2 16013.6 16018.4 14368.1 14404.0 14413.2 14448.3 14507.6 700.3 719.2 853.7 866.1 874.7 862.5 881.7 884.7 888.5 888.7 932.8 935.7 936.3 936.4 937.0 729.8 889.9 925.1 928.0 929.5 686.4 688.7 688.7 692.9 693.8 14497.3 14531.3 14546.6 14547.6 14549.1 13671.4 13838.3 14029.2 14072.9 14170.1 12672.6 12793.7 12843.6 12988.4 13391.3 4521.7 4596.7 4609.8 4621.0 4770.5 107755.0 109994.0 111094.8 112857.0 113402.4 10996.3 11048.0 11062.2 11272.6 11334.9 21747.5 21866.0 21876.9 21883.9 21895.3 7694.6 7729.8 7776.3 7798.6 7966.4 4273.4 4397.8 4447.3 4462.2 4568.7 3409.4 3524.0 3822.2 3984.8 4003.0 717.8 727.7 732.9 735.9 738.0 611.6 649.7 652.6 669.5 670.2 9411.8 9505.6 9801.4 9822.8 9991.6 578.8 633.5 639.7 656.8 668.5 3270.0 4742.4 4804.3 4805.4 4847.3 115581.4 154275.0 157512.0 157705.0 158934.0 92730.5 105300.0 107844.4 114017.4 114370.4 97437.0 99583.5 102545.5 104250.5 104340.0 9498.0 9543.5 9888.3 9920.1 9939.3 58877.8 58983.0 59465.0 61788.7 62507.7 84882.0 87382.6 88721.6 90622.1 91895.6 12942.6 13067.7 13072.3 13435.3 13688.6 12608.4 14598.1 14623.3 14817.9 15307.4 13680.9 13808.8 13914.7 14263.7 14301.0 12098.5 13677.4 13913.5 13936.0 14431.8 11662.4 13577.9 13631.5 13925.9 14164.8 11024.0 11188.7 11404.5 11530.1 12241.6 9669.6 9970.0 10533.8 11257.2 11555.2 06:30:50 INFO - PROCESS | 1651 | -------- Summary: end -------- 06:30:50 INFO - PROCESS | 1651 | 06:30:51 INFO - TEST-INFO | 1651: exit 0 06:30:51 INFO - TEST-OK | dromaeo_css | took 1118221ms 06:30:51 INFO - TEST-START | kraken 06:30:51 INFO - operating with platform_type : mac_ 06:30:51 INFO - Initialising browser for kraken test... 06:30:51 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmp0cBb9h/profile http://localhost:49271/getInfo.html) 06:30:53 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 06:30:53 INFO - PROCESS | 1661 | colorDepth:24 06:30:53 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 06:30:53 INFO - PROCESS | 1661 | __metrics 06:30:53 INFO - PROCESS | 1661 | 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" 06:30:53 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:30:54 INFO - TEST-INFO | 1661: exit 0 06:30:54 INFO - Browser initialized. 06:30:54 INFO - Running cycle 1/1 for kraken test... 06:30:54 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmp0cBb9h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:31:06 INFO - PROCESS | 1662 | RSS: Main: 243269632 06:31:06 INFO - PROCESS | 1662 | 06:31:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 06:31:09 INFO - PROCESS | 1662 | RSS: Main: 294060032 06:31:09 INFO - PROCESS | 1662 | 06:31:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 06:31:13 INFO - PROCESS | 1662 | RSS: Main: 301871104 06:31:13 INFO - PROCESS | 1662 | 06:31:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 06:31:17 INFO - PROCESS | 1662 | RSS: Main: 397303808 06:31:17 INFO - PROCESS | 1662 | 06:31:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 06:31:20 INFO - PROCESS | 1662 | RSS: Main: 299192320 06:31:20 INFO - PROCESS | 1662 | 06:31:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:31:22 INFO - PROCESS | 1662 | RSS: Main: 303693824 06:31:22 INFO - PROCESS | 1662 | 06:31:25 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 06:31:26 INFO - PROCESS | 1662 | RSS: Main: 340414464 06:31:26 INFO - PROCESS | 1662 | 06:31:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 06:31:29 INFO - PROCESS | 1662 | RSS: Main: 342298624 06:31:29 INFO - PROCESS | 1662 | 06:31:32 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 06:31:33 INFO - PROCESS | 1662 | RSS: Main: 342134784 06:31:33 INFO - PROCESS | 1662 | 06:31:34 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:31:35 INFO - PROCESS | 1662 | RSS: Main: 313925632 06:31:35 INFO - PROCESS | 1662 | 06:31:37 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:31:38 INFO - PROCESS | 1662 | RSS: Main: 318824448 06:31:38 INFO - PROCESS | 1662 | 06:31:40 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:31:41 INFO - PROCESS | 1662 | RSS: Main: 326778880 06:31:41 INFO - PROCESS | 1662 | 06:31:43 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:31:44 INFO - PROCESS | 1662 | RSS: Main: 330235904 06:31:44 INFO - PROCESS | 1662 | 06:31:47 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:31:48 INFO - PROCESS | 1662 | RSS: Main: 331649024 06:31:48 INFO - PROCESS | 1662 | 06:31:49 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 06:31:50 INFO - PROCESS | 1662 | RSS: Main: 375078912 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | __start_tp_report 06:31:50 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 06:31:50 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 06:31:50 INFO - PROCESS | 1662 | |i|pagename|runs| 06:31:50 INFO - PROCESS | 1662 | |0;ai-astar;102;114;114;111;114;112;112;112;112;113 06:31:50 INFO - PROCESS | 1662 | |1;audio-beat-detection;142;110;107;167;111;137;116;125;204;105 06:31:50 INFO - PROCESS | 1662 | |2;audio-dft;185;183;183;181;184;179;184;182;183;183 06:31:50 INFO - PROCESS | 1662 | |3;audio-fft;77;58;71;128;79;75;59;67;86;74 06:31:50 INFO - PROCESS | 1662 | |4;audio-oscillator;87;69;93;71;83;68;97;71;68;103 06:31:50 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;87;85;86;84;87;84;86;88;132;112 06:31:50 INFO - PROCESS | 1662 | |6;imaging-darkroom;93;92;93;92;92;92;91;92;93;92 06:31:50 INFO - PROCESS | 1662 | |7;imaging-desaturate;83;84;85;100;134;131;84;84;83;84 06:31:50 INFO - PROCESS | 1662 | |8;json-parse-financial;54;54;52;53;51;51;50;52;51;52 06:31:50 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;66;67;80;72;74;71;70;69;95;102 06:31:50 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;83;86;86;87;85;82;84;83;86;86 06:31:50 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;140;135;138;147;152;141;139;138;134;139 06:31:50 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;166;168;168;165;167;169;168;168;181;216 06:31:50 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;58;81;89;86;67;66;64;66;66;67 06:31:50 INFO - PROCESS | 1662 | __end_tp_report 06:31:50 INFO - PROCESS | 1662 | __start_cc_report 06:31:50 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2092 06:31:50 INFO - PROCESS | 1662 | __end_cc_report 06:31:50 INFO - PROCESS | 1662 | __startTimestamp1470403910176__endTimestamp 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | ------- Summary: start ------- 06:31:50 INFO - PROCESS | 1662 | Number of tests: 14 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:3.53 (3.1%) stddev-sans-first:1.12 06:31:50 INFO - PROCESS | 1662 | Values: 102.0 114.0 114.0 111.0 114.0 112.0 112.0 112.0 112.0 113.0 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:131.00 stddev:31.83 (24.3%) stddev-sans-first:33.57 06:31:50 INFO - PROCESS | 1662 | Values: 142.0 110.0 107.0 167.0 111.0 137.0 116.0 125.0 204.0 105.0 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.70 (0.9%) stddev-sans-first:1.59 06:31:50 INFO - PROCESS | 1662 | Values: 185.0 183.0 183.0 181.0 184.0 179.0 184.0 182.0 183.0 183.0 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:77.40 Median:74.50 stddev:19.77 (26.5%) stddev-sans-first:20.97 06:31:50 INFO - PROCESS | 1662 | Values: 77.0 58.0 71.0 128.0 79.0 75.0 59.0 67.0 86.0 74.0 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:81.00 Median:77.00 stddev:13.36 (17.3%) stddev-sans-first:13.99 06:31:50 INFO - PROCESS | 1662 | Values: 87.0 69.0 93.0 71.0 83.0 68.0 97.0 71.0 68.0 103.0 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:86.00 stddev:16.00 (18.6%) stddev-sans-first:16.81 06:31:50 INFO - PROCESS | 1662 | Values: 87.0 85.0 86.0 84.0 87.0 84.0 86.0 88.0 132.0 112.0 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:92.20 Median:92.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 06:31:50 INFO - PROCESS | 1662 | Values: 93.0 92.0 93.0 92.0 92.0 92.0 91.0 92.0 93.0 92.0 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:84.00 stddev:20.31 (24.2%) stddev-sans-first:21.06 06:31:50 INFO - PROCESS | 1662 | Values: 83.0 84.0 85.0 100.0 134.0 131.0 84.0 84.0 83.0 84.0 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.33 (2.6%) stddev-sans-first:1.20 06:31:50 INFO - PROCESS | 1662 | Values: 54.0 54.0 52.0 53.0 51.0 51.0 50.0 52.0 51.0 52.0 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:76.60 Median:71.50 stddev:12.29 (17.2%) stddev-sans-first:12.43 06:31:50 INFO - PROCESS | 1662 | Values: 66.0 67.0 80.0 72.0 74.0 71.0 70.0 69.0 95.0 102.0 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:86.00 stddev:1.69 (2.0%) stddev-sans-first:1.66 06:31:50 INFO - PROCESS | 1662 | Values: 83.0 86.0 86.0 87.0 85.0 82.0 84.0 83.0 86.0 86.0 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:139.50 stddev:5.42 (3.9%) stddev-sans-first:5.74 06:31:50 INFO - PROCESS | 1662 | Values: 140.0 135.0 138.0 147.0 152.0 141.0 139.0 138.0 134.0 139.0 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:168.00 stddev:15.54 (9.3%) stddev-sans-first:16.24 06:31:50 INFO - PROCESS | 1662 | Values: 166.0 168.0 168.0 165.0 167.0 169.0 168.0 168.0 181.0 216.0 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:67.00 stddev:10.40 (15.5%) stddev-sans-first:9.91 06:31:50 INFO - PROCESS | 1662 | Values: 58.0 81.0 89.0 86.0 67.0 66.0 64.0 66.0 66.0 67.0 06:31:50 INFO - PROCESS | 1662 | -------- Summary: end -------- 06:31:50 INFO - PROCESS | 1662 | 06:31:50 INFO - TEST-INFO | 1662: exit 0 06:31:51 INFO - TEST-OK | kraken | took 59785ms 06:31:51 INFO - SUITE-END | took 1178s 06:31:51 INFO - Completed test suite (00:19:38) 06:31:51 INFO - javascript benchmark 06:31:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3438.4154693702067, 3442.759006869517, 3456.1014136324548, 3471.375152472557, 3510.5085288059677, 4894.143524883145, 5606.691631960241, 5738.254026976498, 5893.292804863411, 5955.225820643315, 5901.203337549429, 5915.704214789254, 6046.304674962381, 6049.848753781158, 6084.604500707451, 5227.869303267411, 5314.495122963332, 5333.386660534049, 5339.946600534003, 5380.24676545284, 4506.278995360743, 5427.755750991195, 5447.564194864422, 5450.018996580614, 5481.917771233435, 5240.947590524084, 5313.282706834567, 5327.866803329909, 5370.140777475624, 5390.245365648812, 5339.733013349317, 5345.385280692732, 5360.383555891083, 5365.3293338332705, 5370.0, 5266.578673706094, 5304.36347638282, 5316.362036555638, 5332.146856502941, 5355.036093503168, 5815.621984571032, 5867.647941123503, 5868.0, 5871.9412805871825, 5874.295084589834, 5427.647202931837, 6234.064890266451, 6275.623462592259, 6298.149749783766, 6305.432511074026, 6143.569950103494, 6244.687765611701, 6252.0, 6268.843278918018, 6270.8118756436925, 5919.3192782829665, 6078.584854392223, 6082.974913061355, 6116.868379349835, 6140.078988151813, 5405.459454054641, 6222.253329600387, 6270.090836828635, 6293.465055470245, 6435.967820160869, 6298.433141017239, 6308.3060863305, 6330.240371155399, 6333.271673757485, 6355.904661430082, 6222.3466536013975, 6314.9684251579365, 6322.178116844872, 6335.778247761306, 6338.619682819046, 6238.812835614848, 6264.154339164245, 6271.43557079865, 6300.30696623371, 6346.873062538723, 6275.843103922439, 6298.244210694655, 6301.7164227609865, 6308.148399965946, 6310.400511951358, 4987.102321582078, 4989.351384320015, 5061.772220250097, 5074.162763144113, 5115.769790359368, 4544.318352247189, 4581.931271030937, 4581.991961768405, 4594.058218065288, 4647.790849411785, 5858.970705146532, 5924.496417804448, 5936.8812623748145, 5943.613665111754, 5989.880202396015, 6186.721597528032, 6231.138734119068, 6291.96854015727, 6306.873862522724, 6312.936870631327, 5859.0, 5907.586468947218, 5944.583879128506, 5958.314793798769, 6003.6397816131175, 5586.608937374426, 5591.776328946878, 5600.775968961196, 5613.410591887793, 5615.438456154434, 5238.135707608202, 6424.261209960728, 6424.871502569922, 6441.774537891151, 6457.644829534421, 6183.103449999815, 6209.223847019122, 6232.501399887908, 6287.811365659038, 6296.496280297657, 6398.616083034846, 6422.678866056585, 6426.935730642821, 6428.55000149985, 6429.8714025720155, 6146.309764814533, 6287.748490060347, 6296.968515157395, 6309.0, 6334.6199228044625, 6187.288461826947, 6202.844928876814, 6234.314225435108, 6258.9374106260175, 6276.466500347522, 6251.53113516479, 6262.185915831095, 6290.150829637941, 6291.559590828598, 6313.905291420724, 6101.489633126442, 6234.906476402948, 6248.250209974651, 6311.747530098928, 6317.842053948688, 6130.080487926846, 6134.1610691366095, 6150.876982460415, 6212.81361559154, 6215.502759779117, 6263.718132683949, 6272.466840318624, 6278.089676996901, 6294.276158241861, 6306.842328941813, 6024.87950240984, 6182.227221597301, 6209.316975132822, 6210.937890621036, 6211.254649442096], "value": 5814.274134780335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.50796845580265, 537.8758394954544, 538.6714104396317, 541.9675518137949, 549.714148642706, 30132.99999999997, 30935.38129237414, 40084.398734019014, 41292.79353603228, 41313.58686413135, 42830.0, 43138.98027138101, 43173.56826431735, 43221.56778432215, 43222.0, 8278.337732981377, 8913.420627659198, 9689.515524223796, 9702.126808587225, 9713.902860971406, 8675.522846243486, 8860.158284962918, 11527.769444611145, 11680.883191168106, 11729.4135293235, 11736.7652646947, 11845.0, 11850.933415992558, 11852.7629447411, 11924.344161071138, 11805.291682499077, 11849.7630047399, 11853.229540079867, 11886.465109070112, 11889.227200231957, 11732.765344693144, 11780.823287650692, 11804.704882377924, 11804.940975295069, 11808.881911180864, 41805.37291940623, 42065.78967105145, 42086.0, 42126.57873421257, 42252.577474225174, 3385.373705864423, 3428.919890234568, 3434.6050204226585, 3443.3974054540604, 3487.581490221164, 32520.512192317135, 32802.6719732802, 33116.33767324664, 33316.83341583301, 33397.6660233397, 3243.2378391078078, 3274.5579346788118, 3298.6041674999155, 3343.7157841583494, 3406.9829650851834, 411627.0, 509127.0, 510470.0, 511826.440867797, 512756.0, 56070.43929560652, 56354.59113522195, 56414.71792641011, 56522.43477565254, 56715.0, 35047.824760876545, 35334.293314133574, 35400.291994159976, 37316.0, 37385.81307093447, 14086.506972255922, 16985.320587176622, 16992.490225293262, 16999.91500042492, 17020.404285849934, 11550.249233799945, 11860.406979651156, 12792.424340904681, 12972.610821675366, 12975.286359250333, 17285.752852129142, 17424.0, 17444.12779361052, 17449.56376090608, 18458.35395761142, 6375.394337537927, 7395.0, 7903.616867048244, 7909.881351779728, 7972.0, 790.9525428474195, 843.5571325054395, 906.0984320601044, 953.323140570189, 1042.2756184451732, 29897.611602356188, 29979.70020299769, 30140.0, 30275.545866812015, 30665.540016899766, 1039.3815679670583, 1041.9843702344472, 1059.364381371171, 1060.7560261139981, 1068.391017120234, 15467.690646187013, 15508.147051912027, 15580.220988950507, 15741.212939352987, 15873.12697801632, 720964.0, 724260.0, 724935.0, 725421.0, 727156.0, 62005.0, 62556.06165907515, 62584.0, 62616.68691656604, 62643.373566264665, 1330.7804212305055, 1348.0563605476207, 1361.7889227169806, 1363.5023216526095, 1366.9589912302647, 29474.0, 30713.0, 30757.846210768803, 30870.0, 31500.369992600477, 56425.71787141038, 57361.0, 57364.85270294654, 57462.425375745705, 57516.71241643765, 647259.0, 654679.0, 654978.0, 655266.0, 656430.0, 42483.575164249196, 43119.13761724685, 43477.13045739131, 44057.77971110124, 44069.55930440783, 49504.25743613776, 50100.0, 50968.0, 51112.74443627758, 51241.48758512367, 35999.28001440009, 38598.22803543969, 38890.4166437498, 39290.60709392984, 40562.594374057066, 26932.86533567398, 37556.0, 38204.42693359546, 39702.801485992386, 39834.0, 37999.430008550444, 38519.2296154081, 38584.6141538581, 38739.612603874724, 38793.80603096967, 32106.0, 34145.0, 34975.65024349724, 35133.82433087818, 35134.64865351314, 24451.0, 25455.0, 25546.361340965883, 25906.870465647553, 26380.8680956594], "value": 20569.68600989203, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.93465404937933, 321.5466192668337, 377.74690957058783, 382.7741632436862, 404.7854637042367, 15542.378304867805, 17753.023583702892, 20590.38228853133, 20730.378088657326, 20744.89627551862, 11769.70575735607, 14479.565613031626, 19584.510387240327, 20281.797182028175, 20419.28532501363, 5426.158945363475, 5633.183188437674, 5648.717564121798, 5651.547876169917, 5656.264685590888, 5335.039692855285, 5528.115501519757, 5534.916976245359, 5579.581531385142, 5594.216809646653, 5581.972090139564, 5586.497215250627, 5587.580931430139, 5595.132754423071, 5597.916031259534, 4612.46956599992, 5778.393268706788, 6070.089486577004, 6122.816315510542, 6177.332120327531, 5756.740946657411, 5993.4006599340155, 6013.128096426038, 6014.0, 6017.69911504423, 12782.10525263232, 13182.0, 13182.86817131826, 13269.668258293523, 13631.591052268448, 2279.851809632385, 2287.348105789842, 2291.4844160064017, 2325.720913490375, 2374.78626923576, 9739.366941148874, 9752.951235243849, 10358.844617330746, 11241.763406025331, 14755.04092234012, 1831.4047934421367, 1845.935392261278, 1851.574137948266, 1905.1807722679243, 1957.1877670766614, 83534.0, 115067.0, 124293.13560296602, 127275.0, 128112.0, 9760.09596161541, 11061.502232399562, 11177.66467005991, 11454.59908903201, 11514.251573647685, 14568.125912445286, 14590.0, 14601.634959126106, 14614.269286535631, 14625.0, 8204.302634276153, 8487.490750554864, 8525.360597955054, 8606.82786344282, 8612.311015118776, 8387.832243355098, 8418.579071046423, 8430.199131082538, 8621.913780862236, 8634.78413039679, 3656.2815476725896, 4403.603675669141, 4491.752953587518, 4574.130915126116, 4578.839740609063, 1747.6417334446662, 1821.1622653579236, 1854.9814501855078, 1908.9140988655545, 1919.740834987259, 801.7314199743034, 877.622622272429, 925.4169872979979, 939.3847030195233, 1003.2726273451689, 20087.497812554804, 20523.0, 21149.471263218544, 21158.259460918795, 21166.153353865982, 928.257394084743, 930.9441433514011, 957.4590356448723, 967.4823969176457, 1049.354646892171, 10707.625233116803, 11102.852781698983, 11259.605913793142, 11273.985341319321, 11307.49116289769, 594296.0, 609050.0, 617516.0, 618636.0, 625482.0, 121427.0, 124488.37755811164, 130532.0, 133337.0, 138469.3076534611, 917.5274733512247, 986.1765425869336, 1011.1607365886297, 1031.9742006449749, 1035.8394448860438, 15348.769768453705, 18086.276548938422, 18721.25114995385, 19229.0, 19371.031448427802, 52351.73824130855, 52836.0, 53250.0, 58828.117578235506, 59874.70062649833, 87927.0, 88679.0, 89569.0, 90010.0, 90865.6370154435, 6098.634081955097, 8031.59842007909, 8229.0, 8238.09380968105, 8283.58582070906, 10948.660658499235, 12601.369931503572, 12841.422136004088, 13038.152520086163, 13053.543125990545, 11002.449877506253, 11206.83189752138, 11398.94300528492, 11400.600978965696, 11517.712057198301, 9503.429794212369, 10954.507047182737, 10977.725556861142, 11331.830022549504, 11477.655670329903, 9474.85787713171, 11347.886521135013, 11548.653540393801, 11575.88424115748, 11593.6521904343, 7940.444168908121, 8171.959140204261, 8180.877286840821, 8187.467814592271, 8229.95885020571, 8767.517786521803, 10980.670579882617, 11045.779084418427, 11258.83111753308, 11284.379359135326], "value": 9325.669564140771, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.6937927724819, 1521.0569446942893, 1628.666123444694, 1664.7169981103211, 1709.6495218480204, 8142.91857081429, 8828.028916819152, 8828.382013259074, 8831.779205519857, 8845.159709827572, 7719.459637825355, 7929.444938854283, 8367.58162091896, 8561.272291855184, 8637.179467950551, 2339.2046704120594, 2371.1700904683307, 2372.9406764830933, 2373.1456675596773, 2378.797802186816, 2329.126577533425, 2358.7759162879497, 2377.2749311459997, 2377.869217193054, 2379.3337865397716, 2336.894839732208, 2347.8473899196583, 2353.2234362660365, 2367.6566897799808, 2375.3824005758543, 2299.8965046572944, 2311.225739377302, 2311.734150572689, 2312.6762253284555, 2352.717673879128, 2205.0408072488517, 2208.712867327253, 2211.6903633491324, 2213.833962452806, 2216.6342553478657, 8671.176238257356, 8770.3422243332, 8781.253593444564, 8797.0, 8803.031666516677, 5157.4068982067165, 5330.173823057432, 5334.893302133974, 5338.973305133488, 5344.0, 3393.7624366294367, 3426.2804810989724, 3573.249617580311, 3574.5174401455993, 3581.301646178996, 964.363520076753, 1053.4979423868313, 1075.7256899490658, 1095.370162156763, 1109.7059279290995, 11356.545738170464, 11501.07991360689, 11513.884861151366, 11531.654050378502, 11542.653720388402, 4514.0, 4603.723776573416, 4756.405449318835, 4788.760561971888, 4793.688410253392, 9847.50762461874, 9862.753431164278, 9870.555824987892, 9874.0, 9880.950595246977, 5292.867678308073, 5296.576273898079, 5299.5760339172775, 5304.575633949275, 5308.787648494094, 4308.655307575386, 4470.0, 4652.302154676758, 4779.402574678165, 4844.903101938012, 3854.3640299350855, 3898.0449789801114, 3976.9602303977167, 4006.5192176938954, 4019.618136277049, 1283.153118941494, 1288.323630094208, 1289.8516670583003, 1301.5509649171022, 1305.09948135786, 748.5957582905279, 796.3390385979623, 920.8770162790807, 934.4673536084503, 970.3450171134456, 5610.551155907518, 5796.304443466811, 5978.760849566055, 5989.64062156272, 6174.876502470015, 433.53828172995657, 442.41601086565424, 445.2786485892874, 453.65748859610784, 454.9818007279672, 3928.587498312636, 3940.6059394060367, 4005.5994400560294, 4058.1477889643506, 4091.181763647223, 10173.0, 10666.573337066586, 10669.253152279422, 10714.196435267386, 10714.250002499906, 10626.468676566295, 10628.574857005633, 10638.787224255626, 10641.361518308926, 10657.467126643636, 8133.552654604054, 8216.712415065444, 8218.465799722879, 8221.79445513867, 8235.547044912588, 5681.602287839812, 5728.1694154348215, 5931.792387266425, 5956.255468066492, 5957.076653118774, 9876.506174691092, 9916.454594997344, 9949.502524873873, 10002.299839011199, 10049.397036177852, 9892.109710126124, 10190.745231369276, 10198.745031374276, 10207.336523125972, 10265.076143147153, 6834.419074378733, 7065.788026359218, 7223.819404514929, 7471.514351567348, 7579.1284002340435, 7169.283071692789, 8050.436469447082, 8398.748037558884, 8399.160083991552, 8399.328053755808, 7361.190269070505, 7445.888311675438, 7491.3632341251605, 7520.473566850268, 7664.156942736406, 7154.499185056996, 7346.449016323691, 7363.337299642843, 7376.520526165782, 7421.4062874968795, 6928.930710692828, 6933.618650974043, 7016.36852683261, 7024.2975702431395, 7038.788836334918, 4813.831515896927, 4944.629152813482, 4973.552380285647, 4992.80028798844, 5128.897422051613, 4425.849279187499, 4704.92942605868, 4930.408350997904, 5118.334616499831, 5200.037992971313], "value": 4464.1794879326335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.98644905442296, 314.47011785142035, 316.66591745708286, 320.91370710146145, 321.63012535584073, 5062.519060689228, 5077.64456488046, 5446.482584154504, 5467.425920278373, 5501.312335958005, 4400.515943246241, 4850.927236091461, 5427.701476418795, 5475.945240547593, 5502.386366475932, 3667.0, 3875.5349358077, 3937.606239376068, 4088.0393107619684, 4102.610252026053, 3472.2881809229175, 4147.274227010261, 4172.311568591194, 4184.0, 4208.263553878074, 4107.507099148092, 4120.361343991686, 4121.0, 4140.047789008529, 4148.211839750437, 3749.7562658427114, 3884.6309600588042, 3900.1203249768773, 4149.564295748933, 4153.273177193979, 3571.339302229096, 3571.678548930609, 3577.4633804929467, 3586.3006713690843, 3630.2920930418577, 5206.609504287194, 5223.347081614798, 5242.292290540767, 5253.0, 5301.628885977983, 3621.692156166729, 4583.381243532147, 4640.559146881041, 4674.322223277606, 4716.268978308368, 5605.355384130837, 5618.185363122365, 5618.943810561883, 5662.348829884575, 5667.716614169275, 3858.266929283427, 3885.1452680410266, 3893.2213557288655, 3901.882943511699, 3902.6292502212245, 5494.5054945054735, 5884.176215329814, 5933.376995415462, 5983.940160598426, 6075.817725468243, 3457.0, 3514.699561162386, 3805.866794662229, 3906.843726250975, 3910.6284902934176, 3347.782394144373, 3361.562996810399, 3966.3143164155117, 3966.8809935701975, 3970.4838371011583, 3519.5248641433077, 4029.0531725044593, 4285.228658841438, 4375.2780791169735, 4602.364132335418, 5617.230572369691, 5676.297110866723, 5706.201131841545, 5790.334111577223, 5810.331811841692, 1096.7203363142348, 1223.5534030079134, 1257.2142410993129, 1301.7526669932683, 1349.7570437321376, 698.8392669686001, 736.6022347932163, 743.5390058163973, 760.4296777416937, 819.9467034642848, 4338.676703605368, 4422.469303683514, 5168.3539557555305, 5267.762950667153, 5354.955783622157, 5527.226188333637, 5568.888622227532, 5832.416758324133, 5883.823485295448, 5948.910766338508, 4408.58118478744, 4439.689221754511, 5282.022825777243, 5308.867278318073, 5322.361316642027, 2793.2178989882864, 3035.5598438226775, 3052.931473984132, 3053.9389212215633, 3054.373853360056, 5290.338707661543, 5511.448855114457, 5516.862078448071, 5701.771929122871, 5949.315828679757, 5220.504052115043, 5486.0, 5608.355039170548, 5964.582479226499, 5976.834517269091, 5716.885662286731, 5936.970315148483, 5942.881142377215, 5947.434993675594, 5959.553033522417, 5506.504414602705, 5512.80705175317, 5796.855078623068, 5811.738471768696, 5816.73824677882, 5693.715314234189, 5702.429757024264, 5711.5145212655725, 5747.51146152565, 5763.596548241583, 4529.6602754794185, 5696.860627874359, 5939.703014849327, 5944.375840536682, 5986.730597123053, 3259.1037464697397, 3582.3372676055014, 3654.3239500692457, 3890.4553362529837, 3895.5325360956867, 5662.886742265049, 5797.420257974169, 5833.733109458717, 5847.473727364558, 5864.384239654945, 5162.561182299547, 5510.8071217507195, 5684.658920464785, 5715.8856822864145, 5721.685307308138, 4868.223098568926, 5649.971750141223, 5669.149627555899, 5713.857153571194, 5741.368449470639, 5604.747786349542, 5614.0, 5631.831045068655, 5639.830805075854, 5654.264945557051, 5431.83704488866, 5550.33583879748, 5674.404187560247, 5755.740991655469, 5783.334916484489, 4643.767811609474, 5587.0, 5597.160425936142, 5600.691961942132, 5605.663660180402], "value": 4102.770563322738, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.4950859152891, 739.9001134846794, 744.3970383988966, 789.9368050555956, 808.341201920435, 15168.317425715843, 15882.36470541177, 15981.200939953014, 16013.59966000849, 16018.35926562936, 14368.137911725304, 14404.0, 14413.207273599948, 14448.349824257908, 14507.564773056825, 700.3486757315694, 719.2447929673822, 853.6542700206427, 866.1468453573225, 874.6982291109557, 862.4738909265343, 881.7266647339313, 884.7257350221452, 888.5468411110348, 888.7111688701166, 932.8367535681263, 935.7473482159813, 936.3258453913205, 936.3585943628602, 936.9786932243853, 729.7810656802938, 889.8709687095335, 925.0887875442684, 927.9814403711922, 929.4748467116092, 686.3856848120954, 688.6659969914588, 688.6797639097794, 692.9237783843773, 693.767587858063, 14497.275136243146, 14531.346089426, 14546.636334091627, 14547.563573092824, 14549.127052376785, 13671.384787684578, 13838.30808459573, 14029.158250505003, 14072.859271407257, 14170.149791012573, 12672.619821405373, 12793.744125117446, 12843.614691559174, 12988.415521301564, 13391.263480508665, 4521.683482156251, 4596.724196548218, 4609.815607375701, 4620.953790462086, 4770.475247722748, 107755.0, 109994.0, 111094.77810443827, 112857.0, 113402.43298783536, 10996.28524145928, 11047.987309141321, 11062.170337224741, 11272.605458809066, 11334.94332528332, 21747.456313592287, 21866.0, 21876.89061554682, 21883.90580471002, 21895.343139705834, 7694.615269236516, 7729.806754831175, 7776.300132988058, 7798.649060792278, 7966.442349035512, 4273.380359847867, 4397.802098905557, 4447.3329000650165, 4462.241418958784, 4568.748718820497, 3409.369266685671, 3523.982380088083, 3822.197338558878, 3984.8406063757125, 4002.9792402937064, 717.8061923280685, 727.6798208788116, 732.9377002954702, 735.9080114985627, 737.9926200737924, 611.6391329115843, 649.7043845050491, 652.5953908576713, 669.4945316286173, 670.2024590737008, 9411.764705882271, 9505.619775208914, 9801.411915285105, 9822.75443113928, 9991.550380232908, 578.8205656246577, 633.4773811605444, 639.6993413095837, 656.7832615236961, 668.4952860590223, 3269.967300327014, 4742.4309082909585, 4804.279358096313, 4805.423349198119, 4847.2729090636685, 115581.422092889, 154275.0, 157512.0, 157705.0, 158934.0, 92730.53634731783, 105300.0, 107844.38233426349, 114017.42991284991, 114370.42814785872, 97437.0, 99583.50208248913, 102545.46181807428, 104250.47874760578, 104340.0, 9498.0, 9543.502147637542, 9888.307818452638, 9920.107190352903, 9939.304248702521, 58877.82244355003, 58983.0, 59465.0, 61788.69105654443, 62507.687461562404, 84882.0, 87382.56308718416, 88721.55639222021, 90622.09377906137, 91895.56731028763, 12942.611721648365, 13067.738645226853, 13072.281024543741, 13435.328233588087, 13688.589342319747, 12608.432620532281, 14598.124112553282, 14623.268836557916, 14817.925910370379, 15307.387704491695, 13680.863191368357, 13808.792868106786, 13914.652133696738, 14263.714725705635, 14301.0, 12098.455569499569, 13677.384517696926, 13913.513027044004, 13936.0, 14431.75044704939, 11662.358570278717, 13577.864221358055, 13631.522896698569, 13925.860741392456, 14164.78752818688, 11024.0, 11188.66434006981, 11404.48679809427, 11530.135239856876, 12241.571544995883, 9669.564869581027, 9969.950150249202, 10533.78932421332, 11257.15571332137, 11555.2489088209], "value": 7889.794726381516, "unit": "score"}], "name": "dromaeo_css", "value": 7377.159668413568, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 114.0, 111.0, 114.0, 112.0, 112.0, 112.0, 112.0, 113.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 107.0, 167.0, 111.0, 137.0, 116.0, 125.0, 204.0, 105.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 183.0, 181.0, 184.0, 179.0, 184.0, 182.0, 183.0, 183.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 58.0, 71.0, 128.0, 79.0, 75.0, 59.0, 67.0, 86.0, 74.0], "value": 77.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 93.0, 71.0, 83.0, 68.0, 97.0, 71.0, 68.0, 103.0], "value": 81.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 84.0, 87.0, 84.0, 86.0, 88.0, 132.0, 112.0], "value": 93.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 92.0, 92.0, 92.0, 91.0, 92.0, 93.0, 92.0], "value": 92.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 85.0, 100.0, 134.0, 131.0, 84.0, 84.0, 83.0, 84.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 52.0, 53.0, 51.0, 51.0, 50.0, 52.0, 51.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 80.0, 72.0, 74.0, 71.0, 70.0, 69.0, 95.0, 102.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 86.0, 87.0, 85.0, 82.0, 84.0, 83.0, 86.0, 86.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 138.0, 147.0, 152.0, 141.0, 139.0, 138.0, 134.0, 139.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 168.0, 165.0, 167.0, 169.0, 168.0, 168.0, 181.0, 216.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 81.0, 89.0, 86.0, 67.0, 66.0, 64.0, 66.0, 66.0, 67.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1463.9, "alertThreshold": 2.0}]} 06:31:51 INFO - Return code: 0 06:31:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:31:51 INFO - # TBPL SUCCESS # 06:31:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:31:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:31:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:31:51 INFO - 2016-08-05 06:31:51.506 screenresolution[1666:10112] starting screenresolution argv=screenresolution get 06:31:51 INFO - 2016-08-05 06:31:51.509 screenresolution[1666:10112] Display 0: 1600x1200x32@60 06:31:51 INFO - 2016-08-05 06:31:51.515 screenresolution[1667:10115] starting screenresolution argv=screenresolution list 06:31:51 INFO - Available Modes on Display 0 06:31:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:31:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:31:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:31:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:31:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:31:51 INFO - Intel Iris: 06:31:51 INFO - Chipset Model: Intel Iris 06:31:51 INFO - Type: GPU 06:31:51 INFO - Bus: Built-In 06:31:51 INFO - VRAM (Dynamic, Max): 1536 MB 06:31:51 INFO - Vendor: Intel (0x8086) 06:31:51 INFO - Device ID: 0x0a2e 06:31:51 INFO - Revision ID: 0x0009 06:31:51 INFO - Displays: 06:31:51 INFO - Display: 06:31:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:31:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:31:51 INFO - Display Serial Number: 1600x1200 60 06:31:51 INFO - Main Display: Yes 06:31:51 INFO - Mirror: Off 06:31:51 INFO - Online: Yes 06:31:51 INFO - Rotation: Supported 06:31:51 INFO - Return code: 0 06:31:51 INFO - Running post-action listener: _resource_record_post_action 06:31:51 INFO - [mozharness: 2016-08-05 13:31:51.758575Z] Finished run-tests step (success) 06:31:51 INFO - Running post-run listener: _resource_record_post_run 06:31:51 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 37073920; Write bytes: 703227904; Read time: 252; Write time: 1955 06:31:51 INFO - TinderboxPrint: CPU usage
53.7% 06:31:51 INFO - TinderboxPrint: I/O read bytes / time
37,073,920 / 252 06:31:51 INFO - TinderboxPrint: I/O write bytes / time
703,227,904 / 1,955 06:31:51 INFO - TinderboxPrint: CPU idle
2,248.1 (46.3%) 06:31:51 INFO - TinderboxPrint: CPU system
974.1 (20.1%) 06:31:51 INFO - TinderboxPrint: CPU user
1,631.5 (33.6%) 06:31:51 INFO - TinderboxPrint: Swap in / out
441,368,576 / 0 06:31:51 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402391552; Write bytes: 396277248; Read time: 30092; Write time: 810 06:31:51 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34948096; Write bytes: 295227904; Read time: 232; Write time: 1108 06:31:52 INFO - Running post-run listener: _upload_blobber_files 06:31:52 INFO - Blob upload gear active. 06:31:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:31:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:31:52 INFO - (blobuploader) - INFO - Open directory for files ... 06:31:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:31:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:31:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:31:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:31:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:31:53 INFO - (blobuploader) - INFO - Done attempting. 06:31:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:31:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:31:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:31:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:31:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:31:54 INFO - (blobuploader) - INFO - Done attempting. 06:31:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:31:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:31:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:31:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:31:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:31:57 INFO - (blobuploader) - INFO - Done attempting. 06:31:57 INFO - (blobuploader) - INFO - Iteration through files over. 06:31:57 INFO - Return code: 0 06:31:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:31:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:31:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bbab2fc491b556f7ea4e795deaf8e775d7cfb8e35e0a12cdef1114b48ec293f1794d119eb2ce173bf10094b0c3f3914e705aaed6f6a879664f6a2d318196130", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8d4d4227296043a03f371f678eb90cfc1d1f39e801ccec60dc4ce9fbd2c82d72260e529f6673ce68fdfafc39701f2a4d2a3f1b233f7b1f16ea5e68540c072c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ebb7a50650f018770b0f04327c2f4e4a87c5eee76b9cb40b12b44dfb6f6b1c103516be58de4bda2f513820891ac0725fa85a1128d26a41113a57a0fdc8d8747"} 06:31:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:31:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:31:57 INFO - Contents: 06:31:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bbab2fc491b556f7ea4e795deaf8e775d7cfb8e35e0a12cdef1114b48ec293f1794d119eb2ce173bf10094b0c3f3914e705aaed6f6a879664f6a2d318196130", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8d4d4227296043a03f371f678eb90cfc1d1f39e801ccec60dc4ce9fbd2c82d72260e529f6673ce68fdfafc39701f2a4d2a3f1b233f7b1f16ea5e68540c072c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ebb7a50650f018770b0f04327c2f4e4a87c5eee76b9cb40b12b44dfb6f6b1c103516be58de4bda2f513820891ac0725fa85a1128d26a41113a57a0fdc8d8747"} 06:31:57 INFO - Running post-run listener: copy_logs_to_upload_dir 06:31:57 INFO - Copying logs to upload dir... 06:31:57 INFO - mkdir: /builds/slave/test/build/upload/logs 06:31:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.326637 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-05 06:31:57.154166) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 06:31:57.157526) ========= 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.03V9UO5uhp/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.CDjJ680tlD/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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/5bbab2fc491b556f7ea4e795deaf8e775d7cfb8e35e0a12cdef1114b48ec293f1794d119eb2ce173bf10094b0c3f3914e705aaed6f6a879664f6a2d318196130", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8d4d4227296043a03f371f678eb90cfc1d1f39e801ccec60dc4ce9fbd2c82d72260e529f6673ce68fdfafc39701f2a4d2a3f1b233f7b1f16ea5e68540c072c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ebb7a50650f018770b0f04327c2f4e4a87c5eee76b9cb40b12b44dfb6f6b1c103516be58de4bda2f513820891ac0725fa85a1128d26a41113a57a0fdc8d8747"} build_url:https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011001 build_url: 'https://queue.taskcluster.net/v1/task/PDQcQntET52vwsKJ6IdveA/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/5bbab2fc491b556f7ea4e795deaf8e775d7cfb8e35e0a12cdef1114b48ec293f1794d119eb2ce173bf10094b0c3f3914e705aaed6f6a879664f6a2d318196130", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8d4d4227296043a03f371f678eb90cfc1d1f39e801ccec60dc4ce9fbd2c82d72260e529f6673ce68fdfafc39701f2a4d2a3f1b233f7b1f16ea5e68540c072c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ebb7a50650f018770b0f04327c2f4e4a87c5eee76b9cb40b12b44dfb6f6b1c103516be58de4bda2f513820891ac0725fa85a1128d26a41113a57a0fdc8d8747"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 06:31:57.190854) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 06:31:57.191242) ========= 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.03V9UO5uhp/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.CDjJ680tlD/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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.005140 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 06:31:57.240350) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 06:31:57.240703) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 06:31:57.241101) ========= ========= Total master_lag: 0.18 =========