builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0180 starttime: 1468086663.99 results: success (0) buildid: 20160709090127 builduid: 767be1e5e05a4f51b51b5bcc9a402adb revision: 679118259e91f40d4a8f968f03ec4cff066cdb5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 10:51:03.989203) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 10:51:03.989645) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 10:51:03.989922) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 10:51:04.278784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 10:51:04.279272) ========= 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.MPfyTkyzkN/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.WxNCJVy6pa/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-07-09 10:51:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 135M=0s 2016-07-09 10:51:04 (135 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.475200 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 10:51:04.893971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 10:51:04.894299) ========= 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.MPfyTkyzkN/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.WxNCJVy6pa/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.020388 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 10:51:05.014726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-09 10:51:05.015233) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 679118259e91f40d4a8f968f03ec4cff066cdb5b --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 679118259e91f40d4a8f968f03ec4cff066cdb5b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MPfyTkyzkN/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.WxNCJVy6pa/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-07-09 10:51:05,100 truncating revision to first 12 chars 2016-07-09 10:51:05,100 Setting DEBUG logging. 2016-07-09 10:51:05,100 attempt 1/10 2016-07-09 10:51:05,100 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/679118259e91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-09 10:51:06,189 unpacking tar archive at: fx-team-679118259e91/testing/mozharness/ program finished with exit code 0 elapsedTime=1.359892 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-09 10:51:06.437239) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 10:51:06.437595) ========= script_repo_revision: 679118259e91f40d4a8f968f03ec4cff066cdb5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 10:51:06.438071) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 10:51:06.438352) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 10:51:06.840518) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-07-09 10:51:06.840861) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MPfyTkyzkN/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.WxNCJVy6pa/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:51:07 INFO - MultiFileLogger online at 20160709 10:51:07 in /builds/slave/test 10:51:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:51:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:51:07 INFO - {'append_to_log': False, 10:51:07 INFO - 'base_work_dir': '/builds/slave/test', 10:51:07 INFO - 'blob_upload_branch': 'Fx-Team', 10:51:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:51:07 INFO - 'branch': 'Fx-Team', 10:51:07 INFO - 'buildbot_json_path': 'buildprops.json', 10:51:07 INFO - 'config_files': ('talos/mac_config.py',), 10:51:07 INFO - 'default_actions': ('clobber', 10:51:07 INFO - 'read-buildbot-config', 10:51:07 INFO - 'download-and-extract', 10:51:07 INFO - 'populate-webroot', 10:51:07 INFO - 'create-virtualenv', 10:51:07 INFO - 'install', 10:51:07 INFO - 'run-tests'), 10:51:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:51:07 INFO - 'download_minidump_stackwalk': True, 10:51:07 INFO - 'download_symbols': 'ondemand', 10:51:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:51:07 INFO - 'tooltool.py': '/tools/tooltool.py', 10:51:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:51:07 INFO - '/tools/misc-python/virtualenv.py')}, 10:51:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:51:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:51:07 INFO - 'installer_path': 'installer.exe', 10:51:07 INFO - 'log_level': 'info', 10:51:07 INFO - 'log_name': 'talos', 10:51:07 INFO - 'log_to_console': True, 10:51:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:51:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:51:07 INFO - 'opt_config_files': (), 10:51:07 INFO - 'pip_index': False, 10:51:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:51:07 INFO - 'cmd': ('bash', 10:51:07 INFO - '-c', 10:51:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:51:07 INFO - 'enabled': True, 10:51:07 INFO - 'halt_on_failure': False, 10:51:07 INFO - 'name': 'check_screen_resolution'},), 10:51:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:51:07 INFO - 'cmd': ('bash', 10:51:07 INFO - '-c', 10:51:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:51:07 INFO - 'enabled': True, 10:51:07 INFO - 'halt_on_failure': False, 10:51:07 INFO - 'name': 'check_screen_resolution'},), 10:51:07 INFO - 'run_cmd_checks_enabled': True, 10:51:07 INFO - 'sps_profile': False, 10:51:07 INFO - 'sps_profile_interval': 0, 10:51:07 INFO - 'suite': 'dromaeojs', 10:51:07 INFO - 'system_bits': '32', 10:51:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:51:07 INFO - 'title': 't-yosemite-r7-0180', 10:51:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:51:07 INFO - 'use_talos_json': True, 10:51:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:51:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:51:07 INFO - 'work_dir': 'build'} 10:51:07 INFO - ##### 10:51:07 INFO - ##### Running clobber step. 10:51:07 INFO - ##### 10:51:07 INFO - Running pre-action listener: _resource_record_pre_action 10:51:07 INFO - Running main action method: clobber 10:51:07 INFO - rmtree: /builds/slave/test/build 10:51:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:51:08 INFO - Running post-action listener: _resource_record_post_action 10:51:08 INFO - ##### 10:51:08 INFO - ##### Finished clobber step (success) 10:51:08 INFO - ##### 10:51:08 INFO - ##### 10:51:08 INFO - ##### Running read-buildbot-config step. 10:51:08 INFO - ##### 10:51:08 INFO - Running pre-action listener: _resource_record_pre_action 10:51:08 INFO - Running main action method: read_buildbot_config 10:51:08 INFO - Using buildbot properties: 10:51:08 INFO - { 10:51:08 INFO - "project": "", 10:51:08 INFO - "product": "firefox", 10:51:08 INFO - "script_repo_revision": "production", 10:51:08 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:51:08 INFO - "repository": "", 10:51:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:51:08 INFO - "buildid": "20160709090127", 10:51:08 INFO - "pgo_build": "False", 10:51:08 INFO - "basedir": "/builds/slave/test", 10:51:08 INFO - "buildnumber": 882, 10:51:08 INFO - "slavename": "t-yosemite-r7-0180", 10:51:08 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:51:08 INFO - "platform": "yosemite_r7", 10:51:08 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:51:08 INFO - "branch": "fx-team", 10:51:08 INFO - "repo_path": "integration/fx-team", 10:51:08 INFO - "revision": "679118259e91f40d4a8f968f03ec4cff066cdb5b", 10:51:08 INFO - "stage_platform": "macosx64", 10:51:08 INFO - "builduid": "767be1e5e05a4f51b51b5bcc9a402adb", 10:51:08 INFO - "slavebuilddir": "test" 10:51:08 INFO - } 10:51:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 10:51:08 INFO - Running post-action listener: _resource_record_post_action 10:51:08 INFO - ##### 10:51:08 INFO - ##### Finished read-buildbot-config step (success) 10:51:08 INFO - ##### 10:51:08 INFO - ##### 10:51:08 INFO - ##### Running download-and-extract step. 10:51:08 INFO - ##### 10:51:08 INFO - Running pre-action listener: _resource_record_pre_action 10:51:08 INFO - Running main action method: download_and_extract 10:51:08 INFO - mkdir: /builds/slave/test/build/tests 10:51:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:08 INFO - https://queue.taskcluster.net/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:51:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:51:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:51:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:51:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 10:51:18 INFO - Downloaded 1199 bytes. 10:51:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:51:18 INFO - Using the following test package requirements: 10:51:18 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:51:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:51:18 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 10:51:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:51:18 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 10:51:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:51:18 INFO - u'jsshell-mac.zip'], 10:51:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:51:18 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 10:51:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:51:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:51:18 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 10:51:18 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:51:18 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 10:51:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:51:18 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 10:51:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:51:18 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 10:51:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:51:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:18 INFO - https://queue.taskcluster.net/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:51:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:51:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:51:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:51:22 INFO - Downloaded 18806818 bytes. 10:51:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:51:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:51:25 INFO - Return code: 0 10:51:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:51: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:25 INFO - https://queue.taskcluster.net/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:51:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:51:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:51:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:51:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:51:34 INFO - Downloaded 18806818 bytes. 10:51:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:51:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:51:38 INFO - Return code: 0 10:51:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:38 INFO - https://queue.taskcluster.net/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:51:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:51:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:51:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:51:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:51:39 INFO - Downloaded 14403333 bytes. 10:51:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:51:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:51:39 INFO - Return code: 0 10:51:39 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:39 INFO - https://queue.taskcluster.net/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 10:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 10:51:46 INFO - Downloaded 112361527 bytes. 10:51:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:51:46 INFO - mkdir: /builds/slave/test/properties 10:51:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:51:46 INFO - Writing to file /builds/slave/test/properties/build_url 10:51:46 INFO - Contents: 10:51:46 INFO - build_url:https://queue.taskcluster.net/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:51:47 INFO - Running post-action listener: _resource_record_post_action 10:51:47 INFO - Running post-action listener: set_extra_try_arguments 10:51:47 INFO - ##### 10:51:47 INFO - ##### Finished download-and-extract step (success) 10:51:47 INFO - ##### 10:51:47 INFO - ##### 10:51:47 INFO - ##### Running populate-webroot step. 10:51:47 INFO - ##### 10:51:47 INFO - Running pre-action listener: _resource_record_pre_action 10:51:47 INFO - Running main action method: populate_webroot 10:51:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:51:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:51:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:51:47 INFO - '--tppagecycles', 10:51:47 INFO - '7'], 10:51:47 INFO - 'tests': ['tsvgm']}}, 10:51:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:51:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:51:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:51:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:51:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:51:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:51:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:47 INFO - 'talos_options': ['--disable-e10s'], 10:51:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:47 INFO - 'talos_options': ['--disable-e10s'], 10:51:47 INFO - 'tests': ['damp', 'tps']}, 10:51:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:47 INFO - 'tests': ['damp', 'tps']}, 10:51:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:51:47 INFO - 'tests': ['dromaeo_dom']}, 10:51:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:51:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:51:47 INFO - 'tests': ['basic_compositor_video']}, 10:51:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:51:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:51:47 INFO - 'tests': ['a11yr', 10:51:47 INFO - 'ts_paint', 10:51:47 INFO - 'tpaint', 10:51:47 INFO - 'sessionrestore', 10:51:47 INFO - 'sessionrestore_no_auto_restore', 10:51:47 INFO - 'tabpaint']}, 10:51:47 INFO - 'other-e10s': {'tests': ['a11yr', 10:51:47 INFO - 'ts_paint', 10:51:47 INFO - 'tpaint', 10:51:47 INFO - 'sessionrestore', 10:51:47 INFO - 'sessionrestore_no_auto_restore', 10:51:47 INFO - 'tabpaint']}, 10:51:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:51:47 INFO - 'ts_paint', 10:51:47 INFO - 'tpaint', 10:51:47 INFO - 'sessionrestore', 10:51:47 INFO - 'sessionrestore_no_auto_restore', 10:51:47 INFO - 'tabpaint']}, 10:51:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:51:47 INFO - 'ts_paint', 10:51:47 INFO - 'tpaint', 10:51:47 INFO - 'sessionrestore', 10:51:47 INFO - 'sessionrestore_no_auto_restore', 10:51:47 INFO - 'tabpaint']}, 10:51:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:51:47 INFO - 'tests': ['a11yr', 10:51:47 INFO - 'ts_paint', 10:51:47 INFO - 'tpaint', 10:51:47 INFO - 'sessionrestore', 10:51:47 INFO - 'sessionrestore_no_auto_restore', 10:51:47 INFO - 'tabpaint']}, 10:51:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:51:47 INFO - 'tests': ['a11yr', 10:51:47 INFO - 'ts_paint', 10:51:47 INFO - 'tpaint', 10:51:47 INFO - 'sessionrestore', 10:51:47 INFO - 'sessionrestore_no_auto_restore', 10:51:47 INFO - 'tabpaint']}, 10:51:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:51:47 INFO - 'tests': ['tsvgx', 10:51:47 INFO - 'tsvgr_opacity', 10:51:47 INFO - 'tart', 10:51:47 INFO - 'tscrollx', 10:51:47 INFO - 'cart']}, 10:51:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:51:47 INFO - 'tsvgr_opacity', 10:51:47 INFO - 'tart', 10:51:47 INFO - 'tscrollx', 10:51:47 INFO - 'cart']}, 10:51:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:47 INFO - 'talos_options': ['--disable-e10s'], 10:51:47 INFO - 'tests': ['tp5o']}, 10:51:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:47 INFO - 'tests': ['tp5o']}, 10:51:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:47 INFO - 'talos_options': ['--disable-e10s', 10:51:47 INFO - '--xperf_path', 10:51:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:47 INFO - 'tests': ['tp5n']}, 10:51:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:47 INFO - 'talos_options': ['--xperf_path', 10:51:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:47 INFO - 'tests': ['tp5n']}}, 10:51:47 INFO - 'talos.zip': {'path': '', 10:51:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:51:47 INFO - Running post-action listener: _resource_record_post_action 10:51:47 INFO - ##### 10:51:47 INFO - ##### Finished populate-webroot step (success) 10:51:47 INFO - ##### 10:51:47 INFO - ##### 10:51:47 INFO - ##### Running create-virtualenv step. 10:51:47 INFO - ##### 10:51:47 INFO - Running pre-action listener: _resource_record_pre_action 10:51:47 INFO - Running main action method: create_virtualenv 10:51:47 INFO - Creating virtualenv /builds/slave/test/build/venv 10:51:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:51:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:51:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:51:47 INFO - Using real prefix '/tools/python27' 10:51:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:51:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:51:51 INFO - Installing pip.................done. 10:51:51 INFO - Return code: 0 10:51:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:51:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:51 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 0x101090a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101125618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333599310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff4d30>, '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 0x100d59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fecb20>, '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.MPfyTkyzkN/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.WxNCJVy6pa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:51:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MPfyTkyzkN/Render', 10:51:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:51 INFO - 'HOME': '/Users/cltbld', 10:51:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:51 INFO - 'LOGNAME': 'cltbld', 10:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:51 INFO - 'MOZ_NO_REMOTE': '1', 10:51:51 INFO - 'NO_EM_RESTART': '1', 10:51:51 INFO - 'PAGER': '/bin/cat', 10:51:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:51 INFO - 'PWD': '/builds/slave/test', 10:51:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:51 INFO - 'SHELL': '/bin/bash', 10:51:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxNCJVy6pa/Listeners', 10:51:51 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 10:51:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:51 INFO - 'USER': 'cltbld', 10:51:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:51 INFO - 'XPC_FLAGS': '0x0', 10:51:51 INFO - 'XPC_SERVICE_NAME': '0', 10:51:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:51:51 INFO - Cleaning up... 10:51:51 INFO - Return code: 0 10:51:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:51:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:51 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 0x101090a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101125618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333599310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff4d30>, '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 0x100d59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fecb20>, '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.MPfyTkyzkN/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.WxNCJVy6pa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:51:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MPfyTkyzkN/Render', 10:51:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:51 INFO - 'HOME': '/Users/cltbld', 10:51:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:51 INFO - 'LOGNAME': 'cltbld', 10:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:51 INFO - 'MOZ_NO_REMOTE': '1', 10:51:51 INFO - 'NO_EM_RESTART': '1', 10:51:51 INFO - 'PAGER': '/bin/cat', 10:51:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:51 INFO - 'PWD': '/builds/slave/test', 10:51:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:51 INFO - 'SHELL': '/bin/bash', 10:51:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxNCJVy6pa/Listeners', 10:51:51 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 10:51:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:51 INFO - 'USER': 'cltbld', 10:51:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:51 INFO - 'XPC_FLAGS': '0x0', 10:51:51 INFO - 'XPC_SERVICE_NAME': '0', 10:51:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:51 INFO - Downloading/unpacking psutil>=3.1.1 10:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:51:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:54 INFO - Installing collected packages: psutil 10:51:54 INFO - Running setup.py install for psutil 10:51:54 INFO - building 'psutil._psutil_osx' extension 10:51:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:51:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:51:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:51:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:51:55 INFO - building 'psutil._psutil_posix' extension 10:51:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:51:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:51:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:51:55 INFO - ^ 10:51:55 INFO - 1 warning generated. 10:51:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:51:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:55 INFO - Successfully installed psutil 10:51:55 INFO - Cleaning up... 10:51:55 INFO - Return code: 0 10:51:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:51: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101090a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101125618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333599310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff4d30>, '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 0x100d59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fecb20>, '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.MPfyTkyzkN/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.WxNCJVy6pa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:51:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MPfyTkyzkN/Render', 10:51:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:55 INFO - 'HOME': '/Users/cltbld', 10:51:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:55 INFO - 'LOGNAME': 'cltbld', 10:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:55 INFO - 'MOZ_NO_REMOTE': '1', 10:51:55 INFO - 'NO_EM_RESTART': '1', 10:51:55 INFO - 'PAGER': '/bin/cat', 10:51:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:55 INFO - 'PWD': '/builds/slave/test', 10:51:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:55 INFO - 'SHELL': '/bin/bash', 10:51:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxNCJVy6pa/Listeners', 10:51:55 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 10:51:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:55 INFO - 'USER': 'cltbld', 10:51:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:55 INFO - 'XPC_FLAGS': '0x0', 10:51:55 INFO - 'XPC_SERVICE_NAME': '0', 10:51:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:51:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:51:58 INFO - Installing collected packages: mozsystemmonitor 10:51:58 INFO - Running setup.py install for mozsystemmonitor 10:51:58 INFO - Successfully installed mozsystemmonitor 10:51:58 INFO - Cleaning up... 10:51:58 INFO - Return code: 0 10:51:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101090a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101125618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333599310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff4d30>, '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 0x100d59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fecb20>, '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.MPfyTkyzkN/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.WxNCJVy6pa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:51:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:51:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MPfyTkyzkN/Render', 10:51:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:58 INFO - 'HOME': '/Users/cltbld', 10:51:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:58 INFO - 'LOGNAME': 'cltbld', 10:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:58 INFO - 'MOZ_NO_REMOTE': '1', 10:51:58 INFO - 'NO_EM_RESTART': '1', 10:51:58 INFO - 'PAGER': '/bin/cat', 10:51:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:58 INFO - 'PWD': '/builds/slave/test', 10:51:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:58 INFO - 'SHELL': '/bin/bash', 10:51:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxNCJVy6pa/Listeners', 10:51:58 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 10:51:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:58 INFO - 'USER': 'cltbld', 10:51:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:58 INFO - 'XPC_FLAGS': '0x0', 10:51:58 INFO - 'XPC_SERVICE_NAME': '0', 10:51:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:59 INFO - Downloading/unpacking jsonschema==2.5.1 10:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:52:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:01 INFO - Downloading functools32-3.2.3-2.tar.gz 10:52:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:52:01 INFO - warning: no files found matching '*.txt' 10:52:01 INFO - no previously-included directories found matching 'build' 10:52:01 INFO - no previously-included directories found matching 'dist' 10:52:01 INFO - no previously-included directories found matching '.git*' 10:52:01 INFO - Installing collected packages: jsonschema, functools32 10:52:01 INFO - Running setup.py install for functools32 10:52:02 INFO - warning: no files found matching '*.txt' 10:52:02 INFO - no previously-included directories found matching 'build' 10:52:02 INFO - no previously-included directories found matching 'dist' 10:52:02 INFO - no previously-included directories found matching '.git*' 10:52:02 INFO - Successfully installed jsonschema functools32 10:52:02 INFO - Cleaning up... 10:52:02 INFO - Return code: 0 10:52:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:02 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 0x101090a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101125618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333599310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff4d30>, '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 0x100d59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fecb20>, '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.MPfyTkyzkN/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.WxNCJVy6pa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:52:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MPfyTkyzkN/Render', 10:52:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:02 INFO - 'HOME': '/Users/cltbld', 10:52:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:02 INFO - 'LOGNAME': 'cltbld', 10:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:02 INFO - 'MOZ_NO_REMOTE': '1', 10:52:02 INFO - 'NO_EM_RESTART': '1', 10:52:02 INFO - 'PAGER': '/bin/cat', 10:52:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:02 INFO - 'PWD': '/builds/slave/test', 10:52:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:02 INFO - 'SHELL': '/bin/bash', 10:52:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxNCJVy6pa/Listeners', 10:52:02 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 10:52:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:02 INFO - 'USER': 'cltbld', 10:52:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:02 INFO - 'XPC_FLAGS': '0x0', 10:52:02 INFO - 'XPC_SERVICE_NAME': '0', 10:52:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:02 INFO - Downloading/unpacking blobuploader==1.2.4 10:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:04 INFO - Downloading blobuploader-1.2.4.tar.gz 10:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:52:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:52:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:06 INFO - Downloading docopt-0.6.1.tar.gz 10:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:52:06 INFO - Installing collected packages: blobuploader, requests, docopt 10:52:06 INFO - Running setup.py install for blobuploader 10:52:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:52:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:52:06 INFO - Running setup.py install for requests 10:52:06 INFO - Running setup.py install for docopt 10:52:06 INFO - Successfully installed blobuploader requests docopt 10:52:06 INFO - Cleaning up... 10:52:07 INFO - Return code: 0 10:52:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:07 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 0x101090a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101125618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333599310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff4d30>, '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 0x100d59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fecb20>, '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.MPfyTkyzkN/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.WxNCJVy6pa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:52:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MPfyTkyzkN/Render', 10:52:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:07 INFO - 'HOME': '/Users/cltbld', 10:52:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:07 INFO - 'LOGNAME': 'cltbld', 10:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:07 INFO - 'MOZ_NO_REMOTE': '1', 10:52:07 INFO - 'NO_EM_RESTART': '1', 10:52:07 INFO - 'PAGER': '/bin/cat', 10:52:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:07 INFO - 'PWD': '/builds/slave/test', 10:52:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:07 INFO - 'SHELL': '/bin/bash', 10:52:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxNCJVy6pa/Listeners', 10:52:07 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 10:52:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:07 INFO - 'USER': 'cltbld', 10:52:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:07 INFO - 'XPC_FLAGS': '0x0', 10:52:07 INFO - 'XPC_SERVICE_NAME': '0', 10:52:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Yp41JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-PeuFvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-UN9F3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-2dId_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ZegMZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-QglDKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-p16NnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:08 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Aw68GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:08 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-o4Mlun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:08 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ECzd6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:08 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-BbfzyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:08 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-MyGvl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:08 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-wlpuso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:08 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-yi13AW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:08 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-RVmLtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:08 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Y3mm7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:09 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-WomJPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:52:09 INFO - Running setup.py install for manifestparser 10:52:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:52:09 INFO - Running setup.py install for mozcrash 10:52:09 INFO - Running setup.py install for mozdebug 10:52:09 INFO - Running setup.py install for mozdevice 10:52:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:52:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:52:09 INFO - Running setup.py install for mozfile 10:52:09 INFO - Running setup.py install for mozhttpd 10:52:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:52:09 INFO - Running setup.py install for mozinfo 10:52:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:52:10 INFO - Running setup.py install for mozInstall 10:52:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:52:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:52:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:52:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:52:10 INFO - Running setup.py install for mozleak 10:52:10 INFO - Running setup.py install for mozlog 10:52:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:52:10 INFO - Running setup.py install for moznetwork 10:52:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:52:10 INFO - Running setup.py install for mozprocess 10:52:10 INFO - Running setup.py install for mozprofile 10:52:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:52:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:52:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:52:11 INFO - Running setup.py install for mozrunner 10:52:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:52:11 INFO - Running setup.py install for mozscreenshot 10:52:11 INFO - Running setup.py install for moztest 10:52:11 INFO - Running setup.py install for mozversion 10:52:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:52:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:52:11 INFO - Cleaning up... 10:52:11 INFO - Return code: 0 10:52:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:11 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 0x101090a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101125618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333599310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff4d30>, '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 0x100d59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fecb20>, '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.MPfyTkyzkN/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.WxNCJVy6pa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:52:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MPfyTkyzkN/Render', 10:52:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:11 INFO - 'HOME': '/Users/cltbld', 10:52:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:11 INFO - 'LOGNAME': 'cltbld', 10:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:11 INFO - 'MOZ_NO_REMOTE': '1', 10:52:11 INFO - 'NO_EM_RESTART': '1', 10:52:11 INFO - 'PAGER': '/bin/cat', 10:52:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:11 INFO - 'PWD': '/builds/slave/test', 10:52:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:11 INFO - 'SHELL': '/bin/bash', 10:52:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxNCJVy6pa/Listeners', 10:52:11 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 10:52:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:11 INFO - 'USER': 'cltbld', 10:52:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:11 INFO - 'XPC_FLAGS': '0x0', 10:52:11 INFO - 'XPC_SERVICE_NAME': '0', 10:52:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:11 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ccIcIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-2KMl9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-iwKrQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-KLsuyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-eDZbcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-_EPNCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-2KflTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Bjmwtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-AbyMnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:12 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-tsEJ8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-TM6zAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-yV51wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-wBni6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ob7pse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-sAb05V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-DDw3cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:13 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-yZcFSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:52:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:16 INFO - Downloading blessings-1.6.tar.gz 10:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:52:16 INFO - Installing collected packages: blessings 10:52:16 INFO - Running setup.py install for blessings 10:52:16 INFO - Successfully installed blessings 10:52:16 INFO - Cleaning up... 10:52:16 INFO - Return code: 0 10:52:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:52:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:16 INFO - Reading from file tmpfile_stdout 10:52:16 INFO - Current package versions: 10:52:16 INFO - blessings == 1.6 10:52:16 INFO - blobuploader == 1.2.4 10:52:16 INFO - docopt == 0.6.1 10:52:16 INFO - functools32 == 3.2.3-2 10:52:16 INFO - jsonschema == 2.5.1 10:52:16 INFO - manifestparser == 1.1 10:52:16 INFO - mozInstall == 1.12 10:52:16 INFO - mozcrash == 0.17 10:52:16 INFO - mozdebug == 0.1 10:52:16 INFO - mozdevice == 0.48 10:52:16 INFO - mozfile == 1.2 10:52:16 INFO - mozhttpd == 0.7 10:52:16 INFO - mozinfo == 0.9 10:52:16 INFO - mozleak == 0.1 10:52:16 INFO - mozlog == 3.2 10:52:16 INFO - moznetwork == 0.27 10:52:16 INFO - mozprocess == 0.23 10:52:16 INFO - mozprofile == 0.28 10:52:16 INFO - mozrunner == 6.12 10:52:16 INFO - mozscreenshot == 0.1 10:52:16 INFO - mozsystemmonitor == 0.3 10:52:16 INFO - moztest == 0.7 10:52:16 INFO - mozversion == 1.4 10:52:16 INFO - psutil == 3.1.1 10:52:16 INFO - requests == 1.2.3 10:52:16 INFO - wsgiref == 0.1.2 10:52:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:16 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 0x101090a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101125618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333599310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff4d30>, '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 0x100d59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fecb20>, '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.MPfyTkyzkN/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.WxNCJVy6pa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MPfyTkyzkN/Render', 10:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:16 INFO - 'HOME': '/Users/cltbld', 10:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:16 INFO - 'LOGNAME': 'cltbld', 10:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:16 INFO - 'MOZ_NO_REMOTE': '1', 10:52:16 INFO - 'NO_EM_RESTART': '1', 10:52:16 INFO - 'PAGER': '/bin/cat', 10:52:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:16 INFO - 'PWD': '/builds/slave/test', 10:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:16 INFO - 'SHELL': '/bin/bash', 10:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxNCJVy6pa/Listeners', 10:52:16 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 10:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:16 INFO - 'USER': 'cltbld', 10:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:16 INFO - 'XPC_FLAGS': '0x0', 10:52:16 INFO - 'XPC_SERVICE_NAME': '0', 10:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:52:17 INFO - Cleaning up... 10:52:17 INFO - Return code: 0 10:52:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:52:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:17 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 0x101090a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101125618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe333599310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff4d30>, '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 0x100d59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fecb20>, '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.MPfyTkyzkN/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.WxNCJVy6pa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:52:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:52:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MPfyTkyzkN/Render', 10:52:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:17 INFO - 'HOME': '/Users/cltbld', 10:52:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:17 INFO - 'LOGNAME': 'cltbld', 10:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:17 INFO - 'MOZ_NO_REMOTE': '1', 10:52:17 INFO - 'NO_EM_RESTART': '1', 10:52:17 INFO - 'PAGER': '/bin/cat', 10:52:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:17 INFO - 'PWD': '/builds/slave/test', 10:52:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:17 INFO - 'SHELL': '/bin/bash', 10:52:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxNCJVy6pa/Listeners', 10:52:17 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 10:52:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:17 INFO - 'USER': 'cltbld', 10:52:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:17 INFO - 'XPC_FLAGS': '0x0', 10:52:17 INFO - 'XPC_SERVICE_NAME': '0', 10:52:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:52:17 INFO - Cleaning up... 10:52:17 INFO - Return code: 0 10:52:17 INFO - Running post-action listener: _resource_record_post_action 10:52:17 INFO - Running post-action listener: _start_resource_monitoring 10:52:17 INFO - Starting resource monitoring. 10:52:17 INFO - ##### 10:52:17 INFO - ##### Finished create-virtualenv step (success) 10:52:17 INFO - ##### 10:52:17 INFO - ##### 10:52:17 INFO - ##### Running install step. 10:52:17 INFO - ##### 10:52:17 INFO - Running pre-action listener: _resource_record_pre_action 10:52:17 INFO - Running main action method: install 10:52:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:17 INFO - Reading from file tmpfile_stdout 10:52:17 INFO - Detecting whether we're running mozinstall >=1.0... 10:52:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:52:17 INFO - Reading from file tmpfile_stdout 10:52:17 INFO - Output received: 10:52:17 INFO - Usage: mozinstall [options] installer 10:52:17 INFO - Options: 10:52:17 INFO - -h, --help show this help message and exit 10:52:17 INFO - -d DEST, --destination=DEST 10:52:17 INFO - Directory to install application into. [default: 10:52:17 INFO - "/builds/slave/test"] 10:52:17 INFO - --app=APP Application being installed. [default: firefox] 10:52:17 INFO - mkdir: /builds/slave/test/build/application 10:52:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:52:52 INFO - Reading from file tmpfile_stdout 10:52:52 INFO - Output received: 10:52:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:52:52 INFO - Running post-action listener: _resource_record_post_action 10:52:52 INFO - ##### 10:52:52 INFO - ##### Finished install step (success) 10:52:52 INFO - ##### 10:52:52 INFO - ##### 10:52:52 INFO - ##### Running run-tests step. 10:52:52 INFO - ##### 10:52:52 INFO - Running pre-action listener: _resource_record_pre_action 10:52:52 INFO - Running main action method: run_tests 10:52:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:52:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:52:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:52:52 INFO - 2016-07-09 10:52:52.234 screenresolution[2333:291815] starting screenresolution argv=screenresolution get 10:52:52 INFO - 2016-07-09 10:52:52.236 screenresolution[2333:291815] Display 0: 1600x1200x32@60 10:52:52 INFO - 2016-07-09 10:52:52.242 screenresolution[2334:291818] starting screenresolution argv=screenresolution list 10:52:52 INFO - Available Modes on Display 0 10:52:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:52:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:52:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:52:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:52:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:52:52 INFO - Intel Iris: 10:52:52 INFO - Chipset Model: Intel Iris 10:52:52 INFO - Type: GPU 10:52:52 INFO - Bus: Built-In 10:52:52 INFO - VRAM (Dynamic, Max): 1536 MB 10:52:52 INFO - Vendor: Intel (0x8086) 10:52:52 INFO - Device ID: 0x0a2e 10:52:52 INFO - Revision ID: 0x0009 10:52:52 INFO - Displays: 10:52:52 INFO - Display: 10:52:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:52:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:52:52 INFO - Display Serial Number: 1600x1200 60 10:52:52 INFO - Main Display: Yes 10:52:52 INFO - Mirror: Off 10:52:52 INFO - Online: Yes 10:52:52 INFO - Rotation: Supported 10:52:52 INFO - Return code: 0 10:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:52:52 INFO - Python 2.7.3 10:52:52 INFO - Return code: 0 10:52:52 INFO - grabbing minidump binary from tooltool 10:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:52 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 0x100ff4d30>, '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 0x100d59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100fecb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:52:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:52:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:52:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:52:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:52:52 INFO - Return code: 0 10:52:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:52:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:52:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:52:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:52:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:52:52 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/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:52:52 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/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0180 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:52:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MPfyTkyzkN/Render', 10:52:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:52 INFO - 'HOME': '/Users/cltbld', 10:52:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:52 INFO - 'LOGNAME': 'cltbld', 10:52:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:52:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:52 INFO - 'MOZ_NO_REMOTE': '1', 10:52:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:52:52 INFO - 'NO_EM_RESTART': '1', 10:52:52 INFO - 'PAGER': '/bin/cat', 10:52:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:52 INFO - 'PWD': '/builds/slave/test', 10:52:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:52:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:52 INFO - 'SHELL': '/bin/bash', 10:52:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WxNCJVy6pa/Listeners', 10:52:52 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 10:52:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:52 INFO - 'USER': 'cltbld', 10:52:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:52 INFO - 'XPC_FLAGS': '0x0', 10:52:52 INFO - 'XPC_SERVICE_NAME': '0', 10:52:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:52 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/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:52:52 INFO - mozversion application_buildid: 20160709090127 10:52:52 INFO - mozversion application_changeset: 679118259e91f40d4a8f968f03ec4cff066cdb5b 10:52:52 INFO - mozversion application_display_name: Nightly 10:52:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:52:52 INFO - mozversion application_name: Firefox 10:52:52 INFO - mozversion application_remotingname: firefox 10:52:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:52:52 INFO - mozversion application_vendor: Mozilla 10:52:52 INFO - mozversion application_version: 50.0a1 10:52:52 INFO - mozversion platform_buildid: 20160709090127 10:52:52 INFO - mozversion platform_changeset: 679118259e91f40d4a8f968f03ec4cff066cdb5b 10:52:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:52:52 INFO - mozversion platform_version: 50.0a1 10:52:52 INFO - using testdate: 1468086772 10:52:52 INFO - actual date: 1468086772 10:52:52 INFO - starting webserver on 'localhost:52761' 10:52:52 INFO - SUITE-START | Running 2 tests 10:52:52 INFO - TEST-START | dromaeo_css 10:52:52 INFO - operating with platform_type : mac_ 10:52:52 INFO - Initialising browser for dromaeo_css test... 10:52:52 INFO - TEST-INFO | started process 2344 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmp8QOhqZ/profile http://localhost:52761/getInfo.html) 10:52:54 INFO - PROCESS | 2344 | __metrics Screen width/height:1600/1200 10:52:54 INFO - PROCESS | 2344 | colorDepth:24 10:52:54 INFO - PROCESS | 2344 | Browser inner width/height: 1024/689 10:52:54 INFO - PROCESS | 2344 | __metrics 10:52:55 INFO - PROCESS | 2344 | 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:52:55 INFO - PROCESS | 2344 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:52:55 INFO - TEST-INFO | 2344: exit 0 10:52:55 INFO - Browser initialized. 10:52:55 INFO - Running cycle 1/1 for dromaeo_css test... 10:52:55 INFO - TEST-INFO | started process 2346 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmp8QOhqZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:07 INFO - PROCESS | 2346 | RSS: Main: 243560448 10:53:07 INFO - PROCESS | 2346 | 10:53:59 INFO - PROCESS | 2346 | 1468086839529 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:56:09 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:52761/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52761/tests/dromaeo/cssquery-ext.html) 10:56:11 INFO - PROCESS | 2346 | RSS: Main: 356610048 10:56:11 INFO - PROCESS | 2346 | 10:59:14 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:52761/tests/dromaeo/cssquery-ext.html (next: http://localhost:52761/tests/dromaeo/cssquery-jquery.html) 10:59:15 INFO - PROCESS | 2346 | RSS: Main: 379940864 10:59:15 INFO - PROCESS | 2346 | 11:02:17 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:52761/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52761/tests/dromaeo/cssquery-mootools.html) 11:02:18 INFO - PROCESS | 2346 | RSS: Main: 372871168 11:02:18 INFO - PROCESS | 2346 | 11:05:20 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:52761/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52761/tests/dromaeo/cssquery-prototype.html) 11:05:21 INFO - PROCESS | 2346 | RSS: Main: 371638272 11:05:21 INFO - PROCESS | 2346 | 11:08:24 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:52761/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52761/tests/dromaeo/cssquery-yui.html) 11:08:25 INFO - PROCESS | 2346 | RSS: Main: 335986688 11:08:25 INFO - PROCESS | 2346 | 11:11:29 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:52761/tests/dromaeo/cssquery-yui.html (next: http://localhost:52761/tests/dromaeo/cssquery-dojo.html) 11:11:29 INFO - PROCESS | 2346 | RSS: Main: 390246400 11:11:29 INFO - PROCESS | 2346 | 11:11:29 INFO - PROCESS | 2346 | __start_tp_report 11:11:29 INFO - PROCESS | 2346 | _x_x_mozilla_page_load 11:11:29 INFO - PROCESS | 2346 | _x_x_mozilla_page_load_details 11:11:29 INFO - PROCESS | 2346 | |i|pagename|runs| 11:11:29 INFO - PROCESS | 2346 | |0;dojo.html;3323.252268239646;3345.096823857557;3346.9163270918207;3354.5806774153225;3409.914752131198;5565.888682226353;5615.775368985241;5643.746031428585;5724.112762521805;5728.770849166033;5610.214569960209;5669.8582535436735;5746.827595172152;5764.596478246524;5826;5076.213186956028;5117.488251174871;5157.123289040854;5173.560247378959;5296.443873393296;5265.0259701955065;5290.1006828839;5292.047431462335;5316.813911513079;5349.625526213166;5128.666636668623;5177.37871455424;5189.506996835295;5221.843344699665;5241.056609810233;4434.933475997863;5101.923471147936;5110.9744451277875;5146.3824341078935;5200.687958722451;5101.336826212606;5149.742512874342;5182.326297581328;5195.844124676266;5249.186376111671;5699.287589051369;5711.314642242916;5741.684207368593;5758.539316854642;5785.508231800302;6111.899858025554;6136.733532366115;6211.130441738161;6213.099100630383;6274.905876411857;5529.972350138264;6271.5923464975085;6288.842778930518;6298.3701629837105;6317.147185129995;5696.458836410535;5829.213056237439;5842.941570584239;5881.441263080001;5904.439078287556;5261.263423120766;6240.500759939194;6275.905861412082;6296.275928268216;6296.590721603081;6187.3503282155625;6187.659678717624;6193.163922870445;6213.378662133841;6217.533684973645;6097.222222222223;6225.252969643671;6287.842803929939;6318.08387783778;6323.683815809191;6100.206973093469;6123.831729140451;6151.3541078187045;6213.099100630383;6214.223222097238;6212.9068063979075;6280.654563998933;6291;6301.086342480315;6306.527010474233;5012.448630650625;5013.172826483589;5016.44819069902;5033.446320904697;5051.696898186121;4308.224519586442;4416.315471101984;4444.177827101932;4450.732956022649;4569.314602809605;5596.496315331639;5605.887882242332;5616.6068375213345;5617.410171931889;5646.378898321182;6116.3883611638485;6139.570230083851;6142.447179753754;6158.137860699506;6159.199304090529;5526.668399896019;5605.635633683797;5718.857028574235;5736.311642602915;5790.10253410722;5467.234587157801;5474.616776825664;5474.863128421821;5483.177523371446;5499.50504454593;6272.874542509125;6290.4653104485715;6295.968520157461;6455.064015717789;6492.253390860112;6110.725017374318;6153.800008998202;6217.751289948352;6225.097360882556;6246.968765156145;6281.434670879643;6289.40250676185;6303.684815759286;6314.463270622048;6316.368363163647;6174.567780255339;6175.135481032748;6181.412765787243;6194.442500175006;6196.597221180609;6141.508679305555;6193.566450348612;6212.347703491068;6277.874442511215;6314.273858506147;6137.7851775187655;6145;6145.692715364304;6168.845778855385;6175.5677102602385;5932.940670593412;6075.665838378932;6113.51091912637;6149.692515374303;6152.0156774915795;5834.94165058344;5855.502282306052;5917.970410147922;5923.289205295392;5932.851678708067;6127.378954131758;6132.172156758959;6166.845828854314;6170.660613666291;6188;5931.754331590414;5975.103734439869;6004.039353703386;6009.849753756191;6012.098185272069 11:11:29 INFO - PROCESS | 2346 | |1;ext.html;449.44044664392817;519.5479932458761;519.9263520829488;527.1039233303385;536.9140937450009;30804.537931931038;41128.17743645129;42372;42440.363394549066;42451.57548424515;42866.71399858002;43037.92405189864;43154;43207.56792432075;43242.783786081025;8651.65393384267;9642.228621710281;9826.705198844045;9826.852597211047;9842.753931151707;8689.695860644879;11919.165658403916;12067.939660301687;12082.69793255167;12328.137030407875;12149.453274602663;12194.207376520542;12227.388630568481;12234.93882530586;12237.877621223808;8745.562721863946;11855.110866684947;12042;12078.335691536962;12163.999999999956;11912.463939122761;11988;11992;12008.919197272287;12009.279443233347;40311.99220019494;40631.18737625231;40651.57719479834;40661.59338406608;40705.38941915874;3534.487499312611;3572.678458938708;3674.779513229215;3694.907627309312;3821.426785982097;31382.686173138205;32132.196695082577;32280.838595807105;32332;32711.836440817882;3180.443422401094;3190.313554849692;3215.5819743433203;3245.269814291789;3336.5328853960464;512369;514441;516028;520540;522716.3864180693;33485.66514334874;61953.76092478125;62621.68689156525;62674.68662656749;62839.17223724852;34187.14532136667;35765.64234357675;35810;35823.104422389646;35882.8205858969;15090.24548772579;15139.015963962307;15260.160691162093;15265.847341526443;15282.159481228638;11641.825372619418;11836.349000804867;12581.559645412366;12747.42636581356;12783.296918669377;7836.412269079842;7847.176046515148;7853.253940875607;7908.4859484134495;7939.6824127035425;3007.7066861249436;3288.3423315337027;3288.638249792521;3293;3293.901182964515;820.659426338063;890.3900827932757;1028.493257377945;1030.314840630972;1099.4667586220676;30561;30900.69099309023;31122;31222;31647.367052658818;1090.2967585907045;1094.5074716377503;1112.9109671226283;1114.9944250278697;1179.475133565555;15889.967152135074;16123.871329007092;16191.919040404722;16297.67404651924;16630.916845415697;745065;754026;754625;755141.224293886;756621.2168939121;49675.50324496709;58407.70796146077;60047;60086;60150;1255.215490318551;1296.8184454176424;1378.9034767566575;1387.3479464651598;1429.421084460795;31721;31832.68167318297;32126.51810222802;32277.677223227467;32333.868314609816;49292.26061609007;49762.75118624384;50069.24896126634;50162.498375015784;50164.49835501598;497118;499410;499637;499742;502307;23496.530069398174;26208.868955655864;26685.332866678487;26688.866555667097;26728.331791705365;48236.517634823205;48255.517444825105;48835;49197;49398;39189.608103918596;40319.3952090713;40378.79810600928;40632.390514142906;40965;32521.02436926896;36676;39951.400728988505;40032.79983600063;40638.187236255704;38108.23783524369;38207.617923820406;38615.80692096522;38864.6113538861;38976.02559936024;33824.323513529096;33986.8300658505;34635.48046779351;34803.65196348004;34856.82571587126;25443.236702898943;25589;25761.840717168147;25771.969121235692;26371.4725705481 11:11:29 INFO - PROCESS | 2346 | |2;jquery.html;356.7360153486418;377.19280739218067;382.59253894602244;385.97105217108714;406.16127696307126;15611.921940390297;15855.445059422922;16852.57868553285;20624.69062964057;21300.89349553254;20792.48018799527;21134.788652113475;21246.68329967132;21446.678299825515;21501.03245353959;4738.597219236369;5554.305711786027;5704.201411802351;5969.820905372846;6016.608920420159;5635.182898479718;5878.412158784109;5880.088586269114;5925.940740592582;5928.377520360344;5753.395893431192;5875.941240587604;5876.265466816648;6101.328853826076;6113.633182009072;6036.999999999956;6067.666278354689;6071.180390647272;6094.146819445281;6096.847578810521;5750.25246717924;5928.318243402021;5932.3474417814;5932.614380065282;5938.079597662369;13027.804582931263;13061.21632702041;13120.884724798403;13295.933520332337;13364.866351336557;2363.1138323128826;2535.3154648245054;2871.0956048844546;3035.8178509289514;3142.9528557071662;10103.696889093339;10118.190544756402;10152.847707284396;10289.536970836256;10513.632022879163;1861.3113148135142;1931.2757715856553;1944.5819148882917;1958.520162560182;1973.1219607274768;91622;96994.0901772948;102305.9769402304;104453;125308;9368.39316862999;10487.37075775456;11477.483513241925;11528.250663706833;11550.768984620428;14340.784888226684;14460.566183014316;14498;14506.782398264035;14520.056196347203;8449.873251901226;8604;8664.480131192022;8716.956415217883;8719.346049046348;8620.913790862136;8630.5253211074;8642.697505587274;8776.824463510695;8782.91217087821;3845.3655146901006;4458.331250312479;4549.317602359606;4574.6340292776495;4622.2835460503675;1913.5216195951011;1929.7684277886462;1933.574613585009;1938.4475424503948;1954.2378472395776;753.5328096580156;820.885076089348;923.5705396990431;923.6443969071955;1013.5337744637402;20363.490912727004;21219.939003050094;21497.892510537346;21517.56964860694;21596.686123140727;906.4525106349186;918.5453200665713;931.6459745296744;968.4431451915177;1036.08306648615;10716.571337146426;10951.4524273786;10969.561217551369;10985.725356866142;11021.944890275658;589847;600898;606545;607898;608065;114134;137305;142226;143773;145056.27471862573;1001.9899801001897;1010.1716592394166;1013.9188864890791;1039.27770199712;1040.9323393979366;18481.260749569865;18565.44303670892;18565.535861603566;18690.065496725383;18729.81270187281;47546.04907901753;49634;49999.75000624868;57226.56933576694;57381.713091435944;85671;85854.57072714846;86316.2736745249;86412;87126.56436717777;7096.7516136934955;7894.842103158019;7928.7621371358955;8056;8271.586420679063;11182.832257516306;11360.318380897173;11361.602343917923;11391.715207119889;11719.589814356797;8953.552322383985;10993.175511836484;11001.339919604849;11050.834237486604;11065.834012489659;10695.893041069801;10798;10801.67594972152;10966.561337546409;11034.117270618171;9395.81208375815;11224.494897729459;11300.94349528247;11374.601888933848;11376;7894.526328420313;8061.153578874134;8107.14874938123;8125.309348705427;8244.010718713793;10623.734406639896;11048.889511104786;11061.723456913642;11130.220884538328;11183.664490065312 11:11:29 INFO - PROCESS | 2346 | |3;mootools.html;1384.9099808512453;1388.4515616331548;1531.2956040221502;1719.9656006879864;1917.1468696430077;7798.220177982206;8522.147785221474;8758.562071896396;8769.736907892757;8903.688370907019;8545.359098067654;8782.209601135897;8785.077566855483;8788.51663158526;8790.340724445676;2116.5872654832315;2196.121551379445;2198.659207822782;2360.4570948681812;2394.964075538868;2192.5395666909967;2221.1004543160047;2334.8832558372014;2422.685050943384;2426.648136020276;2387.403149212697;2388.9761102389016;2391.964120538193;2395.940101497468;2398.1846172301416;2016.7176595276746;2326.3835083702834;2364.6571247169236;2371.988140059306;2376.619740841457;2094.7591027031935;2306.9653955190684;2380.6071998120287;2381.297517232403;2397.113068164773;8776.385653004292;8844.11558844117;8870.42342247752;8874.822503549893;8875.822483550293;4782.426108866924;5373.489518495737;5375.650582712111;5375.704336261504;5381.112116500773;3477.6174620791694;3564.6613571710645;3607.3687104756564;3637.6907962823193;3637.963620363789;954.7851733360008;1045.0751085289498;1069.6523629820263;1083.967480975572;1102.5534658463334;9973.102420782165;11584.768304633944;11626.360550169737;11652.941735291353;11657.475413606408;4554.977225113919;4654.464736555339;4816.253480710496;4828.275758636232;4842.273658951115;9905.900940990641;9975;9976.50117494137;9979.550920208609;9980.700578982642;5335.626506144533;5338.519533242027;5344.251804747339;5345.3852806926925;5350.197470379474;4433.379326894237;4714.528547145326;4892.657513974059;4898.118338699069;4901.289313049588;3595.17311018462;3701.3152566775234;3710.666040056408;3712.5916149223563;3771.7548359356556;1135.6195674448986;1148.2019996102629;1158.9188756786943;1159.513004538096;1164.574930150489;842.5366048673205;861.2291998661163;873.9519326437107;880.212210071982;910.9842525583927;5226.372835259793;5270.183121616155;5448.56411487088;5472.50747432733;5536.695481748542;870.4951128345544;890.6125835261553;901.378049146087;917.1607978699416;926.7358802741186;3469.7571170017854;3572.2676851245433;3610.097475631092;3610.512580801558;3631.7094632429344;10356.016178463035;10625.46872656364;10634.680959571226;10691.144708423308;10691.83962240567;10287.125594324567;10534.57861685524;10666.520006599721;10675.519601617945;10688.893111068945;8073.798155046171;8095.542802295526;8192.877106843402;8204.507729536246;8211;5281.260623512634;5345.2249423832545;5361.383440904346;5408.75660595282;5496.395396506301;9568.186704130227;9907.900920990698;9918.652847150315;9946.45294508809;10151.898481015096;8078.919210807817;10218.335808172445;10243.692689219335;10285.2800303978;10306.845397319195;7089.432845372255;7123.394511466583;7195.100612423447;7196.856062878818;7282.380997615051;7667.501612395176;7899.210078992284;8116.675332986614;8193.139720329518;8306.003279606486;7572.280633339824;7578.810529736801;7595.278448547379;7596.696132154873;7769.6892124316655;7201.387882030086;7464.216257292906;7504.099508059068;7640.73257435987;7648.579328136783;6805.3875151236625;7128.180259270251;7137.10786151731;7139.143302803697;7261.092363454568;5047.2681461187185;5074.949250507448;5091.389033316026;5098.1842905135;5226.163813789775;5069.467705890828;5083.466236045162;5170.948290517197;5292.9735351323;5304.07178743726 11:11:29 INFO - PROCESS | 2346 | |4;prototype.html;242.88220213196607;301.60489758416475;303.77065315686656;310.8119587649473;312.3549869519442;4692.601128904043;5280.313559237304;5373.650712703671;5409.702466364349;5441.401445840955;5293.417724050351;5295.258663787073;5313.707746073965;5324.946750532494;5352.437994010631;3168.8732450701946;3835.961640383602;4042.777647229416;4084.101497670523;4115.753054816721;3950.0519875229884;3986.1429792594586;4067.2068946555432;4098.909556126382;4114.567970363114;3867.8646247381207;4005.259027079985;4041.655839613017;4065.329220678599;4081.4081958116053;3143.8899638512544;3755.2489502099415;4008.739431936929;4040.1919616076902;4105.835766569334;2926.536731634183;3517.9120521987156;3526.6297038810812;3528.876489322887;3542.2738338640515;5219.869503262411;5223.921641175385;5253.369595648508;5274.05067087924;5290.629655924087;3885.494885664874;4520.52534483881;4654.069186162747;4661.277501987197;4681.602063824579;5285.762140703678;5528.474794894479;5542.86142846428;5548.55611551079;5571.8885622287735;3283.96716032839;3951.2463159998115;3958.426028225891;3973.384125460558;3978.701597380179;4901.338319326881;5136.537711605936;5442.591805614595;5881.911771323391;5905.907407129695;3754.9061273468383;3849.191669749328;3864.0146762575364;3868.941965870514;3885.339492286318;3332.6835899819434;3454.844531996016;3625.552751892462;3978.840846366113;4005.177644171895;3900.693267755277;4037.858674946363;4368.793759151608;4439.62263207631;4676.929846052312;5497.972510137423;5674.177244299553;5676.772929082873;5721.685307308055;5737.799177028784;1144.2321613107767;1312.3503865586595;1336.5565189595213;1342.6576223063253;1359.9796003059962;720.4020662849822;789.8064974081387;817.5748610722391;833;835.5613303015965;4387.232234358974;4965.478624744422;4981.402231732215;5294;5356.678599283978;5456.290682211287;5807.912881306784;5829.8251052468495;5875.6180848245585;5922;4271.466066741657;5009.974950125226;5260.684358938476;5354.598405119632;5401.461313182798;3004.5793588897573;3030.212144842357;3034.787564870438;3048.542718592229;3070.5087186050123;4783.689060211075;5720.399358067343;5929.347771745104;5976.61152025117;6014.7594096236535;4905.705657660552;5550.7779688812;5883.441073098049;5917.940820591739;6045.486133678599;4886.755662216946;5869.8239052828485;5929.703514824241;5943.732532036069;5944.643321400817;4766.7854946526795;5312.229726689686;5664.178694089252;5836.445537673914;5858.384869588632;5669.603127781181;5670.688112153706;5695.095501294452;5724.79963201286;5729.226554415267;6017.729202185825;6024.939750602438;6036.547258955684;6045.153678485103;6048.395160484092;3398.881039163716;3617.3850445423814;3721.7580857244193;3857.267119247334;3915.7846318452757;4695.976520117378;5484.287042684585;5685.289338832646;5708.714564271853;5759.971200143972;4918.262260660929;5657.236273103243;5677.261955945701;5677.943220567741;5681.602287839977;4593.425821772278;4660.1145782301255;4740.288956656529;5572.192032155233;5577.972110139423;5276.472352764693;5404;5467.097928841856;5521.558275338044;5548.583856210719;5419.485148910847;5595.964746521907;5616.326040875121;5637.661740295595;5706.4864162225595;4802.423709154924;5502.284702988586;5565.080047383646;5565.248691426606;5579.609427340048 11:11:29 INFO - PROCESS | 2346 | |5;yui.html;731.7365748330601;774.4810976645647;775.2092865277417;849.6809969590364;853.4623187391942;12400;14941.477048303312;16021;16166.353345866166;16558.586035349123;14994.325255363508;15189.544313670607;15193.392264309441;15205.935584509061;15259.542213733606;722.2596838240819;882.2765332427412;896.4128495835238;896.8116695493954;896.8116695493954;729.733647218764;887.5517863478934;917.2570218123308;917.7063339731288;924.1959495239151;958.8226178157063;960.1742501448748;962.9407651583273;966.8018056298442;968.2254196642693;753.2768542199495;778.6729573579111;944.9574769135405;945.3854994253755;945.7682867697458;564.2777245126244;568.496880260972;692.6052150274346;713.6253466929903;714.0431821359351;12817.295048772314;12821.294828784414;12835.807462888064;12882.098253122285;12923.289219092947;14209.076410033314;14377.424903003868;14440.350184241734;14540.636484087876;14549.70900581993;13100.34498275092;13156.60530184096;13184.60446186616;13445.32773361328;13640.93179534106;4294.227039132955;4295.4201182840225;4415.227335216357;4454.153710794971;4476.977615111936;105342;105974;109712.90287097107;109900;110354.34468482979;11240.49417776202;11278.154248131354;11285.605003824827;11370.431478426046;11395.487203075882;22987.195448159233;23017;23027.309180724606;23043.88478057599;23044.65433018506;8098.271155596025;8102.7569172924905;8142.4300298978505;8218.301444377175;8309.169083091763;4404.405405270248;4453.153900758845;4546.636269098531;4554.726716397026;4696.060787842377;3501.9474707879403;3617.1680513482047;3619.9276014480088;3620.2397496525496;3623.927521449609;657.2769953051605;665.4377051391566;668.1147479589563;683.282553319013;684.8356394465293;555.822136916191;618.9721462534196;646.7413034786123;650.2424675253277;655.8917778566483;8830.116988301119;8898.555072246361;9026.548672566345;9029.957487385322;9087.318451116193;588.9252114890343;626.8965620672537;640.1390130274773;641.682367228225;650.3106706890711;3453.8791142309897;4247.291166532733;4379.627731642846;4385;4568.588827005586;128555;130244;134266.32866835798;141326;148152;93871.53064234772;105942;119770.80229197771;125734;127621.36189318994;102138.48930755298;102456.97543024624;105445.47277263565;107096.92903070869;114069.4296528512;8892.688755893512;9936.503174841084;9961.551730172305;10097.091261786474;10159.339642923187;43677.563224367346;59611.70194149001;60311.396886030576;62908;65981.0102848448;94845.05154948363;95363.52318238365;95916;96930;102048;10541.367517948947;13689.657758556115;13714.0400171987;13776;14325.856741432452;15405.691886162438;15419.691606168039;15444.22778861075;15670.530337369482;15767.290471928562;14142.78785818193;14282.857171428153;14338.996270260981;14477.855221448071;14526.273686315853;13927.651808704459;14202.502912398017;14294.571162865132;14339.211343376215;14777.482788102365;13898.791518127035;14020.158790472604;14523;14671.339789709702;14685;9071.637134514545;10122.914706453583;11111.11111111102;11674.94162529182;12006.339651319262;9946.303758736818;10557.63048293306;10839.620613278497;11394.202405831513;11735.76528469443 11:11:29 INFO - PROCESS | 2346 | __end_tp_report 11:11:29 INFO - PROCESS | 2346 | __start_cc_report 11:11:29 INFO - PROCESS | 2346 | _x_x_mozilla_cycle_collect,1343 11:11:29 INFO - PROCESS | 2346 | __end_cc_report 11:11:29 INFO - PROCESS | 2346 | __startTimestamp1468087889403__endTimestamp 11:11:29 INFO - PROCESS | 2346 | 11:11:29 INFO - PROCESS | 2346 | ------- Summary: start ------- 11:11:29 INFO - PROCESS | 2346 | Number of tests: 6 11:11:29 INFO - PROCESS | 2346 | 11:11:29 INFO - PROCESS | 2346 | [#0] dojo.html Cycles:165 Average:5737.95 Median:5932.85 stddev:643.23 (10.8%) stddev-sans-first:616.68 11:11:29 INFO - PROCESS | 2346 | Values: 3323.3 3345.1 3346.9 3354.6 3409.9 5565.9 5615.8 5643.7 5724.1 5728.8 5610.2 5669.9 5746.8 5764.6 5826.0 5076.2 5117.5 5157.1 5173.6 5296.4 5265.0 5290.1 5292.0 5316.8 5349.6 5128.7 5177.4 5189.5 5221.8 5241.1 4434.9 5101.9 5111.0 5146.4 5200.7 5101.3 5149.7 5182.3 5195.8 5249.2 5699.3 5711.3 5741.7 5758.5 5785.5 6111.9 6136.7 6211.1 6213.1 6274.9 5530.0 6271.6 6288.8 6298.4 6317.1 5696.5 5829.2 5842.9 5881.4 5904.4 5261.3 6240.5 6275.9 6296.3 6296.6 6187.4 6187.7 6193.2 6213.4 6217.5 6097.2 6225.3 6287.8 6318.1 6323.7 6100.2 6123.8 6151.4 6213.1 6214.2 6212.9 6280.7 6291.0 6301.1 6306.5 5012.4 5013.2 5016.4 5033.4 5051.7 4308.2 4416.3 4444.2 4450.7 4569.3 5596.5 5605.9 5616.6 5617.4 5646.4 6116.4 6139.6 6142.4 6158.1 6159.2 5526.7 5605.6 5718.9 5736.3 5790.1 5467.2 5474.6 5474.9 5483.2 5499.5 6272.9 6290.5 6296.0 6455.1 6492.3 6110.7 6153.8 6217.8 6225.1 6247.0 6281.4 6289.4 6303.7 6314.5 6316.4 6174.6 6175.1 6181.4 6194.4 6196.6 6141.5 6193.6 6212.3 6277.9 6314.3 6137.8 6145.0 6145.7 6168.8 6175.6 5932.9 6075.7 6113.5 6149.7 6152.0 5834.9 5855.5 5918.0 5923.3 5932.9 6127.4 6132.2 6166.8 6170.7 6188.0 5931.8 5975.1 6004.0 6009.8 6012.1 11:11:29 INFO - PROCESS | 2346 | 11:11:29 INFO - PROCESS | 2346 | [#1] ext.html Cycles:180 Average:71183.42 Median:3553.58 stddev:161295.34 (4538.9%) stddev-sans-first:161660.38 11:11:29 INFO - PROCESS | 2346 | Values: 449.4 519.5 519.9 527.1 536.9 30804.5 41128.2 42372.0 42440.4 42451.6 42866.7 43037.9 43154.0 43207.6 43242.8 8651.7 9642.2 9826.7 9826.9 9842.8 8689.7 11919.2 12067.9 12082.7 12328.1 12149.5 12194.2 12227.4 12234.9 12237.9 8745.6 11855.1 12042.0 12078.3 12164.0 11912.5 11988.0 11992.0 12008.9 12009.3 40312.0 40631.2 40651.6 40661.6 40705.4 3534.5 3572.7 3674.8 3694.9 3821.4 31382.7 32132.2 32280.8 32332.0 32711.8 3180.4 3190.3 3215.6 3245.3 3336.5 512369.0 514441.0 516028.0 520540.0 522716.4 33485.7 61953.8 62621.7 62674.7 62839.2 34187.1 35765.6 35810.0 35823.1 35882.8 15090.2 15139.0 15260.2 15265.8 15282.2 11641.8 11836.3 12581.6 12747.4 12783.3 7836.4 7847.2 7853.3 7908.5 7939.7 3007.7 3288.3 3288.6 3293.0 3293.9 820.7 890.4 1028.5 1030.3 1099.5 30561.0 30900.7 31122.0 31222.0 31647.4 1090.3 1094.5 1112.9 1115.0 1179.5 15890.0 16123.9 16191.9 16297.7 16630.9 745065.0 754026.0 754625.0 755141.2 756621.2 49675.5 58407.7 60047.0 60086.0 60150.0 1255.2 1296.8 1378.9 1387.3 1429.4 31721.0 31832.7 32126.5 32277.7 32333.9 49292.3 49762.8 50069.2 50162.5 50164.5 497118.0 499410.0 499637.0 499742.0 502307.0 23496.5 26208.9 26685.3 26688.9 26728.3 48236.5 48255.5 48835.0 49197.0 49398.0 39189.6 40319.4 40378.8 40632.4 40965.0 32521.0 36676.0 39951.4 40032.8 40638.2 38108.2 38207.6 38615.8 38864.6 38976.0 33824.3 33986.8 34635.5 34803.7 34856.8 25443.2 25589.0 25761.8 25772.0 26371.5 11:11:29 INFO - PROCESS | 2346 | 11:11:29 INFO - PROCESS | 2346 | [#2] jquery.html Cycles:180 Average:34790.89 Median:21557.13 stddev:100695.86 (467.1%) stddev-sans-first:100945.15 11:11:29 INFO - PROCESS | 2346 | Values: 356.7 377.2 382.6 386.0 406.2 15611.9 15855.4 16852.6 20624.7 21300.9 20792.5 21134.8 21246.7 21446.7 21501.0 4738.6 5554.3 5704.2 5969.8 6016.6 5635.2 5878.4 5880.1 5925.9 5928.4 5753.4 5875.9 5876.3 6101.3 6113.6 6037.0 6067.7 6071.2 6094.1 6096.8 5750.3 5928.3 5932.3 5932.6 5938.1 13027.8 13061.2 13120.9 13295.9 13364.9 2363.1 2535.3 2871.1 3035.8 3143.0 10103.7 10118.2 10152.8 10289.5 10513.6 1861.3 1931.3 1944.6 1958.5 1973.1 91622.0 96994.1 102306.0 104453.0 125308.0 9368.4 10487.4 11477.5 11528.3 11550.8 14340.8 14460.6 14498.0 14506.8 14520.1 8449.9 8604.0 8664.5 8717.0 8719.3 8620.9 8630.5 8642.7 8776.8 8782.9 3845.4 4458.3 4549.3 4574.6 4622.3 1913.5 1929.8 1933.6 1938.4 1954.2 753.5 820.9 923.6 923.6 1013.5 20363.5 21219.9 21497.9 21517.6 21596.7 906.5 918.5 931.6 968.4 1036.1 10716.6 10951.5 10969.6 10985.7 11021.9 589847.0 600898.0 606545.0 607898.0 608065.0 114134.0 137305.0 142226.0 143773.0 145056.3 1002.0 1010.2 1013.9 1039.3 1040.9 18481.3 18565.4 18565.5 18690.1 18729.8 47546.0 49634.0 49999.8 57226.6 57381.7 85671.0 85854.6 86316.3 86412.0 87126.6 7096.8 7894.8 7928.8 8056.0 8271.6 11182.8 11360.3 11361.6 11391.7 11719.6 8953.6 10993.2 11001.3 11050.8 11065.8 10695.9 10798.0 10801.7 10966.6 11034.1 9395.8 11224.5 11300.9 11374.6 11376.0 7894.5 8061.2 8107.1 8125.3 8244.0 10623.7 11048.9 11061.7 11130.2 11183.7 11:11:29 INFO - PROCESS | 2346 | 11:11:29 INFO - PROCESS | 2346 | [#3] mootools.html Cycles:180 Average:5640.03 Median:5198.56 stddev:3180.52 (61.2%) stddev-sans-first:3173.37 11:11:29 INFO - PROCESS | 2346 | Values: 1384.9 1388.5 1531.3 1720.0 1917.1 7798.2 8522.1 8758.6 8769.7 8903.7 8545.4 8782.2 8785.1 8788.5 8790.3 2116.6 2196.1 2198.7 2360.5 2395.0 2192.5 2221.1 2334.9 2422.7 2426.6 2387.4 2389.0 2392.0 2395.9 2398.2 2016.7 2326.4 2364.7 2372.0 2376.6 2094.8 2307.0 2380.6 2381.3 2397.1 8776.4 8844.1 8870.4 8874.8 8875.8 4782.4 5373.5 5375.7 5375.7 5381.1 3477.6 3564.7 3607.4 3637.7 3638.0 954.8 1045.1 1069.7 1084.0 1102.6 9973.1 11584.8 11626.4 11652.9 11657.5 4555.0 4654.5 4816.3 4828.3 4842.3 9905.9 9975.0 9976.5 9979.6 9980.7 5335.6 5338.5 5344.3 5345.4 5350.2 4433.4 4714.5 4892.7 4898.1 4901.3 3595.2 3701.3 3710.7 3712.6 3771.8 1135.6 1148.2 1158.9 1159.5 1164.6 842.5 861.2 874.0 880.2 911.0 5226.4 5270.2 5448.6 5472.5 5536.7 870.5 890.6 901.4 917.2 926.7 3469.8 3572.3 3610.1 3610.5 3631.7 10356.0 10625.5 10634.7 10691.1 10691.8 10287.1 10534.6 10666.5 10675.5 10688.9 8073.8 8095.5 8192.9 8204.5 8211.0 5281.3 5345.2 5361.4 5408.8 5496.4 9568.2 9907.9 9918.7 9946.5 10151.9 8078.9 10218.3 10243.7 10285.3 10306.8 7089.4 7123.4 7195.1 7196.9 7282.4 7667.5 7899.2 8116.7 8193.1 8306.0 7572.3 7578.8 7595.3 7596.7 7769.7 7201.4 7464.2 7504.1 7640.7 7648.6 6805.4 7128.2 7137.1 7139.1 7261.1 5047.3 5074.9 5091.4 5098.2 5226.2 5069.5 5083.5 5170.9 5293.0 5304.1 11:11:29 INFO - PROCESS | 2346 | 11:11:29 INFO - PROCESS | 2346 | [#4] prototype.html Cycles:180 Average:4538.04 Median:5257.03 stddev:1422.18 (27.1%) stddev-sans-first:1389.15 11:11:29 INFO - PROCESS | 2346 | Values: 242.9 301.6 303.8 310.8 312.4 4692.6 5280.3 5373.7 5409.7 5441.4 5293.4 5295.3 5313.7 5324.9 5352.4 3168.9 3836.0 4042.8 4084.1 4115.8 3950.1 3986.1 4067.2 4098.9 4114.6 3867.9 4005.3 4041.7 4065.3 4081.4 3143.9 3755.2 4008.7 4040.2 4105.8 2926.5 3517.9 3526.6 3528.9 3542.3 5219.9 5223.9 5253.4 5274.1 5290.6 3885.5 4520.5 4654.1 4661.3 4681.6 5285.8 5528.5 5542.9 5548.6 5571.9 3284.0 3951.2 3958.4 3973.4 3978.7 4901.3 5136.5 5442.6 5881.9 5905.9 3754.9 3849.2 3864.0 3868.9 3885.3 3332.7 3454.8 3625.6 3978.8 4005.2 3900.7 4037.9 4368.8 4439.6 4676.9 5498.0 5674.2 5676.8 5721.7 5737.8 1144.2 1312.4 1336.6 1342.7 1360.0 720.4 789.8 817.6 833.0 835.6 4387.2 4965.5 4981.4 5294.0 5356.7 5456.3 5807.9 5829.8 5875.6 5922.0 4271.5 5010.0 5260.7 5354.6 5401.5 3004.6 3030.2 3034.8 3048.5 3070.5 4783.7 5720.4 5929.3 5976.6 6014.8 4905.7 5550.8 5883.4 5917.9 6045.5 4886.8 5869.8 5929.7 5943.7 5944.6 4766.8 5312.2 5664.2 5836.4 5858.4 5669.6 5670.7 5695.1 5724.8 5729.2 6017.7 6024.9 6036.5 6045.2 6048.4 3398.9 3617.4 3721.8 3857.3 3915.8 4696.0 5484.3 5685.3 5708.7 5760.0 4918.3 5657.2 5677.3 5677.9 5681.6 4593.4 4660.1 4740.3 5572.2 5578.0 5276.5 5404.0 5467.1 5521.6 5548.6 5419.5 5596.0 5616.3 5637.7 5706.5 4802.4 5502.3 5565.1 5565.2 5579.6 11:11:29 INFO - PROCESS | 2346 | 11:11:29 INFO - PROCESS | 2346 | [#5] yui.html Cycles:180 Average:24180.90 Median:3477.91 stddev:37420.13 (1075.9%) stddev-sans-first:37483.68 11:11:29 INFO - PROCESS | 2346 | Values: 731.7 774.5 775.2 849.7 853.5 12400.0 14941.5 16021.0 16166.4 16558.6 14994.3 15189.5 15193.4 15205.9 15259.5 722.3 882.3 896.4 896.8 896.8 729.7 887.6 917.3 917.7 924.2 958.8 960.2 962.9 966.8 968.2 753.3 778.7 945.0 945.4 945.8 564.3 568.5 692.6 713.6 714.0 12817.3 12821.3 12835.8 12882.1 12923.3 14209.1 14377.4 14440.4 14540.6 14549.7 13100.3 13156.6 13184.6 13445.3 13640.9 4294.2 4295.4 4415.2 4454.2 4477.0 105342.0 105974.0 109712.9 109900.0 110354.3 11240.5 11278.2 11285.6 11370.4 11395.5 22987.2 23017.0 23027.3 23043.9 23044.7 8098.3 8102.8 8142.4 8218.3 8309.2 4404.4 4453.2 4546.6 4554.7 4696.1 3501.9 3617.2 3619.9 3620.2 3623.9 657.3 665.4 668.1 683.3 684.8 555.8 619.0 646.7 650.2 655.9 8830.1 8898.6 9026.5 9030.0 9087.3 588.9 626.9 640.1 641.7 650.3 3453.9 4247.3 4379.6 4385.0 4568.6 128555.0 130244.0 134266.3 141326.0 148152.0 93871.5 105942.0 119770.8 125734.0 127621.4 102138.5 102457.0 105445.5 107096.9 114069.4 8892.7 9936.5 9961.6 10097.1 10159.3 43677.6 59611.7 60311.4 62908.0 65981.0 94845.1 95363.5 95916.0 96930.0 102048.0 10541.4 13689.7 13714.0 13776.0 14325.9 15405.7 15419.7 15444.2 15670.5 15767.3 14142.8 14282.9 14339.0 14477.9 14526.3 13927.7 14202.5 14294.6 14339.2 14777.5 13898.8 14020.2 14523.0 14671.3 14685.0 9071.6 10122.9 11111.1 11674.9 12006.3 9946.3 10557.6 10839.6 11394.2 11735.8 11:11:29 INFO - PROCESS | 2346 | -------- Summary: end -------- 11:11:29 INFO - PROCESS | 2346 | 11:11:29 INFO - TEST-INFO | 2346: exit 0 11:11:29 INFO - TEST-OK | dromaeo_css | took 1117159ms 11:11:29 INFO - TEST-START | kraken 11:11:29 INFO - operating with platform_type : mac_ 11:11:29 INFO - Initialising browser for kraken test... 11:11:29 INFO - TEST-INFO | started process 2350 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpuVU1Av/profile http://localhost:52761/getInfo.html) 11:11:32 INFO - PROCESS | 2350 | __metrics Screen width/height:1600/1200 11:11:32 INFO - PROCESS | 2350 | colorDepth:24 11:11:32 INFO - PROCESS | 2350 | Browser inner width/height: 1024/689 11:11:32 INFO - PROCESS | 2350 | __metrics 11:11:32 INFO - PROCESS | 2350 | 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" 11:11:32 INFO - PROCESS | 2350 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:11:33 INFO - TEST-INFO | 2350: exit 0 11:11:33 INFO - Browser initialized. 11:11:33 INFO - Running cycle 1/1 for kraken test... 11:11:33 INFO - TEST-INFO | started process 2351 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpuVU1Av/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:45 INFO - PROCESS | 2351 | RSS: Main: 243548160 11:11:45 INFO - PROCESS | 2351 | 11:11:47 INFO - PROCESS | 2351 | Cycle 1(1): loaded http://localhost:52761/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52761/tests/kraken/driver.html?testName=audio-beat-detection) 11:11:48 INFO - PROCESS | 2351 | RSS: Main: 294273024 11:11:48 INFO - PROCESS | 2351 | 11:11:51 INFO - PROCESS | 2351 | Cycle 1(1): loaded http://localhost:52761/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52761/tests/kraken/driver.html?testName=audio-dft) 11:11:51 INFO - PROCESS | 2351 | RSS: Main: 304447488 11:11:51 INFO - PROCESS | 2351 | 11:11:55 INFO - PROCESS | 2351 | Cycle 1(1): loaded http://localhost:52761/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52761/tests/kraken/driver.html?testName=audio-fft) 11:11:55 INFO - PROCESS | 2351 | RSS: Main: 387780608 11:11:55 INFO - PROCESS | 2351 | 11:11:58 INFO - PROCESS | 2351 | Cycle 1(1): loaded http://localhost:52761/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52761/tests/kraken/driver.html?testName=audio-oscillator) 11:11:58 INFO - PROCESS | 2351 | RSS: Main: 290250752 11:11:58 INFO - PROCESS | 2351 | 11:12:00 INFO - PROCESS | 2351 | Cycle 1(1): loaded http://localhost:52761/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52761/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:12:01 INFO - PROCESS | 2351 | RSS: Main: 294354944 11:12:01 INFO - PROCESS | 2351 | 11:12:04 INFO - PROCESS | 2351 | Cycle 1(1): loaded http://localhost:52761/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52761/tests/kraken/driver.html?testName=imaging-darkroom) 11:12:04 INFO - PROCESS | 2351 | RSS: Main: 332070912 11:12:04 INFO - PROCESS | 2351 | 11:12:07 INFO - PROCESS | 2351 | Cycle 1(1): loaded http://localhost:52761/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52761/tests/kraken/driver.html?testName=imaging-desaturate) 11:12:08 INFO - PROCESS | 2351 | RSS: Main: 332533760 11:12:08 INFO - PROCESS | 2351 | 11:12:11 INFO - PROCESS | 2351 | Cycle 1(1): loaded http://localhost:52761/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52761/tests/kraken/driver.html?testName=json-parse-financial) 11:12:11 INFO - PROCESS | 2351 | RSS: Main: 331423744 11:12:11 INFO - PROCESS | 2351 | 11:12:13 INFO - PROCESS | 2351 | Cycle 1(1): loaded http://localhost:52761/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52761/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:12:14 INFO - PROCESS | 2351 | RSS: Main: 311947264 11:12:14 INFO - PROCESS | 2351 | 11:12:16 INFO - PROCESS | 2351 | Cycle 1(1): loaded http://localhost:52761/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52761/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:12:16 INFO - PROCESS | 2351 | RSS: Main: 318779392 11:12:16 INFO - PROCESS | 2351 | 11:12:18 INFO - PROCESS | 2351 | Cycle 1(1): loaded http://localhost:52761/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52761/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:12:19 INFO - PROCESS | 2351 | RSS: Main: 316100608 11:12:19 INFO - PROCESS | 2351 | 11:12:22 INFO - PROCESS | 2351 | Cycle 1(1): loaded http://localhost:52761/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:12:23 INFO - PROCESS | 2351 | RSS: Main: 325795840 11:12:23 INFO - PROCESS | 2351 | 11:12:26 INFO - PROCESS | 2351 | Cycle 1(1): loaded http://localhost:52761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:12:26 INFO - PROCESS | 2351 | RSS: Main: 327819264 11:12:26 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | Cycle 1(1): loaded http://localhost:52761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52761/tests/kraken/driver.html?testName=ai-astar) 11:12:28 INFO - PROCESS | 2351 | RSS: Main: 371060736 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | __start_tp_report 11:12:28 INFO - PROCESS | 2351 | _x_x_mozilla_page_load 11:12:28 INFO - PROCESS | 2351 | _x_x_mozilla_page_load_details 11:12:28 INFO - PROCESS | 2351 | |i|pagename|runs| 11:12:28 INFO - PROCESS | 2351 | |0;ai-astar;101;111;112;110;112;112;113;111;111;112 11:12:28 INFO - PROCESS | 2351 | |1;audio-beat-detection;144;109;106;158;108;108;128;106;152;106 11:12:28 INFO - PROCESS | 2351 | |2;audio-dft;186;185;185;185;184;184;180;185;183;182 11:12:28 INFO - PROCESS | 2351 | |3;audio-fft;84;72;57;108;58;58;60;90;103;56 11:12:28 INFO - PROCESS | 2351 | |4;audio-oscillator;87;88;93;70;80;68;98;72;68;105 11:12:28 INFO - PROCESS | 2351 | |5;imaging-gaussian-blur;88;86;90;86;89;86;88;86;89;86 11:12:28 INFO - PROCESS | 2351 | |6;imaging-darkroom;95;94;95;94;94;94;95;93;94;94 11:12:28 INFO - PROCESS | 2351 | |7;imaging-desaturate;87;84;82;77;132;142;85;83;86;94 11:12:28 INFO - PROCESS | 2351 | |8;json-parse-financial;56;56;53;55;55;55;54;55;53;54 11:12:28 INFO - PROCESS | 2351 | |9;json-stringify-tinderbox;74;73;68;71;102;106;102;103;72;72 11:12:28 INFO - PROCESS | 2351 | |10;stanford-crypto-aes;84;84;83;85;85;82;81;83;83;85 11:12:28 INFO - PROCESS | 2351 | |11;stanford-crypto-ccm;161;146;153;146;138;150;148;141;236;138 11:12:28 INFO - PROCESS | 2351 | |12;stanford-crypto-pbkdf2;163;164;163;164;162;163;164;163;162;164 11:12:28 INFO - PROCESS | 2351 | |13;stanford-crypto-sha256-iterative;66;66;67;67;66;67;77;86;83;71 11:12:28 INFO - PROCESS | 2351 | __end_tp_report 11:12:28 INFO - PROCESS | 2351 | __start_cc_report 11:12:28 INFO - PROCESS | 2351 | _x_x_mozilla_cycle_collect,2028 11:12:28 INFO - PROCESS | 2351 | __end_cc_report 11:12:28 INFO - PROCESS | 2351 | __startTimestamp1468087948771__endTimestamp 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | ------- Summary: start ------- 11:12:28 INFO - PROCESS | 2351 | Number of tests: 14 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.44 (3.1%) stddev-sans-first:0.88 11:12:28 INFO - PROCESS | 2351 | Values: 101.0 111.0 112.0 110.0 112.0 112.0 113.0 111.0 111.0 112.0 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:118.50 stddev:21.19 (17.9%) stddev-sans-first:21.00 11:12:28 INFO - PROCESS | 2351 | Values: 144.0 109.0 106.0 158.0 108.0 108.0 128.0 106.0 152.0 106.0 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | [#2] audio-dft Cycles:10 Average:183.90 Median:185.00 stddev:1.79 (1.0%) stddev-sans-first:1.73 11:12:28 INFO - PROCESS | 2351 | Values: 186.0 185.0 185.0 185.0 184.0 184.0 180.0 185.0 183.0 182.0 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | [#3] audio-fft Cycles:10 Average:74.60 Median:59.00 stddev:20.21 (34.2%) stddev-sans-first:21.14 11:12:28 INFO - PROCESS | 2351 | Values: 84.0 72.0 57.0 108.0 58.0 58.0 60.0 90.0 103.0 56.0 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:83.50 stddev:13.33 (16.0%) stddev-sans-first:14.05 11:12:28 INFO - PROCESS | 2351 | Values: 87.0 88.0 93.0 70.0 80.0 68.0 98.0 72.0 68.0 105.0 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:1.58 (1.8%) stddev-sans-first:1.66 11:12:28 INFO - PROCESS | 2351 | Values: 88.0 86.0 90.0 86.0 89.0 86.0 88.0 86.0 89.0 86.0 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 11:12:28 INFO - PROCESS | 2351 | Values: 95.0 94.0 95.0 94.0 94.0 94.0 95.0 93.0 94.0 94.0 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:84.50 stddev:22.56 (26.7%) stddev-sans-first:23.74 11:12:28 INFO - PROCESS | 2351 | Values: 87.0 84.0 82.0 77.0 132.0 142.0 85.0 83.0 86.0 94.0 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.07 (2.0%) stddev-sans-first:1.01 11:12:28 INFO - PROCESS | 2351 | Values: 56.0 56.0 53.0 55.0 55.0 55.0 54.0 55.0 53.0 54.0 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | [#9] json-stringify-tinderbox Cycles:10 Average:84.30 Median:71.50 stddev:16.42 (23.0%) stddev-sans-first:16.99 11:12:28 INFO - PROCESS | 2351 | Values: 74.0 73.0 68.0 71.0 102.0 106.0 102.0 103.0 72.0 72.0 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:1.35 (1.6%) stddev-sans-first:1.42 11:12:28 INFO - PROCESS | 2351 | Values: 84.0 84.0 83.0 85.0 85.0 82.0 81.0 83.0 83.0 85.0 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | [#11] stanford-crypto-ccm Cycles:10 Average:155.70 Median:149.00 stddev:29.07 (19.5%) stddev-sans-first:30.77 11:12:28 INFO - PROCESS | 2351 | Values: 161.0 146.0 153.0 146.0 138.0 150.0 148.0 141.0 236.0 138.0 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:163.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 11:12:28 INFO - PROCESS | 2351 | Values: 163.0 164.0 163.0 164.0 162.0 163.0 164.0 163.0 162.0 164.0 11:12:28 INFO - PROCESS | 2351 | 11:12:28 INFO - PROCESS | 2351 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:69.00 stddev:7.63 (11.1%) stddev-sans-first:7.82 11:12:28 INFO - PROCESS | 2351 | Values: 66.0 66.0 67.0 67.0 66.0 67.0 77.0 86.0 83.0 71.0 11:12:28 INFO - PROCESS | 2351 | -------- Summary: end -------- 11:12:28 INFO - PROCESS | 2351 | 11:12:29 INFO - TEST-INFO | 2351: exit 0 11:12:29 INFO - TEST-OK | kraken | took 59650ms 11:12:29 INFO - SUITE-END | took 1176s 11:12:29 INFO - Completed test suite (00:19:37) 11:12:29 INFO - javascript benchmark 11:12:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3323.252268239646, 3345.096823857557, 3346.9163270918207, 3354.5806774153225, 3409.914752131198, 5565.888682226353, 5615.775368985241, 5643.746031428585, 5724.112762521805, 5728.770849166033, 5610.214569960209, 5669.8582535436735, 5746.827595172152, 5764.596478246524, 5826.0, 5076.213186956028, 5117.488251174871, 5157.123289040854, 5173.560247378959, 5296.443873393296, 5265.0259701955065, 5290.1006828839, 5292.047431462335, 5316.813911513079, 5349.625526213166, 5128.666636668623, 5177.37871455424, 5189.506996835295, 5221.843344699665, 5241.056609810233, 4434.933475997863, 5101.923471147936, 5110.9744451277875, 5146.3824341078935, 5200.687958722451, 5101.336826212606, 5149.742512874342, 5182.326297581328, 5195.844124676266, 5249.186376111671, 5699.287589051369, 5711.314642242916, 5741.684207368593, 5758.539316854642, 5785.508231800302, 6111.899858025554, 6136.733532366115, 6211.130441738161, 6213.099100630383, 6274.905876411857, 5529.972350138264, 6271.5923464975085, 6288.842778930518, 6298.3701629837105, 6317.147185129995, 5696.458836410535, 5829.213056237439, 5842.941570584239, 5881.441263080001, 5904.439078287556, 5261.263423120766, 6240.500759939194, 6275.905861412082, 6296.275928268216, 6296.590721603081, 6187.3503282155625, 6187.659678717624, 6193.163922870445, 6213.378662133841, 6217.533684973645, 6097.222222222223, 6225.252969643671, 6287.842803929939, 6318.08387783778, 6323.683815809191, 6100.206973093469, 6123.831729140451, 6151.3541078187045, 6213.099100630383, 6214.223222097238, 6212.9068063979075, 6280.654563998933, 6291.0, 6301.086342480315, 6306.527010474233, 5012.448630650625, 5013.172826483589, 5016.44819069902, 5033.446320904697, 5051.696898186121, 4308.224519586442, 4416.315471101984, 4444.177827101932, 4450.732956022649, 4569.314602809605, 5596.496315331639, 5605.887882242332, 5616.6068375213345, 5617.410171931889, 5646.378898321182, 6116.3883611638485, 6139.570230083851, 6142.447179753754, 6158.137860699506, 6159.199304090529, 5526.668399896019, 5605.635633683797, 5718.857028574235, 5736.311642602915, 5790.10253410722, 5467.234587157801, 5474.616776825664, 5474.863128421821, 5483.177523371446, 5499.50504454593, 6272.874542509125, 6290.4653104485715, 6295.968520157461, 6455.064015717789, 6492.253390860112, 6110.725017374318, 6153.800008998202, 6217.751289948352, 6225.097360882556, 6246.968765156145, 6281.434670879643, 6289.40250676185, 6303.684815759286, 6314.463270622048, 6316.368363163647, 6174.567780255339, 6175.135481032748, 6181.412765787243, 6194.442500175006, 6196.597221180609, 6141.508679305555, 6193.566450348612, 6212.347703491068, 6277.874442511215, 6314.273858506147, 6137.7851775187655, 6145.0, 6145.692715364304, 6168.845778855385, 6175.5677102602385, 5932.940670593412, 6075.665838378932, 6113.51091912637, 6149.692515374303, 6152.0156774915795, 5834.94165058344, 5855.502282306052, 5917.970410147922, 5923.289205295392, 5932.851678708067, 6127.378954131758, 6132.172156758959, 6166.845828854314, 6170.660613666291, 6188.0, 5931.754331590414, 5975.103734439869, 6004.039353703386, 6009.849753756191, 6012.098185272069], "value": 5696.487253518308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.44044664392817, 519.5479932458761, 519.9263520829488, 527.1039233303385, 536.9140937450009, 30804.537931931038, 41128.17743645129, 42372.0, 42440.363394549066, 42451.57548424515, 42866.71399858002, 43037.92405189864, 43154.0, 43207.56792432075, 43242.783786081025, 8651.65393384267, 9642.228621710281, 9826.705198844045, 9826.852597211047, 9842.753931151707, 8689.695860644879, 11919.165658403916, 12067.939660301687, 12082.69793255167, 12328.137030407875, 12149.453274602663, 12194.207376520542, 12227.388630568481, 12234.93882530586, 12237.877621223808, 8745.562721863946, 11855.110866684947, 12042.0, 12078.335691536962, 12163.999999999956, 11912.463939122761, 11988.0, 11992.0, 12008.919197272287, 12009.279443233347, 40311.99220019494, 40631.18737625231, 40651.57719479834, 40661.59338406608, 40705.38941915874, 3534.487499312611, 3572.678458938708, 3674.779513229215, 3694.907627309312, 3821.426785982097, 31382.686173138205, 32132.196695082577, 32280.838595807105, 32332.0, 32711.836440817882, 3180.443422401094, 3190.313554849692, 3215.5819743433203, 3245.269814291789, 3336.5328853960464, 512369.0, 514441.0, 516028.0, 520540.0, 522716.3864180693, 33485.66514334874, 61953.76092478125, 62621.68689156525, 62674.68662656749, 62839.17223724852, 34187.14532136667, 35765.64234357675, 35810.0, 35823.104422389646, 35882.8205858969, 15090.24548772579, 15139.015963962307, 15260.160691162093, 15265.847341526443, 15282.159481228638, 11641.825372619418, 11836.349000804867, 12581.559645412366, 12747.42636581356, 12783.296918669377, 7836.412269079842, 7847.176046515148, 7853.253940875607, 7908.4859484134495, 7939.6824127035425, 3007.7066861249436, 3288.3423315337027, 3288.638249792521, 3293.0, 3293.901182964515, 820.659426338063, 890.3900827932757, 1028.493257377945, 1030.314840630972, 1099.4667586220676, 30561.0, 30900.69099309023, 31122.0, 31222.0, 31647.367052658818, 1090.2967585907045, 1094.5074716377503, 1112.9109671226283, 1114.9944250278697, 1179.475133565555, 15889.967152135074, 16123.871329007092, 16191.919040404722, 16297.67404651924, 16630.916845415697, 745065.0, 754026.0, 754625.0, 755141.224293886, 756621.2168939121, 49675.50324496709, 58407.70796146077, 60047.0, 60086.0, 60150.0, 1255.215490318551, 1296.8184454176424, 1378.9034767566575, 1387.3479464651598, 1429.421084460795, 31721.0, 31832.68167318297, 32126.51810222802, 32277.677223227467, 32333.868314609816, 49292.26061609007, 49762.75118624384, 50069.24896126634, 50162.498375015784, 50164.49835501598, 497118.0, 499410.0, 499637.0, 499742.0, 502307.0, 23496.530069398174, 26208.868955655864, 26685.332866678487, 26688.866555667097, 26728.331791705365, 48236.517634823205, 48255.517444825105, 48835.0, 49197.0, 49398.0, 39189.608103918596, 40319.3952090713, 40378.79810600928, 40632.390514142906, 40965.0, 32521.02436926896, 36676.0, 39951.400728988505, 40032.79983600063, 40638.187236255704, 38108.23783524369, 38207.617923820406, 38615.80692096522, 38864.6113538861, 38976.02559936024, 33824.323513529096, 33986.8300658505, 34635.48046779351, 34803.65196348004, 34856.82571587126, 25443.236702898943, 25589.0, 25761.840717168147, 25771.969121235692, 26371.4725705481], "value": 19351.35677566033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.7360153486418, 377.19280739218067, 382.59253894602244, 385.97105217108714, 406.16127696307126, 15611.921940390297, 15855.445059422922, 16852.57868553285, 20624.69062964057, 21300.89349553254, 20792.48018799527, 21134.788652113475, 21246.68329967132, 21446.678299825515, 21501.03245353959, 4738.597219236369, 5554.305711786027, 5704.201411802351, 5969.820905372846, 6016.608920420159, 5635.182898479718, 5878.412158784109, 5880.088586269114, 5925.940740592582, 5928.377520360344, 5753.395893431192, 5875.941240587604, 5876.265466816648, 6101.328853826076, 6113.633182009072, 6036.999999999956, 6067.666278354689, 6071.180390647272, 6094.146819445281, 6096.847578810521, 5750.25246717924, 5928.318243402021, 5932.3474417814, 5932.614380065282, 5938.079597662369, 13027.804582931263, 13061.21632702041, 13120.884724798403, 13295.933520332337, 13364.866351336557, 2363.1138323128826, 2535.3154648245054, 2871.0956048844546, 3035.8178509289514, 3142.9528557071662, 10103.696889093339, 10118.190544756402, 10152.847707284396, 10289.536970836256, 10513.632022879163, 1861.3113148135142, 1931.2757715856553, 1944.5819148882917, 1958.520162560182, 1973.1219607274768, 91622.0, 96994.0901772948, 102305.9769402304, 104453.0, 125308.0, 9368.39316862999, 10487.37075775456, 11477.483513241925, 11528.250663706833, 11550.768984620428, 14340.784888226684, 14460.566183014316, 14498.0, 14506.782398264035, 14520.056196347203, 8449.873251901226, 8604.0, 8664.480131192022, 8716.956415217883, 8719.346049046348, 8620.913790862136, 8630.5253211074, 8642.697505587274, 8776.824463510695, 8782.91217087821, 3845.3655146901006, 4458.331250312479, 4549.317602359606, 4574.6340292776495, 4622.2835460503675, 1913.5216195951011, 1929.7684277886462, 1933.574613585009, 1938.4475424503948, 1954.2378472395776, 753.5328096580156, 820.885076089348, 923.5705396990431, 923.6443969071955, 1013.5337744637402, 20363.490912727004, 21219.939003050094, 21497.892510537346, 21517.56964860694, 21596.686123140727, 906.4525106349186, 918.5453200665713, 931.6459745296744, 968.4431451915177, 1036.08306648615, 10716.571337146426, 10951.4524273786, 10969.561217551369, 10985.725356866142, 11021.944890275658, 589847.0, 600898.0, 606545.0, 607898.0, 608065.0, 114134.0, 137305.0, 142226.0, 143773.0, 145056.27471862573, 1001.9899801001897, 1010.1716592394166, 1013.9188864890791, 1039.27770199712, 1040.9323393979366, 18481.260749569865, 18565.44303670892, 18565.535861603566, 18690.065496725383, 18729.81270187281, 47546.04907901753, 49634.0, 49999.75000624868, 57226.56933576694, 57381.713091435944, 85671.0, 85854.57072714846, 86316.2736745249, 86412.0, 87126.56436717777, 7096.7516136934955, 7894.842103158019, 7928.7621371358955, 8056.0, 8271.586420679063, 11182.832257516306, 11360.318380897173, 11361.602343917923, 11391.715207119889, 11719.589814356797, 8953.552322383985, 10993.175511836484, 11001.339919604849, 11050.834237486604, 11065.834012489659, 10695.893041069801, 10798.0, 10801.67594972152, 10966.561337546409, 11034.117270618171, 9395.81208375815, 11224.494897729459, 11300.94349528247, 11374.601888933848, 11376.0, 7894.526328420313, 8061.153578874134, 8107.14874938123, 8125.309348705427, 8244.010718713793, 10623.734406639896, 11048.889511104786, 11061.723456913642, 11130.220884538328, 11183.664490065312], "value": 9402.257324844262, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.9099808512453, 1388.4515616331548, 1531.2956040221502, 1719.9656006879864, 1917.1468696430077, 7798.220177982206, 8522.147785221474, 8758.562071896396, 8769.736907892757, 8903.688370907019, 8545.359098067654, 8782.209601135897, 8785.077566855483, 8788.51663158526, 8790.340724445676, 2116.5872654832315, 2196.121551379445, 2198.659207822782, 2360.4570948681812, 2394.964075538868, 2192.5395666909967, 2221.1004543160047, 2334.8832558372014, 2422.685050943384, 2426.648136020276, 2387.403149212697, 2388.9761102389016, 2391.964120538193, 2395.940101497468, 2398.1846172301416, 2016.7176595276746, 2326.3835083702834, 2364.6571247169236, 2371.988140059306, 2376.619740841457, 2094.7591027031935, 2306.9653955190684, 2380.6071998120287, 2381.297517232403, 2397.113068164773, 8776.385653004292, 8844.11558844117, 8870.42342247752, 8874.822503549893, 8875.822483550293, 4782.426108866924, 5373.489518495737, 5375.650582712111, 5375.704336261504, 5381.112116500773, 3477.6174620791694, 3564.6613571710645, 3607.3687104756564, 3637.6907962823193, 3637.963620363789, 954.7851733360008, 1045.0751085289498, 1069.6523629820263, 1083.967480975572, 1102.5534658463334, 9973.102420782165, 11584.768304633944, 11626.360550169737, 11652.941735291353, 11657.475413606408, 4554.977225113919, 4654.464736555339, 4816.253480710496, 4828.275758636232, 4842.273658951115, 9905.900940990641, 9975.0, 9976.50117494137, 9979.550920208609, 9980.700578982642, 5335.626506144533, 5338.519533242027, 5344.251804747339, 5345.3852806926925, 5350.197470379474, 4433.379326894237, 4714.528547145326, 4892.657513974059, 4898.118338699069, 4901.289313049588, 3595.17311018462, 3701.3152566775234, 3710.666040056408, 3712.5916149223563, 3771.7548359356556, 1135.6195674448986, 1148.2019996102629, 1158.9188756786943, 1159.513004538096, 1164.574930150489, 842.5366048673205, 861.2291998661163, 873.9519326437107, 880.212210071982, 910.9842525583927, 5226.372835259793, 5270.183121616155, 5448.56411487088, 5472.50747432733, 5536.695481748542, 870.4951128345544, 890.6125835261553, 901.378049146087, 917.1607978699416, 926.7358802741186, 3469.7571170017854, 3572.2676851245433, 3610.097475631092, 3610.512580801558, 3631.7094632429344, 10356.016178463035, 10625.46872656364, 10634.680959571226, 10691.144708423308, 10691.83962240567, 10287.125594324567, 10534.57861685524, 10666.520006599721, 10675.519601617945, 10688.893111068945, 8073.798155046171, 8095.542802295526, 8192.877106843402, 8204.507729536246, 8211.0, 5281.260623512634, 5345.2249423832545, 5361.383440904346, 5408.75660595282, 5496.395396506301, 9568.186704130227, 9907.900920990698, 9918.652847150315, 9946.45294508809, 10151.898481015096, 8078.919210807817, 10218.335808172445, 10243.692689219335, 10285.2800303978, 10306.845397319195, 7089.432845372255, 7123.394511466583, 7195.100612423447, 7196.856062878818, 7282.380997615051, 7667.501612395176, 7899.210078992284, 8116.675332986614, 8193.139720329518, 8306.003279606486, 7572.280633339824, 7578.810529736801, 7595.278448547379, 7596.696132154873, 7769.6892124316655, 7201.387882030086, 7464.216257292906, 7504.099508059068, 7640.73257435987, 7648.579328136783, 6805.3875151236625, 7128.180259270251, 7137.10786151731, 7139.143302803697, 7261.092363454568, 5047.2681461187185, 5074.949250507448, 5091.389033316026, 5098.1842905135, 5226.163813789775, 5069.467705890828, 5083.466236045162, 5170.948290517197, 5292.9735351323, 5304.07178743726], "value": 4511.801564690537, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [242.88220213196607, 301.60489758416475, 303.77065315686656, 310.8119587649473, 312.3549869519442, 4692.601128904043, 5280.313559237304, 5373.650712703671, 5409.702466364349, 5441.401445840955, 5293.417724050351, 5295.258663787073, 5313.707746073965, 5324.946750532494, 5352.437994010631, 3168.8732450701946, 3835.961640383602, 4042.777647229416, 4084.101497670523, 4115.753054816721, 3950.0519875229884, 3986.1429792594586, 4067.2068946555432, 4098.909556126382, 4114.567970363114, 3867.8646247381207, 4005.259027079985, 4041.655839613017, 4065.329220678599, 4081.4081958116053, 3143.8899638512544, 3755.2489502099415, 4008.739431936929, 4040.1919616076902, 4105.835766569334, 2926.536731634183, 3517.9120521987156, 3526.6297038810812, 3528.876489322887, 3542.2738338640515, 5219.869503262411, 5223.921641175385, 5253.369595648508, 5274.05067087924, 5290.629655924087, 3885.494885664874, 4520.52534483881, 4654.069186162747, 4661.277501987197, 4681.602063824579, 5285.762140703678, 5528.474794894479, 5542.86142846428, 5548.55611551079, 5571.8885622287735, 3283.96716032839, 3951.2463159998115, 3958.426028225891, 3973.384125460558, 3978.701597380179, 4901.338319326881, 5136.537711605936, 5442.591805614595, 5881.911771323391, 5905.907407129695, 3754.9061273468383, 3849.191669749328, 3864.0146762575364, 3868.941965870514, 3885.339492286318, 3332.6835899819434, 3454.844531996016, 3625.552751892462, 3978.840846366113, 4005.177644171895, 3900.693267755277, 4037.858674946363, 4368.793759151608, 4439.62263207631, 4676.929846052312, 5497.972510137423, 5674.177244299553, 5676.772929082873, 5721.685307308055, 5737.799177028784, 1144.2321613107767, 1312.3503865586595, 1336.5565189595213, 1342.6576223063253, 1359.9796003059962, 720.4020662849822, 789.8064974081387, 817.5748610722391, 833.0, 835.5613303015965, 4387.232234358974, 4965.478624744422, 4981.402231732215, 5294.0, 5356.678599283978, 5456.290682211287, 5807.912881306784, 5829.8251052468495, 5875.6180848245585, 5922.0, 4271.466066741657, 5009.974950125226, 5260.684358938476, 5354.598405119632, 5401.461313182798, 3004.5793588897573, 3030.212144842357, 3034.787564870438, 3048.542718592229, 3070.5087186050123, 4783.689060211075, 5720.399358067343, 5929.347771745104, 5976.61152025117, 6014.7594096236535, 4905.705657660552, 5550.7779688812, 5883.441073098049, 5917.940820591739, 6045.486133678599, 4886.755662216946, 5869.8239052828485, 5929.703514824241, 5943.732532036069, 5944.643321400817, 4766.7854946526795, 5312.229726689686, 5664.178694089252, 5836.445537673914, 5858.384869588632, 5669.603127781181, 5670.688112153706, 5695.095501294452, 5724.79963201286, 5729.226554415267, 6017.729202185825, 6024.939750602438, 6036.547258955684, 6045.153678485103, 6048.395160484092, 3398.881039163716, 3617.3850445423814, 3721.7580857244193, 3857.267119247334, 3915.7846318452757, 4695.976520117378, 5484.287042684585, 5685.289338832646, 5708.714564271853, 5759.971200143972, 4918.262260660929, 5657.236273103243, 5677.261955945701, 5677.943220567741, 5681.602287839977, 4593.425821772278, 4660.1145782301255, 4740.288956656529, 5572.192032155233, 5577.972110139423, 5276.472352764693, 5404.0, 5467.097928841856, 5521.558275338044, 5548.583856210719, 5419.485148910847, 5595.964746521907, 5616.326040875121, 5637.661740295595, 5706.4864162225595, 4802.423709154924, 5502.284702988586, 5565.080047383646, 5565.248691426606, 5579.609427340048], "value": 4074.1380436248805, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.7365748330601, 774.4810976645647, 775.2092865277417, 849.6809969590364, 853.4623187391942, 12400.0, 14941.477048303312, 16021.0, 16166.353345866166, 16558.586035349123, 14994.325255363508, 15189.544313670607, 15193.392264309441, 15205.935584509061, 15259.542213733606, 722.2596838240819, 882.2765332427412, 896.4128495835238, 896.8116695493954, 896.8116695493954, 729.733647218764, 887.5517863478934, 917.2570218123308, 917.7063339731288, 924.1959495239151, 958.8226178157063, 960.1742501448748, 962.9407651583273, 966.8018056298442, 968.2254196642693, 753.2768542199495, 778.6729573579111, 944.9574769135405, 945.3854994253755, 945.7682867697458, 564.2777245126244, 568.496880260972, 692.6052150274346, 713.6253466929903, 714.0431821359351, 12817.295048772314, 12821.294828784414, 12835.807462888064, 12882.098253122285, 12923.289219092947, 14209.076410033314, 14377.424903003868, 14440.350184241734, 14540.636484087876, 14549.70900581993, 13100.34498275092, 13156.60530184096, 13184.60446186616, 13445.32773361328, 13640.93179534106, 4294.227039132955, 4295.4201182840225, 4415.227335216357, 4454.153710794971, 4476.977615111936, 105342.0, 105974.0, 109712.90287097107, 109900.0, 110354.34468482979, 11240.49417776202, 11278.154248131354, 11285.605003824827, 11370.431478426046, 11395.487203075882, 22987.195448159233, 23017.0, 23027.309180724606, 23043.88478057599, 23044.65433018506, 8098.271155596025, 8102.7569172924905, 8142.4300298978505, 8218.301444377175, 8309.169083091763, 4404.405405270248, 4453.153900758845, 4546.636269098531, 4554.726716397026, 4696.060787842377, 3501.9474707879403, 3617.1680513482047, 3619.9276014480088, 3620.2397496525496, 3623.927521449609, 657.2769953051605, 665.4377051391566, 668.1147479589563, 683.282553319013, 684.8356394465293, 555.822136916191, 618.9721462534196, 646.7413034786123, 650.2424675253277, 655.8917778566483, 8830.116988301119, 8898.555072246361, 9026.548672566345, 9029.957487385322, 9087.318451116193, 588.9252114890343, 626.8965620672537, 640.1390130274773, 641.682367228225, 650.3106706890711, 3453.8791142309897, 4247.291166532733, 4379.627731642846, 4385.0, 4568.588827005586, 128555.0, 130244.0, 134266.32866835798, 141326.0, 148152.0, 93871.53064234772, 105942.0, 119770.80229197771, 125734.0, 127621.36189318994, 102138.48930755298, 102456.97543024624, 105445.47277263565, 107096.92903070869, 114069.4296528512, 8892.688755893512, 9936.503174841084, 9961.551730172305, 10097.091261786474, 10159.339642923187, 43677.563224367346, 59611.70194149001, 60311.396886030576, 62908.0, 65981.0102848448, 94845.05154948363, 95363.52318238365, 95916.0, 96930.0, 102048.0, 10541.367517948947, 13689.657758556115, 13714.0400171987, 13776.0, 14325.856741432452, 15405.691886162438, 15419.691606168039, 15444.22778861075, 15670.530337369482, 15767.290471928562, 14142.78785818193, 14282.857171428153, 14338.996270260981, 14477.855221448071, 14526.273686315853, 13927.651808704459, 14202.502912398017, 14294.571162865132, 14339.211343376215, 14777.482788102365, 13898.791518127035, 14020.158790472604, 14523.0, 14671.339789709702, 14685.0, 9071.637134514545, 10122.914706453583, 11111.11111111102, 11674.94162529182, 12006.339651319262, 9946.303758736818, 10557.63048293306, 10839.620613278497, 11394.202405831513, 11735.76528469443], "value": 7898.20844097605, "unit": "score"}], "name": "dromaeo_css", "value": 7293.204699452323, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 112.0, 110.0, 112.0, 112.0, 113.0, 111.0, 111.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 106.0, 158.0, 108.0, 108.0, 128.0, 106.0, 152.0, 106.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 185.0, 185.0, 184.0, 184.0, 180.0, 185.0, 183.0, 182.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 72.0, 57.0, 108.0, 58.0, 58.0, 60.0, 90.0, 103.0, 56.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 93.0, 70.0, 80.0, 68.0, 98.0, 72.0, 68.0, 105.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 90.0, 86.0, 89.0, 86.0, 88.0, 86.0, 89.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 93.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 82.0, 77.0, 132.0, 142.0, 85.0, 83.0, 86.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 53.0, 55.0, 55.0, 55.0, 54.0, 55.0, 53.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 68.0, 71.0, 102.0, 106.0, 102.0, 103.0, 72.0, 72.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 85.0, 85.0, 82.0, 81.0, 83.0, 83.0, 85.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 146.0, 153.0, 146.0, 138.0, 150.0, 148.0, 141.0, 236.0, 138.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 164.0, 162.0, 163.0, 164.0, 163.0, 162.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 66.0, 67.0, 77.0, 86.0, 83.0, 71.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1464.1, "alertThreshold": 2.0}]} 11:12:30 INFO - Return code: 0 11:12:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:12:30 INFO - # TBPL SUCCESS # 11:12:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:12:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:12:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:12:30 INFO - 2016-07-09 11:12:30.088 screenresolution[2355:293760] starting screenresolution argv=screenresolution get 11:12:30 INFO - 2016-07-09 11:12:30.091 screenresolution[2355:293760] Display 0: 1600x1200x32@60 11:12:30 INFO - 2016-07-09 11:12:30.097 screenresolution[2356:293763] starting screenresolution argv=screenresolution list 11:12:30 INFO - Available Modes on Display 0 11:12:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:12:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:12:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:12:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:12:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:12:30 INFO - Intel Iris: 11:12:30 INFO - Chipset Model: Intel Iris 11:12:30 INFO - Type: GPU 11:12:30 INFO - Bus: Built-In 11:12:30 INFO - VRAM (Dynamic, Max): 1536 MB 11:12:30 INFO - Vendor: Intel (0x8086) 11:12:30 INFO - Device ID: 0x0a2e 11:12:30 INFO - Revision ID: 0x0009 11:12:30 INFO - Displays: 11:12:30 INFO - Display: 11:12:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:12:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:12:30 INFO - Display Serial Number: 1600x1200 60 11:12:30 INFO - Main Display: Yes 11:12:30 INFO - Mirror: Off 11:12:30 INFO - Online: Yes 11:12:30 INFO - Rotation: Supported 11:12:30 INFO - Return code: 0 11:12:30 INFO - Running post-action listener: _resource_record_post_action 11:12:30 INFO - ##### 11:12:30 INFO - ##### Finished run-tests step (success) 11:12:30 INFO - ##### 11:12:30 INFO - Running post-run listener: _resource_record_post_run 11:12:30 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 1060864; Write bytes: 705442304; Read time: 11; Write time: 1963 11:12:30 INFO - TinderboxPrint: CPU usage
53.3% 11:12:30 INFO - TinderboxPrint: I/O read bytes / time
1,060,864 / 11 11:12:30 INFO - TinderboxPrint: I/O write bytes / time
705,442,304 / 1,963 11:12:30 INFO - TinderboxPrint: CPU idle
2,264.4 (46.7%) 11:12:30 INFO - TinderboxPrint: CPU system
967.9 (20.0%) 11:12:30 INFO - TinderboxPrint: CPU user
1,617.3 (33.3%) 11:12:30 INFO - TinderboxPrint: Swap in / out
406,683,648 / 0 11:12:30 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 389386752; Write bytes: 385646080; Read time: 29066; Write time: 773 11:12:30 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 1060864; Write bytes: 294663168; Read time: 11; Write time: 1117 11:12:30 INFO - Running post-run listener: _upload_blobber_files 11:12:30 INFO - Blob upload gear active. 11:12:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:12:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:12:31 INFO - (blobuploader) - INFO - Open directory for files ... 11:12:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:12:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:12:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:31 INFO - (blobuploader) - INFO - Done attempting. 11:12:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:12:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:12:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:32 INFO - (blobuploader) - INFO - Done attempting. 11:12:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:12:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:12:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:35 INFO - (blobuploader) - INFO - Done attempting. 11:12:35 INFO - (blobuploader) - INFO - Iteration through files over. 11:12:35 INFO - Return code: 0 11:12:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:12:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:12:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e91ab66d5ef74ea1da7f54e60e39de85e8fcfe004040bfe5520956f383d1cb7bed5e99f61d86a0c86edf64073ba8b531abba0c03da850f25d3f067cde3bdf37e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b97486ad1838947556761680180ce1f91c30e98b6e98e4a59818d48b32fb405d848385f894ba86664f3d9cb6c4f0f1149580416cf9812bcbd72be3b72926b945", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b69d43787671cea26dd6e6b0547a2b90ce3530a717ea0fe2c7543997a6cc699148d2e7f805bfb6ed7ac619ea362475282651d0a27f593ef93d2ccd0d9b615e95"} 11:12:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:12:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:12:35 INFO - Contents: 11:12:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e91ab66d5ef74ea1da7f54e60e39de85e8fcfe004040bfe5520956f383d1cb7bed5e99f61d86a0c86edf64073ba8b531abba0c03da850f25d3f067cde3bdf37e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b97486ad1838947556761680180ce1f91c30e98b6e98e4a59818d48b32fb405d848385f894ba86664f3d9cb6c4f0f1149580416cf9812bcbd72be3b72926b945", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b69d43787671cea26dd6e6b0547a2b90ce3530a717ea0fe2c7543997a6cc699148d2e7f805bfb6ed7ac619ea362475282651d0a27f593ef93d2ccd0d9b615e95"} 11:12:35 INFO - Running post-run listener: copy_logs_to_upload_dir 11:12:35 INFO - Copying logs to upload dir... 11:12:35 INFO - mkdir: /builds/slave/test/build/upload/logs 11:12:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.842304 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-07-09 11:12:35.727646) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 11:12:35.733461) ========= 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.MPfyTkyzkN/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.WxNCJVy6pa/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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/e91ab66d5ef74ea1da7f54e60e39de85e8fcfe004040bfe5520956f383d1cb7bed5e99f61d86a0c86edf64073ba8b531abba0c03da850f25d3f067cde3bdf37e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b97486ad1838947556761680180ce1f91c30e98b6e98e4a59818d48b32fb405d848385f894ba86664f3d9cb6c4f0f1149580416cf9812bcbd72be3b72926b945", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b69d43787671cea26dd6e6b0547a2b90ce3530a717ea0fe2c7543997a6cc699148d2e7f805bfb6ed7ac619ea362475282651d0a27f593ef93d2ccd0d9b615e95"} build_url:https://queue.taskcluster.net/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011443 build_url: 'https://queue.taskcluster.net/v1/task/QK-VzZ3lQ3eiHdckD3cEDg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e91ab66d5ef74ea1da7f54e60e39de85e8fcfe004040bfe5520956f383d1cb7bed5e99f61d86a0c86edf64073ba8b531abba0c03da850f25d3f067cde3bdf37e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b97486ad1838947556761680180ce1f91c30e98b6e98e4a59818d48b32fb405d848385f894ba86664f3d9cb6c4f0f1149580416cf9812bcbd72be3b72926b945", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b69d43787671cea26dd6e6b0547a2b90ce3530a717ea0fe2c7543997a6cc699148d2e7f805bfb6ed7ac619ea362475282651d0a27f593ef93d2ccd0d9b615e95"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 11:12:35.766451) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 11:12:35.766786) ========= 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.MPfyTkyzkN/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.WxNCJVy6pa/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.005222 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 11:12:35.815544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 11:12:35.816135) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 11:12:35.816708) ========= ========= Total master_lag: 0.41 =========