builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0326 starttime: 1477932050.36 results: success (0) buildid: 20161031084021 builduid: e7798dc3d5cf4d39b86953fdf7d574cd revision: 182f24158aad396bcf11a3b531ed903d6e10a60c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 09:40:50.362472) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 09:40:50.363068) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 09:40:50.363388) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 09:40:50.389372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 09:40:50.389956) ========= 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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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-10-31 09:40:50-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.0M=0.001s 2016-10-31 09:40:50 (21.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088913 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 09:40:50.502759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 09:40:50.503083) ========= 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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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.024919 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 09:40:50.551128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-31 09:40:50.551473) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 182f24158aad396bcf11a3b531ed903d6e10a60c --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 182f24158aad396bcf11a3b531ed903d6e10a60c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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-10-31 09:40:50,638 truncating revision to first 12 chars 2016-10-31 09:40:50,638 Setting DEBUG logging. 2016-10-31 09:40:50,638 attempt 1/10 2016-10-31 09:40:50,639 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/182f24158aad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 09:40:52,498 unpacking tar archive at: fx-team-182f24158aad/testing/mozharness/ program finished with exit code 0 elapsedTime=2.219451 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-31 09:40:52.793160) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 09:40:52.793768) ========= script_repo_revision: 182f24158aad396bcf11a3b531ed903d6e10a60c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 09:40:52.794286) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 09:40:52.794653) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 09:40:52.813011) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-10-31 09:40:52.813399) ========= /tools/buildbot/bin/python -u 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', '-u', '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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 09:40:53 INFO - MultiFileLogger online at 20161031 09:40:53 in /builds/slave/test 09:40:53 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 09:40:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:40:53 INFO - {'append_to_log': False, 09:40:53 INFO - 'base_work_dir': '/builds/slave/test', 09:40:53 INFO - 'blob_upload_branch': 'Fx-Team', 09:40:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:40:53 INFO - 'branch': 'Fx-Team', 09:40:53 INFO - 'buildbot_json_path': 'buildprops.json', 09:40:53 INFO - 'config_files': ('talos/mac_config.py',), 09:40:53 INFO - 'default_actions': ('clobber', 09:40:53 INFO - 'read-buildbot-config', 09:40:53 INFO - 'download-and-extract', 09:40:53 INFO - 'populate-webroot', 09:40:53 INFO - 'create-virtualenv', 09:40:53 INFO - 'install', 09:40:53 INFO - 'run-tests'), 09:40:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:40:53 INFO - 'download_minidump_stackwalk': True, 09:40:53 INFO - 'download_symbols': 'ondemand', 09:40:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:40:53 INFO - 'tooltool.py': '/tools/tooltool.py', 09:40:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:40:53 INFO - '/tools/misc-python/virtualenv.py')}, 09:40:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:40:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:40:53 INFO - 'installer_path': 'installer.exe', 09:40:53 INFO - 'log_level': 'info', 09:40:53 INFO - 'log_name': 'talos', 09:40:53 INFO - 'log_to_console': True, 09:40:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:40:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:40:53 INFO - 'opt_config_files': (), 09:40:53 INFO - 'pip_index': False, 09:40:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:40:53 INFO - 'cmd': ('bash', 09:40:53 INFO - '-c', 09:40:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:40:53 INFO - 'enabled': True, 09:40:53 INFO - 'halt_on_failure': False, 09:40:53 INFO - 'name': 'check_screen_resolution'},), 09:40:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:40:53 INFO - 'cmd': ('bash', 09:40:53 INFO - '-c', 09:40:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:40:53 INFO - 'enabled': True, 09:40:53 INFO - 'halt_on_failure': False, 09:40:53 INFO - 'name': 'check_screen_resolution'},), 09:40:53 INFO - 'run_cmd_checks_enabled': True, 09:40:53 INFO - 'sps_profile': False, 09:40:53 INFO - 'sps_profile_interval': 0, 09:40:53 INFO - 'suite': 'dromaeojs', 09:40:53 INFO - 'system_bits': '32', 09:40:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:40:53 INFO - 'title': 't-yosemite-r7-0326', 09:40:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:40:53 INFO - 'use_talos_json': True, 09:40:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:40:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:40:53 INFO - 'work_dir': 'build'} 09:40:53 INFO - [mozharness: 2016-10-31 16:40:53.017471Z] Running clobber step. 09:40:53 INFO - Running pre-action listener: _resource_record_pre_action 09:40:53 INFO - Running main action method: clobber 09:40:53 INFO - rmtree: /builds/slave/test/build 09:40:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:40:55 INFO - Running post-action listener: _resource_record_post_action 09:40:55 INFO - [mozharness: 2016-10-31 16:40:55.362677Z] Finished clobber step (success) 09:40:55 INFO - [mozharness: 2016-10-31 16:40:55.362897Z] Running read-buildbot-config step. 09:40:55 INFO - Running pre-action listener: _resource_record_pre_action 09:40:55 INFO - Running main action method: read_buildbot_config 09:40:55 INFO - Using buildbot properties: 09:40:55 INFO - { 09:40:55 INFO - "project": "", 09:40:55 INFO - "product": "firefox", 09:40:55 INFO - "script_repo_revision": "production", 09:40:55 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 09:40:55 INFO - "repository": "", 09:40:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 09:40:55 INFO - "buildid": "20161031084021", 09:40:55 INFO - "pgo_build": "False", 09:40:55 INFO - "basedir": "/builds/slave/test", 09:40:55 INFO - "buildnumber": 12, 09:40:55 INFO - "slavename": "t-yosemite-r7-0326", 09:40:55 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:40:55 INFO - "platform": "yosemite_r7", 09:40:55 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:40:55 INFO - "branch": "fx-team", 09:40:55 INFO - "repo_path": "integration/fx-team", 09:40:55 INFO - "revision": "182f24158aad396bcf11a3b531ed903d6e10a60c", 09:40:55 INFO - "stage_platform": "macosx64", 09:40:55 INFO - "builduid": "e7798dc3d5cf4d39b86953fdf7d574cd", 09:40:55 INFO - "slavebuilddir": "test" 09:40:55 INFO - } 09:40:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 09:40:55 INFO - Running post-action listener: _resource_record_post_action 09:40:55 INFO - [mozharness: 2016-10-31 16:40:55.368666Z] Finished read-buildbot-config step (success) 09:40:55 INFO - [mozharness: 2016-10-31 16:40:55.368820Z] Running download-and-extract step. 09:40:55 INFO - Running pre-action listener: _resource_record_pre_action 09:40:55 INFO - Running main action method: download_and_extract 09:40:55 INFO - mkdir: /builds/slave/test/build/tests 09:40: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')]} 09:40:55 INFO - trying https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 09:40:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:40:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 09:40:56 INFO - Downloaded 1199 bytes. 09:40:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:40:56 INFO - Using the following test package requirements: 09:40:56 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:40:56 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:40:56 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 09:40:56 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:40:56 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 09:40:56 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:40:56 INFO - u'jsshell-mac.zip'], 09:40:56 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:40:56 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 09:40:56 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:40:56 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:40:56 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 09:40:56 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:40:56 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 09:40:56 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:40:56 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 09:40:56 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:40:56 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 09:40:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:40:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:40:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:40:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:40:57 INFO - Http code: 200 09:40:57 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 09:40:57 INFO - x-amz-cf-id: 6fhntEDFPCCI87eCnXmHuuPm9U_HMcrBoWz8tAq8UeYsLmffuSIckQ== 09:40:57 INFO - x-amz-version-id: LdQh88qNdYw5WbujAAXnznc1D0pnugtS 09:40:57 INFO - Expected file size: 16391988 09:40:57 INFO - Obtained file size: 16391988 09:41:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:41:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:41:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:41:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:41:04 INFO - Http code: 200 09:41:04 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 09:41:04 INFO - x-amz-cf-id: 6TefNsCDHsBSYGSQhdwfZfsumf2WBIgbOYVRkPVGUo5PS8baqDQElw== 09:41:04 INFO - x-amz-version-id: LdQh88qNdYw5WbujAAXnznc1D0pnugtS 09:41:05 INFO - Expected file size: 16391988 09:41:05 INFO - Obtained file size: 16391988 09:41:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 09:41:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:41:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 09:41:12 INFO - Http code: 200 09:41:12 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 09:41:12 INFO - x-amz-cf-id: P4n0_6RudAVHw7moWXXMFUc0P9w6FoFhQLF9rwfEZMz0qe_8hsOVBw== 09:41:12 INFO - x-amz-version-id: AU1x3li_GUTSahDXFm_Bf3jZQRGm11EH 09:41:12 INFO - Expected file size: 14409038 09:41:12 INFO - Obtained file size: 14409038 09:41: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')]} 09:41:12 INFO - trying https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:41:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 09:41:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 09:41:15 INFO - Downloaded 112096851 bytes. 09:41:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:41:15 INFO - mkdir: /builds/slave/test/properties 09:41:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:41:15 INFO - Writing to file /builds/slave/test/properties/build_url 09:41:15 INFO - Contents: 09:41:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:41:16 INFO - Running post-action listener: _resource_record_post_action 09:41:16 INFO - Running post-action listener: set_extra_try_arguments 09:41:16 INFO - [mozharness: 2016-10-31 16:41:16.284677Z] Finished download-and-extract step (success) 09:41:16 INFO - [mozharness: 2016-10-31 16:41:16.284797Z] Running populate-webroot step. 09:41:16 INFO - Running pre-action listener: _resource_record_pre_action 09:41:16 INFO - Running main action method: populate_webroot 09:41:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:41:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:41:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:41:16 INFO - '--tppagecycles', 09:41:16 INFO - '7'], 09:41:16 INFO - 'tests': ['tsvgm']}}, 09:41:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:41:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:41:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:41:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:41:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:41:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:41:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:16 INFO - 'talos_options': ['--disable-e10s'], 09:41:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:41:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:41:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:16 INFO - 'talos_options': ['--disable-e10s'], 09:41:16 INFO - 'tests': ['damp', 'tps']}, 09:41:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:16 INFO - 'tests': ['damp', 'tps']}, 09:41:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:41:16 INFO - 'tests': ['dromaeo_dom']}, 09:41:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:41:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:41:16 INFO - 'tests': ['basic_compositor_video']}, 09:41:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:41:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:41:16 INFO - 'tests': ['a11yr', 09:41:16 INFO - 'ts_paint', 09:41:16 INFO - 'tpaint', 09:41:16 INFO - 'sessionrestore', 09:41:16 INFO - 'sessionrestore_no_auto_restore', 09:41:16 INFO - 'tabpaint']}, 09:41:16 INFO - 'other-e10s': {'tests': ['a11yr', 09:41:16 INFO - 'ts_paint', 09:41:16 INFO - 'tpaint', 09:41:16 INFO - 'sessionrestore', 09:41:16 INFO - 'sessionrestore_no_auto_restore', 09:41:16 INFO - 'tabpaint']}, 09:41:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:41:16 INFO - 'ts_paint', 09:41:16 INFO - 'tpaint', 09:41:16 INFO - 'sessionrestore', 09:41:16 INFO - 'sessionrestore_no_auto_restore', 09:41:16 INFO - 'tabpaint']}, 09:41:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:41:16 INFO - 'ts_paint', 09:41:16 INFO - 'tpaint', 09:41:16 INFO - 'sessionrestore', 09:41:16 INFO - 'sessionrestore_no_auto_restore', 09:41:16 INFO - 'tabpaint']}, 09:41:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:41:16 INFO - 'tests': ['a11yr', 09:41:16 INFO - 'ts_paint', 09:41:16 INFO - 'tpaint', 09:41:16 INFO - 'sessionrestore', 09:41:16 INFO - 'sessionrestore_no_auto_restore', 09:41:16 INFO - 'tabpaint']}, 09:41:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:41:16 INFO - 'tests': ['a11yr', 09:41:16 INFO - 'ts_paint', 09:41:16 INFO - 'tpaint', 09:41:16 INFO - 'sessionrestore', 09:41:16 INFO - 'sessionrestore_no_auto_restore', 09:41:16 INFO - 'tabpaint']}, 09:41:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:41:16 INFO - 'tests': ['tsvgx', 09:41:16 INFO - 'tsvgr_opacity', 09:41:16 INFO - 'tart', 09:41:16 INFO - 'tscrollx', 09:41:16 INFO - 'cart']}, 09:41:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:41:16 INFO - 'tsvgr_opacity', 09:41:16 INFO - 'tart', 09:41:16 INFO - 'tscrollx', 09:41:16 INFO - 'cart']}, 09:41:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:16 INFO - 'talos_options': ['--disable-e10s'], 09:41:16 INFO - 'tests': ['tp5o']}, 09:41:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:16 INFO - 'tests': ['tp5o']}, 09:41:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:16 INFO - 'talos_options': ['--disable-e10s', 09:41:16 INFO - '--xperf_path', 09:41:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:41:16 INFO - 'tests': ['tp5n']}, 09:41:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:41:16 INFO - 'talos_options': ['--xperf_path', 09:41:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:41:16 INFO - 'tests': ['tp5n']}}, 09:41:16 INFO - 'talos.zip': {'path': '', 09:41:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:41:16 INFO - Running post-action listener: _resource_record_post_action 09:41:16 INFO - [mozharness: 2016-10-31 16:41:16.303437Z] Finished populate-webroot step (success) 09:41:16 INFO - [mozharness: 2016-10-31 16:41:16.303567Z] Running create-virtualenv step. 09:41:16 INFO - Running pre-action listener: _resource_record_pre_action 09:41:16 INFO - Running main action method: create_virtualenv 09:41:16 INFO - Creating virtualenv /builds/slave/test/build/venv 09:41:16 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 09:41:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:41:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:41:16 INFO - Using real prefix '/tools/python27' 09:41:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:41:17 INFO - Installing distribute.............................................................................................................................................................................................done. 09:41:20 INFO - Installing pip.................done. 09:41:20 INFO - Return code: 0 09:41:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:41:20 INFO - Reading from file tmpfile_stdout 09:41:20 INFO - Output received: 09:41:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:41:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cfcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed72d98c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cddfd30>, '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 0x10cc05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdd7b20>, '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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 09:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:41:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.87V0OWV0Bt/Render', 09:41:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:20 INFO - 'HOME': '/Users/cltbld', 09:41:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:20 INFO - 'LOGNAME': 'cltbld', 09:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:20 INFO - 'MOZ_NO_REMOTE': '1', 09:41:20 INFO - 'NO_EM_RESTART': '1', 09:41:20 INFO - 'PAGER': '/bin/cat', 09:41:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:20 INFO - 'PWD': '/builds/slave/test', 09:41:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:20 INFO - 'SHELL': '/bin/bash', 09:41:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zL5Lj9ajuC/Listeners', 09:41:20 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 09:41:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:20 INFO - 'USER': 'cltbld', 09:41:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:20 INFO - 'XPC_FLAGS': '0x0', 09:41:20 INFO - 'XPC_SERVICE_NAME': '0', 09:41:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:20 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 09:41:20 INFO - Cleaning up... 09:41:20 INFO - Return code: 0 09:41:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cfcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed72d98c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cddfd30>, '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 0x10cc05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdd7b20>, '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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 09:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:41:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.87V0OWV0Bt/Render', 09:41:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:20 INFO - 'HOME': '/Users/cltbld', 09:41:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:20 INFO - 'LOGNAME': 'cltbld', 09:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:20 INFO - 'MOZ_NO_REMOTE': '1', 09:41:20 INFO - 'NO_EM_RESTART': '1', 09:41:20 INFO - 'PAGER': '/bin/cat', 09:41:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:20 INFO - 'PWD': '/builds/slave/test', 09:41:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:20 INFO - 'SHELL': '/bin/bash', 09:41:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zL5Lj9ajuC/Listeners', 09:41:20 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 09:41:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:20 INFO - 'USER': 'cltbld', 09:41:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:20 INFO - 'XPC_FLAGS': '0x0', 09:41:20 INFO - 'XPC_SERVICE_NAME': '0', 09:41:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:20 INFO - Downloading/unpacking psutil>=3.1.1 09:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:41:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:41:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:41:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:41:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:41:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:41:24 INFO - Installing collected packages: psutil 09:41:24 INFO - Running setup.py install for psutil 09:41:24 INFO - building 'psutil._psutil_osx' extension 09:41:24 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 09:41:24 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 09:41:24 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 09:41:24 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 09:41:24 INFO - building 'psutil._psutil_posix' extension 09:41:24 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 09:41:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:41:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:41:25 INFO - ^ 09:41:25 INFO - 1 warning generated. 09:41:25 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 09:41:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:41:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:41:25 INFO - Successfully installed psutil 09:41:25 INFO - Cleaning up... 09:41:25 INFO - Return code: 0 09:41:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:41:25 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')]} 09:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:25 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')]} 09:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:25 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 0x10cfcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed72d98c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cddfd30>, '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 0x10cc05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdd7b20>, '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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 09:41:25 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 09:41:25 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 09:41:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.87V0OWV0Bt/Render', 09:41:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:25 INFO - 'HOME': '/Users/cltbld', 09:41:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:25 INFO - 'LOGNAME': 'cltbld', 09:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:25 INFO - 'MOZ_NO_REMOTE': '1', 09:41:25 INFO - 'NO_EM_RESTART': '1', 09:41:25 INFO - 'PAGER': '/bin/cat', 09:41:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:25 INFO - 'PWD': '/builds/slave/test', 09:41:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:25 INFO - 'SHELL': '/bin/bash', 09:41:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zL5Lj9ajuC/Listeners', 09:41:25 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 09:41:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:25 INFO - 'USER': 'cltbld', 09:41:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:25 INFO - 'XPC_FLAGS': '0x0', 09:41:25 INFO - 'XPC_SERVICE_NAME': '0', 09:41:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:41: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 09:41: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 09:41: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 09:41: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 09:41: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 09:41: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 09:41:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:41:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:41:28 INFO - Installing collected packages: mozsystemmonitor 09:41:28 INFO - Running setup.py install for mozsystemmonitor 09:41:28 INFO - Successfully installed mozsystemmonitor 09:41:28 INFO - Cleaning up... 09:41:28 INFO - Return code: 0 09:41:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:28 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 0x10cfcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed72d98c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cddfd30>, '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 0x10cc05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdd7b20>, '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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 09:41:28 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 09:41:28 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 09:41:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.87V0OWV0Bt/Render', 09:41:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:28 INFO - 'HOME': '/Users/cltbld', 09:41:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:28 INFO - 'LOGNAME': 'cltbld', 09:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:28 INFO - 'MOZ_NO_REMOTE': '1', 09:41:28 INFO - 'NO_EM_RESTART': '1', 09:41:28 INFO - 'PAGER': '/bin/cat', 09:41:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:28 INFO - 'PWD': '/builds/slave/test', 09:41:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:28 INFO - 'SHELL': '/bin/bash', 09:41:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zL5Lj9ajuC/Listeners', 09:41:28 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 09:41:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:28 INFO - 'USER': 'cltbld', 09:41:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:28 INFO - 'XPC_FLAGS': '0x0', 09:41:28 INFO - 'XPC_SERVICE_NAME': '0', 09:41:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:28 INFO - Downloading/unpacking jsonschema==2.5.1 09:41:28 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 09:41:28 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 09:41:28 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 09:41:28 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 09:41:28 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 09:41:28 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 09:41:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:41:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:41:31 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 09:41:31 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 09:41:31 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 09:41:31 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 09:41:31 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 09:41:31 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 09:41:31 INFO - Downloading functools32-3.2.3-2.tar.gz 09:41:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:41:31 INFO - warning: no files found matching '*.txt' 09:41:31 INFO - no previously-included directories found matching 'build' 09:41:31 INFO - no previously-included directories found matching 'dist' 09:41:31 INFO - no previously-included directories found matching '.git*' 09:41:31 INFO - Installing collected packages: jsonschema, functools32 09:41:31 INFO - Running setup.py install for functools32 09:41:31 INFO - warning: no files found matching '*.txt' 09:41:31 INFO - no previously-included directories found matching 'build' 09:41:31 INFO - no previously-included directories found matching 'dist' 09:41:31 INFO - no previously-included directories found matching '.git*' 09:41:31 INFO - Successfully installed jsonschema functools32 09:41:31 INFO - Cleaning up... 09:41:31 INFO - Return code: 0 09:41:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:31 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 0x10cfcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed72d98c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cddfd30>, '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 0x10cc05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdd7b20>, '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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 09:41:31 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 09:41:31 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 09:41:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.87V0OWV0Bt/Render', 09:41:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:31 INFO - 'HOME': '/Users/cltbld', 09:41:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:31 INFO - 'LOGNAME': 'cltbld', 09:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:31 INFO - 'MOZ_NO_REMOTE': '1', 09:41:31 INFO - 'NO_EM_RESTART': '1', 09:41:31 INFO - 'PAGER': '/bin/cat', 09:41:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:31 INFO - 'PWD': '/builds/slave/test', 09:41:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:31 INFO - 'SHELL': '/bin/bash', 09:41:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zL5Lj9ajuC/Listeners', 09:41:31 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 09:41:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:31 INFO - 'USER': 'cltbld', 09:41:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:31 INFO - 'XPC_FLAGS': '0x0', 09:41:31 INFO - 'XPC_SERVICE_NAME': '0', 09:41:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:41:32 INFO - Cleaning up... 09:41:32 INFO - Return code: 0 09:41:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:41: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')]} 09:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41: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')]} 09:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:32 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 0x10cfcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed72d98c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cddfd30>, '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 0x10cc05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdd7b20>, '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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 09:41:32 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 09:41:32 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 09:41:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.87V0OWV0Bt/Render', 09:41:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:32 INFO - 'HOME': '/Users/cltbld', 09:41:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:32 INFO - 'LOGNAME': 'cltbld', 09:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:32 INFO - 'MOZ_NO_REMOTE': '1', 09:41:32 INFO - 'NO_EM_RESTART': '1', 09:41:32 INFO - 'PAGER': '/bin/cat', 09:41:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:32 INFO - 'PWD': '/builds/slave/test', 09:41:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:32 INFO - 'SHELL': '/bin/bash', 09:41:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zL5Lj9ajuC/Listeners', 09:41:32 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 09:41:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:32 INFO - 'USER': 'cltbld', 09:41:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:32 INFO - 'XPC_FLAGS': '0x0', 09:41:32 INFO - 'XPC_SERVICE_NAME': '0', 09:41:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:41:32 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 09:41:32 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 09:41:32 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 09:41:32 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 09:41:32 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 09:41:32 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 09:41:35 INFO - Downloading blobuploader-1.2.4.tar.gz 09:41:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:41:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:41:35 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 09:41:35 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 09:41:35 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 09:41:35 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 09:41:35 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 09:41:35 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 09:41:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:41:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:41:35 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 09:41:35 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 09:41:35 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 09:41:35 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 09:41:35 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 09:41:35 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 09:41:36 INFO - Downloading docopt-0.6.1.tar.gz 09:41:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:41:36 INFO - Installing collected packages: blobuploader, requests, docopt 09:41:36 INFO - Running setup.py install for blobuploader 09:41:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:41:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:41:36 INFO - Running setup.py install for requests 09:41:37 INFO - Running setup.py install for docopt 09:41:37 INFO - Successfully installed blobuploader requests docopt 09:41:37 INFO - Cleaning up... 09:41:37 INFO - Return code: 0 09:41:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:41: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')]} 09:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41: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')]} 09:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:37 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 0x10cfcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed72d98c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cddfd30>, '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 0x10cc05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdd7b20>, '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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 09:41:37 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 09:41:37 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 09:41:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.87V0OWV0Bt/Render', 09:41:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:37 INFO - 'HOME': '/Users/cltbld', 09:41:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:37 INFO - 'LOGNAME': 'cltbld', 09:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:37 INFO - 'MOZ_NO_REMOTE': '1', 09:41:37 INFO - 'NO_EM_RESTART': '1', 09:41:37 INFO - 'PAGER': '/bin/cat', 09:41:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:37 INFO - 'PWD': '/builds/slave/test', 09:41:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:37 INFO - 'SHELL': '/bin/bash', 09:41:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zL5Lj9ajuC/Listeners', 09:41:37 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 09:41:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:37 INFO - 'USER': 'cltbld', 09:41:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:37 INFO - 'XPC_FLAGS': '0x0', 09:41:37 INFO - 'XPC_SERVICE_NAME': '0', 09:41:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:41:37 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-YNqYgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:41:37 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-31ieSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:41:37 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-WO1FMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:41:37 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-hRSfMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:41:37 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-ssk7Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:41:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Uf96DZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:41:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-UwH7AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:41:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-1jT0Je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:41:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-wvQRGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:41:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-0KrUtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:41:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-8XsGEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:41:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Y1V9XO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:41:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-d_4Udq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:41:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-FVQaGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:39 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-OpkG48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:41:39 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-SU5eag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:41:39 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-YlCe4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:41:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:41:39 INFO - Running setup.py install for manifestparser 09:41:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:41:39 INFO - Running setup.py install for mozcrash 09:41:39 INFO - Running setup.py install for mozdebug 09:41:39 INFO - Running setup.py install for mozdevice 09:41:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:41:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:41:39 INFO - Running setup.py install for mozfile 09:41:40 INFO - Running setup.py install for mozhttpd 09:41:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:41:40 INFO - Running setup.py install for mozinfo 09:41:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:41:40 INFO - Running setup.py install for mozInstall 09:41:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:41:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:41:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:41:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:41:40 INFO - Running setup.py install for mozleak 09:41:40 INFO - Running setup.py install for mozlog 09:41:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:41:40 INFO - Running setup.py install for moznetwork 09:41:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:41:40 INFO - Running setup.py install for mozprocess 09:41:41 INFO - Running setup.py install for mozprofile 09:41:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:41:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:41:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:41:41 INFO - Running setup.py install for mozrunner 09:41:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:41:41 INFO - Running setup.py install for mozscreenshot 09:41:41 INFO - Running setup.py install for moztest 09:41:41 INFO - Running setup.py install for mozversion 09:41:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:41:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:41:41 INFO - Cleaning up... 09:41:41 INFO - Return code: 0 09:41:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:41:41 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')]} 09:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:41 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')]} 09:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:42 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 0x10cfcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed72d98c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cddfd30>, '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 0x10cc05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdd7b20>, '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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 09:41:42 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 09:41:42 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 09:41:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.87V0OWV0Bt/Render', 09:41:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:42 INFO - 'HOME': '/Users/cltbld', 09:41:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:42 INFO - 'LOGNAME': 'cltbld', 09:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:42 INFO - 'MOZ_NO_REMOTE': '1', 09:41:42 INFO - 'NO_EM_RESTART': '1', 09:41:42 INFO - 'PAGER': '/bin/cat', 09:41:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:42 INFO - 'PWD': '/builds/slave/test', 09:41:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:42 INFO - 'SHELL': '/bin/bash', 09:41:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zL5Lj9ajuC/Listeners', 09:41:42 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 09:41:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:42 INFO - 'USER': 'cltbld', 09:41:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:42 INFO - 'XPC_FLAGS': '0x0', 09:41:42 INFO - 'XPC_SERVICE_NAME': '0', 09:41:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:41:42 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Qy0QHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:41:42 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)) 09:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:41:42 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-dlfpM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:41:42 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)) 09:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:41:42 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-LlHyAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:41:42 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)) 09:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:41:42 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-lgWPgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:41:43 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)) 09:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:41:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-fPXmIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:41:43 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)) 09:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:41:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-FZM6rB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:41:43 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)) 09:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:41:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-seqBbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:41:43 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)) 09:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:41:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-G9GKsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:41:43 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)) 09:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:41:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-xeDJJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:41:43 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)) 09:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:41:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-WOzD91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:41:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 09:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:41:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-GBM_FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:41:43 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)) 09:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:41:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-ydrPa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:41:43 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)) 09:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:41:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-SO453D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:41:43 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)) 09:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:41:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-5hqvYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:41:44 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)) 09:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-VPkq5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:44 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)) 09:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:41:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-LG3USZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:41:44 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)) 09:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:41:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-vMPJsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:41:44 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)) 09:41:44 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)) 09:41:44 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)) 09:41:44 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)) 09:41:44 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)) 09:41:44 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)) 09:41:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:41:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:41:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:41:47 INFO - Downloading blessings-1.6.tar.gz 09:41:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:41:47 INFO - Installing collected packages: blessings 09:41:47 INFO - Running setup.py install for blessings 09:41:47 INFO - Successfully installed blessings 09:41:47 INFO - Cleaning up... 09:41:47 INFO - Return code: 0 09:41:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:41:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:41:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:41:47 INFO - Reading from file tmpfile_stdout 09:41:47 INFO - Current package versions: 09:41:47 INFO - blessings == 1.6 09:41:47 INFO - blobuploader == 1.2.4 09:41:47 INFO - docopt == 0.6.1 09:41:47 INFO - functools32 == 3.2.3-2 09:41:47 INFO - jsonschema == 2.5.1 09:41:47 INFO - manifestparser == 1.1 09:41:47 INFO - mozInstall == 1.12 09:41:47 INFO - mozcrash == 0.17 09:41:47 INFO - mozdebug == 0.1 09:41:47 INFO - mozdevice == 0.48 09:41:47 INFO - mozfile == 1.2 09:41:47 INFO - mozhttpd == 0.7 09:41:47 INFO - mozinfo == 0.9 09:41:47 INFO - mozleak == 0.1 09:41:47 INFO - mozlog == 3.4 09:41:47 INFO - moznetwork == 0.27 09:41:47 INFO - mozprocess == 0.23 09:41:47 INFO - mozprofile == 0.28 09:41:47 INFO - mozrunner == 6.12 09:41:47 INFO - mozscreenshot == 0.1 09:41:47 INFO - mozsystemmonitor == 0.3 09:41:47 INFO - moztest == 0.7 09:41:47 INFO - mozversion == 1.4 09:41:47 INFO - psutil == 3.1.1 09:41:47 INFO - requests == 1.2.3 09:41:47 INFO - wsgiref == 0.1.2 09:41:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:41: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')]} 09:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41: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')]} 09:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:47 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 0x10cfcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed72d98c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cddfd30>, '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 0x10cc05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdd7b20>, '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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 09:41:47 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 09:41:47 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 09:41:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.87V0OWV0Bt/Render', 09:41:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:47 INFO - 'HOME': '/Users/cltbld', 09:41:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:47 INFO - 'LOGNAME': 'cltbld', 09:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:47 INFO - 'MOZ_NO_REMOTE': '1', 09:41:47 INFO - 'NO_EM_RESTART': '1', 09:41:47 INFO - 'PAGER': '/bin/cat', 09:41:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:47 INFO - 'PWD': '/builds/slave/test', 09:41:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:47 INFO - 'SHELL': '/bin/bash', 09:41:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zL5Lj9ajuC/Listeners', 09:41:47 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 09:41:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:47 INFO - 'USER': 'cltbld', 09:41:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:47 INFO - 'XPC_FLAGS': '0x0', 09:41:47 INFO - 'XPC_SERVICE_NAME': '0', 09:41:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:48 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)) 09:41:48 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)) 09:41:48 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)) 09:41:48 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)) 09:41:48 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)) 09:41:48 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)) 09:41:48 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)) 09:41:48 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)) 09:41:48 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)) 09:41:48 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)) 09:41:48 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)) 09:41:48 INFO - Cleaning up... 09:41:48 INFO - Return code: 0 09:41:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:48 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 0x10cfcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed72d98c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cddfd30>, '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 0x10cc05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdd7b20>, '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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 09:41:48 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 09:41:48 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 09:41:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.87V0OWV0Bt/Render', 09:41:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:48 INFO - 'HOME': '/Users/cltbld', 09:41:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:48 INFO - 'LOGNAME': 'cltbld', 09:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:48 INFO - 'MOZ_NO_REMOTE': '1', 09:41:48 INFO - 'NO_EM_RESTART': '1', 09:41:48 INFO - 'PAGER': '/bin/cat', 09:41:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:48 INFO - 'PWD': '/builds/slave/test', 09:41:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:48 INFO - 'SHELL': '/bin/bash', 09:41:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zL5Lj9ajuC/Listeners', 09:41:48 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 09:41:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:48 INFO - 'USER': 'cltbld', 09:41:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:48 INFO - 'XPC_FLAGS': '0x0', 09:41:48 INFO - 'XPC_SERVICE_NAME': '0', 09:41:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:41:48 INFO - Cleaning up... 09:41:48 INFO - Return code: 0 09:41:48 INFO - Running post-action listener: _resource_record_post_action 09:41:48 INFO - Running post-action listener: _start_resource_monitoring 09:41:48 INFO - Starting resource monitoring. 09:41:48 INFO - [mozharness: 2016-10-31 16:41:48.515336Z] Finished create-virtualenv step (success) 09:41:48 INFO - [mozharness: 2016-10-31 16:41:48.516328Z] Running install step. 09:41:48 INFO - Running pre-action listener: _resource_record_pre_action 09:41:48 INFO - Running main action method: install 09:41:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:41:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:41:48 INFO - Reading from file tmpfile_stdout 09:41:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:41:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:41:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:41:48 INFO - Reading from file tmpfile_stdout 09:41:48 INFO - Output received: 09:41:48 INFO - Usage: mozinstall [options] installer 09:41:48 INFO - Options: 09:41:48 INFO - -h, --help show this help message and exit 09:41:48 INFO - -d DEST, --destination=DEST 09:41:48 INFO - Directory to install application into. [default: 09:41:48 INFO - "/builds/slave/test"] 09:41:48 INFO - --app=APP Application being installed. [default: firefox] 09:41:48 INFO - mkdir: /builds/slave/test/build/application 09:41:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:41:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:42:24 INFO - Reading from file tmpfile_stdout 09:42:24 INFO - Output received: 09:42:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:42:24 INFO - Running post-action listener: _resource_record_post_action 09:42:24 INFO - [mozharness: 2016-10-31 16:42:24.016908Z] Finished install step (success) 09:42:24 INFO - [mozharness: 2016-10-31 16:42:24.017062Z] Running run-tests step. 09:42:24 INFO - Running pre-action listener: _resource_record_pre_action 09:42:24 INFO - Running main action method: run_tests 09:42:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:42:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:42:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:42:24 INFO - 2016-10-31 09:42:24.031 screenresolution[1646:7413] starting screenresolution argv=screenresolution get 09:42:24 INFO - 2016-10-31 09:42:24.034 screenresolution[1646:7413] Display 0: 1600x1200x32@60 09:42:24 INFO - 2016-10-31 09:42:24.040 screenresolution[1647:7415] starting screenresolution argv=screenresolution list 09:42:24 INFO - Available Modes on Display 0 09:42:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:42:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:42:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:42:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:42:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:42:24 INFO - Intel Iris: 09:42:24 INFO - Chipset Model: Intel Iris 09:42:24 INFO - Type: GPU 09:42:24 INFO - Bus: Built-In 09:42:24 INFO - VRAM (Dynamic, Max): 1536 MB 09:42:24 INFO - Vendor: Intel (0x8086) 09:42:24 INFO - Device ID: 0x0a2e 09:42:24 INFO - Revision ID: 0x0009 09:42:24 INFO - Displays: 09:42:24 INFO - Display: 09:42:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:42:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:42:24 INFO - Display Serial Number: 1600x1200 60 09:42:24 INFO - Main Display: Yes 09:42:24 INFO - Mirror: Off 09:42:24 INFO - Online: Yes 09:42:24 INFO - Rotation: Supported 09:42:24 INFO - Return code: 0 09:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:42:24 INFO - Python 2.7.3 09:42:24 INFO - Return code: 0 09:42:24 INFO - grabbing minidump binary from tooltool 09:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:24 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 0x10cddfd30>, '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 0x10cc05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cdd7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:42:24 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 09:42:24 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 09:42:24 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 09:42:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:42:24 INFO - Return code: 0 09:42:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:42:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:42:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:42:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:42:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:42:24 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/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0326', '--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 09:42:24 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/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0326 --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 09:42:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.87V0OWV0Bt/Render', 09:42:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:24 INFO - 'HOME': '/Users/cltbld', 09:42:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:24 INFO - 'LOGNAME': 'cltbld', 09:42:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:42:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:24 INFO - 'MOZ_NO_REMOTE': '1', 09:42:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:42:24 INFO - 'NO_EM_RESTART': '1', 09:42:24 INFO - 'PAGER': '/bin/cat', 09:42:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:24 INFO - 'PWD': '/builds/slave/test', 09:42:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:42:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:24 INFO - 'SHELL': '/bin/bash', 09:42:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zL5Lj9ajuC/Listeners', 09:42:24 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 09:42:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:24 INFO - 'USER': 'cltbld', 09:42:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:24 INFO - 'XPC_FLAGS': '0x0', 09:42:24 INFO - 'XPC_SERVICE_NAME': '0', 09:42:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:24 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/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0326', '--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 09:42:24 INFO - mozversion application_buildid: 20161031084021 09:42:24 INFO - mozversion application_changeset: 182f24158aad396bcf11a3b531ed903d6e10a60c 09:42:24 INFO - mozversion application_display_name: Nightly 09:42:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:42:24 INFO - mozversion application_name: Firefox 09:42:24 INFO - mozversion application_remotingname: firefox 09:42:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:42:24 INFO - mozversion application_vendor: Mozilla 09:42:24 INFO - mozversion application_version: 52.0a1 09:42:24 INFO - mozversion platform_buildid: 20161031084021 09:42:24 INFO - mozversion platform_changeset: 182f24158aad396bcf11a3b531ed903d6e10a60c 09:42:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:42:24 INFO - mozversion platform_version: 52.0a1 09:42:24 INFO - using testdate: 1477932144 09:42:24 INFO - actual date: 1477932144 09:42:24 INFO - starting webserver on 'localhost:49269' 09:42:24 INFO - SUITE-START | Running 2 tests 09:42:24 INFO - TEST-START | dromaeo_css 09:42:24 INFO - operating with platform_type : mac_ 09:42:24 INFO - Initialising browser for dromaeo_css test... 09:42:24 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpXnNUt9/profile http://localhost:49269/getInfo.html) 09:42:27 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 09:42:27 INFO - PROCESS | 1657 | colorDepth:24 09:42:27 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 09:42:27 INFO - PROCESS | 1657 | __metrics 09:42:27 INFO - PROCESS | 1657 | 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" 09:42:27 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:42:28 INFO - TEST-INFO | 1657: exit 0 09:42:28 INFO - Browser initialized. 09:42:28 INFO - Running cycle 1/1 for dromaeo_css test... 09:42:28 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpXnNUt9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:42:40 INFO - PROCESS | 1662 | RSS: Main: 233115648 09:42:40 INFO - PROCESS | 1662 | 09:43:31 INFO - PROCESS | 1662 | 1477932211799 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] 09:45:45 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 09:45:46 INFO - PROCESS | 1662 | RSS: Main: 381378560 09:45:46 INFO - PROCESS | 1662 | 09:48:49 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 09:48:50 INFO - PROCESS | 1662 | RSS: Main: 376389632 09:48:50 INFO - PROCESS | 1662 | 09:51:52 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 09:51:53 INFO - PROCESS | 1662 | RSS: Main: 360677376 09:51:53 INFO - PROCESS | 1662 | 09:54:55 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 09:54:55 INFO - PROCESS | 1662 | RSS: Main: 345292800 09:54:55 INFO - PROCESS | 1662 | 09:57:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 09:57:59 INFO - PROCESS | 1662 | RSS: Main: 331685888 09:57:59 INFO - PROCESS | 1662 | 10:01:03 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 10:01:03 INFO - PROCESS | 1662 | RSS: Main: 377208832 10:01:03 INFO - PROCESS | 1662 | 10:01:03 INFO - PROCESS | 1662 | __start_tp_report 10:01:03 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 10:01:03 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 10:01:03 INFO - PROCESS | 1662 | |i|pagename|runs| 10:01:03 INFO - PROCESS | 1662 | |0;dojo.html;3305.1076209423454;3321.983390083051;3351.1287065363;3372.359251742167;3392.0841372829336;5510;5622.943770562293;5652.236948012022;5686.3744988051285;5725.112607545831;5652.06740887754;5677.772889084432;5711.914321285174;5711.971440142804;5727.971360143193;5125.077486052509;5137.666051706646;5147.305113809625;5176.715280659562;5194.27280180775;5249.973750131244;5254.710990895499;5261.947380526203;5272.209168624718;5276.445973172819;5163.380394352683;5197.194434862602;5240.397354304247;5249;5250.4487028861995;5279.577633789307;5286.656367336111;5289.559948346058;5295.814646487393;5310.548603368718;5020.347354843883;5144.485551444863;5193;5222.73886305687;5230.816921407771;5595.244641973322;5641.182028605829;5643.915341269884;5670.036093864053;5692.203091567184;6128.3258841527395;6154.046122850965;6175.536834737368;6187.845303867394;6203.2866220384785;6127.172831667713;6137.9386206137815;6159.3224745277985;6188.783392581283;6198.4731297839735;5699.430056994309;5758.568107391879;5769.567282453832;5770.942290577124;5872.0898260769645;6212.161358216583;6219.844503887439;6227.875442491216;6230.065490176419;6235.314115447297;6120.816375508742;6129.988551888978;6151.692415379213;6155.076738489262;6164.106204600397;6046.334903160737;6102.115193296947;6130.165000698321;6144.047672610753;6220.502359811204;6111.297200821962;6118.619179173164;6136.188830398254;6186.876262474725;6189.35011823761;6149.96925015381;6181.536384771161;6184.783532576338;6187.288461826857;6191.380861913773;4848.612111031109;4868.196747536687;4926.704397736147;4940.1601727706375;4959.603231741452;4393.890152746207;4412.161689279027;4436.3123715824095;4453.844115455943;4454.77726113693;5783.884322313615;5788.681622510802;5798.82603521895;5808.709564521757;5843.2695913010875;5602.59935016246;5816.447437493432;6235.688215589203;6237.5321850860455;6244.188255526843;5598.552115830806;5659.151127330851;5688.203651488795;5777.133429985536;5791.015527360359;5363.678179309254;5378.838634840961;5411.702356370359;5455.781768729285;5461.044317244467;6280;6292.622442653455;6296.5592408530965;6309.968450157903;6315.873682526232;6090.786822461193;6228.750849965951;6230.6884655766125;6237.313895471585;6270.090836828543;6175.96912015437;6186.412290832363;6253.405926436982;6254.530910181664;6285.49716022708;6133.815985520441;6166.938330616816;6168.660723660242;6177.320494745664;6186.845328866634;6049.770524223511;6181.258249010148;6212;6219.440250377488;6220.7511699533325;6088.117223002729;6091.847703807441;6105.9084113737445;6115.6859809352345;6130.816075517741;5913.733881975236;5951.791687290924;5983.222181116427;6021.096835474714;6075.210222671201;5946.07835785454;5948.762049517971;5952.285725712769;5966.254218222723;5993.520518358434;6053.364396738279;6073.544484163794;6100.481459075851;6101.816945491642;6105.236845394325;5783.306003279465;5847.035239185487;5856.619319744203;5876.382979787232;5940.108983652487 10:01:03 INFO - PROCESS | 1662 | |1;ext.html;462.72467881610453;482.0335227868125;497.72376331136206;524.5200641413107;532.6777299733664;30750.077497675076;39876.40185397218;41103.58896411042;41145.7942710286;43784.78107609465;42625;42990;43003.97944287802;43077;43268;9451.763705907355;9645.083717046904;9650.613975440974;9651.5174241288;9675.177609903167;9417.952910235474;9516.286278529104;9522.428654280731;9532.237421006303;9535.99872013439;9380.296477764161;9463.621455141785;9534.332596718232;9541.95229023854;9585.2811039172;9442.905570944306;9510.33427660064;9513.857292140623;9514.714558563253;9531.857022144673;9313.813723725556;9380.8592871107;9395.34232603718;9441.952790236073;9452.57463414148;40573;40672.38991415131;40979.590204097876;41002.38496422556;41082.178356433;3414.539037229967;3415.590129184489;3474.6351633078666;3624.8912532624063;3811.6950643948417;30572.8471357644;30697.539536906963;30764.53853192204;31069.689303106905;31611.84194079015;3167.461531539621;3206.71139597435;3206.8717251309918;3237.27161388688;3322.0864262327814;460701;461395;462656.9999999966;463058;464875;57755.42244577585;58044;58056.70971645115;58073.70963145157;58087.41912580904;34238;34645.826770865984;34775.956721298404;60456.69771651114;60551.69724151351;15849.603759906095;16177.654240135114;16223.918880405523;16239.944403613727;16244.02535847853;10284.948575257076;11984.880151198551;11993.88006119945;12580.496780128693;12581.55964541255;18299.359522416653;18307.267709291744;18313.90843045803;18981.33565325207;19007.239710411428;6413.236360000944;6460.967695161494;7568.508046976929;7675.2324767522805;7685;725.2493669052611;965.0012237334325;967.1634036558327;969.4425705219527;1029.6228370943318;28984.42031159365;29515.55726664102;29729.12290505565;29953.951611693486;29968.10095697089;1061.7398737309409;1070.2936062198912;1089.2538611051455;1098.5770478365887;1104.1829046505527;13139.488958769864;14509.347079381454;15322;15588.610284742972;15716.764248536281;605935;639090;639796;640199;640422.7978860076;57241.42758572444;57661.71169144211;57809.71095144581;57811;57994;1325.701717113661;1366.9589912302647;1385.3419625677723;1385.5081446086695;1389.7915312703176;25030.37424064413;28347.716522834507;29034.564481533216;29531.818727251528;29762.553561696157;42568.78715606402;48456.27315590198;48618.5138148614;48842.0231595359;48890;530786;533346;533486;534272;535439;24904.50190996134;26510.204693859214;26963.1911042669;27144.1856744298;27759.44481110326;46034.53965460436;46355.53644463512;46870.06259874852;47276.29085563788;47616;38496.6150338493;38649.03377415587;38793.612063879;39592;39717.80141099276;32640.510392343658;33329.166770830925;38413.039674008374;39599.40600891047;39806.20387592174;36606.63393366032;37125.06625583914;37273.88178354654;38305.6169438302;38375.80812095922;31216;32350.676493234765;33210;34098.31803363968;34233.657663423044;23587.64618530689;24961.625575616745;25386.821196008674;25571.872140639178;25853.22440326718 10:01:03 INFO - PROCESS | 1662 | |2;jquery.html;301.32954176956264;318.99840500797495;358.5732977756471;374.8144668389147;401.7669751544105;14859;15689.92155039226;16182.595435114114;20335.18659253628;20534;19504.60990780187;20205.292814751487;21010.36968890936;21039.158433662673;21162.57674846502;5834.883302333951;6042.033274676052;6104.2980057293535;6104.786332478364;6108.511319094484;4196.685248606352;5127.9230811537855;6662.167229096363;6746.662666866661;6866.450683945272;6463.062855885893;6685.4985876059245;6787.389134977851;6795.082663840368;6806.829829254259;6593.439557637606;6622.006698995166;6669.566478178903;6684;6708.932910670879;5504.559635229172;5768.278965129359;5831.970840145815;5835;5839.357670656224;22272.777272227395;24879.004839806385;25296.747032529805;25913.481730365475;26282.474350513075;2272.3296627494765;2370.7369639400504;2381.4760752634393;3045.1321373408696;3077.3691393264326;14856.777148342675;14963.326650300764;15527.922360388238;16144.273507692182;16185.866989310753;1752.8247175282497;1814.1836173721747;1839.7884243311923;1979.5546002149545;2045.509077821312;128123;138138;139327.30336348354;149245.99999999892;157659.2117039419;16607.252673629715;20286.594268114553;21310.467238319165;21433.89283053606;21470.926453677253;36142.8192859034;36164.45753313702;36212.27575448476;36317.54983276584;36392.09019774527;10045.196384289386;10370.948145259375;10643.680689579325;10806.459677016117;11030.834537481944;8716;8750.168733970262;8834.204921556962;9032.819343613091;9033.954830225806;9496.148251090972;9559.42643441382;9645.565949532287;9675.516224188763;9720.416774993522;3561.893143205708;3678.393065144221;3678.668919797231;3682.735117902471;3684.6366844267254;836.3016880904391;841.4404421059927;882.3382463152635;894.3259653635582;969.9660511882191;20200.898995505224;20985.139022051797;21198.894005530183;21223.363299101053;21667.808270545273;852.5779739029097;870.8301881133118;904.3036861616519;917.977050573741;987.116530705015;9517.714468565953;10811.027007569199;10862.402567858844;10905;10927.890721092846;494467;555760;565266;567623;612409;73567;133968.66031339756;135397.64602353852;135570;140482;939.6006697153682;941.4022095969109;973.2894986659636;976.6728146071146;976.7313988653035;14990.175540345386;16980.72644551639;18214.180361884013;18552.44342669722;18893.527661808566;55843.16235256556;56606.43393566012;56679.71660141673;57031.42968570261;58049;75546;78668;79963.60018200104;80913;81293.59353203433;6797.150356205474;6947.40947019509;7027.824304392431;7932;8171.223733745284;11624.128190385585;11990.040796736415;12138.878611213775;12231.816522752344;12274.75450491003;10014.799704005733;10091.293609447268;10488.790224195625;10525.57904682858;10574.312669676447;9813.55838987233;10150.847737283799;10310.639127630497;10491.527881245209;10596.576136954436;10228.079472847181;10387.94806025965;10858.511366988347;10868.565257389615;10891.0742586881;5391.433899440659;7022.4382049436945;7098.041764361745;7178.282171782989;7190.712371505081;8161.347092232489;9791.167750741266;10408.687739367831;10510;10576.576936922746 10:01:03 INFO - PROCESS | 1662 | |3;mootools.html;1358.1647286918549;1485.435534496891;1531.9540413787586;1746.8078511363747;1928.113067988725;7453.888191677122;7760.883586746197;8116.797080072994;8236.38227132966;8356.206160414766;8179.01851777786;8252.958735206315;8262.793430164249;8269.173082691728;8280.585970701455;2268.9432764180906;2297.5519773644146;2301.9539609207804;2304.781045800646;2306.8731219782903;2280.3614987803358;2319.188284100568;2335.8832058397097;2338.240071976606;2341.344423561397;2265.796078352948;2277.350954977832;2307.215546714117;2309.6650985607075;2309.6650985607075;2255.1430456426615;2273.818094552432;2295.4490922178725;2296.827737919646;2303.481716613757;2297.5864344417996;2306.850054746436;2309.8383113182085;2315.9421014474606;2320.025589252518;8197.836043279161;8253.133420990769;8297.087320394752;8299.751007469786;8323.750287491384;4992.126377883892;5032.144535428949;5163.793448262065;5233.528982391603;5245.973770131163;3370.7640465167447;3533;3562.2163124112653;3617.276544691072;3631.927361452756;1008.2135933971514;1034.5965073621294;1062.8033813744482;1063.0857462582173;1071.1537885070784;10682.465876706134;10713.625023124154;10797.514111864906;10799.622013229498;10818.513166907507;4189.308764053958;4360.367746676714;4426.8490192549525;4430.556944305544;4439.533848945879;8430;8552.059273479912;8610.827783444296;8615.181557752003;8617.138286171457;4998.400191976986;5075.467075957045;5075.720835354091;5081.415637201695;5098.668586541863;3750.7937063461773;3767.8411019063997;4284.742915425022;4433.578810013044;4761.166795810719;3579.6420357963993;3594.370985077653;3603.207294395229;3653.06846754076;3674.761140525857;1112.8330750387506;1116.2242241642143;1116.9050630696481;1123.7864805686893;1130.559081958037;737.7860420478002;840.8906842110487;855.2772906893789;923.29190996657;972.3242346569208;4836.371271734652;5393.7572809223675;5737.971310143506;5870;5968.761249550056;382.757950450789;430.87073877836525;431.93520971854474;433.8980339620187;437.6214574393127;3846.74996125251;3884.320243957296;3906.199229158016;3953.011747063234;4027.7381970172432;9568.521573921276;10113.494325283706;10117.342372745748;10150.340227885312;10155;8971.865422018675;9928.453935033498;10121.139703125169;10123.341982771097;10126.189904807597;7617.428692848059;7732.304092631803;7732.6906923723545;7866.213378662203;7893.052833659997;5555.333359996826;5674.2623458950075;5686.374498805046;5772.393898640582;5914.911276330945;9207.677731279373;9208.815823683355;9310.95344523273;9332.30007749408;9435.150836424755;8165.387595930448;9205.204985028124;9354.877414710278;9383.577739001625;9424.057594240796;6721.126253587003;6724.159480064992;6791.660416979033;6814.182298124257;6817.93182068173;7707.576083315472;7778.883316750366;7786.961065194638;7825.100113486794;7830.491018083806;6091.299500557493;7086.149662040588;7160.498765086394;7160.606166660884;7236.095488063992;6822.795316140524;6958.478114141359;6996.230414654486;7051.929480705127;7118.786436406916;6588.901166482411;6648.634325112165;6714.697838597177;6717.966410167918;6722.798316050526;4790.640701947298;4793.065352256276;4830.565249127595;4851.417829860439;4959.578435832995;4703.647226457961;4812.494688057704;4838.782254798472;4867.488913664014;4957.429895562056 10:01:03 INFO - PROCESS | 1662 | |4;prototype.html;241.17397912150878;294.4493796600357;294.59640292798855;305.60729462640506;310.42106471430776;4086.8569600064;4989.307912145009;5048.899022019557;5098.413682426522;5137.666051706637;4427.955720442795;4975.328330675357;5165.664231824938;5191.935653191096;5247.816326428576;3138.7018233267804;3823.713221508384;3903.941440878389;3956.347202711549;3959.6238357356006;3220.6296275928216;3917.4123881417872;3923.4507168996365;3971.319359432386;3977.840886364542;3039.4832878410725;3555.6266592007855;3608.873689420871;3962.48487696599;3967.8809635710977;3368.376850282681;3575.964240357589;3921.8039098044983;3955.545112312078;3962.6433620974108;2784.429192015632;3409.0568376025676;3421.196018935573;3428.9485657715154;3433.7424693147864;4491.573300536444;4759.071980963713;4949.505049495057;5147.279380886679;5161.1742121260795;3751.9869635198343;4415.227335216325;4459.509453960061;4470.530594287586;4509.143262780094;4490.461144662629;4525.683202175849;5354.839354819362;5436.178880075179;5490.80782172626;3722.590515043343;3733.770288700282;3735.533058367704;3751.1559899022773;3754.380527213034;5110.310108135392;5359.705216213107;5648.519875810603;5657.953278643464;5668.914966275509;3278.606567211902;3683.079230192452;3747.4004159334377;3792.089898424358;3800.201957588937;3629.8729544466346;3803.2393521295853;3866.5780784005797;3867.941980870289;3878.70909681775;3702.8703995360033;4239.364095385655;4384.254676704968;4511.1654343946475;4535.4103966484145;4844.273358996108;5114.3862736471865;5417.241586177938;5427.3215848019;5455.727213639302;1107.5237647811357;1269.2701696524534;1312.1798875702686;1319.280991859439;1320.5378117658743;742.6583771465187;782.9960850195713;801.6372167315587;812.6302532347768;813.8768499470692;3376.8818091366684;3572.6235361681734;3796.9430458543143;3998.421018443146;4197.643200327945;3958.5645578986287;3980.3631418973405;4018.6383225509844;4444.266695995189;4596.88507787308;3547.5986985140726;3745.4756334113245;3981.3172815146454;4205.3481710334945;4230.682698797603;2416.383822125347;2449.6692946452;2520.798336133105;2636.5254254234424;2755.0357374919017;5005.824796132118;5017.37282839645;5080.695158290514;5674.638086859124;5724.685142317213;5654.180143879197;5669.262995810601;5674.716264186774;5675.928286175516;5698.6580805151825;4572.611328037154;5654.995329133746;5674.467893668769;5692.743826527816;5768.538516918637;4194.259382356288;4231.165119369968;5475.945240547543;5479.917801233064;5551.666899986014;3973.6821054315005;4766.833160839354;5023.522765337287;5438.70087145195;5458.181272808952;4839.685420447659;5006.920743742499;5296.655717378358;5744.712764361849;5797.362290148165;3008.5035969065734;3720.098323307824;3729.9813500932323;3740.4851035330735;3761.6238376162164;5302.920456193083;5518.779248830002;5521.917171242354;5571.679046510653;5583.804566840141;4680.180968330596;4876.951230487792;5083.729067733067;5367.355917289794;5385.38068122171;4478.507364190002;4615.815367385267;5327.588189129961;5339.796122326573;5390.110631745875;4656.790444429941;4984.87840235944;5218.66078704883;5281.207818827206;5300.31095957523;4471.463424389094;5320.52115309624;5337.653052551572;5339.626226164131;5353.598480113929;4273.401723758614;5139.640225184201;5230.398504171917;5277.472252774692;5289.418164002033 10:01:03 INFO - PROCESS | 1662 | |5;yui.html;718.9640517974103;778.4045205417856;779.5673401262297;786.4180506425245;823.4441751817524;14378.784318235223;14694.338754756034;15019;15213.163276019828;15253.771193432107;11459.427028648555;13411.798823017663;14001.789973150386;14012.439502419917;14373.209473478955;849.5115308697493;878.5255961780631;881.6605606841348;881.6870011146048;883.1124719656768;691.5504921800845;713.375796178344;715.059696499102;716.1978583985943;717.5587013986387;712.248577750473;910.7495438754329;942.2744486745202;947.0103741590054;948.5636607160715;894.6913314906346;919.5034681272139;928.7817362919709;929.2751653710117;929.2751653710117;531.4897698209724;680.4080450008474;680.5644387591946;680.9250982391933;682.556338380052;12161.452734626962;12343.5062597496;12367.010639148937;12367.876321236852;12392.56626018094;12988.755335377155;13214.471421143142;13367.598972030855;13693.679421360433;13961.441542338294;11469.770604587946;11524.250923690017;11547.595834145848;11574.18980671345;11928.46321915516;3690.3910854708943;3742.3825068863603;3746.83139258734;3748.175401411685;3832.6358995895625;92003.53998230032;92899;93396;94994;97288.51355743175;9703;10752;10773.353598784099;11070.501827417786;11096.55613775456;19101.331453399063;20317.577769556287;21362.572748544942;21473.355799326044;21479.570408591742;7718.228177182237;7908.4464087513325;7948.642311096015;8024.157463466368;8087.908576677904;3638.945415818765;3737.663610275088;3856.2287542491613;4264.402983582301;4353.6299414549485;3413.4709120086427;3479.7738147020364;3490.965090349064;3519.1554027033326;3531.099569609733;568.6445971267957;643.3052303512195;645.7223393940651;660.5970358081566;666.6033709942576;528.0811388184532;542.7666103575422;587.1281147495965;589.1457386789173;611.1810174366282;7790.922090779133;8453;8493.696084936972;8505.48967061966;8651.221390074923;621.2296752027454;637.4295005969631;637.91069250305;648.5233353485185;652.1294072413381;3972.66232370246;4077.429159917614;4091.3044782387065;4114.5679703630685;4218.282891908321;112833.43583282195;112885.87114128917;113161.30258046136;115100.42449787697;117143;66810.3318966804;93300.53349733344;103397.48301258446;104565;105588.88822223512;91626.54186729157;92875.53562232146;93505.5324723372;93521.59717604377;95870;7786.054487512991;8099.927697025558;8149.674013039649;8248.670053198044;8253.298469629908;53992.19011714906;57805.421945780006;59840;60048.69975650268;61599.692001539705;82011.5899420499;82208;85336;86307.56846215729;88613.55693221492;9856.915739268532;10972.177086718368;11322.886771132513;11469.713257168638;11539.596114135966;12488;12794.616161515169;12970.870291297344;12978.67553311137;12986.285754283605;12018.819717704067;12879.871201288242;13011.609651710463;13293.734125317245;13309.86690133125;10196.898031019891;12723.109382343517;12886.420111094836;13336.733265334833;13417.463301467831;12541;12847.100702950704;13338;13379.264140472367;13451.932740336628;8946.731598052069;10951.616693415692;11091;11221.775564488502;11534.884651153381;8007.959960200162;8831.381803273709;10924.945375273073;11140.82753862989;11213.327200368005 10:01:03 INFO - PROCESS | 1662 | __end_tp_report 10:01:03 INFO - PROCESS | 1662 | __start_cc_report 10:01:03 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1612 10:01:03 INFO - PROCESS | 1662 | __end_cc_report 10:01:03 INFO - PROCESS | 1662 | __startTimestamp1477933263611__endTimestamp 10:01:03 INFO - PROCESS | 1662 | 10:01:03 INFO - PROCESS | 1662 | ------- Summary: start ------- 10:01:03 INFO - PROCESS | 1662 | Number of tests: 6 10:01:03 INFO - PROCESS | 1662 | 10:01:03 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5719.27 Median:5940.11 stddev:620.43 (10.4%) stddev-sans-first:592.72 10:01:03 INFO - PROCESS | 1662 | Values: 3305.1 3322.0 3351.1 3372.4 3392.1 5510.0 5622.9 5652.2 5686.4 5725.1 5652.1 5677.8 5711.9 5712.0 5728.0 5125.1 5137.7 5147.3 5176.7 5194.3 5250.0 5254.7 5261.9 5272.2 5276.4 5163.4 5197.2 5240.4 5249.0 5250.4 5279.6 5286.7 5289.6 5295.8 5310.5 5020.3 5144.5 5193.0 5222.7 5230.8 5595.2 5641.2 5643.9 5670.0 5692.2 6128.3 6154.0 6175.5 6187.8 6203.3 6127.2 6137.9 6159.3 6188.8 6198.5 5699.4 5758.6 5769.6 5770.9 5872.1 6212.2 6219.8 6227.9 6230.1 6235.3 6120.8 6130.0 6151.7 6155.1 6164.1 6046.3 6102.1 6130.2 6144.0 6220.5 6111.3 6118.6 6136.2 6186.9 6189.4 6150.0 6181.5 6184.8 6187.3 6191.4 4848.6 4868.2 4926.7 4940.2 4959.6 4393.9 4412.2 4436.3 4453.8 4454.8 5783.9 5788.7 5798.8 5808.7 5843.3 5602.6 5816.4 6235.7 6237.5 6244.2 5598.6 5659.2 5688.2 5777.1 5791.0 5363.7 5378.8 5411.7 5455.8 5461.0 6280.0 6292.6 6296.6 6310.0 6315.9 6090.8 6228.8 6230.7 6237.3 6270.1 6176.0 6186.4 6253.4 6254.5 6285.5 6133.8 6166.9 6168.7 6177.3 6186.8 6049.8 6181.3 6212.0 6219.4 6220.8 6088.1 6091.8 6105.9 6115.7 6130.8 5913.7 5951.8 5983.2 6021.1 6075.2 5946.1 5948.8 5952.3 5966.3 5993.5 6053.4 6073.5 6100.5 6101.8 6105.2 5783.3 5847.0 5856.6 5876.4 5940.1 10:01:03 INFO - PROCESS | 1662 | 10:01:03 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:67251.34 Median:40224.70 stddev:146274.16 (363.6%) stddev-sans-first:146598.54 10:01:03 INFO - PROCESS | 1662 | Values: 462.7 482.0 497.7 524.5 532.7 30750.1 39876.4 41103.6 41145.8 43784.8 42625.0 42990.0 43004.0 43077.0 43268.0 9451.8 9645.1 9650.6 9651.5 9675.2 9418.0 9516.3 9522.4 9532.2 9536.0 9380.3 9463.6 9534.3 9542.0 9585.3 9442.9 9510.3 9513.9 9514.7 9531.9 9313.8 9380.9 9395.3 9442.0 9452.6 40573.0 40672.4 40979.6 41002.4 41082.2 3414.5 3415.6 3474.6 3624.9 3811.7 30572.8 30697.5 30764.5 31069.7 31611.8 3167.5 3206.7 3206.9 3237.3 3322.1 460701.0 461395.0 462657.0 463058.0 464875.0 57755.4 58044.0 58056.7 58073.7 58087.4 34238.0 34645.8 34776.0 60456.7 60551.7 15849.6 16177.7 16223.9 16239.9 16244.0 10284.9 11984.9 11993.9 12580.5 12581.6 18299.4 18307.3 18313.9 18981.3 19007.2 6413.2 6461.0 7568.5 7675.2 7685.0 725.2 965.0 967.2 969.4 1029.6 28984.4 29515.6 29729.1 29954.0 29968.1 1061.7 1070.3 1089.3 1098.6 1104.2 13139.5 14509.3 15322.0 15588.6 15716.8 605935.0 639090.0 639796.0 640199.0 640422.8 57241.4 57661.7 57809.7 57811.0 57994.0 1325.7 1367.0 1385.3 1385.5 1389.8 25030.4 28347.7 29034.6 29531.8 29762.6 42568.8 48456.3 48618.5 48842.0 48890.0 530786.0 533346.0 533486.0 534272.0 535439.0 24904.5 26510.2 26963.2 27144.2 27759.4 46034.5 46355.5 46870.1 47276.3 47616.0 38496.6 38649.0 38793.6 39592.0 39717.8 32640.5 33329.2 38413.0 39599.4 39806.2 36606.6 37125.1 37273.9 38305.6 38375.8 31216.0 32350.7 33210.0 34098.3 34233.7 23587.6 24961.6 25386.8 25571.9 25853.2 10:01:03 INFO - PROCESS | 1662 | 10:01:03 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:35681.14 Median:36188.37 stddev:94463.10 (261.0%) stddev-sans-first:94690.75 10:01:03 INFO - PROCESS | 1662 | Values: 301.3 319.0 358.6 374.8 401.8 14859.0 15689.9 16182.6 20335.2 20534.0 19504.6 20205.3 21010.4 21039.2 21162.6 5834.9 6042.0 6104.3 6104.8 6108.5 4196.7 5127.9 6662.2 6746.7 6866.5 6463.1 6685.5 6787.4 6795.1 6806.8 6593.4 6622.0 6669.6 6684.0 6708.9 5504.6 5768.3 5832.0 5835.0 5839.4 22272.8 24879.0 25296.7 25913.5 26282.5 2272.3 2370.7 2381.5 3045.1 3077.4 14856.8 14963.3 15527.9 16144.3 16185.9 1752.8 1814.2 1839.8 1979.6 2045.5 128123.0 138138.0 139327.3 149246.0 157659.2 16607.3 20286.6 21310.5 21433.9 21470.9 36142.8 36164.5 36212.3 36317.5 36392.1 10045.2 10370.9 10643.7 10806.5 11030.8 8716.0 8750.2 8834.2 9032.8 9034.0 9496.1 9559.4 9645.6 9675.5 9720.4 3561.9 3678.4 3678.7 3682.7 3684.6 836.3 841.4 882.3 894.3 970.0 20200.9 20985.1 21198.9 21223.4 21667.8 852.6 870.8 904.3 918.0 987.1 9517.7 10811.0 10862.4 10905.0 10927.9 494467.0 555760.0 565266.0 567623.0 612409.0 73567.0 133968.7 135397.6 135570.0 140482.0 939.6 941.4 973.3 976.7 976.7 14990.2 16980.7 18214.2 18552.4 18893.5 55843.2 56606.4 56679.7 57031.4 58049.0 75546.0 78668.0 79963.6 80913.0 81293.6 6797.2 6947.4 7027.8 7932.0 8171.2 11624.1 11990.0 12138.9 12231.8 12274.8 10014.8 10091.3 10488.8 10525.6 10574.3 9813.6 10150.8 10310.6 10491.5 10596.6 10228.1 10387.9 10858.5 10868.6 10891.1 5391.4 7022.4 7098.0 7178.3 7190.7 8161.3 9791.2 10408.7 10510.0 10576.6 10:01:03 INFO - PROCESS | 1662 | 10:01:03 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5345.94 Median:4912.46 stddev:2942.82 (59.9%) stddev-sans-first:2935.82 10:01:03 INFO - PROCESS | 1662 | Values: 1358.2 1485.4 1532.0 1746.8 1928.1 7453.9 7760.9 8116.8 8236.4 8356.2 8179.0 8253.0 8262.8 8269.2 8280.6 2268.9 2297.6 2302.0 2304.8 2306.9 2280.4 2319.2 2335.9 2338.2 2341.3 2265.8 2277.4 2307.2 2309.7 2309.7 2255.1 2273.8 2295.4 2296.8 2303.5 2297.6 2306.9 2309.8 2315.9 2320.0 8197.8 8253.1 8297.1 8299.8 8323.8 4992.1 5032.1 5163.8 5233.5 5246.0 3370.8 3533.0 3562.2 3617.3 3631.9 1008.2 1034.6 1062.8 1063.1 1071.2 10682.5 10713.6 10797.5 10799.6 10818.5 4189.3 4360.4 4426.8 4430.6 4439.5 8430.0 8552.1 8610.8 8615.2 8617.1 4998.4 5075.5 5075.7 5081.4 5098.7 3750.8 3767.8 4284.7 4433.6 4761.2 3579.6 3594.4 3603.2 3653.1 3674.8 1112.8 1116.2 1116.9 1123.8 1130.6 737.8 840.9 855.3 923.3 972.3 4836.4 5393.8 5738.0 5870.0 5968.8 382.8 430.9 431.9 433.9 437.6 3846.7 3884.3 3906.2 3953.0 4027.7 9568.5 10113.5 10117.3 10150.3 10155.0 8971.9 9928.5 10121.1 10123.3 10126.2 7617.4 7732.3 7732.7 7866.2 7893.1 5555.3 5674.3 5686.4 5772.4 5914.9 9207.7 9208.8 9311.0 9332.3 9435.2 8165.4 9205.2 9354.9 9383.6 9424.1 6721.1 6724.2 6791.7 6814.2 6817.9 7707.6 7778.9 7787.0 7825.1 7830.5 6091.3 7086.1 7160.5 7160.6 7236.1 6822.8 6958.5 6996.2 7051.9 7118.8 6588.9 6648.6 6714.7 6718.0 6722.8 4790.6 4793.1 4830.6 4851.4 4959.6 4703.6 4812.5 4838.8 4867.5 4957.4 10:01:03 INFO - PROCESS | 1662 | 10:01:03 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4212.51 Median:4500.36 stddev:1323.02 (29.4%) stddev-sans-first:1292.71 10:01:03 INFO - PROCESS | 1662 | Values: 241.2 294.4 294.6 305.6 310.4 4086.9 4989.3 5048.9 5098.4 5137.7 4428.0 4975.3 5165.7 5191.9 5247.8 3138.7 3823.7 3903.9 3956.3 3959.6 3220.6 3917.4 3923.5 3971.3 3977.8 3039.5 3555.6 3608.9 3962.5 3967.9 3368.4 3576.0 3921.8 3955.5 3962.6 2784.4 3409.1 3421.2 3428.9 3433.7 4491.6 4759.1 4949.5 5147.3 5161.2 3752.0 4415.2 4459.5 4470.5 4509.1 4490.5 4525.7 5354.8 5436.2 5490.8 3722.6 3733.8 3735.5 3751.2 3754.4 5110.3 5359.7 5648.5 5658.0 5668.9 3278.6 3683.1 3747.4 3792.1 3800.2 3629.9 3803.2 3866.6 3867.9 3878.7 3702.9 4239.4 4384.3 4511.2 4535.4 4844.3 5114.4 5417.2 5427.3 5455.7 1107.5 1269.3 1312.2 1319.3 1320.5 742.7 783.0 801.6 812.6 813.9 3376.9 3572.6 3796.9 3998.4 4197.6 3958.6 3980.4 4018.6 4444.3 4596.9 3547.6 3745.5 3981.3 4205.3 4230.7 2416.4 2449.7 2520.8 2636.5 2755.0 5005.8 5017.4 5080.7 5674.6 5724.7 5654.2 5669.3 5674.7 5675.9 5698.7 4572.6 5655.0 5674.5 5692.7 5768.5 4194.3 4231.2 5475.9 5479.9 5551.7 3973.7 4766.8 5023.5 5438.7 5458.2 4839.7 5006.9 5296.7 5744.7 5797.4 3008.5 3720.1 3730.0 3740.5 3761.6 5302.9 5518.8 5521.9 5571.7 5583.8 4680.2 4877.0 5083.7 5367.4 5385.4 4478.5 4615.8 5327.6 5339.8 5390.1 4656.8 4984.9 5218.7 5281.2 5300.3 4471.5 5320.5 5337.7 5339.6 5353.6 4273.4 5139.6 5230.4 5277.5 5289.4 10:01:03 INFO - PROCESS | 1662 | 10:01:03 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:21301.49 Median:4241.34 stddev:32082.97 (756.4%) stddev-sans-first:32135.75 10:01:03 INFO - PROCESS | 1662 | Values: 719.0 778.4 779.6 786.4 823.4 14378.8 14694.3 15019.0 15213.2 15253.8 11459.4 13411.8 14001.8 14012.4 14373.2 849.5 878.5 881.7 881.7 883.1 691.6 713.4 715.1 716.2 717.6 712.2 910.7 942.3 947.0 948.6 894.7 919.5 928.8 929.3 929.3 531.5 680.4 680.6 680.9 682.6 12161.5 12343.5 12367.0 12367.9 12392.6 12988.8 13214.5 13367.6 13693.7 13961.4 11469.8 11524.3 11547.6 11574.2 11928.5 3690.4 3742.4 3746.8 3748.2 3832.6 92003.5 92899.0 93396.0 94994.0 97288.5 9703.0 10752.0 10773.4 11070.5 11096.6 19101.3 20317.6 21362.6 21473.4 21479.6 7718.2 7908.4 7948.6 8024.2 8087.9 3638.9 3737.7 3856.2 4264.4 4353.6 3413.5 3479.8 3491.0 3519.2 3531.1 568.6 643.3 645.7 660.6 666.6 528.1 542.8 587.1 589.1 611.2 7790.9 8453.0 8493.7 8505.5 8651.2 621.2 637.4 637.9 648.5 652.1 3972.7 4077.4 4091.3 4114.6 4218.3 112833.4 112885.9 113161.3 115100.4 117143.0 66810.3 93300.5 103397.5 104565.0 105588.9 91626.5 92875.5 93505.5 93521.6 95870.0 7786.1 8099.9 8149.7 8248.7 8253.3 53992.2 57805.4 59840.0 60048.7 61599.7 82011.6 82208.0 85336.0 86307.6 88613.6 9856.9 10972.2 11322.9 11469.7 11539.6 12488.0 12794.6 12970.9 12978.7 12986.3 12018.8 12879.9 13011.6 13293.7 13309.9 10196.9 12723.1 12886.4 13336.7 13417.5 12541.0 12847.1 13338.0 13379.3 13451.9 8946.7 10951.6 11091.0 11221.8 11534.9 8008.0 8831.4 10924.9 11140.8 11213.3 10:01:03 INFO - PROCESS | 1662 | -------- Summary: end -------- 10:01:03 INFO - PROCESS | 1662 | 10:01:04 INFO - TEST-INFO | 1662: exit 0 10:01:04 INFO - TEST-OK | dromaeo_css | took 1119658ms 10:01:04 INFO - TEST-START | kraken 10:01:04 INFO - operating with platform_type : mac_ 10:01:04 INFO - Initialising browser for kraken test... 10:01:04 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpbKCh51/profile http://localhost:49269/getInfo.html) 10:01:06 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 10:01:06 INFO - PROCESS | 1668 | colorDepth:24 10:01:06 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 10:01:06 INFO - PROCESS | 1668 | __metrics 10:01:06 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:01:06 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:01:07 INFO - TEST-INFO | 1668: exit 0 10:01:07 INFO - Browser initialized. 10:01:07 INFO - Running cycle 1/1 for kraken test... 10:01:07 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpbKCh51/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:19 INFO - PROCESS | 1669 | RSS: Main: 233447424 10:01:19 INFO - PROCESS | 1669 | 10:01:22 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 10:01:23 INFO - PROCESS | 1669 | RSS: Main: 293916672 10:01:23 INFO - PROCESS | 1669 | 10:01:26 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 10:01:26 INFO - PROCESS | 1669 | RSS: Main: 296468480 10:01:26 INFO - PROCESS | 1669 | 10:01:30 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 10:01:31 INFO - PROCESS | 1669 | RSS: Main: 387317760 10:01:31 INFO - PROCESS | 1669 | 10:01:33 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 10:01:33 INFO - PROCESS | 1669 | RSS: Main: 288382976 10:01:33 INFO - PROCESS | 1669 | 10:01:35 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:01:36 INFO - PROCESS | 1669 | RSS: Main: 292433920 10:01:36 INFO - PROCESS | 1669 | 10:01:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 10:01:39 INFO - PROCESS | 1669 | RSS: Main: 331780096 10:01:39 INFO - PROCESS | 1669 | 10:01:42 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 10:01:43 INFO - PROCESS | 1669 | RSS: Main: 330997760 10:01:43 INFO - PROCESS | 1669 | 10:01:46 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 10:01:46 INFO - PROCESS | 1669 | RSS: Main: 328503296 10:01:46 INFO - PROCESS | 1669 | 10:01:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:01:48 INFO - PROCESS | 1669 | RSS: Main: 304664576 10:01:48 INFO - PROCESS | 1669 | 10:01:50 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:01:51 INFO - PROCESS | 1669 | RSS: Main: 306577408 10:01:51 INFO - PROCESS | 1669 | 10:01:53 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:01:54 INFO - PROCESS | 1669 | RSS: Main: 311320576 10:01:54 INFO - PROCESS | 1669 | 10:01:57 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:01:57 INFO - PROCESS | 1669 | RSS: Main: 325701632 10:01:57 INFO - PROCESS | 1669 | 10:02:00 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:02:01 INFO - PROCESS | 1669 | RSS: Main: 320016384 10:02:01 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 10:02:03 INFO - PROCESS | 1669 | RSS: Main: 363831296 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | __start_tp_report 10:02:03 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 10:02:03 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 10:02:03 INFO - PROCESS | 1669 | |i|pagename|runs| 10:02:03 INFO - PROCESS | 1669 | |0;ai-astar;111;113;114;117;162;168;114;112;113;114 10:02:03 INFO - PROCESS | 1669 | |1;audio-beat-detection;139;111;116;146;108;118;97;136;177;142 10:02:03 INFO - PROCESS | 1669 | |2;audio-dft;184;184;186;186;181;184;183;182;182;183 10:02:03 INFO - PROCESS | 1669 | |3;audio-fft;82;60;72;114;88;75;60;59;83;58 10:02:03 INFO - PROCESS | 1669 | |4;audio-oscillator;89;72;91;70;68;68;94;67;69;91 10:02:03 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;90;88;91;88;90;88;91;87;92;130 10:02:03 INFO - PROCESS | 1669 | |6;imaging-darkroom;95;96;96;96;95;95;96;95;94;95 10:02:03 INFO - PROCESS | 1669 | |7;imaging-desaturate;83;81;82;82;83;82;84;82;82;83 10:02:03 INFO - PROCESS | 1669 | |8;json-parse-financial;54;54;53;53;55;56;54;55;56;55 10:02:03 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;65;72;72;78;73;69;70;70;70;71 10:02:03 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;88;86;83;86;91;86;86;90;85;92 10:02:03 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;152;141;145;145;147;150;153;161;186;146 10:02:03 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;175;176;175;172;170;173;177;175;219;172 10:02:03 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;68;67;67;67;68;66;66;69;71;89 10:02:03 INFO - PROCESS | 1669 | __end_tp_report 10:02:03 INFO - PROCESS | 1669 | __start_cc_report 10:02:03 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,2103 10:02:03 INFO - PROCESS | 1669 | __end_cc_report 10:02:03 INFO - PROCESS | 1669 | __startTimestamp1477933323528__endTimestamp 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | ------- Summary: start ------- 10:02:03 INFO - PROCESS | 1669 | Number of tests: 14 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:123.80 Median:114.00 stddev:21.82 (19.1%) stddev-sans-first:22.64 10:02:03 INFO - PROCESS | 1669 | Values: 111.0 113.0 114.0 117.0 162.0 168.0 114.0 112.0 113.0 114.0 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:140.50 stddev:23.55 (16.8%) stddev-sans-first:24.70 10:02:03 INFO - PROCESS | 1669 | Values: 139.0 111.0 116.0 146.0 108.0 118.0 97.0 136.0 177.0 142.0 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.65 (0.9%) stddev-sans-first:1.74 10:02:03 INFO - PROCESS | 1669 | Values: 184.0 184.0 186.0 186.0 181.0 184.0 183.0 182.0 182.0 183.0 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:75.10 Median:73.50 stddev:17.66 (24.0%) stddev-sans-first:18.55 10:02:03 INFO - PROCESS | 1669 | Values: 82.0 60.0 72.0 114.0 88.0 75.0 60.0 59.0 83.0 58.0 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:80.50 stddev:11.63 (14.4%) stddev-sans-first:11.62 10:02:03 INFO - PROCESS | 1669 | Values: 89.0 72.0 91.0 70.0 68.0 68.0 94.0 67.0 69.0 91.0 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:93.50 Median:90.00 stddev:12.93 (14.4%) stddev-sans-first:13.65 10:02:03 INFO - PROCESS | 1669 | Values: 90.0 88.0 91.0 88.0 90.0 88.0 91.0 87.0 92.0 130.0 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 10:02:03 INFO - PROCESS | 1669 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 94.0 95.0 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:82.40 Median:82.50 stddev:0.84 (1.0%) stddev-sans-first:0.87 10:02:03 INFO - PROCESS | 1669 | Values: 83.0 81.0 82.0 82.0 83.0 82.0 84.0 82.0 82.0 83.0 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.08 (2.0%) stddev-sans-first:1.13 10:02:03 INFO - PROCESS | 1669 | Values: 54.0 54.0 53.0 53.0 55.0 56.0 54.0 55.0 56.0 55.0 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.50 stddev:3.30 (4.6%) stddev-sans-first:2.69 10:02:03 INFO - PROCESS | 1669 | Values: 65.0 72.0 72.0 78.0 73.0 69.0 70.0 70.0 70.0 71.0 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.00 stddev:2.87 (3.3%) stddev-sans-first:3.03 10:02:03 INFO - PROCESS | 1669 | Values: 88.0 86.0 83.0 86.0 91.0 86.0 86.0 90.0 85.0 92.0 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:152.60 Median:151.00 stddev:12.99 (8.6%) stddev-sans-first:13.77 10:02:03 INFO - PROCESS | 1669 | Values: 152.0 141.0 145.0 145.0 147.0 150.0 153.0 161.0 186.0 146.0 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.40 Median:175.00 stddev:14.42 (8.2%) stddev-sans-first:15.25 10:02:03 INFO - PROCESS | 1669 | Values: 175.0 176.0 175.0 172.0 170.0 173.0 177.0 175.0 219.0 172.0 10:02:03 INFO - PROCESS | 1669 | 10:02:03 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:68.00 stddev:6.91 (10.2%) stddev-sans-first:7.30 10:02:03 INFO - PROCESS | 1669 | Values: 68.0 67.0 67.0 67.0 68.0 66.0 66.0 69.0 71.0 89.0 10:02:03 INFO - PROCESS | 1669 | -------- Summary: end -------- 10:02:03 INFO - PROCESS | 1669 | 10:02:04 INFO - TEST-INFO | 1669: exit 0 10:02:04 INFO - TEST-OK | kraken | took 60125ms 10:02:04 INFO - SUITE-END | took 1179s 10:02:04 INFO - Completed test suite (00:19:40) 10:02:04 INFO - javascript benchmark 10:02:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3305.1076209423454, 3321.983390083051, 3351.1287065363, 3372.359251742167, 3392.0841372829336, 5510.0, 5622.943770562293, 5652.236948012022, 5686.3744988051285, 5725.112607545831, 5652.06740887754, 5677.772889084432, 5711.914321285174, 5711.971440142804, 5727.971360143193, 5125.077486052509, 5137.666051706646, 5147.305113809625, 5176.715280659562, 5194.27280180775, 5249.973750131244, 5254.710990895499, 5261.947380526203, 5272.209168624718, 5276.445973172819, 5163.380394352683, 5197.194434862602, 5240.397354304247, 5249.0, 5250.4487028861995, 5279.577633789307, 5286.656367336111, 5289.559948346058, 5295.814646487393, 5310.548603368718, 5020.347354843883, 5144.485551444863, 5193.0, 5222.73886305687, 5230.816921407771, 5595.244641973322, 5641.182028605829, 5643.915341269884, 5670.036093864053, 5692.203091567184, 6128.3258841527395, 6154.046122850965, 6175.536834737368, 6187.845303867394, 6203.2866220384785, 6127.172831667713, 6137.9386206137815, 6159.3224745277985, 6188.783392581283, 6198.4731297839735, 5699.430056994309, 5758.568107391879, 5769.567282453832, 5770.942290577124, 5872.0898260769645, 6212.161358216583, 6219.844503887439, 6227.875442491216, 6230.065490176419, 6235.314115447297, 6120.816375508742, 6129.988551888978, 6151.692415379213, 6155.076738489262, 6164.106204600397, 6046.334903160737, 6102.115193296947, 6130.165000698321, 6144.047672610753, 6220.502359811204, 6111.297200821962, 6118.619179173164, 6136.188830398254, 6186.876262474725, 6189.35011823761, 6149.96925015381, 6181.536384771161, 6184.783532576338, 6187.288461826857, 6191.380861913773, 4848.612111031109, 4868.196747536687, 4926.704397736147, 4940.1601727706375, 4959.603231741452, 4393.890152746207, 4412.161689279027, 4436.3123715824095, 4453.844115455943, 4454.77726113693, 5783.884322313615, 5788.681622510802, 5798.82603521895, 5808.709564521757, 5843.2695913010875, 5602.59935016246, 5816.447437493432, 6235.688215589203, 6237.5321850860455, 6244.188255526843, 5598.552115830806, 5659.151127330851, 5688.203651488795, 5777.133429985536, 5791.015527360359, 5363.678179309254, 5378.838634840961, 5411.702356370359, 5455.781768729285, 5461.044317244467, 6280.0, 6292.622442653455, 6296.5592408530965, 6309.968450157903, 6315.873682526232, 6090.786822461193, 6228.750849965951, 6230.6884655766125, 6237.313895471585, 6270.090836828543, 6175.96912015437, 6186.412290832363, 6253.405926436982, 6254.530910181664, 6285.49716022708, 6133.815985520441, 6166.938330616816, 6168.660723660242, 6177.320494745664, 6186.845328866634, 6049.770524223511, 6181.258249010148, 6212.0, 6219.440250377488, 6220.7511699533325, 6088.117223002729, 6091.847703807441, 6105.9084113737445, 6115.6859809352345, 6130.816075517741, 5913.733881975236, 5951.791687290924, 5983.222181116427, 6021.096835474714, 6075.210222671201, 5946.07835785454, 5948.762049517971, 5952.285725712769, 5966.254218222723, 5993.520518358434, 6053.364396738279, 6073.544484163794, 6100.481459075851, 6101.816945491642, 6105.236845394325, 5783.306003279465, 5847.035239185487, 5856.619319744203, 5876.382979787232, 5940.108983652487], "value": 5679.462230589117, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [462.72467881610453, 482.0335227868125, 497.72376331136206, 524.5200641413107, 532.6777299733664, 30750.077497675076, 39876.40185397218, 41103.58896411042, 41145.7942710286, 43784.78107609465, 42625.0, 42990.0, 43003.97944287802, 43077.0, 43268.0, 9451.763705907355, 9645.083717046904, 9650.613975440974, 9651.5174241288, 9675.177609903167, 9417.952910235474, 9516.286278529104, 9522.428654280731, 9532.237421006303, 9535.99872013439, 9380.296477764161, 9463.621455141785, 9534.332596718232, 9541.95229023854, 9585.2811039172, 9442.905570944306, 9510.33427660064, 9513.857292140623, 9514.714558563253, 9531.857022144673, 9313.813723725556, 9380.8592871107, 9395.34232603718, 9441.952790236073, 9452.57463414148, 40573.0, 40672.38991415131, 40979.590204097876, 41002.38496422556, 41082.178356433, 3414.539037229967, 3415.590129184489, 3474.6351633078666, 3624.8912532624063, 3811.6950643948417, 30572.8471357644, 30697.539536906963, 30764.53853192204, 31069.689303106905, 31611.84194079015, 3167.461531539621, 3206.71139597435, 3206.8717251309918, 3237.27161388688, 3322.0864262327814, 460701.0, 461395.0, 462656.9999999966, 463058.0, 464875.0, 57755.42244577585, 58044.0, 58056.70971645115, 58073.70963145157, 58087.41912580904, 34238.0, 34645.826770865984, 34775.956721298404, 60456.69771651114, 60551.69724151351, 15849.603759906095, 16177.654240135114, 16223.918880405523, 16239.944403613727, 16244.02535847853, 10284.948575257076, 11984.880151198551, 11993.88006119945, 12580.496780128693, 12581.55964541255, 18299.359522416653, 18307.267709291744, 18313.90843045803, 18981.33565325207, 19007.239710411428, 6413.236360000944, 6460.967695161494, 7568.508046976929, 7675.2324767522805, 7685.0, 725.2493669052611, 965.0012237334325, 967.1634036558327, 969.4425705219527, 1029.6228370943318, 28984.42031159365, 29515.55726664102, 29729.12290505565, 29953.951611693486, 29968.10095697089, 1061.7398737309409, 1070.2936062198912, 1089.2538611051455, 1098.5770478365887, 1104.1829046505527, 13139.488958769864, 14509.347079381454, 15322.0, 15588.610284742972, 15716.764248536281, 605935.0, 639090.0, 639796.0, 640199.0, 640422.7978860076, 57241.42758572444, 57661.71169144211, 57809.71095144581, 57811.0, 57994.0, 1325.701717113661, 1366.9589912302647, 1385.3419625677723, 1385.5081446086695, 1389.7915312703176, 25030.37424064413, 28347.716522834507, 29034.564481533216, 29531.818727251528, 29762.553561696157, 42568.78715606402, 48456.27315590198, 48618.5138148614, 48842.0231595359, 48890.0, 530786.0, 533346.0, 533486.0, 534272.0, 535439.0, 24904.50190996134, 26510.204693859214, 26963.1911042669, 27144.1856744298, 27759.44481110326, 46034.53965460436, 46355.53644463512, 46870.06259874852, 47276.29085563788, 47616.0, 38496.6150338493, 38649.03377415587, 38793.612063879, 39592.0, 39717.80141099276, 32640.510392343658, 33329.166770830925, 38413.039674008374, 39599.40600891047, 39806.20387592174, 36606.63393366032, 37125.06625583914, 37273.88178354654, 38305.6169438302, 38375.80812095922, 31216.0, 32350.676493234765, 33210.0, 34098.31803363968, 34233.657663423044, 23587.64618530689, 24961.625575616745, 25386.821196008674, 25571.872140639178, 25853.22440326718], "value": 19470.060111402592, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.32954176956264, 318.99840500797495, 358.5732977756471, 374.8144668389147, 401.7669751544105, 14859.0, 15689.92155039226, 16182.595435114114, 20335.18659253628, 20534.0, 19504.60990780187, 20205.292814751487, 21010.36968890936, 21039.158433662673, 21162.57674846502, 5834.883302333951, 6042.033274676052, 6104.2980057293535, 6104.786332478364, 6108.511319094484, 4196.685248606352, 5127.9230811537855, 6662.167229096363, 6746.662666866661, 6866.450683945272, 6463.062855885893, 6685.4985876059245, 6787.389134977851, 6795.082663840368, 6806.829829254259, 6593.439557637606, 6622.006698995166, 6669.566478178903, 6684.0, 6708.932910670879, 5504.559635229172, 5768.278965129359, 5831.970840145815, 5835.0, 5839.357670656224, 22272.777272227395, 24879.004839806385, 25296.747032529805, 25913.481730365475, 26282.474350513075, 2272.3296627494765, 2370.7369639400504, 2381.4760752634393, 3045.1321373408696, 3077.3691393264326, 14856.777148342675, 14963.326650300764, 15527.922360388238, 16144.273507692182, 16185.866989310753, 1752.8247175282497, 1814.1836173721747, 1839.7884243311923, 1979.5546002149545, 2045.509077821312, 128123.0, 138138.0, 139327.30336348354, 149245.99999999892, 157659.2117039419, 16607.252673629715, 20286.594268114553, 21310.467238319165, 21433.89283053606, 21470.926453677253, 36142.8192859034, 36164.45753313702, 36212.27575448476, 36317.54983276584, 36392.09019774527, 10045.196384289386, 10370.948145259375, 10643.680689579325, 10806.459677016117, 11030.834537481944, 8716.0, 8750.168733970262, 8834.204921556962, 9032.819343613091, 9033.954830225806, 9496.148251090972, 9559.42643441382, 9645.565949532287, 9675.516224188763, 9720.416774993522, 3561.893143205708, 3678.393065144221, 3678.668919797231, 3682.735117902471, 3684.6366844267254, 836.3016880904391, 841.4404421059927, 882.3382463152635, 894.3259653635582, 969.9660511882191, 20200.898995505224, 20985.139022051797, 21198.894005530183, 21223.363299101053, 21667.808270545273, 852.5779739029097, 870.8301881133118, 904.3036861616519, 917.977050573741, 987.116530705015, 9517.714468565953, 10811.027007569199, 10862.402567858844, 10905.0, 10927.890721092846, 494467.0, 555760.0, 565266.0, 567623.0, 612409.0, 73567.0, 133968.66031339756, 135397.64602353852, 135570.0, 140482.0, 939.6006697153682, 941.4022095969109, 973.2894986659636, 976.6728146071146, 976.7313988653035, 14990.175540345386, 16980.72644551639, 18214.180361884013, 18552.44342669722, 18893.527661808566, 55843.16235256556, 56606.43393566012, 56679.71660141673, 57031.42968570261, 58049.0, 75546.0, 78668.0, 79963.60018200104, 80913.0, 81293.59353203433, 6797.150356205474, 6947.40947019509, 7027.824304392431, 7932.0, 8171.223733745284, 11624.128190385585, 11990.040796736415, 12138.878611213775, 12231.816522752344, 12274.75450491003, 10014.799704005733, 10091.293609447268, 10488.790224195625, 10525.57904682858, 10574.312669676447, 9813.55838987233, 10150.847737283799, 10310.639127630497, 10491.527881245209, 10596.576136954436, 10228.079472847181, 10387.94806025965, 10858.511366988347, 10868.565257389615, 10891.0742586881, 5391.433899440659, 7022.4382049436945, 7098.041764361745, 7178.282171782989, 7190.712371505081, 8161.347092232489, 9791.167750741266, 10408.687739367831, 10510.0, 10576.576936922746], "value": 10452.420473507005, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.1647286918549, 1485.435534496891, 1531.9540413787586, 1746.8078511363747, 1928.113067988725, 7453.888191677122, 7760.883586746197, 8116.797080072994, 8236.38227132966, 8356.206160414766, 8179.01851777786, 8252.958735206315, 8262.793430164249, 8269.173082691728, 8280.585970701455, 2268.9432764180906, 2297.5519773644146, 2301.9539609207804, 2304.781045800646, 2306.8731219782903, 2280.3614987803358, 2319.188284100568, 2335.8832058397097, 2338.240071976606, 2341.344423561397, 2265.796078352948, 2277.350954977832, 2307.215546714117, 2309.6650985607075, 2309.6650985607075, 2255.1430456426615, 2273.818094552432, 2295.4490922178725, 2296.827737919646, 2303.481716613757, 2297.5864344417996, 2306.850054746436, 2309.8383113182085, 2315.9421014474606, 2320.025589252518, 8197.836043279161, 8253.133420990769, 8297.087320394752, 8299.751007469786, 8323.750287491384, 4992.126377883892, 5032.144535428949, 5163.793448262065, 5233.528982391603, 5245.973770131163, 3370.7640465167447, 3533.0, 3562.2163124112653, 3617.276544691072, 3631.927361452756, 1008.2135933971514, 1034.5965073621294, 1062.8033813744482, 1063.0857462582173, 1071.1537885070784, 10682.465876706134, 10713.625023124154, 10797.514111864906, 10799.622013229498, 10818.513166907507, 4189.308764053958, 4360.367746676714, 4426.8490192549525, 4430.556944305544, 4439.533848945879, 8430.0, 8552.059273479912, 8610.827783444296, 8615.181557752003, 8617.138286171457, 4998.400191976986, 5075.467075957045, 5075.720835354091, 5081.415637201695, 5098.668586541863, 3750.7937063461773, 3767.8411019063997, 4284.742915425022, 4433.578810013044, 4761.166795810719, 3579.6420357963993, 3594.370985077653, 3603.207294395229, 3653.06846754076, 3674.761140525857, 1112.8330750387506, 1116.2242241642143, 1116.9050630696481, 1123.7864805686893, 1130.559081958037, 737.7860420478002, 840.8906842110487, 855.2772906893789, 923.29190996657, 972.3242346569208, 4836.371271734652, 5393.7572809223675, 5737.971310143506, 5870.0, 5968.761249550056, 382.757950450789, 430.87073877836525, 431.93520971854474, 433.8980339620187, 437.6214574393127, 3846.74996125251, 3884.320243957296, 3906.199229158016, 3953.011747063234, 4027.7381970172432, 9568.521573921276, 10113.494325283706, 10117.342372745748, 10150.340227885312, 10155.0, 8971.865422018675, 9928.453935033498, 10121.139703125169, 10123.341982771097, 10126.189904807597, 7617.428692848059, 7732.304092631803, 7732.6906923723545, 7866.213378662203, 7893.052833659997, 5555.333359996826, 5674.2623458950075, 5686.374498805046, 5772.393898640582, 5914.911276330945, 9207.677731279373, 9208.815823683355, 9310.95344523273, 9332.30007749408, 9435.150836424755, 8165.387595930448, 9205.204985028124, 9354.877414710278, 9383.577739001625, 9424.057594240796, 6721.126253587003, 6724.159480064992, 6791.660416979033, 6814.182298124257, 6817.93182068173, 7707.576083315472, 7778.883316750366, 7786.961065194638, 7825.100113486794, 7830.491018083806, 6091.299500557493, 7086.149662040588, 7160.498765086394, 7160.606166660884, 7236.095488063992, 6822.795316140524, 6958.478114141359, 6996.230414654486, 7051.929480705127, 7118.786436406916, 6588.901166482411, 6648.634325112165, 6714.697838597177, 6717.966410167918, 6722.798316050526, 4790.640701947298, 4793.065352256276, 4830.565249127595, 4851.417829860439, 4959.578435832995, 4703.647226457961, 4812.494688057704, 4838.782254798472, 4867.488913664014, 4957.429895562056], "value": 4258.234897586289, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [241.17397912150878, 294.4493796600357, 294.59640292798855, 305.60729462640506, 310.42106471430776, 4086.8569600064, 4989.307912145009, 5048.899022019557, 5098.413682426522, 5137.666051706637, 4427.955720442795, 4975.328330675357, 5165.664231824938, 5191.935653191096, 5247.816326428576, 3138.7018233267804, 3823.713221508384, 3903.941440878389, 3956.347202711549, 3959.6238357356006, 3220.6296275928216, 3917.4123881417872, 3923.4507168996365, 3971.319359432386, 3977.840886364542, 3039.4832878410725, 3555.6266592007855, 3608.873689420871, 3962.48487696599, 3967.8809635710977, 3368.376850282681, 3575.964240357589, 3921.8039098044983, 3955.545112312078, 3962.6433620974108, 2784.429192015632, 3409.0568376025676, 3421.196018935573, 3428.9485657715154, 3433.7424693147864, 4491.573300536444, 4759.071980963713, 4949.505049495057, 5147.279380886679, 5161.1742121260795, 3751.9869635198343, 4415.227335216325, 4459.509453960061, 4470.530594287586, 4509.143262780094, 4490.461144662629, 4525.683202175849, 5354.839354819362, 5436.178880075179, 5490.80782172626, 3722.590515043343, 3733.770288700282, 3735.533058367704, 3751.1559899022773, 3754.380527213034, 5110.310108135392, 5359.705216213107, 5648.519875810603, 5657.953278643464, 5668.914966275509, 3278.606567211902, 3683.079230192452, 3747.4004159334377, 3792.089898424358, 3800.201957588937, 3629.8729544466346, 3803.2393521295853, 3866.5780784005797, 3867.941980870289, 3878.70909681775, 3702.8703995360033, 4239.364095385655, 4384.254676704968, 4511.1654343946475, 4535.4103966484145, 4844.273358996108, 5114.3862736471865, 5417.241586177938, 5427.3215848019, 5455.727213639302, 1107.5237647811357, 1269.2701696524534, 1312.1798875702686, 1319.280991859439, 1320.5378117658743, 742.6583771465187, 782.9960850195713, 801.6372167315587, 812.6302532347768, 813.8768499470692, 3376.8818091366684, 3572.6235361681734, 3796.9430458543143, 3998.421018443146, 4197.643200327945, 3958.5645578986287, 3980.3631418973405, 4018.6383225509844, 4444.266695995189, 4596.88507787308, 3547.5986985140726, 3745.4756334113245, 3981.3172815146454, 4205.3481710334945, 4230.682698797603, 2416.383822125347, 2449.6692946452, 2520.798336133105, 2636.5254254234424, 2755.0357374919017, 5005.824796132118, 5017.37282839645, 5080.695158290514, 5674.638086859124, 5724.685142317213, 5654.180143879197, 5669.262995810601, 5674.716264186774, 5675.928286175516, 5698.6580805151825, 4572.611328037154, 5654.995329133746, 5674.467893668769, 5692.743826527816, 5768.538516918637, 4194.259382356288, 4231.165119369968, 5475.945240547543, 5479.917801233064, 5551.666899986014, 3973.6821054315005, 4766.833160839354, 5023.522765337287, 5438.70087145195, 5458.181272808952, 4839.685420447659, 5006.920743742499, 5296.655717378358, 5744.712764361849, 5797.362290148165, 3008.5035969065734, 3720.098323307824, 3729.9813500932323, 3740.4851035330735, 3761.6238376162164, 5302.920456193083, 5518.779248830002, 5521.917171242354, 5571.679046510653, 5583.804566840141, 4680.180968330596, 4876.951230487792, 5083.729067733067, 5367.355917289794, 5385.38068122171, 4478.507364190002, 4615.815367385267, 5327.588189129961, 5339.796122326573, 5390.110631745875, 4656.790444429941, 4984.87840235944, 5218.66078704883, 5281.207818827206, 5300.31095957523, 4471.463424389094, 5320.52115309624, 5337.653052551572, 5339.626226164131, 5353.598480113929, 4273.401723758614, 5139.640225184201, 5230.398504171917, 5277.472252774692, 5289.418164002033], "value": 3797.0105263839505, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.9640517974103, 778.4045205417856, 779.5673401262297, 786.4180506425245, 823.4441751817524, 14378.784318235223, 14694.338754756034, 15019.0, 15213.163276019828, 15253.771193432107, 11459.427028648555, 13411.798823017663, 14001.789973150386, 14012.439502419917, 14373.209473478955, 849.5115308697493, 878.5255961780631, 881.6605606841348, 881.6870011146048, 883.1124719656768, 691.5504921800845, 713.375796178344, 715.059696499102, 716.1978583985943, 717.5587013986387, 712.248577750473, 910.7495438754329, 942.2744486745202, 947.0103741590054, 948.5636607160715, 894.6913314906346, 919.5034681272139, 928.7817362919709, 929.2751653710117, 929.2751653710117, 531.4897698209724, 680.4080450008474, 680.5644387591946, 680.9250982391933, 682.556338380052, 12161.452734626962, 12343.5062597496, 12367.010639148937, 12367.876321236852, 12392.56626018094, 12988.755335377155, 13214.471421143142, 13367.598972030855, 13693.679421360433, 13961.441542338294, 11469.770604587946, 11524.250923690017, 11547.595834145848, 11574.18980671345, 11928.46321915516, 3690.3910854708943, 3742.3825068863603, 3746.83139258734, 3748.175401411685, 3832.6358995895625, 92003.53998230032, 92899.0, 93396.0, 94994.0, 97288.51355743175, 9703.0, 10752.0, 10773.353598784099, 11070.501827417786, 11096.55613775456, 19101.331453399063, 20317.577769556287, 21362.572748544942, 21473.355799326044, 21479.570408591742, 7718.228177182237, 7908.4464087513325, 7948.642311096015, 8024.157463466368, 8087.908576677904, 3638.945415818765, 3737.663610275088, 3856.2287542491613, 4264.402983582301, 4353.6299414549485, 3413.4709120086427, 3479.7738147020364, 3490.965090349064, 3519.1554027033326, 3531.099569609733, 568.6445971267957, 643.3052303512195, 645.7223393940651, 660.5970358081566, 666.6033709942576, 528.0811388184532, 542.7666103575422, 587.1281147495965, 589.1457386789173, 611.1810174366282, 7790.922090779133, 8453.0, 8493.696084936972, 8505.48967061966, 8651.221390074923, 621.2296752027454, 637.4295005969631, 637.91069250305, 648.5233353485185, 652.1294072413381, 3972.66232370246, 4077.429159917614, 4091.3044782387065, 4114.5679703630685, 4218.282891908321, 112833.43583282195, 112885.87114128917, 113161.30258046136, 115100.42449787697, 117143.0, 66810.3318966804, 93300.53349733344, 103397.48301258446, 104565.0, 105588.88822223512, 91626.54186729157, 92875.53562232146, 93505.5324723372, 93521.59717604377, 95870.0, 7786.054487512991, 8099.927697025558, 8149.674013039649, 8248.670053198044, 8253.298469629908, 53992.19011714906, 57805.421945780006, 59840.0, 60048.69975650268, 61599.692001539705, 82011.5899420499, 82208.0, 85336.0, 86307.56846215729, 88613.55693221492, 9856.915739268532, 10972.177086718368, 11322.886771132513, 11469.713257168638, 11539.596114135966, 12488.0, 12794.616161515169, 12970.870291297344, 12978.67553311137, 12986.285754283605, 12018.819717704067, 12879.871201288242, 13011.609651710463, 13293.734125317245, 13309.86690133125, 10196.898031019891, 12723.109382343517, 12886.420111094836, 13336.733265334833, 13417.463301467831, 12541.0, 12847.100702950704, 13338.0, 13379.264140472367, 13451.932740336628, 8946.731598052069, 10951.616693415692, 11091.0, 11221.775564488502, 11534.884651153381, 8007.959960200162, 8831.381803273709, 10924.945375273073, 11140.82753862989, 11213.327200368005], "value": 7244.639387942198, "unit": "score"}], "name": "dromaeo_css", "value": 7165.92226952746, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 114.0, 117.0, 162.0, 168.0, 114.0, 112.0, 113.0, 114.0], "value": 123.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 111.0, 116.0, 146.0, 108.0, 118.0, 97.0, 136.0, 177.0, 142.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 186.0, 186.0, 181.0, 184.0, 183.0, 182.0, 182.0, 183.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 72.0, 114.0, 88.0, 75.0, 60.0, 59.0, 83.0, 58.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 72.0, 91.0, 70.0, 68.0, 68.0, 94.0, 67.0, 69.0, 91.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 91.0, 88.0, 90.0, 88.0, 91.0, 87.0, 92.0, 130.0], "value": 93.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 82.0, 83.0, 82.0, 84.0, 82.0, 82.0, 83.0], "value": 82.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 55.0, 56.0, 54.0, 55.0, 56.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 72.0, 78.0, 73.0, 69.0, 70.0, 70.0, 70.0, 71.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 83.0, 86.0, 91.0, 86.0, 86.0, 90.0, 85.0, 92.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 141.0, 145.0, 145.0, 147.0, 150.0, 153.0, 161.0, 186.0, 146.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 175.0, 172.0, 170.0, 173.0, 177.0, 175.0, 219.0, 172.0], "value": 178.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 68.0, 66.0, 66.0, 69.0, 71.0, 89.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1474.1, "alertThreshold": 2.0}]} 10:02:04 INFO - Return code: 0 10:02:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:02:04 INFO - # TBPL SUCCESS # 10:02:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:02:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:02:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:02:04 INFO - 2016-10-31 10:02:04.806 screenresolution[1673:9783] starting screenresolution argv=screenresolution get 10:02:04 INFO - 2016-10-31 10:02:04.809 screenresolution[1673:9783] Display 0: 1600x1200x32@60 10:02:04 INFO - 2016-10-31 10:02:04.815 screenresolution[1674:9786] starting screenresolution argv=screenresolution list 10:02:04 INFO - Available Modes on Display 0 10:02:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:02:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:02:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:02:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:02:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:02:05 INFO - Intel Iris: 10:02:05 INFO - Chipset Model: Intel Iris 10:02:05 INFO - Type: GPU 10:02:05 INFO - Bus: Built-In 10:02:05 INFO - VRAM (Dynamic, Max): 1536 MB 10:02:05 INFO - Vendor: Intel (0x8086) 10:02:05 INFO - Device ID: 0x0a2e 10:02:05 INFO - Revision ID: 0x0009 10:02:05 INFO - Displays: 10:02:05 INFO - Display: 10:02:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:02:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:02:05 INFO - Display Serial Number: 1600x1200 60 10:02:05 INFO - Main Display: Yes 10:02:05 INFO - Mirror: Off 10:02:05 INFO - Online: Yes 10:02:05 INFO - Rotation: Supported 10:02:05 INFO - Return code: 0 10:02:05 INFO - Running post-action listener: _resource_record_post_action 10:02:05 INFO - [mozharness: 2016-10-31 17:02:05.057514Z] Finished run-tests step (success) 10:02:05 INFO - Running post-run listener: _resource_record_post_run 10:02:05 INFO - Total resource usage - Wall time: 1216s; CPU: 53.0%; Read bytes: 37385216; Write bytes: 708841984; Read time: 239; Write time: 2023 10:02:05 INFO - TinderboxPrint: CPU usage
53.4% 10:02:05 INFO - TinderboxPrint: I/O read bytes / time
37,385,216 / 239 10:02:05 INFO - TinderboxPrint: I/O write bytes / time
708,841,984 / 2,023 10:02:05 INFO - TinderboxPrint: CPU idle
2,267.4 (46.6%) 10:02:05 INFO - TinderboxPrint: CPU system
971.1 (20.0%) 10:02:05 INFO - TinderboxPrint: CPU user
1,627.2 (33.4%) 10:02:05 INFO - TinderboxPrint: Swap in / out
444,661,760 / 0 10:02:05 INFO - install - Wall time: 36s; CPU: 54.0%; Read bytes: 398213632; Write bytes: 392273408; Read time: 30151; Write time: 864 10:02:05 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 35386368; Write bytes: 298157056; Read time: 222; Write time: 1110 10:02:05 INFO - Running post-run listener: _upload_blobber_files 10:02:05 INFO - Blob upload gear active. 10:02:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:02:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:02:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:02:05 INFO - (blobuploader) - INFO - Open directory for files ... 10:02:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:02:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:02:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:07 INFO - (blobuploader) - INFO - Done attempting. 10:02:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:02:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:02:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:08 INFO - (blobuploader) - INFO - Done attempting. 10:02:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:02:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:02:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:11 INFO - (blobuploader) - INFO - Done attempting. 10:02:11 INFO - (blobuploader) - INFO - Iteration through files over. 10:02:11 INFO - Return code: 0 10:02:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:02:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:02:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74ba90e0506612bf9f24fde5513c5e1a288224b00925544dcfab0777e72b1889555318ac2cc11bc5afd8bd6c66c48b265d55ab584e15503b48722ab41f00c342", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/220b053ff279efbecaf05879599b086e2f10c7282c2c9ac028a13de2d2c40def8c5ef554097d464475f37882c26733ede946f349093abcb4adbab98b893a0fea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddd0b47b8209c57eecc8e22519426f3bb5899b72259e9ef33043c78b6b69e4b33dc5497bd0be398c4f30e84867ada98f4986b92cf97a85e905f5a1425df2e997"} 10:02:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:02:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:02:11 INFO - Contents: 10:02:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74ba90e0506612bf9f24fde5513c5e1a288224b00925544dcfab0777e72b1889555318ac2cc11bc5afd8bd6c66c48b265d55ab584e15503b48722ab41f00c342", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/220b053ff279efbecaf05879599b086e2f10c7282c2c9ac028a13de2d2c40def8c5ef554097d464475f37882c26733ede946f349093abcb4adbab98b893a0fea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddd0b47b8209c57eecc8e22519426f3bb5899b72259e9ef33043c78b6b69e4b33dc5497bd0be398c4f30e84867ada98f4986b92cf97a85e905f5a1425df2e997"} 10:02:11 INFO - Running post-run listener: copy_logs_to_upload_dir 10:02:11 INFO - Copying logs to upload dir... 10:02:11 INFO - mkdir: /builds/slave/test/build/upload/logs 10:02:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.833389 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-10-31 10:02:11.688028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 10:02:11.691697) ========= 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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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/74ba90e0506612bf9f24fde5513c5e1a288224b00925544dcfab0777e72b1889555318ac2cc11bc5afd8bd6c66c48b265d55ab584e15503b48722ab41f00c342", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/220b053ff279efbecaf05879599b086e2f10c7282c2c9ac028a13de2d2c40def8c5ef554097d464475f37882c26733ede946f349093abcb4adbab98b893a0fea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddd0b47b8209c57eecc8e22519426f3bb5899b72259e9ef33043c78b6b69e4b33dc5497bd0be398c4f30e84867ada98f4986b92cf97a85e905f5a1425df2e997"} build_url:https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011057 build_url: 'https://queue.taskcluster.net/v1/task/Q2sYU9b8T4GYH4bUnUNKHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74ba90e0506612bf9f24fde5513c5e1a288224b00925544dcfab0777e72b1889555318ac2cc11bc5afd8bd6c66c48b265d55ab584e15503b48722ab41f00c342", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/220b053ff279efbecaf05879599b086e2f10c7282c2c9ac028a13de2d2c40def8c5ef554097d464475f37882c26733ede946f349093abcb4adbab98b893a0fea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddd0b47b8209c57eecc8e22519426f3bb5899b72259e9ef33043c78b6b69e4b33dc5497bd0be398c4f30e84867ada98f4986b92cf97a85e905f5a1425df2e997"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 10:02:11.726794) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 10:02:11.727409) ========= 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.87V0OWV0Bt/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.zL5Lj9ajuC/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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.005058 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 10:02:11.776638) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 10:02:11.777378) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 10:02:11.778061) ========= ========= Total master_lag: 0.18 =========