builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0164 starttime: 1470941712.19 results: success (0) buildid: 20160811083720 builduid: b3c6cb78963c488188d7073e30824951 revision: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 11:55:12.187949) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 11:55:12.188409) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 11:55:12.188701) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 11:55:12.214471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:55:12.215156) ========= 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.ky3AYI8yRB/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.lVMzMThnP5/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-11 11:55:12-- 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% 32.8M=0s 2016-08-11 11:55:12 (32.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110681 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:55:12.353607) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:55:12.354384) ========= 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.ky3AYI8yRB/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.lVMzMThnP5/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.028025 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:55:12.408106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 11:55:12.408887) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 --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 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ky3AYI8yRB/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.lVMzMThnP5/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-11 11:55:12,487 truncating revision to first 12 chars 2016-08-11 11:55:12,487 Setting DEBUG logging. 2016-08-11 11:55:12,487 attempt 1/10 2016-08-11 11:55:12,487 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9dae91a2c31d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 11:55:13,719 unpacking tar archive at: fx-team-9dae91a2c31d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.491458 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 11:55:13.928194) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 11:55:13.928604) ========= script_repo_revision: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 11:55:13.929079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 11:55:13.929411) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 11:55:13.948689) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-11 11:55:13.949402) ========= /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.ky3AYI8yRB/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.lVMzMThnP5/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 11:55:14 INFO - MultiFileLogger online at 20160811 11:55:14 in /builds/slave/test 11:55:14 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 11:55:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:55:14 INFO - {'append_to_log': False, 11:55:14 INFO - 'base_work_dir': '/builds/slave/test', 11:55:14 INFO - 'blob_upload_branch': 'Fx-Team', 11:55:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:55:14 INFO - 'branch': 'Fx-Team', 11:55:14 INFO - 'buildbot_json_path': 'buildprops.json', 11:55:14 INFO - 'config_files': ('talos/mac_config.py',), 11:55:14 INFO - 'default_actions': ('clobber', 11:55:14 INFO - 'read-buildbot-config', 11:55:14 INFO - 'download-and-extract', 11:55:14 INFO - 'populate-webroot', 11:55:14 INFO - 'create-virtualenv', 11:55:14 INFO - 'install', 11:55:14 INFO - 'run-tests'), 11:55:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:55:14 INFO - 'download_minidump_stackwalk': True, 11:55:14 INFO - 'download_symbols': 'ondemand', 11:55:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:55:14 INFO - 'tooltool.py': '/tools/tooltool.py', 11:55:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:55:14 INFO - '/tools/misc-python/virtualenv.py')}, 11:55:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:55:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:55:14 INFO - 'installer_path': 'installer.exe', 11:55:14 INFO - 'log_level': 'info', 11:55:14 INFO - 'log_name': 'talos', 11:55:14 INFO - 'log_to_console': True, 11:55:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:55:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:55:14 INFO - 'opt_config_files': (), 11:55:14 INFO - 'pip_index': False, 11:55:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:55:14 INFO - 'cmd': ('bash', 11:55:14 INFO - '-c', 11:55:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:55:14 INFO - 'enabled': True, 11:55:14 INFO - 'halt_on_failure': False, 11:55:14 INFO - 'name': 'check_screen_resolution'},), 11:55:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:55:14 INFO - 'cmd': ('bash', 11:55:14 INFO - '-c', 11:55:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:55:14 INFO - 'enabled': True, 11:55:14 INFO - 'halt_on_failure': False, 11:55:14 INFO - 'name': 'check_screen_resolution'},), 11:55:14 INFO - 'run_cmd_checks_enabled': True, 11:55:14 INFO - 'sps_profile': False, 11:55:14 INFO - 'sps_profile_interval': 0, 11:55:14 INFO - 'suite': 'dromaeojs', 11:55:14 INFO - 'system_bits': '32', 11:55:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:55:14 INFO - 'title': 't-yosemite-r7-0164', 11:55:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:55:14 INFO - 'use_talos_json': True, 11:55:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:55:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:55:14 INFO - 'work_dir': 'build'} 11:55:14 INFO - [mozharness: 2016-08-11 18:55:14.144700Z] Running clobber step. 11:55:14 INFO - Running pre-action listener: _resource_record_pre_action 11:55:14 INFO - Running main action method: clobber 11:55:14 INFO - rmtree: /builds/slave/test/build 11:55:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:55:15 INFO - Running post-action listener: _resource_record_post_action 11:55:15 INFO - [mozharness: 2016-08-11 18:55:15.691049Z] Finished clobber step (success) 11:55:15 INFO - [mozharness: 2016-08-11 18:55:15.691255Z] Running read-buildbot-config step. 11:55:15 INFO - Running pre-action listener: _resource_record_pre_action 11:55:15 INFO - Running main action method: read_buildbot_config 11:55:15 INFO - Using buildbot properties: 11:55:15 INFO - { 11:55:15 INFO - "project": "", 11:55:15 INFO - "product": "firefox", 11:55:15 INFO - "script_repo_revision": "production", 11:55:15 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:55:15 INFO - "repository": "", 11:55:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:55:15 INFO - "buildid": "20160811083720", 11:55:15 INFO - "pgo_build": "False", 11:55:15 INFO - "basedir": "/builds/slave/test", 11:55:15 INFO - "buildnumber": 122, 11:55:15 INFO - "slavename": "t-yosemite-r7-0164", 11:55:15 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 11:55:15 INFO - "platform": "yosemite_r7", 11:55:15 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 11:55:15 INFO - "branch": "fx-team", 11:55:15 INFO - "repo_path": "integration/fx-team", 11:55:15 INFO - "revision": "9dae91a2c31d1d7ee1f426b4f61179a42e0dab64", 11:55:15 INFO - "stage_platform": "macosx64", 11:55:15 INFO - "builduid": "b3c6cb78963c488188d7073e30824951", 11:55:15 INFO - "slavebuilddir": "test" 11:55:15 INFO - } 11:55:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:55:15 INFO - Running post-action listener: _resource_record_post_action 11:55:15 INFO - [mozharness: 2016-08-11 18:55:15.695236Z] Finished read-buildbot-config step (success) 11:55:15 INFO - [mozharness: 2016-08-11 18:55:15.695357Z] Running download-and-extract step. 11:55:15 INFO - Running pre-action listener: _resource_record_pre_action 11:55:15 INFO - Running main action method: download_and_extract 11:55:15 INFO - mkdir: /builds/slave/test/build/tests 11:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:15 INFO - trying https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:55:15 INFO - Downloading https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:55:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 11:55:17 INFO - Downloaded 1199 bytes. 11:55:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:55:17 INFO - Using the following test package requirements: 11:55:17 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:55:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:17 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:55:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:17 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:55:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:17 INFO - u'jsshell-mac.zip'], 11:55:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:17 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:55:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:55:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:17 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:55:17 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:17 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:55:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:17 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:55:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:17 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:55:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:17 INFO - trying https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:55:17 INFO - Downloading https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:55:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:55:17 INFO - Downloaded 16328359 bytes. 11:55:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:55:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:55:20 INFO - Return code: 0 11:55:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:20 INFO - trying https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:55:20 INFO - Downloading https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:55:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:55:21 INFO - Downloaded 16328359 bytes. 11:55:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:55:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:55:25 INFO - Return code: 0 11:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:25 INFO - trying https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:55:25 INFO - Downloading https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:55:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:55:26 INFO - Downloaded 14413719 bytes. 11:55:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:55:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:55:26 INFO - Return code: 0 11:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:26 INFO - trying https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:55:26 INFO - Downloading https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:55:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 11:55:29 INFO - Downloaded 110898778 bytes. 11:55:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:55:29 INFO - mkdir: /builds/slave/test/properties 11:55:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:55:29 INFO - Writing to file /builds/slave/test/properties/build_url 11:55:29 INFO - Contents: 11:55:29 INFO - build_url:https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:55:30 INFO - Running post-action listener: _resource_record_post_action 11:55:30 INFO - Running post-action listener: set_extra_try_arguments 11:55:30 INFO - [mozharness: 2016-08-11 18:55:30.309123Z] Finished download-and-extract step (success) 11:55:30 INFO - [mozharness: 2016-08-11 18:55:30.309274Z] Running populate-webroot step. 11:55:30 INFO - Running pre-action listener: _resource_record_pre_action 11:55:30 INFO - Running main action method: populate_webroot 11:55:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:55:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:55:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:55:30 INFO - '--tppagecycles', 11:55:30 INFO - '7'], 11:55:30 INFO - 'tests': ['tsvgm']}}, 11:55:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:55:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:55:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:55:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:55:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:55:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:55:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:30 INFO - 'talos_options': ['--disable-e10s'], 11:55:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:30 INFO - 'talos_options': ['--disable-e10s'], 11:55:30 INFO - 'tests': ['damp', 'tps']}, 11:55:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:30 INFO - 'tests': ['damp', 'tps']}, 11:55:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:55:30 INFO - 'tests': ['dromaeo_dom']}, 11:55:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:55:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:55:30 INFO - 'tests': ['basic_compositor_video']}, 11:55:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:55:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:55:30 INFO - 'tests': ['a11yr', 11:55:30 INFO - 'ts_paint', 11:55:30 INFO - 'tpaint', 11:55:30 INFO - 'sessionrestore', 11:55:30 INFO - 'sessionrestore_no_auto_restore', 11:55:30 INFO - 'tabpaint']}, 11:55:30 INFO - 'other-e10s': {'tests': ['a11yr', 11:55:30 INFO - 'ts_paint', 11:55:30 INFO - 'tpaint', 11:55:30 INFO - 'sessionrestore', 11:55:30 INFO - 'sessionrestore_no_auto_restore', 11:55:30 INFO - 'tabpaint']}, 11:55:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:55:30 INFO - 'ts_paint', 11:55:30 INFO - 'tpaint', 11:55:30 INFO - 'sessionrestore', 11:55:30 INFO - 'sessionrestore_no_auto_restore', 11:55:30 INFO - 'tabpaint']}, 11:55:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:55:30 INFO - 'ts_paint', 11:55:30 INFO - 'tpaint', 11:55:30 INFO - 'sessionrestore', 11:55:30 INFO - 'sessionrestore_no_auto_restore', 11:55:30 INFO - 'tabpaint']}, 11:55:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:55:30 INFO - 'tests': ['a11yr', 11:55:30 INFO - 'ts_paint', 11:55:30 INFO - 'tpaint', 11:55:30 INFO - 'sessionrestore', 11:55:30 INFO - 'sessionrestore_no_auto_restore', 11:55:30 INFO - 'tabpaint']}, 11:55:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:55:30 INFO - 'tests': ['a11yr', 11:55:30 INFO - 'ts_paint', 11:55:30 INFO - 'tpaint', 11:55:30 INFO - 'sessionrestore', 11:55:30 INFO - 'sessionrestore_no_auto_restore', 11:55:30 INFO - 'tabpaint']}, 11:55:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:55:30 INFO - 'tests': ['tsvgx', 11:55:30 INFO - 'tsvgr_opacity', 11:55:30 INFO - 'tart', 11:55:30 INFO - 'tscrollx', 11:55:30 INFO - 'cart']}, 11:55:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:55:30 INFO - 'tsvgr_opacity', 11:55:30 INFO - 'tart', 11:55:30 INFO - 'tscrollx', 11:55:30 INFO - 'cart']}, 11:55:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:30 INFO - 'talos_options': ['--disable-e10s'], 11:55:30 INFO - 'tests': ['tp5o']}, 11:55:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:30 INFO - 'tests': ['tp5o']}, 11:55:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:30 INFO - 'talos_options': ['--disable-e10s', 11:55:30 INFO - '--xperf_path', 11:55:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:30 INFO - 'tests': ['tp5n']}, 11:55:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:30 INFO - 'talos_options': ['--xperf_path', 11:55:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:30 INFO - 'tests': ['tp5n']}}, 11:55:30 INFO - 'talos.zip': {'path': '', 11:55:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:55:30 INFO - Running post-action listener: _resource_record_post_action 11:55:30 INFO - [mozharness: 2016-08-11 18:55:30.328496Z] Finished populate-webroot step (success) 11:55:30 INFO - [mozharness: 2016-08-11 18:55:30.328580Z] Running create-virtualenv step. 11:55:30 INFO - Running pre-action listener: _resource_record_pre_action 11:55:30 INFO - Running main action method: create_virtualenv 11:55:30 INFO - Creating virtualenv /builds/slave/test/build/venv 11:55:30 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 11:55:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:55:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:55:30 INFO - Using real prefix '/tools/python27' 11:55:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:55:31 INFO - Installing distribute.............................................................................................................................................................................................done. 11:55:34 INFO - Installing pip.................done. 11:55:34 INFO - Return code: 0 11:55:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:34 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 0x10547aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10550f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd015d0750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053ded30>, '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 0x105143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d6b20>, '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.ky3AYI8yRB/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.lVMzMThnP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 11:55:34 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 11:55:34 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 11:55:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ky3AYI8yRB/Render', 11:55:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:34 INFO - 'HOME': '/Users/cltbld', 11:55:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:34 INFO - 'LOGNAME': 'cltbld', 11:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:34 INFO - 'MOZ_NO_REMOTE': '1', 11:55:34 INFO - 'NO_EM_RESTART': '1', 11:55:34 INFO - 'PAGER': '/bin/cat', 11:55:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:34 INFO - 'PWD': '/builds/slave/test', 11:55:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:34 INFO - 'SHELL': '/bin/bash', 11:55:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVMzMThnP5/Listeners', 11:55:34 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 11:55:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:34 INFO - 'USER': 'cltbld', 11:55:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:34 INFO - 'XPC_FLAGS': '0x0', 11:55:34 INFO - 'XPC_SERVICE_NAME': '0', 11:55:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:34 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 11:55:34 INFO - Cleaning up... 11:55:34 INFO - Return code: 0 11:55:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:34 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 0x10547aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10550f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd015d0750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053ded30>, '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 0x105143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d6b20>, '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.ky3AYI8yRB/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.lVMzMThnP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 11:55:34 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 11:55:34 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 11:55:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ky3AYI8yRB/Render', 11:55:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:34 INFO - 'HOME': '/Users/cltbld', 11:55:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:34 INFO - 'LOGNAME': 'cltbld', 11:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:34 INFO - 'MOZ_NO_REMOTE': '1', 11:55:34 INFO - 'NO_EM_RESTART': '1', 11:55:34 INFO - 'PAGER': '/bin/cat', 11:55:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:34 INFO - 'PWD': '/builds/slave/test', 11:55:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:34 INFO - 'SHELL': '/bin/bash', 11:55:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVMzMThnP5/Listeners', 11:55:34 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 11:55:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:34 INFO - 'USER': 'cltbld', 11:55:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:34 INFO - 'XPC_FLAGS': '0x0', 11:55:34 INFO - 'XPC_SERVICE_NAME': '0', 11:55:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:34 INFO - Downloading/unpacking psutil>=3.1.1 11:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:55:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:37 INFO - Installing collected packages: psutil 11:55:37 INFO - Running setup.py install for psutil 11:55:37 INFO - building 'psutil._psutil_osx' extension 11:55:37 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 11:55:38 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 11:55:38 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 11:55:38 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 11:55:38 INFO - building 'psutil._psutil_posix' extension 11:55:38 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 11:55:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:55:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:55:38 INFO - ^ 11:55:38 INFO - 1 warning generated. 11:55:38 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 11:55:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:38 INFO - Successfully installed psutil 11:55:38 INFO - Cleaning up... 11:55:38 INFO - Return code: 0 11:55:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:38 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 0x10547aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10550f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd015d0750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053ded30>, '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 0x105143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d6b20>, '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.ky3AYI8yRB/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.lVMzMThnP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 11:55:38 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 11:55:38 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 11:55:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ky3AYI8yRB/Render', 11:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:38 INFO - 'HOME': '/Users/cltbld', 11:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:38 INFO - 'LOGNAME': 'cltbld', 11:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:38 INFO - 'MOZ_NO_REMOTE': '1', 11:55:38 INFO - 'NO_EM_RESTART': '1', 11:55:38 INFO - 'PAGER': '/bin/cat', 11:55:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:38 INFO - 'PWD': '/builds/slave/test', 11:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:38 INFO - 'SHELL': '/bin/bash', 11:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVMzMThnP5/Listeners', 11:55:38 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 11:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:38 INFO - 'USER': 'cltbld', 11:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:38 INFO - 'XPC_FLAGS': '0x0', 11:55:38 INFO - 'XPC_SERVICE_NAME': '0', 11:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:55:39 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 11:55:39 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 11:55:39 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 11:55:39 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 11:55:39 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 11:55:39 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 11:55:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:55:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:55:41 INFO - Installing collected packages: mozsystemmonitor 11:55:41 INFO - Running setup.py install for mozsystemmonitor 11:55:41 INFO - Successfully installed mozsystemmonitor 11:55:41 INFO - Cleaning up... 11:55:41 INFO - Return code: 0 11:55:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:41 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 0x10547aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10550f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd015d0750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053ded30>, '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 0x105143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d6b20>, '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.ky3AYI8yRB/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.lVMzMThnP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 11:55:41 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 11:55:41 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 11:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ky3AYI8yRB/Render', 11:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:41 INFO - 'HOME': '/Users/cltbld', 11:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:41 INFO - 'LOGNAME': 'cltbld', 11:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:41 INFO - 'MOZ_NO_REMOTE': '1', 11:55:41 INFO - 'NO_EM_RESTART': '1', 11:55:41 INFO - 'PAGER': '/bin/cat', 11:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:41 INFO - 'PWD': '/builds/slave/test', 11:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:41 INFO - 'SHELL': '/bin/bash', 11:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVMzMThnP5/Listeners', 11:55:41 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 11:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:41 INFO - 'USER': 'cltbld', 11:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:41 INFO - 'XPC_FLAGS': '0x0', 11:55:41 INFO - 'XPC_SERVICE_NAME': '0', 11:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:42 INFO - Downloading/unpacking jsonschema==2.5.1 11:55:42 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 11:55:42 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 11:55:42 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 11:55:42 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 11:55:42 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 11:55:42 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 11:55:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:55:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:44 INFO - Downloading functools32-3.2.3-2.tar.gz 11:55:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:55:45 INFO - warning: no files found matching '*.txt' 11:55:45 INFO - no previously-included directories found matching 'build' 11:55:45 INFO - no previously-included directories found matching 'dist' 11:55:45 INFO - no previously-included directories found matching '.git*' 11:55:45 INFO - Installing collected packages: jsonschema, functools32 11:55:45 INFO - Running setup.py install for functools32 11:55:45 INFO - warning: no files found matching '*.txt' 11:55:45 INFO - no previously-included directories found matching 'build' 11:55:45 INFO - no previously-included directories found matching 'dist' 11:55:45 INFO - no previously-included directories found matching '.git*' 11:55:45 INFO - Successfully installed jsonschema functools32 11:55:45 INFO - Cleaning up... 11:55:45 INFO - Return code: 0 11:55:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10547aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10550f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd015d0750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053ded30>, '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 0x105143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d6b20>, '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.ky3AYI8yRB/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.lVMzMThnP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 11:55:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:55:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ky3AYI8yRB/Render', 11:55:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:45 INFO - 'HOME': '/Users/cltbld', 11:55:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:45 INFO - 'LOGNAME': 'cltbld', 11:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:45 INFO - 'MOZ_NO_REMOTE': '1', 11:55:45 INFO - 'NO_EM_RESTART': '1', 11:55:45 INFO - 'PAGER': '/bin/cat', 11:55:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:45 INFO - 'PWD': '/builds/slave/test', 11:55:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:45 INFO - 'SHELL': '/bin/bash', 11:55:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVMzMThnP5/Listeners', 11:55:45 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 11:55:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:45 INFO - 'USER': 'cltbld', 11:55:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:45 INFO - 'XPC_FLAGS': '0x0', 11:55:45 INFO - 'XPC_SERVICE_NAME': '0', 11:55:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:55:45 INFO - Cleaning up... 11:55:45 INFO - Return code: 0 11:55:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:45 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 0x10547aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10550f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd015d0750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053ded30>, '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 0x105143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d6b20>, '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.ky3AYI8yRB/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.lVMzMThnP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 11:55:45 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 11:55:45 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 11:55:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ky3AYI8yRB/Render', 11:55:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:45 INFO - 'HOME': '/Users/cltbld', 11:55:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:45 INFO - 'LOGNAME': 'cltbld', 11:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:45 INFO - 'MOZ_NO_REMOTE': '1', 11:55:45 INFO - 'NO_EM_RESTART': '1', 11:55:45 INFO - 'PAGER': '/bin/cat', 11:55:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:45 INFO - 'PWD': '/builds/slave/test', 11:55:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:45 INFO - 'SHELL': '/bin/bash', 11:55:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVMzMThnP5/Listeners', 11:55:45 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 11:55:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:45 INFO - 'USER': 'cltbld', 11:55:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:45 INFO - 'XPC_FLAGS': '0x0', 11:55:45 INFO - 'XPC_SERVICE_NAME': '0', 11:55:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:45 INFO - Downloading/unpacking blobuploader==1.2.4 11:55:45 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 11:55:45 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 11:55:45 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 11:55:45 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 11:55:45 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 11:55:45 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 11:55:48 INFO - Downloading blobuploader-1.2.4.tar.gz 11:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:55:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:55:48 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 11:55:48 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 11:55:48 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 11:55:48 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 11:55:48 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 11:55:48 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 11:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:55:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:49 INFO - Downloading docopt-0.6.1.tar.gz 11:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:55:49 INFO - Installing collected packages: blobuploader, requests, docopt 11:55:49 INFO - Running setup.py install for blobuploader 11:55:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:55:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:55:49 INFO - Running setup.py install for requests 11:55:50 INFO - Running setup.py install for docopt 11:55:50 INFO - Successfully installed blobuploader requests docopt 11:55:50 INFO - Cleaning up... 11:55:50 INFO - Return code: 0 11:55:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:50 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 0x10547aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10550f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd015d0750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053ded30>, '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 0x105143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d6b20>, '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.ky3AYI8yRB/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.lVMzMThnP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 11:55:50 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 11:55:50 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 11:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ky3AYI8yRB/Render', 11:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:50 INFO - 'HOME': '/Users/cltbld', 11:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:50 INFO - 'LOGNAME': 'cltbld', 11:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:50 INFO - 'MOZ_NO_REMOTE': '1', 11:55:50 INFO - 'NO_EM_RESTART': '1', 11:55:50 INFO - 'PAGER': '/bin/cat', 11:55:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:50 INFO - 'PWD': '/builds/slave/test', 11:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:50 INFO - 'SHELL': '/bin/bash', 11:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVMzMThnP5/Listeners', 11:55:50 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 11:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:50 INFO - 'USER': 'cltbld', 11:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:50 INFO - 'XPC_FLAGS': '0x0', 11:55:50 INFO - 'XPC_SERVICE_NAME': '0', 11:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:50 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-5uK9xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:50 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-wcmNrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:51 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-pqO8as-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:51 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-dfOI6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:51 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-_pQZc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:51 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-tzdP9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:51 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-8SfI8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:51 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-3cdWTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:51 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-NiPLWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:51 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-_J6odI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:51 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Gtfkws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:52 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-33UHdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:52 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-rnhBt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:52 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-DJ6wAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:52 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-852RL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:52 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-dak81K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:52 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-xJFL1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:55:52 INFO - Running setup.py install for manifestparser 11:55:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:55:52 INFO - Running setup.py install for mozcrash 11:55:52 INFO - Running setup.py install for mozdebug 11:55:53 INFO - Running setup.py install for mozdevice 11:55:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:55:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:55:53 INFO - Running setup.py install for mozfile 11:55:53 INFO - Running setup.py install for mozhttpd 11:55:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:55:53 INFO - Running setup.py install for mozinfo 11:55:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:55:53 INFO - Running setup.py install for mozInstall 11:55:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:55:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:55:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:55:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:55:53 INFO - Running setup.py install for mozleak 11:55:53 INFO - Running setup.py install for mozlog 11:55:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:55:54 INFO - Running setup.py install for moznetwork 11:55:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:55:54 INFO - Running setup.py install for mozprocess 11:55:54 INFO - Running setup.py install for mozprofile 11:55:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:55:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:55:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:55:54 INFO - Running setup.py install for mozrunner 11:55:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:55:54 INFO - Running setup.py install for mozscreenshot 11:55:54 INFO - Running setup.py install for moztest 11:55:55 INFO - Running setup.py install for mozversion 11:55:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:55:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:55:55 INFO - Cleaning up... 11:55:55 INFO - Return code: 0 11:55:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:55 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 0x10547aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10550f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd015d0750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053ded30>, '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 0x105143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d6b20>, '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.ky3AYI8yRB/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.lVMzMThnP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 11:55:55 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 11:55:55 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 11:55:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ky3AYI8yRB/Render', 11:55:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:55 INFO - 'HOME': '/Users/cltbld', 11:55:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:55 INFO - 'LOGNAME': 'cltbld', 11:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:55 INFO - 'MOZ_NO_REMOTE': '1', 11:55:55 INFO - 'NO_EM_RESTART': '1', 11:55:55 INFO - 'PAGER': '/bin/cat', 11:55:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:55 INFO - 'PWD': '/builds/slave/test', 11:55:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:55 INFO - 'SHELL': '/bin/bash', 11:55:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVMzMThnP5/Listeners', 11:55:55 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 11:55:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:55 INFO - 'USER': 'cltbld', 11:55:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:55 INFO - 'XPC_FLAGS': '0x0', 11:55:55 INFO - 'XPC_SERVICE_NAME': '0', 11:55:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:55 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-FGCFqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:55 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)) 11:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:55 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-uD98fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:55 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)) 11:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:55 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-6GZHOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:55 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)) 11:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:55 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-cat2g7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:55 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)) 11:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:55 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Dn98q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:56 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)) 11:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-vsy_DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:56 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)) 11:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-wkXfzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:56 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)) 11:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-iqdMB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:56 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)) 11:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-JQ5ech-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:56 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)) 11:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-F77k_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-R4PRnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:56 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)) 11:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-_Kzuwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:56 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)) 11:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-i9naFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:56 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)) 11:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:56 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-AfxwzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:57 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)) 11:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:57 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-8ITg0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:57 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)) 11:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:57 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-6TI68h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:57 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)) 11:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:57 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-ZFafaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:57 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)) 11:55:57 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)) 11:55:57 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)) 11:55:57 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)) 11:55:57 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)) 11:55:57 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)) 11:55:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:55:57 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 11:55:57 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 11:55:57 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 11:55:57 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 11:55:57 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 11:55:57 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 11:55:59 INFO - Downloading blessings-1.6.tar.gz 11:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:55:59 INFO - Installing collected packages: blessings 11:55:59 INFO - Running setup.py install for blessings 11:56:00 INFO - Successfully installed blessings 11:56:00 INFO - Cleaning up... 11:56:00 INFO - Return code: 0 11:56:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:56:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:56:00 INFO - Reading from file tmpfile_stdout 11:56:00 INFO - Current package versions: 11:56:00 INFO - blessings == 1.6 11:56:00 INFO - blobuploader == 1.2.4 11:56:00 INFO - docopt == 0.6.1 11:56:00 INFO - functools32 == 3.2.3-2 11:56:00 INFO - jsonschema == 2.5.1 11:56:00 INFO - manifestparser == 1.1 11:56:00 INFO - mozInstall == 1.12 11:56:00 INFO - mozcrash == 0.17 11:56:00 INFO - mozdebug == 0.1 11:56:00 INFO - mozdevice == 0.48 11:56:00 INFO - mozfile == 1.2 11:56:00 INFO - mozhttpd == 0.7 11:56:00 INFO - mozinfo == 0.9 11:56:00 INFO - mozleak == 0.1 11:56:00 INFO - mozlog == 3.3 11:56:00 INFO - moznetwork == 0.27 11:56:00 INFO - mozprocess == 0.23 11:56:00 INFO - mozprofile == 0.28 11:56:00 INFO - mozrunner == 6.12 11:56:00 INFO - mozscreenshot == 0.1 11:56:00 INFO - mozsystemmonitor == 0.3 11:56:00 INFO - moztest == 0.7 11:56:00 INFO - mozversion == 1.4 11:56:00 INFO - psutil == 3.1.1 11:56:00 INFO - requests == 1.2.3 11:56:00 INFO - wsgiref == 0.1.2 11:56:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:00 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 0x10547aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10550f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd015d0750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053ded30>, '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 0x105143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d6b20>, '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.ky3AYI8yRB/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.lVMzMThnP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 11:56:00 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 11:56:00 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 11:56:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ky3AYI8yRB/Render', 11:56:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:56:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:56:00 INFO - 'HOME': '/Users/cltbld', 11:56:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:56:00 INFO - 'LOGNAME': 'cltbld', 11:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:00 INFO - 'MOZ_NO_REMOTE': '1', 11:56:00 INFO - 'NO_EM_RESTART': '1', 11:56:00 INFO - 'PAGER': '/bin/cat', 11:56:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:00 INFO - 'PWD': '/builds/slave/test', 11:56:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:56:00 INFO - 'SHELL': '/bin/bash', 11:56:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVMzMThnP5/Listeners', 11:56:00 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 11:56:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:56:00 INFO - 'USER': 'cltbld', 11:56:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:56:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:00 INFO - 'XPC_FLAGS': '0x0', 11:56:00 INFO - 'XPC_SERVICE_NAME': '0', 11:56:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:00 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)) 11:56:00 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)) 11:56:00 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)) 11:56:00 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)) 11:56:00 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)) 11:56:00 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)) 11:56:00 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)) 11:56:00 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)) 11:56:00 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)) 11:56:00 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)) 11:56:00 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)) 11:56:00 INFO - Cleaning up... 11:56:00 INFO - Return code: 0 11:56:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:00 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 0x10547aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10550f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd015d0750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053ded30>, '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 0x105143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d6b20>, '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.ky3AYI8yRB/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.lVMzMThnP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 11:56:00 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 11:56:00 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 11:56:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ky3AYI8yRB/Render', 11:56:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:56:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:56:00 INFO - 'HOME': '/Users/cltbld', 11:56:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:56:00 INFO - 'LOGNAME': 'cltbld', 11:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:00 INFO - 'MOZ_NO_REMOTE': '1', 11:56:00 INFO - 'NO_EM_RESTART': '1', 11:56:00 INFO - 'PAGER': '/bin/cat', 11:56:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:00 INFO - 'PWD': '/builds/slave/test', 11:56:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:56:00 INFO - 'SHELL': '/bin/bash', 11:56:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVMzMThnP5/Listeners', 11:56:00 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 11:56:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:56:00 INFO - 'USER': 'cltbld', 11:56:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:56:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:00 INFO - 'XPC_FLAGS': '0x0', 11:56:00 INFO - 'XPC_SERVICE_NAME': '0', 11:56:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:56:00 INFO - Cleaning up... 11:56:00 INFO - Return code: 0 11:56:00 INFO - Running post-action listener: _resource_record_post_action 11:56:00 INFO - Running post-action listener: _start_resource_monitoring 11:56:00 INFO - Starting resource monitoring. 11:56:00 INFO - [mozharness: 2016-08-11 18:56:00.963753Z] Finished create-virtualenv step (success) 11:56:00 INFO - [mozharness: 2016-08-11 18:56:00.964634Z] Running install step. 11:56:00 INFO - Running pre-action listener: _resource_record_pre_action 11:56:00 INFO - Running main action method: install 11:56:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:56:01 INFO - Reading from file tmpfile_stdout 11:56:01 INFO - Detecting whether we're running mozinstall >=1.0... 11:56:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:56:01 INFO - Reading from file tmpfile_stdout 11:56:01 INFO - Output received: 11:56:01 INFO - Usage: mozinstall [options] installer 11:56:01 INFO - Options: 11:56:01 INFO - -h, --help show this help message and exit 11:56:01 INFO - -d DEST, --destination=DEST 11:56:01 INFO - Directory to install application into. [default: 11:56:01 INFO - "/builds/slave/test"] 11:56:01 INFO - --app=APP Application being installed. [default: firefox] 11:56:01 INFO - mkdir: /builds/slave/test/build/application 11:56:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:56:35 INFO - Reading from file tmpfile_stdout 11:56:35 INFO - Output received: 11:56:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:56:35 INFO - Running post-action listener: _resource_record_post_action 11:56:35 INFO - [mozharness: 2016-08-11 18:56:35.672573Z] Finished install step (success) 11:56:35 INFO - [mozharness: 2016-08-11 18:56:35.672712Z] Running run-tests step. 11:56:35 INFO - Running pre-action listener: _resource_record_pre_action 11:56:35 INFO - Running main action method: run_tests 11:56:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:56:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:56:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:56:35 INFO - 2016-08-11 11:56:35.687 screenresolution[1642:7316] starting screenresolution argv=screenresolution get 11:56:35 INFO - 2016-08-11 11:56:35.689 screenresolution[1642:7316] Display 0: 1600x1200x32@60 11:56:35 INFO - 2016-08-11 11:56:35.695 screenresolution[1643:7318] starting screenresolution argv=screenresolution list 11:56:35 INFO - Available Modes on Display 0 11:56:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:56:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:56:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:56:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:56:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:56:35 INFO - Intel Iris: 11:56:35 INFO - Chipset Model: Intel Iris 11:56:35 INFO - Type: GPU 11:56:35 INFO - Bus: Built-In 11:56:35 INFO - VRAM (Dynamic, Max): 1536 MB 11:56:35 INFO - Vendor: Intel (0x8086) 11:56:35 INFO - Device ID: 0x0a2e 11:56:35 INFO - Revision ID: 0x0009 11:56:35 INFO - Displays: 11:56:35 INFO - Display: 11:56:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:56:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:56:35 INFO - Display Serial Number: 1600x1200 60 11:56:35 INFO - Main Display: Yes 11:56:35 INFO - Mirror: Off 11:56:35 INFO - Online: Yes 11:56:35 INFO - Rotation: Supported 11:56:35 INFO - Return code: 0 11:56:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:56:35 INFO - Python 2.7.3 11:56:35 INFO - Return code: 0 11:56:35 INFO - grabbing minidump binary from tooltool 11:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:35 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 0x1053ded30>, '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 0x105143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:56:35 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 11:56:35 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 11:56:35 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 11:56:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:56:36 INFO - Return code: 0 11:56:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:56:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:56:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:56:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:56:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:56:36 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/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0164', '--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 11:56:36 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/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0164 --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 11:56:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ky3AYI8yRB/Render', 11:56:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:56:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:56:36 INFO - 'HOME': '/Users/cltbld', 11:56:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:56:36 INFO - 'LOGNAME': 'cltbld', 11:56:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:56:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:36 INFO - 'MOZ_NO_REMOTE': '1', 11:56:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:56:36 INFO - 'NO_EM_RESTART': '1', 11:56:36 INFO - 'PAGER': '/bin/cat', 11:56:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:36 INFO - 'PWD': '/builds/slave/test', 11:56:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:56:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:56:36 INFO - 'SHELL': '/bin/bash', 11:56:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVMzMThnP5/Listeners', 11:56:36 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 11:56:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:56:36 INFO - 'USER': 'cltbld', 11:56:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:56:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:36 INFO - 'XPC_FLAGS': '0x0', 11:56:36 INFO - 'XPC_SERVICE_NAME': '0', 11:56:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:56:36 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/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0164', '--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 11:56:36 INFO - mozversion application_buildid: 20160811083720 11:56:36 INFO - mozversion application_changeset: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 11:56:36 INFO - mozversion application_display_name: Nightly 11:56:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:56:36 INFO - mozversion application_name: Firefox 11:56:36 INFO - mozversion application_remotingname: firefox 11:56:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:56:36 INFO - mozversion application_vendor: Mozilla 11:56:36 INFO - mozversion application_version: 51.0a1 11:56:36 INFO - mozversion platform_buildid: 20160811083720 11:56:36 INFO - mozversion platform_changeset: 9dae91a2c31d1d7ee1f426b4f61179a42e0dab64 11:56:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:56:36 INFO - mozversion platform_version: 51.0a1 11:56:36 INFO - using testdate: 1470941796 11:56:36 INFO - actual date: 1470941796 11:56:36 INFO - starting webserver on 'localhost:49277' 11:56:36 INFO - SUITE-START | Running 2 tests 11:56:36 INFO - TEST-START | dromaeo_css 11:56:36 INFO - operating with platform_type : mac_ 11:56:36 INFO - Initialising browser for dromaeo_css test... 11:56:36 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmp8wg6wf/profile http://localhost:49277/getInfo.html) 11:56:38 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 11:56:38 INFO - PROCESS | 1653 | colorDepth:24 11:56:38 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 11:56:38 INFO - PROCESS | 1653 | __metrics 11:56:38 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:56:38 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:56:39 INFO - TEST-INFO | 1653: exit 0 11:56:39 INFO - Browser initialized. 11:56:39 INFO - Running cycle 1/1 for dromaeo_css test... 11:56:39 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmp8wg6wf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:51 INFO - PROCESS | 1655 | RSS: Main: 243527680 11:56:51 INFO - PROCESS | 1655 | 11:57:43 INFO - PROCESS | 1655 | 1470941863088 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] 11:59:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 11:59:56 INFO - PROCESS | 1655 | RSS: Main: 376029184 11:59:56 INFO - PROCESS | 1655 | 12:02:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 12:02:59 INFO - PROCESS | 1655 | RSS: Main: 387768320 12:02:59 INFO - PROCESS | 1655 | 12:06:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 12:06:02 INFO - PROCESS | 1655 | RSS: Main: 340414464 12:06:02 INFO - PROCESS | 1655 | 12:09:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 12:09:05 INFO - PROCESS | 1655 | RSS: Main: 363724800 12:09:05 INFO - PROCESS | 1655 | 12:12:09 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 12:12:09 INFO - PROCESS | 1655 | RSS: Main: 342589440 12:12:09 INFO - PROCESS | 1655 | 12:15:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 12:15:13 INFO - PROCESS | 1655 | RSS: Main: 481443840 12:15:13 INFO - PROCESS | 1655 | 12:15:13 INFO - PROCESS | 1655 | __start_tp_report 12:15:13 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 12:15:13 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 12:15:13 INFO - PROCESS | 1655 | |i|pagename|runs| 12:15:13 INFO - PROCESS | 1655 | |0;dojo.html;3091;3374.780639258448;3403.149212696825;3406.4549672052444;3452.34405462962;5553.08374118271;5632.042552766029;5650.237217975572;5731.713414329277;5734.283214598176;5671.943280567193;5709.6574205547695;5728.455796699307;5730.36965933747;5733.197352370671;5183.766730497118;5209.973950130263;5239.5546378557865;5247.1866860636665;5299.311089558352;5287.841364759044;5298.708571028611;5301.204819277101;5301.575873930095;5322.7072511011875;5226.947730522703;5264.078786212417;5276.287701160332;5285.603579731516;5288.206768984644;5329.147336426192;5330.253764472977;5338.412774594792;5353.919691204596;5388.78444862205;5124.718140502271;5131.076406246912;5183.714895680774;5258;5261.552768014723;5682.17608446777;5700.743466544015;5722.570807189436;5745.023346031185;5775.509081728058;6305.306416294204;6322.083297921821;6328.905066424008;6333.683315834236;6341.95357765968;5083.822066227664;6218.906716399258;6251.718672659696;6263.123162757218;6377.68111594423;4861.927071093936;5848.473637372615;5876.1479585459865;5895.911561326584;5921.407859214044;6313.747450102036;6320.778772742932;6330.272018717907;6341;6342.936570634234;5983.371745966698;6047.78832740852;6114.571979961449;6206.844828879314;6231.9688401557705;6255.0617407388345;6317.715702793385;6321.462675672619;6322.114903913456;6325.588836725598;6198.597091189058;6271.216097987752;6280.963640999275;6283.277423096402;6283.560150789493;6092.878142437126;6266.404691554295;6324.747010119636;6327.96836015817;6338.112664227012;4918.5819205367225;4924.4090709115135;4979.875503112378;4983.451820299764;4998.000399920031;4435.512093669694;4435.667324950641;4455.4876189238;4460.643148548108;4498.595126438636;5569.275994120739;5666.801661941812;5693.60144789869;5697.9430205698245;5753.194552762617;6172;6197.5351848610635;6231.750729970841;6244.0321750128805;6338.7464501420345;5654.123610840326;5656.4060773619;5666.4050274721385;5683.0338842396895;5699.772009119672;5394.109971854678;5432.782688692408;5433.510984011458;5436;5442.428545002717;6296.150019747459;6302.306746257999;6316.526260530387;6347.270063942521;6357.491400687842;6358;6368.681565921593;6370.394812492806;6371.108044873628;6379.872402552016;6288.937110628835;6356.332585078685;6360.109584658059;6369.0764839099;6372.203474565679;5429.642589352662;6136.73353236607;6162;6168.845778855564;6256.343083976299;6132.264128304632;6333.8733225336155;6345.333739957238;6351.047342898602;6363.904541431974;6093.451589356979;6141.07883817431;6149.108379285068;6154.415330543591;6180.969095154675;5909.349971503045;6089.969550152221;6131.5295901671125;6137.754489820357;6198.876022479615;5958.702064896651;6045.1234570987845;6048.848778780566;6051.606645568024;6077.179580756718;6151.50787936955;6177.289611694712;6177.444030037318;6179.474744646755;6188.9690551546955;5774.105013722879;5841.649501029951;5874.706264686663;5959.642421454727;5979.910301345571 12:15:13 INFO - PROCESS | 1655 | |1;ext.html;468.88512314482955;486.67879199728173;490.37966971780696;533.7891532844526;555.6443875919415;30339.544906826388;30564.694353056464;39740;40791.388129178085;41030.38454423178;42756.786216068955;43133.82394112703;43197.56802431983;43227.56772432283;43233.35149972753;9682.661106861262;9834.360766550188;9839.21286297098;9844.95077524615;9851.90148098517;9667.806643867118;9777.902220977805;9777.902220977805;9789.90210097897;9792.020797920186;9778.11996920277;9812.264080193978;9827.115559599635;9840.261980351503;9845.606175752997;9738.07488288615;9801.607935682528;9804.117629413387;9809.166220871235;9816.116549510578;9680.75798105046;9759.414435133915;9764.072413120743;9767.023297670246;9776.657816976372;39734.60265397338;40048.39927401091;40049.99875003119;40059;40086.39870401946;3094.3965926644314;3318.1870441741685;3353.4299169141304;3446.362422951762;3537.168765340143;25225.747742522522;30621.846890765402;30994.845025774728;31292.687073129204;31563.684363156302;2712.8101032927702;3152.24346156923;3162.114607909789;3246.577944867152;3299.059767966118;485823.5708821469;488584;489471.99999999645;489511;490324;58064.70967645135;58307;58424;58451.41548584545;58479.41520584825;34181.829090854386;56170.15744763832;56247.15629265564;56317.43682563122;56321.43678563244;15492.690146197237;16105.355785768672;16128.677426451406;16159.192040397933;16215.513534593982;12200;12304.630861074182;12315.69210769738;12321.815172772416;12347.259164450163;18430.631387372177;18763.530911727317;18793.90603046976;18800.905995469937;18830.623387532174;7453.962730186423;7544.79283314667;7921.524708517507;8054.315383192377;8109.891428228585;934.3973137326386;966.1642679082684;1027.6403258859339;1078.223678951154;1078.4715489410132;29830;30057.248568785955;30520;30786.230344241572;30953.380932381227;963.4171326347599;1009.1523120578603;1026.2303272545591;1054.536004158168;1088.4775307852276;13789.448422063006;15714.842851571566;15769.605759855865;15847.603809904615;16076.598085047968;177763;178919.10540447474;179450.1027494854;179497;180477.0976145111;59530.70234648799;59915.40084599098;59937;59979;60146.69926650339;1233.5189276182296;1288.574770325809;1343.6842342049806;1374.1548947397478;1407.1205496564646;25050.37374065663;31252.687473125887;31435.685643143275;31441.213969650027;31975;49828.75085624549;50433.74783126061;50440.99118017693;50461.747691261306;50463;536689;538359;539341;539562;541069;24007.639885401382;25894;26002.21993340203;26337.341566460993;26841.865790670923;48264.758676206395;48296.75851620719;48495.75752121217;48699.5130048695;48848.75575622099;39027.02432439098;39433.40849887311;39473.21053578855;40280.59719402886;40706;35833.46249806203;38219.853404397916;38337.808310958266;38752.6124738749;40118.598814011486;38606.42090368703;39161.804190978866;39670.40494392644;39955.80022099871;41838.1632367357;31703;34633.26833658358;35506.822465887504;35794.463083054296;35824.46263306;21593.568128637653;25707.614385784604;25964.22107336783;25981.0906618275;26143.215703528924 12:15:13 INFO - PROCESS | 1655 | |2;jquery.html;371.47250903716736;372.8508596561375;379.93731034379323;392.4858435449563;400.51737656124374;15740.29168687409;15754.763678544816;16018.415385757755;19061;21902.23342183022;13121.606351809438;21082.89458552709;21168.94155292237;22216.555668886613;22382.664260036112;5613.354464236614;6019.759209631609;6100.23747031621;6103.633781973073;6105.053716673922;4175.290200665894;5995.4304341087745;6086.908696369558;6109.327973922865;6310.873782524347;6005.609635373687;6630.569013014163;6716.529842910998;6768.120144381223;6821.079154314154;6462.806115816533;6717.361850624183;6736.663166841688;6757.256701762852;6792.592444453324;5192.662476938987;5850.327212370589;5850.3564607893095;5850.385709500484;5861.150133230658;12666.11337206396;13415.060945733803;13428;13453.461861525528;15734;2270.4550907782177;2413.4569721812627;2437.536867995075;2673.2381271337576;2841.105051908663;9965.701028969142;10038.397696138256;10456.843147352796;10461.84307235392;10514.264001519896;1806.2774890044088;1849.704047352417;1855.5175654329837;1900.429871038683;1931.5267759398896;85052.57473712592;109289;114875;119796;119862;9256.90743092574;9680.854787178198;9903.405795652285;10124.088832005154;10309.329893556895;12447.004239660806;12532.060095492692;12537.185082969578;12555.435005424777;12841;7130.180029296697;7173.718675544326;8250.339972802161;8522.446041007315;8693.000304964884;8336.62485188168;8440.15598440151;8457.154284571494;8604.182602652738;8604.526751028628;4490.573395527485;4527.320901864681;4572.4055872737;4671.602913752301;4686.859394218179;1743.8517725993433;1788.1125424846596;1830.4508647405726;1883.7645294338208;1891.7635295588052;912.1425859691868;927.6502688588088;952.6951375559754;967.6613185385058;1084.2735367303767;20531.486712832;21990;22016;22039.559208815735;22094.22670206535;890.7238755985666;904.7059705595708;954.742219600704;957.7988622389237;973.8101070291225;11182;11481.311121332747;11592.6522204334;11648.650540483799;11705.531778728926;607563;619725;619872;624124;625633;129248.89131097692;130267;134473;134966.3251683755;135965.32017340048;988.7528117970508;1000.1548691355792;1011.3628414099071;1012.2307046644603;1014.6144465103362;18736.344227951955;19153.61692766165;19195.904020480368;19461.416157515298;19610.313639022566;56682.299531014134;56721.14918276312;57179.71410142923;57479.712601436724;58376.708116460846;57187.714061429426;78651.60674196592;81996;82951.5852420734;85329.14670853212;5794.246747922743;7008.964955175192;7397.704091836482;7419.109706835215;7493.70025198986;11800.232984855957;13309.800352994907;13368.732625347633;13863.4454621814;13950.930245348709;11084.501197446296;11256.831147532957;11321.773564528829;11694.824577631513;11720.120990925545;8222.506649601042;11274.887251127711;11326.32042077478;11596.47815848272;11939.940300298791;11565.942170289094;11591.536338546364;11993.520259189534;12018.819717704417;12049.33728644933;7360.852782944418;7525.661345239368;7575.6969721210535;7594.088709354692;7833.295003449717;9976.401415915068;11419.37193454368;11650.941745291218;11741.29552226869;11860.762784744084 12:15:13 INFO - PROCESS | 1655 | |3;mootools.html;1518.8708959738422;1548.2877876176958;1770.63701941102;1888.4712280561448;1917.913693883776;8215.26062654361;8800.515971621558;8808.251298639623;8822.514761688104;8823.955880220607;7673.616319184032;7977.122516523193;8220.91779082209;8539.188777066185;8612.52631105289;2318.918837840676;2347.6595893595418;2350.2949115265437;2350.647402889563;2354.776296251862;2314.884255787212;2339.1462116327502;2344.460774021976;2365.5741966446035;2368.834181607288;2329.9301020969397;2346.9061237550477;2351.8471299365574;2355.187460326185;2360.8347415680823;2103;2176.183931025865;2307.688462057626;2316.8030717389042;2317.501737126509;2289.553537060274;2316.860988340705;2317.2005658047947;2318.466752646884;2323.233333000123;8588.441751286146;8792;8795.604197811113;8800;8813;4798.71207727534;4935.210366341368;4937.728424936627;4940.925886111711;4947.03532811102;3317.701406873393;3345.063382252949;3545.3263879863002;3559.697425718817;3563.465480177968;1030.8866024737272;1041.9114375278111;1062.3254233561745;1062.4581463453617;1066.6586692258481;11030.558777648885;11277.943610281896;11305.71735706614;11366.659000230007;11424.371659558721;4366.847160349373;4471.35165401015;4555.2256116460285;4603.171429142786;4604.8388306409115;8985.910140898639;8986.910130898737;8993.235574976201;8999.595018224196;9005.864912026325;5141.151709967889;5142.125838607446;5148.536631703165;5148.9742551287;5151.896962060738;4048.6963477739287;4259.361095835649;4389.802458889358;4829.7585120744525;4832.420109586872;3695.6489133532273;3740.8129593520216;3775.565809931893;3819.732618716663;3823.0633494793396;986.2553771902168;1131.9830202546968;1143.6969203161168;1144.8397224388593;1157.8436911017072;755.5542230084167;758.5335018963408;785.9017622797151;791.1613689489045;861.2894362151251;4743.644226682944;5011.498850115032;5719.656820590778;5871.266091738533;5963.642181469126;428.15653163268314;451.850889206561;452.94791099024036;453.57364077766795;941.6751220828941;3730.459083432887;3885.3589157789215;3988.4017397390626;4018.517777866675;4021.879343619696;10366.792664146675;10813.08088812444;10825.350478971286;10830.350178989129;10840.29538080038;10420.06219440254;10522.31604945676;10655.680329590125;10716.249862509705;10780.083692886192;8048.195180481905;8099.554524501209;8196.8360632787;8206.671733130728;8222.136675648972;5728.742206600629;5792.304923409218;5843.2403787507355;5847.853803654943;5898.675572843535;9620.37467564606;9954;9968.750781230527;9969.700908972742;9976.551055202388;9057.864132038156;10032.247581431277;10088.848667269851;10090.293679442368;10098;6489.740410383721;6860.279670634512;6892;6986.056882321025;7080;8066.677332906618;8095.676172953252;8118.878216826634;8142.022957245168;8193.83612327762;7300.087489063867;7308.744193953186;7326.230745771617;7354.485186036926;7397.815054623462;7131.679074441767;7196.10048743907;7221.566705997657;7260.419166466776;7294.927050729637;6778.661066946534;6893.103896493424;6893.414059804973;6897.999790030518;6899.517033807585;4549.1811473933685;4655.3947986761505;4699.812007519661;4742.620590352694;4765.5949244314625;4668.432903703635;4696.365990591226;4819.108464933998;4928.482509336612;4968.776405061853 12:15:13 INFO - PROCESS | 1655 | |4;prototype.html;285.79851204900547;292.3436884194982;305.63171378488914;310.0435157538992;311.8861615510339;4897.559219670229;4904.26436034595;5359;5397.595180361479;5403.135498320265;4773.355596994405;5079.517445842648;5116.211664642769;5221.895562088756;5254.211868219769;3315.7513186511046;4041;4049.3521036634143;4070.615990563208;4070.8398106539644;3323.833808309587;4080.489938757655;4090.141070375225;4104.742391684576;4108.897277568055;3310.519974603681;3359.3785149747373;3626.981865090671;3935.7048221383366;4045.7977101144825;3478.6347433519622;3972.563018067996;3986.7009974251755;4005.5193376794828;4012.598740125964;2599.532084224839;2736.86315684215;3441.1569165554347;3445.810480423576;3504.4217704078796;4701.459332176809;4757.0723708876785;5175.922361164586;5177.948220517785;5236.319278493809;4225.767582782945;4542.8864278392975;4566.360709500673;4578.809509527514;4587.632989360876;5552.194931734876;5597.3003374578175;5601;5605.747741351649;5607.635503692288;3783.4703141560203;3784.9810750946344;3792.658660720521;3797.829097690583;3798.7150963677836;5138.897222055575;5299.860529986033;5482.2873026506695;5598.776048958078;5606.831795046155;3602.5136606558303;3771.86798462058;3777.508923839883;3781;3782.659560639501;3190.6809319067906;3800.5439347278502;3814.1799513104816;3819.2170605025904;3829.9234015320094;3825.6939444844347;3983.8406463741703;4229.2598795210715;4408.206522825923;4466.642668586505;4567.725936443824;5254.316938798008;5425.345269692782;5532.446755324436;5624.91562626561;1179.7876382251106;1275.993620031894;1298.5649807314655;1328.1433475408307;1328.7674656935192;760.7413479417024;804.9455213670111;808.640155130961;817.4196320612313;817.8446095241885;3840.251151025523;3912.29815030457;3984.4222587724616;4280.700350975402;4392.692511524227;4696.107739529479;4732.361131247307;4768.828728895246;4780.426348838162;4786.1863483207935;3727.30407664512;3873.644224521395;4215.78921053946;4265.594768496988;4383.912321753611;2275.3856458756045;2624.081571449977;2658.641083453709;2683.3828219509624;2977.434287485371;5212.0194326155815;5977.462028417376;5987;5994.190784244159;6010.609310394811;4353.0616833637805;5378.757955891994;5496.862578435571;5824.796132135355;5905.616134951214;4806.798300424894;5930.9406905931255;5975.787070115645;5986.640801551921;6009.2188015557695;4848.927266090941;5739.598228124159;5768.278965129359;5829.883402332014;5870.677112758839;5559.499645031967;5678;5698.230738850202;5735.4551317624755;5825;5707.914381284367;5987.341392446914;6000.309964354155;6014;6026.758929642765;3277.3776980394855;3389.983050084734;3727.5154229949935;3862.5944275851757;3901.51231096113;5282.920756188737;5787.305523337226;5790.739416726173;5795.623284486495;5796.652200867961;4639.976800115978;5130.51260130287;5589.524890384363;5595.972020139873;5652.123920792284;5541.861453463695;5545;5566.4990150886615;5575.526080283222;5577.470140336662;5442.619016668795;5514.255575497256;5539.695316757456;5547.7780888764;5577.135543990688;5398.40617532079;5542.556595472433;5547.89180111555;5577.330720313426;5596.216529685766;5455.263539422127;5455.590830687794;5460.481254280837;5467.234587157881;5489.945100549103 12:15:13 INFO - PROCESS | 1655 | |5;yui.html;704.5878161275654;721.8881073433616;733.4352548537627;776.3284758683736;806.2783808491404;15637.687246255067;16717.498475045737;16722.665546689073;16732.66534669306;16756.41352552661;14940.327685254162;15116.622084447894;15121.09273443594;15126.470573529929;15126.848731512682;539.7921800106967;698.0889938630086;719.8272414620493;816.1960468938091;860.4364141487305;857.5969294431638;860.7202659135775;871.559862269553;873.7291439653696;874.5452364770316;925.2921515040999;926.1433174313767;927.420362273579;927.8700981862545;928.8328100941828;715.227554241418;866.1771317248639;918.9862152067724;919.659725901414;921.2215677752289;667.4193451697006;670.4033410264868;671.7951024937393;672.3914857054374;673.7911247513287;15422.305996230196;15461.226938653022;15470.303836327392;15480.148591827445;15499.612509687235;13871.583852484442;14028.43886244549;14151.575452736435;14211.573652790434;14225.14649121056;10584.682459526226;12747;12811.629848478062;12884.742305153939;12957.546485873043;4578.702384345007;4673;4765.2375619900995;4784.0192760484015;4794.256890182028;120443.3977830114;125177;125541.37229313886;125872;126247;10376.391659292822;10641.840372394421;11106.945215135225;11668.88331116678;11733.589324373777;21262;22892.313230603108;23178;23348;23394.06423743065;7400.592967386738;7533.4349923755935;7884.21157884207;7921.287084162453;8129.9187008129165;4369.672274579356;4375.321825117112;4421.845235416809;4464.55354464551;4527.207738645724;3507.6141624421293;3606.04439823447;3628.2743451309843;3632.328019316435;3637.9636203638156;546.5081426715908;650.3723906430317;661.8378497268104;661.9371159739817;665.1054331923555;568.3577557360156;607.5686262753494;618.5082859127004;623.0902881792543;644.3073695776965;7862.52824830512;8216.794580135425;8223.17768223173;8225.12767518831;8288.378371622153;550.9531889410073;560.369584217755;617.1914791622988;629.1789215074372;642.6369101457661;3489.7208223342072;4022.7476803352174;4112.527059388149;4201.117765269328;4358.825646974149;89814.10185898189;105028.37429064182;130150.34924825316;134924;165136;112768;114319.42840285745;121551;124568;129424;82429;104760.47619761853;106678;107883;110218;8013.198680132174;8857.11428857109;9154.67958621445;9194.540272986458;9344.439333640003;45174;53865.461345387615;62648.373516266074;62702.05946910891;64219.357806423206;85345.57327213572;87030.56484717535;88167.55916220378;94892;102218.97781022095;12929.418176182282;12983.545575904798;13416.798748018982;13896.652583685085;13925.860741392456;15189.924050379677;15298.923505382401;15388.230588470755;15457.613559661098;15734.683372231968;13997.860021399656;14107.083039602392;14251.57245282643;14260.857391426369;14510.782338265146;13810.37853296584;14041.368138434;14043.719125617226;14162.575122746333;14177.362018708976;13574.11768235101;13728.862711372758;13794.724105518035;13871.375788089359;14537.636559085684;10947.452627368759;11370.204085714251;11703.32236809423;11825.586104486645;11980.026677377273;10983.61557345489;11336.376499292619;11433.59982400612;11473.770524589629;11575.768484630093 12:15:13 INFO - PROCESS | 1655 | __end_tp_report 12:15:13 INFO - PROCESS | 1655 | __start_cc_report 12:15:13 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1336 12:15:13 INFO - PROCESS | 1655 | __end_cc_report 12:15:13 INFO - PROCESS | 1655 | __startTimestamp1470942913328__endTimestamp 12:15:13 INFO - PROCESS | 1655 | 12:15:13 INFO - PROCESS | 1655 | ------- Summary: start ------- 12:15:13 INFO - PROCESS | 1655 | Number of tests: 6 12:15:13 INFO - PROCESS | 1655 | 12:15:13 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5765.79 Median:5959.64 stddev:651.60 (10.9%) stddev-sans-first:618.89 12:15:13 INFO - PROCESS | 1655 | Values: 3091.0 3374.8 3403.1 3406.5 3452.3 5553.1 5632.0 5650.2 5731.7 5734.3 5671.9 5709.7 5728.5 5730.4 5733.2 5183.8 5210.0 5239.6 5247.2 5299.3 5287.8 5298.7 5301.2 5301.6 5322.7 5226.9 5264.1 5276.3 5285.6 5288.2 5329.1 5330.3 5338.4 5353.9 5388.8 5124.7 5131.1 5183.7 5258.0 5261.6 5682.2 5700.7 5722.6 5745.0 5775.5 6305.3 6322.1 6328.9 6333.7 6342.0 5083.8 6218.9 6251.7 6263.1 6377.7 4861.9 5848.5 5876.1 5895.9 5921.4 6313.7 6320.8 6330.3 6341.0 6342.9 5983.4 6047.8 6114.6 6206.8 6232.0 6255.1 6317.7 6321.5 6322.1 6325.6 6198.6 6271.2 6281.0 6283.3 6283.6 6092.9 6266.4 6324.7 6328.0 6338.1 4918.6 4924.4 4979.9 4983.5 4998.0 4435.5 4435.7 4455.5 4460.6 4498.6 5569.3 5666.8 5693.6 5697.9 5753.2 6172.0 6197.5 6231.8 6244.0 6338.7 5654.1 5656.4 5666.4 5683.0 5699.8 5394.1 5432.8 5433.5 5436.0 5442.4 6296.2 6302.3 6316.5 6347.3 6357.5 6358.0 6368.7 6370.4 6371.1 6379.9 6288.9 6356.3 6360.1 6369.1 6372.2 5429.6 6136.7 6162.0 6168.8 6256.3 6132.3 6333.9 6345.3 6351.0 6363.9 6093.5 6141.1 6149.1 6154.4 6181.0 5909.3 6090.0 6131.5 6137.8 6198.9 5958.7 6045.1 6048.8 6051.6 6077.2 6151.5 6177.3 6177.4 6179.5 6189.0 5774.1 5841.6 5874.7 5959.6 5979.9 12:15:13 INFO - PROCESS | 1655 | 12:15:13 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:56087.75 Median:39737.30 stddev:115693.80 (291.1%) stddev-sans-first:115942.99 12:15:13 INFO - PROCESS | 1655 | Values: 468.9 486.7 490.4 533.8 555.6 30339.5 30564.7 39740.0 40791.4 41030.4 42756.8 43133.8 43197.6 43227.6 43233.4 9682.7 9834.4 9839.2 9845.0 9851.9 9667.8 9777.9 9777.9 9789.9 9792.0 9778.1 9812.3 9827.1 9840.3 9845.6 9738.1 9801.6 9804.1 9809.2 9816.1 9680.8 9759.4 9764.1 9767.0 9776.7 39734.6 40048.4 40050.0 40059.0 40086.4 3094.4 3318.2 3353.4 3446.4 3537.2 25225.7 30621.8 30994.8 31292.7 31563.7 2712.8 3152.2 3162.1 3246.6 3299.1 485823.6 488584.0 489472.0 489511.0 490324.0 58064.7 58307.0 58424.0 58451.4 58479.4 34181.8 56170.2 56247.2 56317.4 56321.4 15492.7 16105.4 16128.7 16159.2 16215.5 12200.0 12304.6 12315.7 12321.8 12347.3 18430.6 18763.5 18793.9 18800.9 18830.6 7454.0 7544.8 7921.5 8054.3 8109.9 934.4 966.2 1027.6 1078.2 1078.5 29830.0 30057.2 30520.0 30786.2 30953.4 963.4 1009.2 1026.2 1054.5 1088.5 13789.4 15714.8 15769.6 15847.6 16076.6 177763.0 178919.1 179450.1 179497.0 180477.1 59530.7 59915.4 59937.0 59979.0 60146.7 1233.5 1288.6 1343.7 1374.2 1407.1 25050.4 31252.7 31435.7 31441.2 31975.0 49828.8 50433.7 50441.0 50461.7 50463.0 536689.0 538359.0 539341.0 539562.0 541069.0 24007.6 25894.0 26002.2 26337.3 26841.9 48264.8 48296.8 48495.8 48699.5 48848.8 39027.0 39433.4 39473.2 40280.6 40706.0 35833.5 38219.9 38337.8 38752.6 40118.6 38606.4 39161.8 39670.4 39955.8 41838.2 31703.0 34633.3 35506.8 35794.5 35824.5 21593.6 25707.6 25964.2 25981.1 26143.2 12:15:13 INFO - PROCESS | 1655 | 12:15:13 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:35219.23 Median:2555.39 stddev:103258.05 (4040.8%) stddev-sans-first:103514.56 12:15:13 INFO - PROCESS | 1655 | Values: 371.5 372.9 379.9 392.5 400.5 15740.3 15754.8 16018.4 19061.0 21902.2 13121.6 21082.9 21168.9 22216.6 22382.7 5613.4 6019.8 6100.2 6103.6 6105.1 4175.3 5995.4 6086.9 6109.3 6310.9 6005.6 6630.6 6716.5 6768.1 6821.1 6462.8 6717.4 6736.7 6757.3 6792.6 5192.7 5850.3 5850.4 5850.4 5861.2 12666.1 13415.1 13428.0 13453.5 15734.0 2270.5 2413.5 2437.5 2673.2 2841.1 9965.7 10038.4 10456.8 10461.8 10514.3 1806.3 1849.7 1855.5 1900.4 1931.5 85052.6 109289.0 114875.0 119796.0 119862.0 9256.9 9680.9 9903.4 10124.1 10309.3 12447.0 12532.1 12537.2 12555.4 12841.0 7130.2 7173.7 8250.3 8522.4 8693.0 8336.6 8440.2 8457.2 8604.2 8604.5 4490.6 4527.3 4572.4 4671.6 4686.9 1743.9 1788.1 1830.5 1883.8 1891.8 912.1 927.7 952.7 967.7 1084.3 20531.5 21990.0 22016.0 22039.6 22094.2 890.7 904.7 954.7 957.8 973.8 11182.0 11481.3 11592.7 11648.7 11705.5 607563.0 619725.0 619872.0 624124.0 625633.0 129248.9 130267.0 134473.0 134966.3 135965.3 988.8 1000.2 1011.4 1012.2 1014.6 18736.3 19153.6 19195.9 19461.4 19610.3 56682.3 56721.1 57179.7 57479.7 58376.7 57187.7 78651.6 81996.0 82951.6 85329.1 5794.2 7009.0 7397.7 7419.1 7493.7 11800.2 13309.8 13368.7 13863.4 13950.9 11084.5 11256.8 11321.8 11694.8 11720.1 8222.5 11274.9 11326.3 11596.5 11939.9 11565.9 11591.5 11993.5 12018.8 12049.3 7360.9 7525.7 7575.7 7594.1 7833.3 9976.4 11419.4 11650.9 11741.3 11860.8 12:15:13 INFO - PROCESS | 1655 | 12:15:13 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5540.44 Median:4743.13 stddev:3147.43 (66.4%) stddev-sans-first:3141.75 12:15:13 INFO - PROCESS | 1655 | Values: 1518.9 1548.3 1770.6 1888.5 1917.9 8215.3 8800.5 8808.3 8822.5 8824.0 7673.6 7977.1 8220.9 8539.2 8612.5 2318.9 2347.7 2350.3 2350.6 2354.8 2314.9 2339.1 2344.5 2365.6 2368.8 2329.9 2346.9 2351.8 2355.2 2360.8 2103.0 2176.2 2307.7 2316.8 2317.5 2289.6 2316.9 2317.2 2318.5 2323.2 8588.4 8792.0 8795.6 8800.0 8813.0 4798.7 4935.2 4937.7 4940.9 4947.0 3317.7 3345.1 3545.3 3559.7 3563.5 1030.9 1041.9 1062.3 1062.5 1066.7 11030.6 11277.9 11305.7 11366.7 11424.4 4366.8 4471.4 4555.2 4603.2 4604.8 8985.9 8986.9 8993.2 8999.6 9005.9 5141.2 5142.1 5148.5 5149.0 5151.9 4048.7 4259.4 4389.8 4829.8 4832.4 3695.6 3740.8 3775.6 3819.7 3823.1 986.3 1132.0 1143.7 1144.8 1157.8 755.6 758.5 785.9 791.2 861.3 4743.6 5011.5 5719.7 5871.3 5963.6 428.2 451.9 452.9 453.6 941.7 3730.5 3885.4 3988.4 4018.5 4021.9 10366.8 10813.1 10825.4 10830.4 10840.3 10420.1 10522.3 10655.7 10716.2 10780.1 8048.2 8099.6 8196.8 8206.7 8222.1 5728.7 5792.3 5843.2 5847.9 5898.7 9620.4 9954.0 9968.8 9969.7 9976.6 9057.9 10032.2 10088.8 10090.3 10098.0 6489.7 6860.3 6892.0 6986.1 7080.0 8066.7 8095.7 8118.9 8142.0 8193.8 7300.1 7308.7 7326.2 7354.5 7397.8 7131.7 7196.1 7221.6 7260.4 7294.9 6778.7 6893.1 6893.4 6898.0 6899.5 4549.2 4655.4 4699.8 4742.6 4765.6 4668.4 4696.4 4819.1 4928.5 4968.8 12:15:13 INFO - PROCESS | 1655 | 12:15:13 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4415.42 Median:4796.49 stddev:1422.79 (29.7%) stddev-sans-first:1392.61 12:15:13 INFO - PROCESS | 1655 | Values: 285.8 292.3 305.6 310.0 311.9 4897.6 4904.3 5359.0 5397.6 5403.1 4773.4 5079.5 5116.2 5221.9 5254.2 3315.8 4041.0 4049.4 4070.6 4070.8 3323.8 4080.5 4090.1 4104.7 4108.9 3310.5 3359.4 3627.0 3935.7 4045.8 3478.6 3972.6 3986.7 4005.5 4012.6 2599.5 2736.9 3441.2 3445.8 3504.4 4701.5 4757.1 5175.9 5177.9 5236.3 4225.8 4542.9 4566.4 4578.8 4587.6 5552.2 5597.3 5601.0 5605.7 5607.6 3783.5 3785.0 3792.7 3797.8 3798.7 5138.9 5299.9 5482.3 5598.8 5606.8 3602.5 3771.9 3777.5 3781.0 3782.7 3190.7 3800.5 3814.2 3819.2 3829.9 3825.7 3983.8 4229.3 4408.2 4466.6 4567.7 5254.3 5425.3 5532.4 5624.9 1179.8 1276.0 1298.6 1328.1 1328.8 760.7 804.9 808.6 817.4 817.8 3840.3 3912.3 3984.4 4280.7 4392.7 4696.1 4732.4 4768.8 4780.4 4786.2 3727.3 3873.6 4215.8 4265.6 4383.9 2275.4 2624.1 2658.6 2683.4 2977.4 5212.0 5977.5 5987.0 5994.2 6010.6 4353.1 5378.8 5496.9 5824.8 5905.6 4806.8 5930.9 5975.8 5986.6 6009.2 4848.9 5739.6 5768.3 5829.9 5870.7 5559.5 5678.0 5698.2 5735.5 5825.0 5707.9 5987.3 6000.3 6014.0 6026.8 3277.4 3390.0 3727.5 3862.6 3901.5 5282.9 5787.3 5790.7 5795.6 5796.7 4640.0 5130.5 5589.5 5596.0 5652.1 5541.9 5545.0 5566.5 5575.5 5577.5 5442.6 5514.3 5539.7 5547.8 5577.1 5398.4 5542.6 5547.9 5577.3 5596.2 5455.3 5455.6 5460.5 5467.2 5489.9 12:15:13 INFO - PROCESS | 1655 | 12:15:13 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:24210.12 Median:3556.83 stddev:37741.71 (1061.1%) stddev-sans-first:37806.31 12:15:13 INFO - PROCESS | 1655 | Values: 704.6 721.9 733.4 776.3 806.3 15637.7 16717.5 16722.7 16732.7 16756.4 14940.3 15116.6 15121.1 15126.5 15126.8 539.8 698.1 719.8 816.2 860.4 857.6 860.7 871.6 873.7 874.5 925.3 926.1 927.4 927.9 928.8 715.2 866.2 919.0 919.7 921.2 667.4 670.4 671.8 672.4 673.8 15422.3 15461.2 15470.3 15480.1 15499.6 13871.6 14028.4 14151.6 14211.6 14225.1 10584.7 12747.0 12811.6 12884.7 12957.5 4578.7 4673.0 4765.2 4784.0 4794.3 120443.4 125177.0 125541.4 125872.0 126247.0 10376.4 10641.8 11106.9 11668.9 11733.6 21262.0 22892.3 23178.0 23348.0 23394.1 7400.6 7533.4 7884.2 7921.3 8129.9 4369.7 4375.3 4421.8 4464.6 4527.2 3507.6 3606.0 3628.3 3632.3 3638.0 546.5 650.4 661.8 661.9 665.1 568.4 607.6 618.5 623.1 644.3 7862.5 8216.8 8223.2 8225.1 8288.4 551.0 560.4 617.2 629.2 642.6 3489.7 4022.7 4112.5 4201.1 4358.8 89814.1 105028.4 130150.3 134924.0 165136.0 112768.0 114319.4 121551.0 124568.0 129424.0 82429.0 104760.5 106678.0 107883.0 110218.0 8013.2 8857.1 9154.7 9194.5 9344.4 45174.0 53865.5 62648.4 62702.1 64219.4 85345.6 87030.6 88167.6 94892.0 102219.0 12929.4 12983.5 13416.8 13896.7 13925.9 15189.9 15298.9 15388.2 15457.6 15734.7 13997.9 14107.1 14251.6 14260.9 14510.8 13810.4 14041.4 14043.7 14162.6 14177.4 13574.1 13728.9 13794.7 13871.4 14537.6 10947.5 11370.2 11703.3 11825.6 11980.0 10983.6 11336.4 11433.6 11473.8 11575.8 12:15:13 INFO - PROCESS | 1655 | -------- Summary: end -------- 12:15:13 INFO - PROCESS | 1655 | 12:15:13 INFO - TEST-INFO | 1655: exit 0 12:15:13 INFO - TEST-OK | dromaeo_css | took 1117718ms 12:15:13 INFO - TEST-START | kraken 12:15:13 INFO - operating with platform_type : mac_ 12:15:13 INFO - Initialising browser for kraken test... 12:15:14 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpsFVmgL/profile http://localhost:49277/getInfo.html) 12:15:16 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 12:15:16 INFO - PROCESS | 1666 | colorDepth:24 12:15:16 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 12:15:16 INFO - PROCESS | 1666 | __metrics 12:15:16 INFO - PROCESS | 1666 | 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" 12:15:16 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:15:17 INFO - TEST-INFO | 1666: exit 0 12:15:17 INFO - Browser initialized. 12:15:17 INFO - Running cycle 1/1 for kraken test... 12:15:17 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpsFVmgL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:29 INFO - PROCESS | 1667 | RSS: Main: 243441664 12:15:29 INFO - PROCESS | 1667 | 12:15:32 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 12:15:33 INFO - PROCESS | 1667 | RSS: Main: 293195776 12:15:33 INFO - PROCESS | 1667 | 12:15:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 12:15:36 INFO - PROCESS | 1667 | RSS: Main: 299843584 12:15:36 INFO - PROCESS | 1667 | 12:15:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 12:15:40 INFO - PROCESS | 1667 | RSS: Main: 393981952 12:15:40 INFO - PROCESS | 1667 | 12:15:42 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 12:15:43 INFO - PROCESS | 1667 | RSS: Main: 296570880 12:15:43 INFO - PROCESS | 1667 | 12:15:45 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:15:45 INFO - PROCESS | 1667 | RSS: Main: 300621824 12:15:45 INFO - PROCESS | 1667 | 12:15:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 12:15:49 INFO - PROCESS | 1667 | RSS: Main: 339193856 12:15:49 INFO - PROCESS | 1667 | 12:15:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 12:15:52 INFO - PROCESS | 1667 | RSS: Main: 339656704 12:15:52 INFO - PROCESS | 1667 | 12:15:55 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 12:15:56 INFO - PROCESS | 1667 | RSS: Main: 337743872 12:15:56 INFO - PROCESS | 1667 | 12:15:57 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:15:58 INFO - PROCESS | 1667 | RSS: Main: 314007552 12:15:58 INFO - PROCESS | 1667 | 12:16:00 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:16:01 INFO - PROCESS | 1667 | RSS: Main: 319815680 12:16:01 INFO - PROCESS | 1667 | 12:16:03 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:16:04 INFO - PROCESS | 1667 | RSS: Main: 317190144 12:16:04 INFO - PROCESS | 1667 | 12:16:07 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:16:07 INFO - PROCESS | 1667 | RSS: Main: 327208960 12:16:07 INFO - PROCESS | 1667 | 12:16:10 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:16:11 INFO - PROCESS | 1667 | RSS: Main: 328691712 12:16:11 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 12:16:13 INFO - PROCESS | 1667 | RSS: Main: 372011008 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | __start_tp_report 12:16:13 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 12:16:13 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 12:16:13 INFO - PROCESS | 1667 | |i|pagename|runs| 12:16:13 INFO - PROCESS | 1667 | |0;ai-astar;102;113;113;112;114;114;112;117;161;132 12:16:13 INFO - PROCESS | 1667 | |1;audio-beat-detection;151;137;136;164;110;130;108;113;182;135 12:16:13 INFO - PROCESS | 1667 | |2;audio-dft;185;183;185;186;185;181;183;184;181;181 12:16:13 INFO - PROCESS | 1667 | |3;audio-fft;75;57;62;87;58;56;64;64;84;56 12:16:13 INFO - PROCESS | 1667 | |4;audio-oscillator;82;94;93;70;71;69;95;70;67;102 12:16:13 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;89;86;91;130;116;88;91;88;90;86 12:16:13 INFO - PROCESS | 1667 | |6;imaging-darkroom;95;95;95;96;94;96;96;96;95;95 12:16:13 INFO - PROCESS | 1667 | |7;imaging-desaturate;86;90;141;85;85;83;87;84;83;83 12:16:13 INFO - PROCESS | 1667 | |8;json-parse-financial;55;53;53;54;53;56;53;54;54;53 12:16:13 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;67;77;81;80;77;72;70;72;71;71 12:16:13 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;88;101;102;105;105;85;92;106;108;81 12:16:13 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;140;139;140;142;139;139;138;142;159;163 12:16:13 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;191;183;184;185;182;181;184;181;183;178 12:16:13 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;69;68;68;69;68;67;68;78;85;85 12:16:13 INFO - PROCESS | 1667 | __end_tp_report 12:16:13 INFO - PROCESS | 1667 | __start_cc_report 12:16:13 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,2121 12:16:13 INFO - PROCESS | 1667 | __end_cc_report 12:16:13 INFO - PROCESS | 1667 | __startTimestamp1470942973461__endTimestamp 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | ------- Summary: start ------- 12:16:13 INFO - PROCESS | 1667 | Number of tests: 14 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:119.00 Median:114.00 stddev:16.49 (14.5%) stddev-sans-first:16.30 12:16:13 INFO - PROCESS | 1667 | Values: 102.0 113.0 113.0 112.0 114.0 114.0 112.0 117.0 161.0 132.0 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:136.50 stddev:23.92 (17.5%) stddev-sans-first:24.79 12:16:13 INFO - PROCESS | 1667 | Values: 151.0 137.0 136.0 164.0 110.0 130.0 108.0 113.0 182.0 135.0 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.50 stddev:1.90 (1.0%) stddev-sans-first:1.92 12:16:13 INFO - PROCESS | 1667 | Values: 185.0 183.0 185.0 186.0 185.0 181.0 183.0 184.0 181.0 181.0 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:66.30 Median:64.00 stddev:11.61 (18.1%) stddev-sans-first:11.88 12:16:13 INFO - PROCESS | 1667 | Values: 75.0 57.0 62.0 87.0 58.0 56.0 64.0 64.0 84.0 56.0 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:76.50 stddev:13.47 (17.6%) stddev-sans-first:14.28 12:16:13 INFO - PROCESS | 1667 | Values: 82.0 94.0 93.0 70.0 71.0 69.0 95.0 70.0 67.0 102.0 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:95.50 Median:88.50 stddev:14.97 (16.9%) stddev-sans-first:15.69 12:16:13 INFO - PROCESS | 1667 | Values: 89.0 86.0 91.0 130.0 116.0 88.0 91.0 88.0 90.0 86.0 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 12:16:13 INFO - PROCESS | 1667 | Values: 95.0 95.0 95.0 96.0 94.0 96.0 96.0 96.0 95.0 95.0 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:90.70 Median:85.00 stddev:17.81 (21.0%) stddev-sans-first:18.81 12:16:13 INFO - PROCESS | 1667 | Values: 86.0 90.0 141.0 85.0 85.0 83.0 87.0 84.0 83.0 83.0 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.03 (1.9%) stddev-sans-first:1.00 12:16:13 INFO - PROCESS | 1667 | Values: 55.0 53.0 53.0 54.0 53.0 56.0 53.0 54.0 54.0 53.0 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:74.50 stddev:4.64 (6.2%) stddev-sans-first:4.22 12:16:13 INFO - PROCESS | 1667 | Values: 67.0 77.0 81.0 80.0 77.0 72.0 70.0 72.0 71.0 71.0 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:97.30 Median:94.50 stddev:9.87 (10.4%) stddev-sans-first:9.87 12:16:13 INFO - PROCESS | 1667 | Values: 88.0 101.0 102.0 105.0 105.0 85.0 92.0 106.0 108.0 81.0 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:141.00 stddev:9.05 (6.4%) stddev-sans-first:9.48 12:16:13 INFO - PROCESS | 1667 | Values: 140.0 139.0 140.0 142.0 139.0 139.0 138.0 142.0 159.0 163.0 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:183.50 stddev:3.39 (1.8%) stddev-sans-first:2.12 12:16:13 INFO - PROCESS | 1667 | Values: 191.0 183.0 184.0 185.0 182.0 181.0 184.0 181.0 183.0 178.0 12:16:13 INFO - PROCESS | 1667 | 12:16:13 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:69.00 stddev:7.29 (10.6%) stddev-sans-first:7.62 12:16:13 INFO - PROCESS | 1667 | Values: 69.0 68.0 68.0 69.0 68.0 67.0 68.0 78.0 85.0 85.0 12:16:13 INFO - PROCESS | 1667 | -------- Summary: end -------- 12:16:13 INFO - PROCESS | 1667 | 12:16:14 INFO - TEST-INFO | 1667: exit 0 12:16:14 INFO - TEST-OK | kraken | took 60538ms 12:16:14 INFO - SUITE-END | took 1178s 12:16:14 INFO - Completed test suite (00:19:38) 12:16:14 INFO - javascript benchmark 12:16:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3091.0, 3374.780639258448, 3403.149212696825, 3406.4549672052444, 3452.34405462962, 5553.08374118271, 5632.042552766029, 5650.237217975572, 5731.713414329277, 5734.283214598176, 5671.943280567193, 5709.6574205547695, 5728.455796699307, 5730.36965933747, 5733.197352370671, 5183.766730497118, 5209.973950130263, 5239.5546378557865, 5247.1866860636665, 5299.311089558352, 5287.841364759044, 5298.708571028611, 5301.204819277101, 5301.575873930095, 5322.7072511011875, 5226.947730522703, 5264.078786212417, 5276.287701160332, 5285.603579731516, 5288.206768984644, 5329.147336426192, 5330.253764472977, 5338.412774594792, 5353.919691204596, 5388.78444862205, 5124.718140502271, 5131.076406246912, 5183.714895680774, 5258.0, 5261.552768014723, 5682.17608446777, 5700.743466544015, 5722.570807189436, 5745.023346031185, 5775.509081728058, 6305.306416294204, 6322.083297921821, 6328.905066424008, 6333.683315834236, 6341.95357765968, 5083.822066227664, 6218.906716399258, 6251.718672659696, 6263.123162757218, 6377.68111594423, 4861.927071093936, 5848.473637372615, 5876.1479585459865, 5895.911561326584, 5921.407859214044, 6313.747450102036, 6320.778772742932, 6330.272018717907, 6341.0, 6342.936570634234, 5983.371745966698, 6047.78832740852, 6114.571979961449, 6206.844828879314, 6231.9688401557705, 6255.0617407388345, 6317.715702793385, 6321.462675672619, 6322.114903913456, 6325.588836725598, 6198.597091189058, 6271.216097987752, 6280.963640999275, 6283.277423096402, 6283.560150789493, 6092.878142437126, 6266.404691554295, 6324.747010119636, 6327.96836015817, 6338.112664227012, 4918.5819205367225, 4924.4090709115135, 4979.875503112378, 4983.451820299764, 4998.000399920031, 4435.512093669694, 4435.667324950641, 4455.4876189238, 4460.643148548108, 4498.595126438636, 5569.275994120739, 5666.801661941812, 5693.60144789869, 5697.9430205698245, 5753.194552762617, 6172.0, 6197.5351848610635, 6231.750729970841, 6244.0321750128805, 6338.7464501420345, 5654.123610840326, 5656.4060773619, 5666.4050274721385, 5683.0338842396895, 5699.772009119672, 5394.109971854678, 5432.782688692408, 5433.510984011458, 5436.0, 5442.428545002717, 6296.150019747459, 6302.306746257999, 6316.526260530387, 6347.270063942521, 6357.491400687842, 6358.0, 6368.681565921593, 6370.394812492806, 6371.108044873628, 6379.872402552016, 6288.937110628835, 6356.332585078685, 6360.109584658059, 6369.0764839099, 6372.203474565679, 5429.642589352662, 6136.73353236607, 6162.0, 6168.845778855564, 6256.343083976299, 6132.264128304632, 6333.8733225336155, 6345.333739957238, 6351.047342898602, 6363.904541431974, 6093.451589356979, 6141.07883817431, 6149.108379285068, 6154.415330543591, 6180.969095154675, 5909.349971503045, 6089.969550152221, 6131.5295901671125, 6137.754489820357, 6198.876022479615, 5958.702064896651, 6045.1234570987845, 6048.848778780566, 6051.606645568024, 6077.179580756718, 6151.50787936955, 6177.289611694712, 6177.444030037318, 6179.474744646755, 6188.9690551546955, 5774.105013722879, 5841.649501029951, 5874.706264686663, 5959.642421454727, 5979.910301345571], "value": 5723.82140574784, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.88512314482955, 486.67879199728173, 490.37966971780696, 533.7891532844526, 555.6443875919415, 30339.544906826388, 30564.694353056464, 39740.0, 40791.388129178085, 41030.38454423178, 42756.786216068955, 43133.82394112703, 43197.56802431983, 43227.56772432283, 43233.35149972753, 9682.661106861262, 9834.360766550188, 9839.21286297098, 9844.95077524615, 9851.90148098517, 9667.806643867118, 9777.902220977805, 9777.902220977805, 9789.90210097897, 9792.020797920186, 9778.11996920277, 9812.264080193978, 9827.115559599635, 9840.261980351503, 9845.606175752997, 9738.07488288615, 9801.607935682528, 9804.117629413387, 9809.166220871235, 9816.116549510578, 9680.75798105046, 9759.414435133915, 9764.072413120743, 9767.023297670246, 9776.657816976372, 39734.60265397338, 40048.39927401091, 40049.99875003119, 40059.0, 40086.39870401946, 3094.3965926644314, 3318.1870441741685, 3353.4299169141304, 3446.362422951762, 3537.168765340143, 25225.747742522522, 30621.846890765402, 30994.845025774728, 31292.687073129204, 31563.684363156302, 2712.8101032927702, 3152.24346156923, 3162.114607909789, 3246.577944867152, 3299.059767966118, 485823.5708821469, 488584.0, 489471.99999999645, 489511.0, 490324.0, 58064.70967645135, 58307.0, 58424.0, 58451.41548584545, 58479.41520584825, 34181.829090854386, 56170.15744763832, 56247.15629265564, 56317.43682563122, 56321.43678563244, 15492.690146197237, 16105.355785768672, 16128.677426451406, 16159.192040397933, 16215.513534593982, 12200.0, 12304.630861074182, 12315.69210769738, 12321.815172772416, 12347.259164450163, 18430.631387372177, 18763.530911727317, 18793.90603046976, 18800.905995469937, 18830.623387532174, 7453.962730186423, 7544.79283314667, 7921.524708517507, 8054.315383192377, 8109.891428228585, 934.3973137326386, 966.1642679082684, 1027.6403258859339, 1078.223678951154, 1078.4715489410132, 29830.0, 30057.248568785955, 30520.0, 30786.230344241572, 30953.380932381227, 963.4171326347599, 1009.1523120578603, 1026.2303272545591, 1054.536004158168, 1088.4775307852276, 13789.448422063006, 15714.842851571566, 15769.605759855865, 15847.603809904615, 16076.598085047968, 177763.0, 178919.10540447474, 179450.1027494854, 179497.0, 180477.0976145111, 59530.70234648799, 59915.40084599098, 59937.0, 59979.0, 60146.69926650339, 1233.5189276182296, 1288.574770325809, 1343.6842342049806, 1374.1548947397478, 1407.1205496564646, 25050.37374065663, 31252.687473125887, 31435.685643143275, 31441.213969650027, 31975.0, 49828.75085624549, 50433.74783126061, 50440.99118017693, 50461.747691261306, 50463.0, 536689.0, 538359.0, 539341.0, 539562.0, 541069.0, 24007.639885401382, 25894.0, 26002.21993340203, 26337.341566460993, 26841.865790670923, 48264.758676206395, 48296.75851620719, 48495.75752121217, 48699.5130048695, 48848.75575622099, 39027.02432439098, 39433.40849887311, 39473.21053578855, 40280.59719402886, 40706.0, 35833.46249806203, 38219.853404397916, 38337.808310958266, 38752.6124738749, 40118.598814011486, 38606.42090368703, 39161.804190978866, 39670.40494392644, 39955.80022099871, 41838.1632367357, 31703.0, 34633.26833658358, 35506.822465887504, 35794.463083054296, 35824.46263306, 21593.568128637653, 25707.614385784604, 25964.22107336783, 25981.0906618275, 26143.215703528924], "value": 19156.61350340081, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.47250903716736, 372.8508596561375, 379.93731034379323, 392.4858435449563, 400.51737656124374, 15740.29168687409, 15754.763678544816, 16018.415385757755, 19061.0, 21902.23342183022, 13121.606351809438, 21082.89458552709, 21168.94155292237, 22216.555668886613, 22382.664260036112, 5613.354464236614, 6019.759209631609, 6100.23747031621, 6103.633781973073, 6105.053716673922, 4175.290200665894, 5995.4304341087745, 6086.908696369558, 6109.327973922865, 6310.873782524347, 6005.609635373687, 6630.569013014163, 6716.529842910998, 6768.120144381223, 6821.079154314154, 6462.806115816533, 6717.361850624183, 6736.663166841688, 6757.256701762852, 6792.592444453324, 5192.662476938987, 5850.327212370589, 5850.3564607893095, 5850.385709500484, 5861.150133230658, 12666.11337206396, 13415.060945733803, 13428.0, 13453.461861525528, 15734.0, 2270.4550907782177, 2413.4569721812627, 2437.536867995075, 2673.2381271337576, 2841.105051908663, 9965.701028969142, 10038.397696138256, 10456.843147352796, 10461.84307235392, 10514.264001519896, 1806.2774890044088, 1849.704047352417, 1855.5175654329837, 1900.429871038683, 1931.5267759398896, 85052.57473712592, 109289.0, 114875.0, 119796.0, 119862.0, 9256.90743092574, 9680.854787178198, 9903.405795652285, 10124.088832005154, 10309.329893556895, 12447.004239660806, 12532.060095492692, 12537.185082969578, 12555.435005424777, 12841.0, 7130.180029296697, 7173.718675544326, 8250.339972802161, 8522.446041007315, 8693.000304964884, 8336.62485188168, 8440.15598440151, 8457.154284571494, 8604.182602652738, 8604.526751028628, 4490.573395527485, 4527.320901864681, 4572.4055872737, 4671.602913752301, 4686.859394218179, 1743.8517725993433, 1788.1125424846596, 1830.4508647405726, 1883.7645294338208, 1891.7635295588052, 912.1425859691868, 927.6502688588088, 952.6951375559754, 967.6613185385058, 1084.2735367303767, 20531.486712832, 21990.0, 22016.0, 22039.559208815735, 22094.22670206535, 890.7238755985666, 904.7059705595708, 954.742219600704, 957.7988622389237, 973.8101070291225, 11182.0, 11481.311121332747, 11592.6522204334, 11648.650540483799, 11705.531778728926, 607563.0, 619725.0, 619872.0, 624124.0, 625633.0, 129248.89131097692, 130267.0, 134473.0, 134966.3251683755, 135965.32017340048, 988.7528117970508, 1000.1548691355792, 1011.3628414099071, 1012.2307046644603, 1014.6144465103362, 18736.344227951955, 19153.61692766165, 19195.904020480368, 19461.416157515298, 19610.313639022566, 56682.299531014134, 56721.14918276312, 57179.71410142923, 57479.712601436724, 58376.708116460846, 57187.714061429426, 78651.60674196592, 81996.0, 82951.5852420734, 85329.14670853212, 5794.246747922743, 7008.964955175192, 7397.704091836482, 7419.109706835215, 7493.70025198986, 11800.232984855957, 13309.800352994907, 13368.732625347633, 13863.4454621814, 13950.930245348709, 11084.501197446296, 11256.831147532957, 11321.773564528829, 11694.824577631513, 11720.120990925545, 8222.506649601042, 11274.887251127711, 11326.32042077478, 11596.47815848272, 11939.940300298791, 11565.942170289094, 11591.536338546364, 11993.520259189534, 12018.819717704417, 12049.33728644933, 7360.852782944418, 7525.661345239368, 7575.6969721210535, 7594.088709354692, 7833.295003449717, 9976.401415915068, 11419.37193454368, 11650.941745291218, 11741.29552226869, 11860.762784744084], "value": 9415.717235560669, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.8708959738422, 1548.2877876176958, 1770.63701941102, 1888.4712280561448, 1917.913693883776, 8215.26062654361, 8800.515971621558, 8808.251298639623, 8822.514761688104, 8823.955880220607, 7673.616319184032, 7977.122516523193, 8220.91779082209, 8539.188777066185, 8612.52631105289, 2318.918837840676, 2347.6595893595418, 2350.2949115265437, 2350.647402889563, 2354.776296251862, 2314.884255787212, 2339.1462116327502, 2344.460774021976, 2365.5741966446035, 2368.834181607288, 2329.9301020969397, 2346.9061237550477, 2351.8471299365574, 2355.187460326185, 2360.8347415680823, 2103.0, 2176.183931025865, 2307.688462057626, 2316.8030717389042, 2317.501737126509, 2289.553537060274, 2316.860988340705, 2317.2005658047947, 2318.466752646884, 2323.233333000123, 8588.441751286146, 8792.0, 8795.604197811113, 8800.0, 8813.0, 4798.71207727534, 4935.210366341368, 4937.728424936627, 4940.925886111711, 4947.03532811102, 3317.701406873393, 3345.063382252949, 3545.3263879863002, 3559.697425718817, 3563.465480177968, 1030.8866024737272, 1041.9114375278111, 1062.3254233561745, 1062.4581463453617, 1066.6586692258481, 11030.558777648885, 11277.943610281896, 11305.71735706614, 11366.659000230007, 11424.371659558721, 4366.847160349373, 4471.35165401015, 4555.2256116460285, 4603.171429142786, 4604.8388306409115, 8985.910140898639, 8986.910130898737, 8993.235574976201, 8999.595018224196, 9005.864912026325, 5141.151709967889, 5142.125838607446, 5148.536631703165, 5148.9742551287, 5151.896962060738, 4048.6963477739287, 4259.361095835649, 4389.802458889358, 4829.7585120744525, 4832.420109586872, 3695.6489133532273, 3740.8129593520216, 3775.565809931893, 3819.732618716663, 3823.0633494793396, 986.2553771902168, 1131.9830202546968, 1143.6969203161168, 1144.8397224388593, 1157.8436911017072, 755.5542230084167, 758.5335018963408, 785.9017622797151, 791.1613689489045, 861.2894362151251, 4743.644226682944, 5011.498850115032, 5719.656820590778, 5871.266091738533, 5963.642181469126, 428.15653163268314, 451.850889206561, 452.94791099024036, 453.57364077766795, 941.6751220828941, 3730.459083432887, 3885.3589157789215, 3988.4017397390626, 4018.517777866675, 4021.879343619696, 10366.792664146675, 10813.08088812444, 10825.350478971286, 10830.350178989129, 10840.29538080038, 10420.06219440254, 10522.31604945676, 10655.680329590125, 10716.249862509705, 10780.083692886192, 8048.195180481905, 8099.554524501209, 8196.8360632787, 8206.671733130728, 8222.136675648972, 5728.742206600629, 5792.304923409218, 5843.2403787507355, 5847.853803654943, 5898.675572843535, 9620.37467564606, 9954.0, 9968.750781230527, 9969.700908972742, 9976.551055202388, 9057.864132038156, 10032.247581431277, 10088.848667269851, 10090.293679442368, 10098.0, 6489.740410383721, 6860.279670634512, 6892.0, 6986.056882321025, 7080.0, 8066.677332906618, 8095.676172953252, 8118.878216826634, 8142.022957245168, 8193.83612327762, 7300.087489063867, 7308.744193953186, 7326.230745771617, 7354.485186036926, 7397.815054623462, 7131.679074441767, 7196.10048743907, 7221.566705997657, 7260.419166466776, 7294.927050729637, 6778.661066946534, 6893.103896493424, 6893.414059804973, 6897.999790030518, 6899.517033807585, 4549.1811473933685, 4655.3947986761505, 4699.812007519661, 4742.620590352694, 4765.5949244314625, 4668.432903703635, 4696.365990591226, 4819.108464933998, 4928.482509336612, 4968.776405061853], "value": 4385.291172406476, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.79851204900547, 292.3436884194982, 305.63171378488914, 310.0435157538992, 311.8861615510339, 4897.559219670229, 4904.26436034595, 5359.0, 5397.595180361479, 5403.135498320265, 4773.355596994405, 5079.517445842648, 5116.211664642769, 5221.895562088756, 5254.211868219769, 3315.7513186511046, 4041.0, 4049.3521036634143, 4070.615990563208, 4070.8398106539644, 3323.833808309587, 4080.489938757655, 4090.141070375225, 4104.742391684576, 4108.897277568055, 3310.519974603681, 3359.3785149747373, 3626.981865090671, 3935.7048221383366, 4045.7977101144825, 3478.6347433519622, 3972.563018067996, 3986.7009974251755, 4005.5193376794828, 4012.598740125964, 2599.532084224839, 2736.86315684215, 3441.1569165554347, 3445.810480423576, 3504.4217704078796, 4701.459332176809, 4757.0723708876785, 5175.922361164586, 5177.948220517785, 5236.319278493809, 4225.767582782945, 4542.8864278392975, 4566.360709500673, 4578.809509527514, 4587.632989360876, 5552.194931734876, 5597.3003374578175, 5601.0, 5605.747741351649, 5607.635503692288, 3783.4703141560203, 3784.9810750946344, 3792.658660720521, 3797.829097690583, 3798.7150963677836, 5138.897222055575, 5299.860529986033, 5482.2873026506695, 5598.776048958078, 5606.831795046155, 3602.5136606558303, 3771.86798462058, 3777.508923839883, 3781.0, 3782.659560639501, 3190.6809319067906, 3800.5439347278502, 3814.1799513104816, 3819.2170605025904, 3829.9234015320094, 3825.6939444844347, 3983.8406463741703, 4229.2598795210715, 4408.206522825923, 4466.642668586505, 4567.725936443824, 5254.316938798008, 5425.345269692782, 5532.446755324436, 5624.91562626561, 1179.7876382251106, 1275.993620031894, 1298.5649807314655, 1328.1433475408307, 1328.7674656935192, 760.7413479417024, 804.9455213670111, 808.640155130961, 817.4196320612313, 817.8446095241885, 3840.251151025523, 3912.29815030457, 3984.4222587724616, 4280.700350975402, 4392.692511524227, 4696.107739529479, 4732.361131247307, 4768.828728895246, 4780.426348838162, 4786.1863483207935, 3727.30407664512, 3873.644224521395, 4215.78921053946, 4265.594768496988, 4383.912321753611, 2275.3856458756045, 2624.081571449977, 2658.641083453709, 2683.3828219509624, 2977.434287485371, 5212.0194326155815, 5977.462028417376, 5987.0, 5994.190784244159, 6010.609310394811, 4353.0616833637805, 5378.757955891994, 5496.862578435571, 5824.796132135355, 5905.616134951214, 4806.798300424894, 5930.9406905931255, 5975.787070115645, 5986.640801551921, 6009.2188015557695, 4848.927266090941, 5739.598228124159, 5768.278965129359, 5829.883402332014, 5870.677112758839, 5559.499645031967, 5678.0, 5698.230738850202, 5735.4551317624755, 5825.0, 5707.914381284367, 5987.341392446914, 6000.309964354155, 6014.0, 6026.758929642765, 3277.3776980394855, 3389.983050084734, 3727.5154229949935, 3862.5944275851757, 3901.51231096113, 5282.920756188737, 5787.305523337226, 5790.739416726173, 5795.623284486495, 5796.652200867961, 4639.976800115978, 5130.51260130287, 5589.524890384363, 5595.972020139873, 5652.123920792284, 5541.861453463695, 5545.0, 5566.4990150886615, 5575.526080283222, 5577.470140336662, 5442.619016668795, 5514.255575497256, 5539.695316757456, 5547.7780888764, 5577.135543990688, 5398.40617532079, 5542.556595472433, 5547.89180111555, 5577.330720313426, 5596.216529685766, 5455.263539422127, 5455.590830687794, 5460.481254280837, 5467.234587157881, 5489.945100549103], "value": 3960.5006266775404, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.5878161275654, 721.8881073433616, 733.4352548537627, 776.3284758683736, 806.2783808491404, 15637.687246255067, 16717.498475045737, 16722.665546689073, 16732.66534669306, 16756.41352552661, 14940.327685254162, 15116.622084447894, 15121.09273443594, 15126.470573529929, 15126.848731512682, 539.7921800106967, 698.0889938630086, 719.8272414620493, 816.1960468938091, 860.4364141487305, 857.5969294431638, 860.7202659135775, 871.559862269553, 873.7291439653696, 874.5452364770316, 925.2921515040999, 926.1433174313767, 927.420362273579, 927.8700981862545, 928.8328100941828, 715.227554241418, 866.1771317248639, 918.9862152067724, 919.659725901414, 921.2215677752289, 667.4193451697006, 670.4033410264868, 671.7951024937393, 672.3914857054374, 673.7911247513287, 15422.305996230196, 15461.226938653022, 15470.303836327392, 15480.148591827445, 15499.612509687235, 13871.583852484442, 14028.43886244549, 14151.575452736435, 14211.573652790434, 14225.14649121056, 10584.682459526226, 12747.0, 12811.629848478062, 12884.742305153939, 12957.546485873043, 4578.702384345007, 4673.0, 4765.2375619900995, 4784.0192760484015, 4794.256890182028, 120443.3977830114, 125177.0, 125541.37229313886, 125872.0, 126247.0, 10376.391659292822, 10641.840372394421, 11106.945215135225, 11668.88331116678, 11733.589324373777, 21262.0, 22892.313230603108, 23178.0, 23348.0, 23394.06423743065, 7400.592967386738, 7533.4349923755935, 7884.21157884207, 7921.287084162453, 8129.9187008129165, 4369.672274579356, 4375.321825117112, 4421.845235416809, 4464.55354464551, 4527.207738645724, 3507.6141624421293, 3606.04439823447, 3628.2743451309843, 3632.328019316435, 3637.9636203638156, 546.5081426715908, 650.3723906430317, 661.8378497268104, 661.9371159739817, 665.1054331923555, 568.3577557360156, 607.5686262753494, 618.5082859127004, 623.0902881792543, 644.3073695776965, 7862.52824830512, 8216.794580135425, 8223.17768223173, 8225.12767518831, 8288.378371622153, 550.9531889410073, 560.369584217755, 617.1914791622988, 629.1789215074372, 642.6369101457661, 3489.7208223342072, 4022.7476803352174, 4112.527059388149, 4201.117765269328, 4358.825646974149, 89814.10185898189, 105028.37429064182, 130150.34924825316, 134924.0, 165136.0, 112768.0, 114319.42840285745, 121551.0, 124568.0, 129424.0, 82429.0, 104760.47619761853, 106678.0, 107883.0, 110218.0, 8013.198680132174, 8857.11428857109, 9154.67958621445, 9194.540272986458, 9344.439333640003, 45174.0, 53865.461345387615, 62648.373516266074, 62702.05946910891, 64219.357806423206, 85345.57327213572, 87030.56484717535, 88167.55916220378, 94892.0, 102218.97781022095, 12929.418176182282, 12983.545575904798, 13416.798748018982, 13896.652583685085, 13925.860741392456, 15189.924050379677, 15298.923505382401, 15388.230588470755, 15457.613559661098, 15734.683372231968, 13997.860021399656, 14107.083039602392, 14251.57245282643, 14260.857391426369, 14510.782338265146, 13810.37853296584, 14041.368138434, 14043.719125617226, 14162.575122746333, 14177.362018708976, 13574.11768235101, 13728.862711372758, 13794.724105518035, 13871.375788089359, 14537.636559085684, 10947.452627368759, 11370.204085714251, 11703.32236809423, 11825.586104486645, 11980.026677377273, 10983.61557345489, 11336.376499292619, 11433.59982400612, 11473.770524589629, 11575.768484630093], "value": 7808.942431564418, "unit": "score"}], "name": "dromaeo_css", "value": 7206.223387239045, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 113.0, 112.0, 114.0, 114.0, 112.0, 117.0, 161.0, 132.0], "value": 119.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 137.0, 136.0, 164.0, 110.0, 130.0, 108.0, 113.0, 182.0, 135.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 185.0, 186.0, 185.0, 181.0, 183.0, 184.0, 181.0, 181.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 57.0, 62.0, 87.0, 58.0, 56.0, 64.0, 64.0, 84.0, 56.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 94.0, 93.0, 70.0, 71.0, 69.0, 95.0, 70.0, 67.0, 102.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 91.0, 130.0, 116.0, 88.0, 91.0, 88.0, 90.0, 86.0], "value": 95.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 94.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 141.0, 85.0, 85.0, 83.0, 87.0, 84.0, 83.0, 83.0], "value": 90.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 54.0, 53.0, 56.0, 53.0, 54.0, 54.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 77.0, 81.0, 80.0, 77.0, 72.0, 70.0, 72.0, 71.0, 71.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 101.0, 102.0, 105.0, 105.0, 85.0, 92.0, 106.0, 108.0, 81.0], "value": 97.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 140.0, 142.0, 139.0, 139.0, 138.0, 142.0, 159.0, 163.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 183.0, 184.0, 185.0, 182.0, 181.0, 184.0, 181.0, 183.0, 178.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 69.0, 68.0, 67.0, 68.0, 78.0, 85.0, 85.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1492.8, "alertThreshold": 2.0}]} 12:16:14 INFO - Return code: 0 12:16:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:16:14 INFO - # TBPL SUCCESS # 12:16:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:16:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:16:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:16:14 INFO - 2016-08-11 12:16:14.763 screenresolution[1671:9495] starting screenresolution argv=screenresolution get 12:16:14 INFO - 2016-08-11 12:16:14.766 screenresolution[1671:9495] Display 0: 1600x1200x32@60 12:16:14 INFO - 2016-08-11 12:16:14.772 screenresolution[1672:9498] starting screenresolution argv=screenresolution list 12:16:14 INFO - Available Modes on Display 0 12:16:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:16:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:16:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:16:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:16:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:16:15 INFO - Intel Iris: 12:16:15 INFO - Chipset Model: Intel Iris 12:16:15 INFO - Type: GPU 12:16:15 INFO - Bus: Built-In 12:16:15 INFO - VRAM (Dynamic, Max): 1536 MB 12:16:15 INFO - Vendor: Intel (0x8086) 12:16:15 INFO - Device ID: 0x0a2e 12:16:15 INFO - Revision ID: 0x0009 12:16:15 INFO - Displays: 12:16:15 INFO - Display: 12:16:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:16:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:16:15 INFO - Display Serial Number: 1600x1200 60 12:16:15 INFO - Main Display: Yes 12:16:15 INFO - Mirror: Off 12:16:15 INFO - Online: Yes 12:16:15 INFO - Rotation: Supported 12:16:15 INFO - Return code: 0 12:16:15 INFO - Running post-action listener: _resource_record_post_action 12:16:15 INFO - [mozharness: 2016-08-11 19:16:15.022156Z] Finished run-tests step (success) 12:16:15 INFO - Running post-run listener: _resource_record_post_run 12:16:15 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 37733376; Write bytes: 701815808; Read time: 398; Write time: 2032 12:16:15 INFO - TinderboxPrint: CPU usage
53.4% 12:16:15 INFO - TinderboxPrint: I/O read bytes / time
37,733,376 / 398 12:16:15 INFO - TinderboxPrint: I/O write bytes / time
701,815,808 / 2,032 12:16:15 INFO - TinderboxPrint: CPU idle
2,259.3 (46.6%) 12:16:15 INFO - TinderboxPrint: CPU system
968.2 (19.9%) 12:16:15 INFO - TinderboxPrint: CPU user
1,626.0 (33.5%) 12:16:15 INFO - TinderboxPrint: Swap in / out
441,745,408 / 0 12:16:15 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389116416; Write bytes: 383547392; Read time: 29394; Write time: 702 12:16:15 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 36779008; Write bytes: 295011328; Read time: 377; Write time: 1282 12:16:15 INFO - Running post-run listener: _upload_blobber_files 12:16:15 INFO - Blob upload gear active. 12:16:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:16:15 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 12:16:15 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'] 12:16:15 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 12:16:15 INFO - (blobuploader) - INFO - Open directory for files ... 12:16:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:16:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:16:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:16 INFO - (blobuploader) - INFO - Done attempting. 12:16:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:16:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:16:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:17 INFO - (blobuploader) - INFO - Done attempting. 12:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:16:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:21 INFO - (blobuploader) - INFO - Done attempting. 12:16:21 INFO - (blobuploader) - INFO - Iteration through files over. 12:16:21 INFO - Return code: 0 12:16:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:16:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:16:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/309d80a053e9e19e202a13d40903a09b4eb718c0ef504e8b249677954008b40e6e92c281276b656f70b260fed86ce40870d593c996ce892f5da94a4ad3d56d13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/518480ba94ffbed995147e6d957b1da5ba057ccf52b26ab91dad94923665f32da8b5b4ab4452fc2adce477bb655a196fdd8617ebe9cfa14490045a57f4cbc2b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f0bdd40fdba4d821e32265e8a6fe5541f3dba93a511c17e4a8a0b69147dddce611243dc9f214f9d111bcb1199feb52b7b21a4db7dca44cf16582958a9161e64"} 12:16:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:16:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:16:21 INFO - Contents: 12:16:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/309d80a053e9e19e202a13d40903a09b4eb718c0ef504e8b249677954008b40e6e92c281276b656f70b260fed86ce40870d593c996ce892f5da94a4ad3d56d13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/518480ba94ffbed995147e6d957b1da5ba057ccf52b26ab91dad94923665f32da8b5b4ab4452fc2adce477bb655a196fdd8617ebe9cfa14490045a57f4cbc2b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f0bdd40fdba4d821e32265e8a6fe5541f3dba93a511c17e4a8a0b69147dddce611243dc9f214f9d111bcb1199feb52b7b21a4db7dca44cf16582958a9161e64"} 12:16:21 INFO - Running post-run listener: copy_logs_to_upload_dir 12:16:21 INFO - Copying logs to upload dir... 12:16:21 INFO - mkdir: /builds/slave/test/build/upload/logs 12:16:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.853543 ========= master_lag: 1.90 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-11 12:16:23.698260) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 12:16:23.701489) ========= 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.ky3AYI8yRB/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.lVMzMThnP5/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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/309d80a053e9e19e202a13d40903a09b4eb718c0ef504e8b249677954008b40e6e92c281276b656f70b260fed86ce40870d593c996ce892f5da94a4ad3d56d13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/518480ba94ffbed995147e6d957b1da5ba057ccf52b26ab91dad94923665f32da8b5b4ab4452fc2adce477bb655a196fdd8617ebe9cfa14490045a57f4cbc2b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f0bdd40fdba4d821e32265e8a6fe5541f3dba93a511c17e4a8a0b69147dddce611243dc9f214f9d111bcb1199feb52b7b21a4db7dca44cf16582958a9161e64"} build_url:https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/L_NRwNL6S5KrmlNkvftLTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/309d80a053e9e19e202a13d40903a09b4eb718c0ef504e8b249677954008b40e6e92c281276b656f70b260fed86ce40870d593c996ce892f5da94a4ad3d56d13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/518480ba94ffbed995147e6d957b1da5ba057ccf52b26ab91dad94923665f32da8b5b4ab4452fc2adce477bb655a196fdd8617ebe9cfa14490045a57f4cbc2b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f0bdd40fdba4d821e32265e8a6fe5541f3dba93a511c17e4a8a0b69147dddce611243dc9f214f9d111bcb1199feb52b7b21a4db7dca44cf16582958a9161e64"}' ========= master_lag: 0.46 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 12:16:24.171971) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 12:16:24.172294) ========= 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.ky3AYI8yRB/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.lVMzMThnP5/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.005373 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 12:16:24.203869) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 12:16:24.204170) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 12:16:24.204491) ========= ========= Total master_lag: 2.46 =========