builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0123 starttime: 1470751553.87 results: success (0) buildid: 20160809050430 builduid: 3a4cc2a27b1c4609b888cd1b892abe3a revision: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:53.868154) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:53.868603) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:53.869207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:53.895192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:53.895444) ========= 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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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-09 07:05:53-- 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% 45.9M=0s 2016-08-09 07:05:54 (45.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.500383 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:54.418102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:54.418405) ========= 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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.026263 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:54.466957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:54.467258) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a3fb4eb11fcf840b9e0d65a06be6cf64584add08 --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 a3fb4eb11fcf840b9e0d65a06be6cf64584add08 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FQ6TphZ1hO/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.SWWWStKXBd/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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-09 07:05:54,546 truncating revision to first 12 chars 2016-08-09 07:05:54,546 Setting DEBUG logging. 2016-08-09 07:05:54,546 attempt 1/10 2016-08-09 07:05:54,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a3fb4eb11fcf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 07:05:55,170 unpacking tar archive at: fx-team-a3fb4eb11fcf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.888005 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:55.391695) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:55.391992) ========= script_repo_revision: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:55.392356) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:55.392630) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 07:05:55.448422) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-09 07:05:55.448696) ========= /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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:05:55 INFO - MultiFileLogger online at 20160809 07:05:55 in /builds/slave/test 07:05:55 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 07:05:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:05:55 INFO - {'append_to_log': False, 07:05:55 INFO - 'base_work_dir': '/builds/slave/test', 07:05:55 INFO - 'blob_upload_branch': 'Fx-Team', 07:05:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:05:55 INFO - 'branch': 'Fx-Team', 07:05:55 INFO - 'buildbot_json_path': 'buildprops.json', 07:05:55 INFO - 'config_files': ('talos/mac_config.py',), 07:05:55 INFO - 'default_actions': ('clobber', 07:05:55 INFO - 'read-buildbot-config', 07:05:55 INFO - 'download-and-extract', 07:05:55 INFO - 'populate-webroot', 07:05:55 INFO - 'create-virtualenv', 07:05:55 INFO - 'install', 07:05:55 INFO - 'run-tests'), 07:05:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:05:55 INFO - 'download_minidump_stackwalk': True, 07:05:55 INFO - 'download_symbols': 'ondemand', 07:05:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:05:55 INFO - 'tooltool.py': '/tools/tooltool.py', 07:05:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:05:55 INFO - '/tools/misc-python/virtualenv.py')}, 07:05:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:05:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:05:55 INFO - 'installer_path': 'installer.exe', 07:05:55 INFO - 'log_level': 'info', 07:05:55 INFO - 'log_name': 'talos', 07:05:55 INFO - 'log_to_console': True, 07:05:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:05:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:05:55 INFO - 'opt_config_files': (), 07:05:55 INFO - 'pip_index': False, 07:05:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:05:55 INFO - 'cmd': ('bash', 07:05:55 INFO - '-c', 07:05:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:05:55 INFO - 'enabled': True, 07:05:55 INFO - 'halt_on_failure': False, 07:05:55 INFO - 'name': 'check_screen_resolution'},), 07:05:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:05:55 INFO - 'cmd': ('bash', 07:05:55 INFO - '-c', 07:05:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:05:55 INFO - 'enabled': True, 07:05:55 INFO - 'halt_on_failure': False, 07:05:55 INFO - 'name': 'check_screen_resolution'},), 07:05:55 INFO - 'run_cmd_checks_enabled': True, 07:05:55 INFO - 'sps_profile': False, 07:05:55 INFO - 'sps_profile_interval': 0, 07:05:55 INFO - 'suite': 'dromaeojs', 07:05:55 INFO - 'system_bits': '32', 07:05:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:05:55 INFO - 'title': 't-yosemite-r7-0123', 07:05:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:05:55 INFO - 'use_talos_json': True, 07:05:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:05:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:05:55 INFO - 'work_dir': 'build'} 07:05:55 INFO - [mozharness: 2016-08-09 14:05:55.656126Z] Running clobber step. 07:05:55 INFO - Running pre-action listener: _resource_record_pre_action 07:05:55 INFO - Running main action method: clobber 07:05:55 INFO - rmtree: /builds/slave/test/build 07:05:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:05:57 INFO - Running post-action listener: _resource_record_post_action 07:05:57 INFO - [mozharness: 2016-08-09 14:05:57.761327Z] Finished clobber step (success) 07:05:57 INFO - [mozharness: 2016-08-09 14:05:57.761475Z] Running read-buildbot-config step. 07:05:57 INFO - Running pre-action listener: _resource_record_pre_action 07:05:57 INFO - Running main action method: read_buildbot_config 07:05:57 INFO - Using buildbot properties: 07:05:57 INFO - { 07:05:57 INFO - "project": "", 07:05:57 INFO - "product": "firefox", 07:05:57 INFO - "script_repo_revision": "production", 07:05:57 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:05:57 INFO - "repository": "", 07:05:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:05:57 INFO - "buildid": "20160809050430", 07:05:57 INFO - "pgo_build": "False", 07:05:57 INFO - "basedir": "/builds/slave/test", 07:05:57 INFO - "buildnumber": 84, 07:05:57 INFO - "slavename": "t-yosemite-r7-0123", 07:05:57 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 07:05:57 INFO - "platform": "yosemite_r7", 07:05:57 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 07:05:57 INFO - "branch": "fx-team", 07:05:57 INFO - "repo_path": "integration/fx-team", 07:05:57 INFO - "revision": "a3fb4eb11fcf840b9e0d65a06be6cf64584add08", 07:05:57 INFO - "stage_platform": "macosx64", 07:05:57 INFO - "builduid": "3a4cc2a27b1c4609b888cd1b892abe3a", 07:05:57 INFO - "slavebuilddir": "test" 07:05:57 INFO - } 07:05:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 07:05:57 INFO - Running post-action listener: _resource_record_post_action 07:05:57 INFO - [mozharness: 2016-08-09 14:05:57.765516Z] Finished read-buildbot-config step (success) 07:05:57 INFO - [mozharness: 2016-08-09 14:05:57.765670Z] Running download-and-extract step. 07:05:57 INFO - Running pre-action listener: _resource_record_pre_action 07:05:57 INFO - Running main action method: download_and_extract 07:05:57 INFO - mkdir: /builds/slave/test/build/tests 07:05:57 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')]} 07:05:57 INFO - trying https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 07:05:57 INFO - Downloading https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:05:58 INFO - Downloaded 1199 bytes. 07:05:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 07:05:58 INFO - Using the following test package requirements: 07:05:58 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:05:58 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 07:05:58 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 07:05:58 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'jsshell-mac.zip'], 07:05:58 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 07:05:58 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:05:58 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 07:05:58 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 07:05:58 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 07:05:58 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:05:58 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 07:05:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:58 INFO - trying https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:05:58 INFO - Downloading https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:05:59 INFO - Downloaded 16324205 bytes. 07:05:59 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'] 07:05:59 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 07:06:02 INFO - Return code: 0 07:06:02 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 07:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:02 INFO - trying https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:06:02 INFO - Downloading https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:06:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:06:03 INFO - Downloaded 16324205 bytes. 07:06:03 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'] 07:06:03 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 07:06:07 INFO - Return code: 0 07:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:07 INFO - trying https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 07:06:07 INFO - Downloading https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:06:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:06:08 INFO - Downloaded 14413723 bytes. 07:06:08 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'] 07:06:08 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 07:06:08 INFO - Return code: 0 07:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:08 INFO - trying https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:06:08 INFO - Downloading https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 07:06:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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 07:06:11 INFO - Downloaded 111954074 bytes. 07:06:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:06:11 INFO - mkdir: /builds/slave/test/properties 07:06:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:06:11 INFO - Writing to file /builds/slave/test/properties/build_url 07:06:11 INFO - Contents: 07:06:11 INFO - build_url:https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:06:12 INFO - Running post-action listener: _resource_record_post_action 07:06:12 INFO - Running post-action listener: set_extra_try_arguments 07:06:12 INFO - [mozharness: 2016-08-09 14:06:12.440245Z] Finished download-and-extract step (success) 07:06:12 INFO - [mozharness: 2016-08-09 14:06:12.440355Z] Running populate-webroot step. 07:06:12 INFO - Running pre-action listener: _resource_record_pre_action 07:06:12 INFO - Running main action method: populate_webroot 07:06:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:06:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:06:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:06:12 INFO - '--tppagecycles', 07:06:12 INFO - '7'], 07:06:12 INFO - 'tests': ['tsvgm']}}, 07:06:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:06:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:06:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:06:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:06:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:06:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:06:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:12 INFO - 'talos_options': ['--disable-e10s'], 07:06:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:12 INFO - 'talos_options': ['--disable-e10s'], 07:06:12 INFO - 'tests': ['damp', 'tps']}, 07:06:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:12 INFO - 'tests': ['damp', 'tps']}, 07:06:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:06:12 INFO - 'tests': ['dromaeo_dom']}, 07:06:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:06:12 INFO - 'tests': ['basic_compositor_video']}, 07:06:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:06:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:06:12 INFO - 'tests': ['a11yr', 07:06:12 INFO - 'ts_paint', 07:06:12 INFO - 'tpaint', 07:06:12 INFO - 'sessionrestore', 07:06:12 INFO - 'sessionrestore_no_auto_restore', 07:06:12 INFO - 'tabpaint']}, 07:06:12 INFO - 'other-e10s': {'tests': ['a11yr', 07:06:12 INFO - 'ts_paint', 07:06:12 INFO - 'tpaint', 07:06:12 INFO - 'sessionrestore', 07:06:12 INFO - 'sessionrestore_no_auto_restore', 07:06:12 INFO - 'tabpaint']}, 07:06:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:06:12 INFO - 'ts_paint', 07:06:12 INFO - 'tpaint', 07:06:12 INFO - 'sessionrestore', 07:06:12 INFO - 'sessionrestore_no_auto_restore', 07:06:12 INFO - 'tabpaint']}, 07:06:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:06:12 INFO - 'ts_paint', 07:06:12 INFO - 'tpaint', 07:06:12 INFO - 'sessionrestore', 07:06:12 INFO - 'sessionrestore_no_auto_restore', 07:06:12 INFO - 'tabpaint']}, 07:06:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:06:12 INFO - 'tests': ['a11yr', 07:06:12 INFO - 'ts_paint', 07:06:12 INFO - 'tpaint', 07:06:12 INFO - 'sessionrestore', 07:06:12 INFO - 'sessionrestore_no_auto_restore', 07:06:12 INFO - 'tabpaint']}, 07:06:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:06:12 INFO - 'tests': ['a11yr', 07:06:12 INFO - 'ts_paint', 07:06:12 INFO - 'tpaint', 07:06:12 INFO - 'sessionrestore', 07:06:12 INFO - 'sessionrestore_no_auto_restore', 07:06:12 INFO - 'tabpaint']}, 07:06:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:06:12 INFO - 'tests': ['tsvgx', 07:06:12 INFO - 'tsvgr_opacity', 07:06:12 INFO - 'tart', 07:06:12 INFO - 'tscrollx', 07:06:12 INFO - 'cart']}, 07:06:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:06:12 INFO - 'tsvgr_opacity', 07:06:12 INFO - 'tart', 07:06:12 INFO - 'tscrollx', 07:06:12 INFO - 'cart']}, 07:06:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:12 INFO - 'talos_options': ['--disable-e10s'], 07:06:12 INFO - 'tests': ['tp5o']}, 07:06:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:12 INFO - 'tests': ['tp5o']}, 07:06:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:12 INFO - 'talos_options': ['--disable-e10s', 07:06:12 INFO - '--xperf_path', 07:06:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:12 INFO - 'tests': ['tp5n']}, 07:06:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:12 INFO - 'talos_options': ['--xperf_path', 07:06:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:12 INFO - 'tests': ['tp5n']}}, 07:06:12 INFO - 'talos.zip': {'path': '', 07:06:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:06:12 INFO - Running post-action listener: _resource_record_post_action 07:06:12 INFO - [mozharness: 2016-08-09 14:06:12.459462Z] Finished populate-webroot step (success) 07:06:12 INFO - [mozharness: 2016-08-09 14:06:12.459569Z] Running create-virtualenv step. 07:06:12 INFO - Running pre-action listener: _resource_record_pre_action 07:06:12 INFO - Running main action method: create_virtualenv 07:06:12 INFO - Creating virtualenv /builds/slave/test/build/venv 07:06:12 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 07:06:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:06:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:12 INFO - Using real prefix '/tools/python27' 07:06:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:06:13 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:16 INFO - Installing pip.................done. 07:06:16 INFO - Return code: 0 07:06:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b234a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2c9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a2596cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b198d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b190b20>, '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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:06:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQ6TphZ1hO/Render', 07:06:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:16 INFO - 'HOME': '/Users/cltbld', 07:06:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:16 INFO - 'LOGNAME': 'cltbld', 07:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:16 INFO - 'MOZ_NO_REMOTE': '1', 07:06:16 INFO - 'NO_EM_RESTART': '1', 07:06:16 INFO - 'PAGER': '/bin/cat', 07:06:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:16 INFO - 'PWD': '/builds/slave/test', 07:06:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:16 INFO - 'SHELL': '/bin/bash', 07:06:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWWWStKXBd/Listeners', 07:06:16 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:06:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:16 INFO - 'USER': 'cltbld', 07:06:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:16 INFO - 'XPC_FLAGS': '0x0', 07:06:16 INFO - 'XPC_SERVICE_NAME': '0', 07:06:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:16 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 07:06:16 INFO - Cleaning up... 07:06:16 INFO - Return code: 0 07:06:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b234a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2c9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a2596cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b198d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b190b20>, '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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:06:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQ6TphZ1hO/Render', 07:06:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:16 INFO - 'HOME': '/Users/cltbld', 07:06:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:16 INFO - 'LOGNAME': 'cltbld', 07:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:16 INFO - 'MOZ_NO_REMOTE': '1', 07:06:16 INFO - 'NO_EM_RESTART': '1', 07:06:16 INFO - 'PAGER': '/bin/cat', 07:06:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:16 INFO - 'PWD': '/builds/slave/test', 07:06:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:16 INFO - 'SHELL': '/bin/bash', 07:06:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWWWStKXBd/Listeners', 07:06:16 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:06:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:16 INFO - 'USER': 'cltbld', 07:06:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:16 INFO - 'XPC_FLAGS': '0x0', 07:06:16 INFO - 'XPC_SERVICE_NAME': '0', 07:06:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:16 INFO - Downloading/unpacking psutil>=3.1.1 07:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:20 INFO - Installing collected packages: psutil 07:06:20 INFO - Running setup.py install for psutil 07:06:20 INFO - building 'psutil._psutil_osx' extension 07:06:20 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 07:06:21 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 07:06:21 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 07:06:21 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 07:06:21 INFO - building 'psutil._psutil_posix' extension 07:06:21 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 07:06:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:06:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:06:21 INFO - ^ 07:06:21 INFO - 1 warning generated. 07:06:21 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 07:06:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:21 INFO - Successfully installed psutil 07:06:21 INFO - Cleaning up... 07:06:21 INFO - Return code: 0 07:06:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:06:21 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')]} 07:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:21 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')]} 07:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:21 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 0x10b234a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2c9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a2596cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b198d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b190b20>, '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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:06:21 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 07:06:21 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 07:06:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQ6TphZ1hO/Render', 07:06:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:21 INFO - 'HOME': '/Users/cltbld', 07:06:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:21 INFO - 'LOGNAME': 'cltbld', 07:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:21 INFO - 'MOZ_NO_REMOTE': '1', 07:06:21 INFO - 'NO_EM_RESTART': '1', 07:06:21 INFO - 'PAGER': '/bin/cat', 07:06:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:21 INFO - 'PWD': '/builds/slave/test', 07:06:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:21 INFO - 'SHELL': '/bin/bash', 07:06:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWWWStKXBd/Listeners', 07:06:21 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:06:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:21 INFO - 'USER': 'cltbld', 07:06:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:21 INFO - 'XPC_FLAGS': '0x0', 07:06:21 INFO - 'XPC_SERVICE_NAME': '0', 07:06:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:06:22 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 07:06:22 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 07:06:22 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 07:06:22 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 07:06:22 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 07:06:22 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 07:06:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:06:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:06:24 INFO - Installing collected packages: mozsystemmonitor 07:06:24 INFO - Running setup.py install for mozsystemmonitor 07:06:24 INFO - Successfully installed mozsystemmonitor 07:06:24 INFO - Cleaning up... 07:06:24 INFO - Return code: 0 07:06:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:24 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 0x10b234a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2c9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a2596cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b198d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b190b20>, '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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:06:24 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 07:06:24 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 07:06:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQ6TphZ1hO/Render', 07:06:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:24 INFO - 'HOME': '/Users/cltbld', 07:06:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:24 INFO - 'LOGNAME': 'cltbld', 07:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:24 INFO - 'MOZ_NO_REMOTE': '1', 07:06:24 INFO - 'NO_EM_RESTART': '1', 07:06:24 INFO - 'PAGER': '/bin/cat', 07:06:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:24 INFO - 'PWD': '/builds/slave/test', 07:06:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:24 INFO - 'SHELL': '/bin/bash', 07:06:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWWWStKXBd/Listeners', 07:06:24 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:06:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:24 INFO - 'USER': 'cltbld', 07:06:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:24 INFO - 'XPC_FLAGS': '0x0', 07:06:24 INFO - 'XPC_SERVICE_NAME': '0', 07:06:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:25 INFO - Downloading/unpacking jsonschema==2.5.1 07:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:06:27 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 07:06:27 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 07:06:27 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 07:06:27 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 07:06:27 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 07:06:27 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 07:06:27 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:28 INFO - warning: no files found matching '*.txt' 07:06:28 INFO - no previously-included directories found matching 'build' 07:06:28 INFO - no previously-included directories found matching 'dist' 07:06:28 INFO - no previously-included directories found matching '.git*' 07:06:28 INFO - Installing collected packages: jsonschema, functools32 07:06:28 INFO - Running setup.py install for functools32 07:06:28 INFO - warning: no files found matching '*.txt' 07:06:28 INFO - no previously-included directories found matching 'build' 07:06:28 INFO - no previously-included directories found matching 'dist' 07:06:28 INFO - no previously-included directories found matching '.git*' 07:06:28 INFO - Successfully installed jsonschema functools32 07:06:28 INFO - Cleaning up... 07:06:28 INFO - Return code: 0 07:06:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b234a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2c9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a2596cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b198d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b190b20>, '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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:06:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQ6TphZ1hO/Render', 07:06:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:28 INFO - 'HOME': '/Users/cltbld', 07:06:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:28 INFO - 'LOGNAME': 'cltbld', 07:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:28 INFO - 'MOZ_NO_REMOTE': '1', 07:06:28 INFO - 'NO_EM_RESTART': '1', 07:06:28 INFO - 'PAGER': '/bin/cat', 07:06:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:28 INFO - 'PWD': '/builds/slave/test', 07:06:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:28 INFO - 'SHELL': '/bin/bash', 07:06:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWWWStKXBd/Listeners', 07:06:28 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:06:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:28 INFO - 'USER': 'cltbld', 07:06:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:28 INFO - 'XPC_FLAGS': '0x0', 07:06:28 INFO - 'XPC_SERVICE_NAME': '0', 07:06:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:06:28 INFO - Cleaning up... 07:06:28 INFO - Return code: 0 07:06:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b234a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2c9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a2596cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b198d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b190b20>, '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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:06:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQ6TphZ1hO/Render', 07:06:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:28 INFO - 'HOME': '/Users/cltbld', 07:06:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:28 INFO - 'LOGNAME': 'cltbld', 07:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:28 INFO - 'MOZ_NO_REMOTE': '1', 07:06:28 INFO - 'NO_EM_RESTART': '1', 07:06:28 INFO - 'PAGER': '/bin/cat', 07:06:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:28 INFO - 'PWD': '/builds/slave/test', 07:06:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:28 INFO - 'SHELL': '/bin/bash', 07:06:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWWWStKXBd/Listeners', 07:06:28 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:06:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:28 INFO - 'USER': 'cltbld', 07:06:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:28 INFO - 'XPC_FLAGS': '0x0', 07:06:28 INFO - 'XPC_SERVICE_NAME': '0', 07:06:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:28 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:31 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:32 INFO - Downloading docopt-0.6.1.tar.gz 07:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:32 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:32 INFO - Running setup.py install for blobuploader 07:06:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:32 INFO - Running setup.py install for requests 07:06:33 INFO - Running setup.py install for docopt 07:06:33 INFO - Successfully installed blobuploader requests docopt 07:06:33 INFO - Cleaning up... 07:06:33 INFO - Return code: 0 07:06:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:33 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')]} 07:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:33 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')]} 07:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:33 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 0x10b234a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2c9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a2596cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b198d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b190b20>, '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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:06:33 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 07:06:33 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 07:06:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQ6TphZ1hO/Render', 07:06:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:33 INFO - 'HOME': '/Users/cltbld', 07:06:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:33 INFO - 'LOGNAME': 'cltbld', 07:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:33 INFO - 'MOZ_NO_REMOTE': '1', 07:06:33 INFO - 'NO_EM_RESTART': '1', 07:06:33 INFO - 'PAGER': '/bin/cat', 07:06:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:33 INFO - 'PWD': '/builds/slave/test', 07:06:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:33 INFO - 'SHELL': '/bin/bash', 07:06:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWWWStKXBd/Listeners', 07:06:33 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:06:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:33 INFO - 'USER': 'cltbld', 07:06:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:33 INFO - 'XPC_FLAGS': '0x0', 07:06:33 INFO - 'XPC_SERVICE_NAME': '0', 07:06:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:33 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-OHpTPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:33 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-W6maoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-QOyb0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-dXB8RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-wnsyDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-ZwgwjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-_jbRQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-4y94ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-I7bsIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-fGJhXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:34 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-5oBphY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-EAzxmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-rsr_Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Vc99Ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-p0Jl1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-AAVDSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-B3WeDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:35 INFO - Running setup.py install for manifestparser 07:06:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:35 INFO - Running setup.py install for mozcrash 07:06:35 INFO - Running setup.py install for mozdebug 07:06:36 INFO - Running setup.py install for mozdevice 07:06:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:06:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:36 INFO - Running setup.py install for mozfile 07:06:36 INFO - Running setup.py install for mozhttpd 07:06:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:36 INFO - Running setup.py install for mozinfo 07:06:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:36 INFO - Running setup.py install for mozInstall 07:06:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:36 INFO - Running setup.py install for mozleak 07:06:36 INFO - Running setup.py install for mozlog 07:06:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:37 INFO - Running setup.py install for moznetwork 07:06:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:37 INFO - Running setup.py install for mozprocess 07:06:37 INFO - Running setup.py install for mozprofile 07:06:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:37 INFO - Running setup.py install for mozrunner 07:06:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:37 INFO - Running setup.py install for mozscreenshot 07:06:37 INFO - Running setup.py install for moztest 07:06:38 INFO - Running setup.py install for mozversion 07:06:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:38 INFO - Cleaning up... 07:06:38 INFO - Return code: 0 07:06:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:38 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 0x10b234a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2c9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a2596cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b198d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b190b20>, '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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:06:38 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 07:06:38 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 07:06:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQ6TphZ1hO/Render', 07:06:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:38 INFO - 'HOME': '/Users/cltbld', 07:06:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:38 INFO - 'LOGNAME': 'cltbld', 07:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:38 INFO - 'MOZ_NO_REMOTE': '1', 07:06:38 INFO - 'NO_EM_RESTART': '1', 07:06:38 INFO - 'PAGER': '/bin/cat', 07:06:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:38 INFO - 'PWD': '/builds/slave/test', 07:06:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:38 INFO - 'SHELL': '/bin/bash', 07:06:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWWWStKXBd/Listeners', 07:06:38 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:06:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:38 INFO - 'USER': 'cltbld', 07:06:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:38 INFO - 'XPC_FLAGS': '0x0', 07:06:38 INFO - 'XPC_SERVICE_NAME': '0', 07:06:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:38 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-p8bKib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:38 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)) 07:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:38 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-fZY1yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:38 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)) 07:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:38 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-dzxow3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:38 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)) 07:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:38 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-TOIAxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:38 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)) 07:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:38 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Zcp8Oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:39 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)) 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:39 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Xnucp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:39 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)) 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:39 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-EjiJgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:39 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)) 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:39 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-DcbnAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:39 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)) 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:39 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Rl30KF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:39 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)) 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:39 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-0Tvp6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:39 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)) 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:39 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-RndyBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:39 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)) 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:39 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-lVlWCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:39 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)) 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:39 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-3MeYma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:39 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)) 07:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:39 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Erz49a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:40 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)) 07:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:40 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-usnUy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:40 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)) 07:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:40 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-HE1VtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:40 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)) 07:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:40 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-6FMN2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:40 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)) 07:06:40 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)) 07:06:40 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)) 07:06:40 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)) 07:06:40 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)) 07:06:40 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)) 07:06:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:40 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 07:06:40 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 07:06:40 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 07:06:40 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 07:06:40 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 07:06:40 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 07:06:43 INFO - Downloading blessings-1.6.tar.gz 07:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:43 INFO - Installing collected packages: blessings 07:06:43 INFO - Running setup.py install for blessings 07:06:44 INFO - Successfully installed blessings 07:06:44 INFO - Cleaning up... 07:06:44 INFO - Return code: 0 07:06:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:44 INFO - Reading from file tmpfile_stdout 07:06:44 INFO - Current package versions: 07:06:44 INFO - blessings == 1.6 07:06:44 INFO - blobuploader == 1.2.4 07:06:44 INFO - docopt == 0.6.1 07:06:44 INFO - functools32 == 3.2.3-2 07:06:44 INFO - jsonschema == 2.5.1 07:06:44 INFO - manifestparser == 1.1 07:06:44 INFO - mozInstall == 1.12 07:06:44 INFO - mozcrash == 0.17 07:06:44 INFO - mozdebug == 0.1 07:06:44 INFO - mozdevice == 0.48 07:06:44 INFO - mozfile == 1.2 07:06:44 INFO - mozhttpd == 0.7 07:06:44 INFO - mozinfo == 0.9 07:06:44 INFO - mozleak == 0.1 07:06:44 INFO - mozlog == 3.3 07:06:44 INFO - moznetwork == 0.27 07:06:44 INFO - mozprocess == 0.23 07:06:44 INFO - mozprofile == 0.28 07:06:44 INFO - mozrunner == 6.12 07:06:44 INFO - mozscreenshot == 0.1 07:06:44 INFO - mozsystemmonitor == 0.3 07:06:44 INFO - moztest == 0.7 07:06:44 INFO - mozversion == 1.4 07:06:44 INFO - psutil == 3.1.1 07:06:44 INFO - requests == 1.2.3 07:06:44 INFO - wsgiref == 0.1.2 07:06:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:44 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 0x10b234a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2c9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a2596cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b198d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b190b20>, '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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:06:44 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 07:06:44 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 07:06:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQ6TphZ1hO/Render', 07:06:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:44 INFO - 'HOME': '/Users/cltbld', 07:06:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:44 INFO - 'LOGNAME': 'cltbld', 07:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:44 INFO - 'MOZ_NO_REMOTE': '1', 07:06:44 INFO - 'NO_EM_RESTART': '1', 07:06:44 INFO - 'PAGER': '/bin/cat', 07:06:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:44 INFO - 'PWD': '/builds/slave/test', 07:06:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:44 INFO - 'SHELL': '/bin/bash', 07:06:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWWWStKXBd/Listeners', 07:06:44 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:06:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:44 INFO - 'USER': 'cltbld', 07:06:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:44 INFO - 'XPC_FLAGS': '0x0', 07:06:44 INFO - 'XPC_SERVICE_NAME': '0', 07:06:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:44 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)) 07:06:44 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)) 07:06:44 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)) 07:06:44 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)) 07:06:44 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)) 07:06:44 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)) 07:06:44 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)) 07:06:44 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)) 07:06:44 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)) 07:06:44 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)) 07:06:44 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)) 07:06:44 INFO - Cleaning up... 07:06:44 INFO - Return code: 0 07:06:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b234a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2c9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9a2596cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b198d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b190b20>, '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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 07:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:06:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQ6TphZ1hO/Render', 07:06:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:44 INFO - 'HOME': '/Users/cltbld', 07:06:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:44 INFO - 'LOGNAME': 'cltbld', 07:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:44 INFO - 'MOZ_NO_REMOTE': '1', 07:06:44 INFO - 'NO_EM_RESTART': '1', 07:06:44 INFO - 'PAGER': '/bin/cat', 07:06:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:44 INFO - 'PWD': '/builds/slave/test', 07:06:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:44 INFO - 'SHELL': '/bin/bash', 07:06:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWWWStKXBd/Listeners', 07:06:44 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:06:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:44 INFO - 'USER': 'cltbld', 07:06:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:44 INFO - 'XPC_FLAGS': '0x0', 07:06:44 INFO - 'XPC_SERVICE_NAME': '0', 07:06:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:06:44 INFO - Cleaning up... 07:06:44 INFO - Return code: 0 07:06:44 INFO - Running post-action listener: _resource_record_post_action 07:06:44 INFO - Running post-action listener: _start_resource_monitoring 07:06:45 INFO - Starting resource monitoring. 07:06:45 INFO - [mozharness: 2016-08-09 14:06:45.014476Z] Finished create-virtualenv step (success) 07:06:45 INFO - [mozharness: 2016-08-09 14:06:45.015425Z] Running install step. 07:06:45 INFO - Running pre-action listener: _resource_record_pre_action 07:06:45 INFO - Running main action method: install 07:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:45 INFO - Reading from file tmpfile_stdout 07:06:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:06:45 INFO - Reading from file tmpfile_stdout 07:06:45 INFO - Output received: 07:06:45 INFO - Usage: mozinstall [options] installer 07:06:45 INFO - Options: 07:06:45 INFO - -h, --help show this help message and exit 07:06:45 INFO - -d DEST, --destination=DEST 07:06:45 INFO - Directory to install application into. [default: 07:06:45 INFO - "/builds/slave/test"] 07:06:45 INFO - --app=APP Application being installed. [default: firefox] 07:06:45 INFO - mkdir: /builds/slave/test/build/application 07:06:45 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'] 07:06:45 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 07:07:19 INFO - Reading from file tmpfile_stdout 07:07:19 INFO - Output received: 07:07:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:07:19 INFO - Running post-action listener: _resource_record_post_action 07:07:19 INFO - [mozharness: 2016-08-09 14:07:19.828075Z] Finished install step (success) 07:07:19 INFO - [mozharness: 2016-08-09 14:07:19.828201Z] Running run-tests step. 07:07:19 INFO - Running pre-action listener: _resource_record_pre_action 07:07:19 INFO - Running main action method: run_tests 07:07:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:07:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:07:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:07:19 INFO - 2016-08-09 07:07:19.842 screenresolution[1650:8567] starting screenresolution argv=screenresolution get 07:07:19 INFO - 2016-08-09 07:07:19.845 screenresolution[1650:8567] Display 0: 1600x1200x32@60 07:07:19 INFO - 2016-08-09 07:07:19.851 screenresolution[1651:8569] starting screenresolution argv=screenresolution list 07:07:19 INFO - Available Modes on Display 0 07:07:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:07:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:07:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:07:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:07:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:07:20 INFO - Intel Iris: 07:07:20 INFO - Chipset Model: Intel Iris 07:07:20 INFO - Type: GPU 07:07:20 INFO - Bus: Built-In 07:07:20 INFO - VRAM (Dynamic, Max): 1536 MB 07:07:20 INFO - Vendor: Intel (0x8086) 07:07:20 INFO - Device ID: 0x0a2e 07:07:20 INFO - Revision ID: 0x0009 07:07:20 INFO - Displays: 07:07:20 INFO - Display: 07:07:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:07:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:07:20 INFO - Display Serial Number: 1600x1200 60 07:07:20 INFO - Main Display: Yes 07:07:20 INFO - Mirror: Off 07:07:20 INFO - Online: Yes 07:07:20 INFO - Rotation: Supported 07:07:20 INFO - Return code: 0 07:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:07:20 INFO - Python 2.7.3 07:07:20 INFO - Return code: 0 07:07:20 INFO - grabbing minidump binary from tooltool 07:07: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')]} 07:07:20 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 0x10b198d30>, '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 0x10aefddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b190b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:07:20 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 07:07:20 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 07:07:20 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 07:07:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:07:20 INFO - Return code: 0 07:07:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:07:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:07:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:07:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:07:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:07:20 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/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--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 07:07:20 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/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0123 --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 07:07:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQ6TphZ1hO/Render', 07:07:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:07:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:07:20 INFO - 'HOME': '/Users/cltbld', 07:07:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:07:20 INFO - 'LOGNAME': 'cltbld', 07:07:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:07:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:20 INFO - 'MOZ_NO_REMOTE': '1', 07:07:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:07:20 INFO - 'NO_EM_RESTART': '1', 07:07:20 INFO - 'PAGER': '/bin/cat', 07:07:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:20 INFO - 'PWD': '/builds/slave/test', 07:07:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:07:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:07:20 INFO - 'SHELL': '/bin/bash', 07:07:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SWWWStKXBd/Listeners', 07:07:20 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 07:07:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:07:20 INFO - 'USER': 'cltbld', 07:07:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:07:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:20 INFO - 'XPC_FLAGS': '0x0', 07:07:20 INFO - 'XPC_SERVICE_NAME': '0', 07:07:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:07:20 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/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--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 07:07:20 INFO - mozversion application_buildid: 20160809050430 07:07:20 INFO - mozversion application_changeset: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 07:07:20 INFO - mozversion application_display_name: Nightly 07:07:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:07:20 INFO - mozversion application_name: Firefox 07:07:20 INFO - mozversion application_remotingname: firefox 07:07:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:07:20 INFO - mozversion application_vendor: Mozilla 07:07:20 INFO - mozversion application_version: 51.0a1 07:07:20 INFO - mozversion platform_buildid: 20160809050430 07:07:20 INFO - mozversion platform_changeset: a3fb4eb11fcf840b9e0d65a06be6cf64584add08 07:07:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:07:20 INFO - mozversion platform_version: 51.0a1 07:07:20 INFO - using testdate: 1470751640 07:07:20 INFO - actual date: 1470751640 07:07:20 INFO - starting webserver on 'localhost:49274' 07:07:20 INFO - SUITE-START | Running 2 tests 07:07:20 INFO - TEST-START | dromaeo_css 07:07:20 INFO - operating with platform_type : mac_ 07:07:20 INFO - Initialising browser for dromaeo_css test... 07:07:20 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpw7yyMW/profile http://localhost:49274/getInfo.html) 07:07:22 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 07:07:22 INFO - PROCESS | 1661 | colorDepth:24 07:07:22 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 07:07:22 INFO - PROCESS | 1661 | __metrics 07:07:23 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:07:23 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:07:23 INFO - TEST-INFO | 1661: exit 0 07:07:23 INFO - Browser initialized. 07:07:23 INFO - Running cycle 1/1 for dromaeo_css test... 07:07:23 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpw7yyMW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:35 INFO - PROCESS | 1664 | RSS: Main: 243662848 07:07:35 INFO - PROCESS | 1664 | 07:08:26 INFO - PROCESS | 1664 | 1470751706804 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] 07:10:39 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 07:10:40 INFO - PROCESS | 1664 | RSS: Main: 371355648 07:10:40 INFO - PROCESS | 1664 | 07:13:43 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 07:13:44 INFO - PROCESS | 1664 | RSS: Main: 386453504 07:13:44 INFO - PROCESS | 1664 | 07:16:46 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 07:16:47 INFO - PROCESS | 1664 | RSS: Main: 351993856 07:16:47 INFO - PROCESS | 1664 | 07:19:49 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 07:19:50 INFO - PROCESS | 1664 | RSS: Main: 352395264 07:19:50 INFO - PROCESS | 1664 | 07:22:53 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 07:22:54 INFO - PROCESS | 1664 | RSS: Main: 347070464 07:22:54 INFO - PROCESS | 1664 | 07:25:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 07:25:57 INFO - PROCESS | 1664 | RSS: Main: 528650240 07:25:57 INFO - PROCESS | 1664 | 07:25:57 INFO - PROCESS | 1664 | __start_tp_report 07:25:57 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 07:25:57 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 07:25:57 INFO - PROCESS | 1664 | |i|pagename|runs| 07:25:57 INFO - PROCESS | 1664 | |0;dojo.html;3355.530225768393;3390.2541440882997;3418.675225853543;3421.144713821544;3456.222349971257;5667.659940403579;5726;5779.797707080253;5805.941940580593;5819.418058194178;5748.511376532989;5754.510866576346;5867.55993300502;5881.558883083764;5932.3474417814;5179.896402071956;5246.554042906358;5263.105272103732;5266.104762190437;5296.523312901838;5356.330458692663;5371.140617501201;5380.21986811912;5382.91925621116;5421.1326187809955;5203.505666961632;5253.4221235664045;5259.684418934838;5293.761780719877;5303.310569625944;5292.497212764782;5305.973470132663;5306.416294207634;5310.20346947957;5323.813666521692;5181.844544663666;5206.193040078794;5213.165893457029;5226.05930932432;5287.524122828964;5734.913976290359;5809.622374545684;5819.156222347779;5871.266091738533;5904.996150654399;6152.2002139722;6258.843528911768;6285.779997700059;6316.431521163117;6322.304546499881;6243.843903902393;6263.060540918853;6279.183706118175;6293.087502312139;6314.368563143649;5961.225040744675;5980.641161530322;5988.071848863433;5994.910076348859;6001.399860013964;6315.778947736899;6321.936780632135;6336.398042185985;6343.016832390987;6344.270408902943;6068.760084398659;6077.696115194222;6121.727351053096;6139.259792094406;6268.749250029948;6257.4994000480765;6268.529860260499;6277.1525844010475;6285.43431091204;6294.244690637152;6083;6213.65824879636;6239.126522286883;6241.96879015602;6254.3745625437095;6145.310039739018;6207.975684012178;6252.968735156386;6265.8120256392385;6285.685715714196;5036.093503169464;5048.116579598555;5048.167052436307;5057.291979122926;5100.438951715309;4485.48416932057;4489.191945449785;4499.820007199741;4538.137753826828;4555.908881822345;5630.915536266959;5675.205471233948;5696.515796157373;5757.8560535986935;5788.957987562279;6207.317195108534;6211.751529938751;6276.309605943343;6285.497160227171;6299.433051025429;5709.600327977002;5768.7692492300675;5783.768649254067;5784.913226301609;5829.038208695518;5531.668099914018;5533.03171944908;5533.280673512418;5534.916976245359;5540.972295138498;6198.907016394667;6222.315545289924;6268.028455589391;6295.401936815995;6422.775202867877;6257.655828929453;6274.278457977391;6277.30949595535;6287.088372186099;6288.245410550763;6382.170317858649;6384.776532821329;6394.616323020634;6402.647854368054;6440.162778838721;6149.446549810538;6192.2569291683485;6205.193324867739;6225.62646241227;6266.937330626818;6257.7184026719815;6303.527235457451;6306.621602703853;6308.558400911892;6310.305866354789;5255.004766444342;6239.688015599293;6240.719167637558;6249.468795152281;6250.4374606285655;6077.696115194134;6104.095385180791;6157.0456579230295;6159.6612186330185;6207.6585787782105;6113.050656958906;6122.877542449215;6134.141220229082;6145.35473775265;6148.323684394623;6182.319944806158;6189.566730329014;6238.344973777688;6261.217347831521;6264.9976003839165;5106;5946.910796338145;5986.55100867428;6015.548833837567;6022.427869352405 07:25:57 INFO - PROCESS | 1664 | |1;ext.html;479.57317986991586;517.0795983149994;523.2831021500543;541.9620626556143;551.7296524702896;31036;31340.373192536135;32629.51055734166;40467.392989105116;41840;43215.78392108043;43584.128317433635;43707;43734.343984840256;43745.906352341204;9565.521723913795;9729.610815567368;9747.220222382193;9749.756256093584;9750.512474376288;8725;8915.68795092172;9555;11819.586314478995;11966.940165299206;11930.701732456671;11988;12002.159848810543;12006.979406750394;12027.278363298186;11886.346250956194;11969.222000569935;11973.521059157623;11973.640790776291;11990.280583165038;11845.348505832177;11910.642680719593;11915.523379064827;11934.462949167308;11961.684214736371;40292.39561406552;40530.79734601337;40662.18675626501;40731;40731.38902916429;3696.2792255510185;3754.1928485375774;3936.0478946951175;4130.421740956269;4311.094670119279;31857;32363;33066.338673226404;33150.17124571881;33229;3250.707436330718;3278.6885245901603;3338.88313909012;3377.4427219508752;3404;423792;522797.3860130713;523532;524898;525390;61279.38720612826;61560;61599.38400616026;61602.69198653978;61612;63951.04073438902;64107.03839442412;64133;64179.67910160513;64312.03531947025;16567.91716041412;16777.580560486087;16786.580335491468;16808;16809.663806724042;12851.742965140646;12892.742145157044;12895.484180632857;12909.677258068623;12958.22250664963;13799.2410417428;14873.628159296104;15266.923665381602;16567.66864662724;16949;5457.836264912059;5474.753636086386;6448.161738973997;6522.543421960418;6533.150690410216;897.8877640294963;933.5332333833084;985.6451677396132;1008.4302369161547;1048.2086025051037;29821.85089074541;29980.250493737833;30306.242343941576;30658.69341306603;30685.69314306873;921.7925966657449;1088.3905013192636;1125.6285425809463;1138.5787258714329;1138.8213199338645;14002.299885005708;15718.371265149495;15762.605934851492;15861.841381586268;15896.364145434285;592678;650564;662729;665890;669275;52439;53369.733151334774;59243;59726.104108438405;59959.40040599538;1366.8496465388798;1387.6877702517054;1420.0201860716072;1424.7008128293176;1424.9358778854976;30734.846325768227;31400.685993139778;31971.282440992774;32342.8679996199;32429.513557296188;52060.73969630127;52414.737926310125;52560.21159682531;52623.47376526186;52764.736176318875;610042;613286;613491.5952521431;613559;613752.931235341;26632.33419164459;27511.899524018816;27533.586996194674;28274.86900523956;41152.38271425871;48348.75825620849;48763.02473950572;49208.753956229986;49615.50384496109;50085.74957125191;33982.66017339894;36499;39691.00772480711;39947.40078898761;41248.762537123934;39400.802995984835;39581.40627890641;39733.80133099316;40707.38938915859;41071;37951;38043.23913521769;38209.4268585977;38735;38933.415998759476;31617;34531.4820277691;34800.777938463274;35165.82417087898;35283;25478.23565293044;25534.23397298084;25775.6133657999;26082.73917260803;26241.737582624693 07:25:57 INFO - PROCESS | 1664 | |2;jquery.html;353.8177838413216;372.83781555023586;374.94750734897116;379.40812332760896;400.5313782874037;15266.923665381672;15660.903736738434;20260.696089558667;20800.89599552;20803.95980200988;20495.795042049576;20798.688019679717;20831.583368332624;20839.0622421991;20853.47866303343;4850.9029819403595;5708.372079071299;5840.3575606683235;6113.724882380281;6118.1434599156155;5835.183074369592;5927.555433342495;5945.702714864239;5950.55370847186;5960.582759206857;5765.538756899459;5819.243498345209;5891.617044892089;5898.7640494380175;5922.97038514809;5935.347111817697;5985.6109352892145;5987.790427335022;5990.861736270094;5996.430339117776;4950.554450099472;5152.562032227265;5191.870203244949;5201.739913004335;5220.791168353261;24334.904929278226;24474;24505.509889802102;24703.50592988148;24729.25812225636;2221.8111460525874;2362.9527409451885;2871.540553511449;3102.115896969353;3223.4197844388;14337.283135843167;14822.703545929022;15233;15587.376504939788;15610.141442220673;1648.7032334179844;1680.6302613425028;1833.7982821889582;1924.9037548122537;1931.0730849192466;86726;108789.45605271924;112838;114145;115221.42389288083;8317.8336433271;9378.765530861647;9885.703428897144;9907.306488545733;9994.450305233282;12269.754604907852;12363.32001739895;12367.319797411228;12378.938105309597;12404.75190496185;7717.884231736529;7915.047402163488;7986.680532778624;8036.758897233092;8303.750887473385;7168.354848063699;8516.74449766508;8591.613377398033;8598.398112132216;8728;3826.323199873108;3886.067343837515;3922.2155568886337;3946.2502124596235;3988.1824226034173;1877.3898482992809;1910.3504808364944;1910.3982245592595;1910.503269150031;1913.3494611832043;817.2481317188201;856.9185927336893;878.8549889268199;892.7327375146808;965.4014511003082;20116.798832011784;21440.24959126423;21460;21488.677669834964;21687.67468487974;804.4650307545417;882.580774132282;939.5818860607101;1004.6584161385164;1069.4492336446735;7918.406119541058;11084.667459976214;11122.721931951766;11183.273087249303;11240.831387529193;301776;306052;306105;567345;599759;98710.5064474673;121049.39475302567;136286.95569566466;140933;148464.77302840466;935.3312381647019;952.9332946693803;978.9363691360039;979.7452662307709;1017.4353233955226;18523.536911577317;18763.90618046901;19441.902790485958;19449.51376215606;19456.513587160433;49983.50016499789;50194.749026254634;50831.49168508268;51194;51618.74190629173;69672.65163674149;73326;75889.24110758821;79371.60314198393;80204.59897700707;8005.559694216874;8156.469829461066;8178.5092894426525;8302.584870756316;8433.409661323649;12092.45583948742;13028.804567931678;13031.348432578523;13521.729565408834;13523;11091.778164436828;11122.777544449227;11492.310461372344;11606.941965290458;11648.359340236368;11015.228933974866;11402.315861048364;11461.255018423775;11474.885251147381;11635.5927542539;11335.923087306694;11474.483648235682;11907.702307442383;11958.402079895797;11965.521379144737;6976.883698608199;7884.566348850868;8123.634436450492;8445.986481622245;8600.311975041857;6130.938690613215;7579.393648508217;7967.960160199162;8337.83324333522;9669.613215471303 07:25:57 INFO - PROCESS | 1664 | |3;mootools.html;1533.1491022482521;1565.389498095743;1756.2974810075968;1885.6700077486437;1902.2010755482688;7514.4364172687065;8293.253607175353;8833.984091829441;8837.91162088378;8854.42446240994;7796.961015194916;7997.240262175099;8425;8629.180227878358;8631.74104776856;2331.941701457464;2360.3745007573007;2362.196853069956;2363.314638754759;2364.84628499147;2334.673145759595;2343.144752165456;2378.9762102379013;2383.2135395319588;2385.9284221473386;2351.341624345186;2362.492064206195;2366.9763302367014;2379.916702915398;2393.3059412770276;2129.2547608337113;2187.50781074257;2343.800776933963;2352.517733864562;2369.7393286738443;2340.9648855267014;2351.4709190432186;2353.423411264234;2360.516094200702;2362.11420717231;8759.693410730657;8822.911770882338;8877.778055548599;8886.111388861127;8904.643814247422;5147.485251474823;5184.222366645034;5264.394594621629;5295.0468915595175;5320.281761962125;3444.2078321986082;3564.322778672044;3646.6717995380545;3649.4525821127045;3657.1954170082804;1053.3890343600692;1089.5587287148637;1092.7541303206795;1110.5835311758092;1111.2054880760215;11441.256318339281;11544.307341559534;11562.53749850005;11574.594889178838;11578.536858525733;4447.6219521341045;4567.314902764546;4704.317873908264;4735.8342458014495;4739.336492890929;9812.362196457207;9830.606775728891;9845.409275443497;9849.015098490094;9858.507074646239;5284.154535274338;5313.388960269541;5319.5744340452675;5319.6808191508635;5332.893342133136;4381.824727010884;4527.09458108373;4703.741294228782;4802.255650374128;4888.144574699413;3356.3790698720813;3857.5370955485523;3904.72666913319;3971.285168669667;4004.2592120457807;1270.6632742323293;1278.5525066226746;1278.5652878021517;1283.2492991599831;1291.4575878131207;858.6479543387181;930.3952430919821;936.9995060545784;940.1679513630486;991.6231831903831;5739.483446489752;5877.853053673607;5897.882042359129;5956.821295361146;5969.074793407029;432.3968064549935;447.66872514339804;448.54696756276394;449.68522034575926;454.5272916167215;3982.820773065161;4007.0583412897945;4130.070734084807;4141.772202528829;4146.004958809864;10007.699769006796;10384.792304153874;10536.789264214673;10676;10685.198610104273;10393.428361440194;10625.628103016357;10636.202284828514;10662.41356725372;10679.985401386855;8117.878231826528;8174.836503269901;8272.33821294307;8288.378371622153;8308.003039635283;5824.446677565625;5913.438223368773;5960.165576819336;5974.850628734316;6025.849353766191;9994.550245238835;10048.949755251177;10049.949750251202;10059.49702514886;10073.848892266475;9536.380135291183;9909.851352229867;9928.106470417697;10121.443320617142;10124.848127278245;6068.21113255274;6916.757913473004;7115.715371385087;7463.776086717407;7621.618919054136;7059.364657180673;7842.058952925686;7853.764387068397;7910.446268761361;8328.791780205544;7160.785176444715;7505.211952744883;7506.174320824595;7537.095548534211;7603.809904752205;7328.083989501312;7332.193458719643;7397.667104980181;7455.701771929279;7509.887351689838;6771.966140169267;6791;6904.240533541407;6912.93087069143;6919.065926099912;4926.359573255454;4972.8508144755715;4999.300097986212;5033.370828646419;5053.519915608012;4609.769511524478;4989.476105008922;5031.597472202142;5112.846614601568;5139.408967968731 07:25:57 INFO - PROCESS | 1664 | |4;prototype.html;299.8965356951852;301.24387786655495;313.3716897620271;315.27486780405064;317.98887038953643;4513.435820522434;5035.823746168876;5163.812323165675;5289.936924599409;5297.563120964356;4638.028837743954;4940.086084074449;5103.260027296049;5115.616328775338;5150.69095854249;3264;3942.231264903338;3975.6223158799867;3980.8606698765548;3997.560268370477;3691.563568045091;3977.164795392971;3982.283189025974;4013.7190396672245;4015.19696060789;3896.2207558488276;3906.448986930223;3915.8237879295357;3923.470331505253;3947.8815635530837;3898.4542164097047;3904.3362628353248;3924.725269231141;3924.862629807943;3935.05558665921;3373.5951685797863;3381.611114721814;3384.5769278840144;3394.7114495267933;3408.7954722716718;3705.40713485841;4652.5114862939245;4943.431505376891;4996.378350026212;5000.249962505617;3876.612338766129;4435.866923992286;4452.28763397858;4464.374987501752;4517.841875534374;4412.146898302689;4471.39636149119;4508.977455112737;5015.974920125413;5208.869778255536;3489.685928266468;3739.5325584301963;3772.5095737554216;3778.5843557208686;3779.8677046303246;4097.7541347519245;4657.254839225708;5666.385080252149;5695.77216911323;5714.485696287313;2993.6407631084408;3176.428242916251;3182.602174728159;3796.1648437343742;3803.372443546784;3278.49183376577;3840.7887566184127;3841.0013396516547;3846.538415390171;3856.6721828644318;4229.217594744982;4401.757903315284;4491.573300536444;4510.774461276923;4533.591976722045;4748.501407352178;5195.818146364934;5470.769076957653;5502.862428439321;5523.530499907552;1082.53992053377;1120.9775804484027;1149.5172027748365;1231.5258625429094;1301.7243101760328;701.7614011236102;774.9845003099906;855.2431098477767;861.9310455163571;880.700561808988;5021.422536408287;5037.042961837239;5052.621053421009;5071.96024814912;5116.386033675908;5336.573074154058;5446.311643390562;5544.944550554524;5556.416576259516;5600.803971860965;4979.502049794992;4983.90032199354;4995.175795993693;5002.549770520671;5037.916847877651;2550.4006558458746;2862.685104638488;2904.5062339402352;2915.9854200729283;2925.6196694429586;4719.33357652925;5094.949050509522;5441.673499589958;5669.631473954262;5744.684042377626;4960.528749768766;5401.109611635975;5621.381648018714;5623.409541998113;5652.63257888236;5187.636865419385;5322.14845624706;5688.431156884196;5694.003549378842;5696.487316141567;4626.884327891695;5218.269442278008;5334.333208348957;5712.685802280915;5829.793613512636;4584.449866015966;4718.575328220477;5619.185218143428;5651.321841379061;5654.378018417889;5471.863203419787;5900.970495147497;5926.1999630049395;5929.911051334319;5986.820395388146;3852.016211651058;3941.6846652267177;3966.643002129822;3968.3849003404516;3996.86010989614;5028.396592408934;5386.353637563518;5615.550755939434;5636.323641163087;5644.8024319148635;5240.829298274489;5508.834734957958;5513;5559.19391688211;5568.582356323211;4039.8788036358956;4602.650495281927;5328.57371410294;5379.246905433164;5476.233327334096;4959.355283813081;5154.433012368561;5170.405403378509;5189.223765285554;5327;4621.491635919979;5499.120140777456;5512.80705175317;5516.3380394352935;5557.388687244481;4613.270023741097;5417.918731218956;5421.783128674809;5421.810236641699;5436.287569415622 07:25:57 INFO - PROCESS | 1664 | |5;yui.html;763.496092578898;782.8311568779783;790.9525428474292;823.6993497373459;824.2416976381728;15132.848671513295;16318;16346.509604711862;16352.83647163531;16355.100469474175;14712.705745885076;14860.405583776635;14869.776953345709;14883;14885.106893586366;701.9649017549127;858.772425307291;872;890.3500444675391;893.1158153428092;885.1679421343948;887.7159309021116;889.8264838356523;889.9021107678183;890.768400215942;936.3492372800906;936.4053825820619;938.2306508662865;939.7227817793733;940.8588711693267;718.1274751177344;878.7846977490556;899.9100089991014;913.8172365526921;924.6440120553601;688.2738710660251;688.4148473797283;688.7830333444949;689.334791925794;693.19935474527;14883.627909302246;14888.106713597219;14889.925550372178;14895.031822931584;14898.553043408716;14071.226082565454;14289.142651440843;14301.427942882272;14305;14659.047161934546;13051;13263.005274604444;13305.866941330656;13544.525941591997;13634.181949083088;4546.340780586829;4620.514845941161;4799.18413869643;4850.151223535867;4855.902881942341;117592.82407175904;120313.39843300727;120778.29882115357;121011;121400.39299803533;10947.418733289802;11244.49399777012;11294.265872718248;11332.773344533063;11590.478428470738;20306;21051.78948210498;21090.683639745417;22853.857307134578;22922.31233063011;8126.309263712533;8162.061362943219;8207.425480216447;8413.831723365498;8468.237858592633;4381.737095774264;4398.118218075879;4457.331400289982;4460.442444694413;4462.754548499864;3663.7618554793853;3763.41667041609;3799.031247031989;3806.1816709407058;3806.980965095157;552.4282367749361;674.430106559956;674.8684006618662;684.1209046375483;699.566268913277;595.6128516464246;647.9805605831832;653.9444147247442;680.4284401103097;685.3576401576121;9066.546672666473;9427.434353938786;9524.285678574135;9560.952195238979;9634.566444510014;591.2845456997081;597.2206270816627;687.6149356360454;696.2914263514931;709.8260926073145;4353.325234588644;4638.79125439356;4668.929966050512;4681.555252251031;4776.59398951093;152774;162712.3728762721;168016;168175;176020;115003;117191.41404292925;117815;132251.33874330568;146764;107378;111916.88083119228;112017.43991280155;112350;116615;9335.159835614828;9895.656684556072;9921.305508614616;9944.254180936603;9961.302708810314;52201.95596088133;64056.85448953492;64838.10971341735;65527;66426.33573664201;80483;92838;97746;99597.50603741095;99911.50044249732;13072.281024543741;13157.60527184186;13410.32948352598;13695.931520342334;13816.447342106203;14856.405743770129;14896.061840593215;14982.40070397172;15018.174000430081;15027.323770430137;13681.863181368457;13845.584632461043;13875.306234688023;14048.578542643738;14549.709005819612;13686.178829270275;13720.519781807589;13751;13947.860521394656;14299.428022878968;13105.737885242432;13121.73756524845;13679.726405471636;13682.31588420595;13734.725305494034;10749.62376316825;11359.261647992855;11398.20212585111;11436.027937625395;11698.575799555552;10178.287519873538;10291.94854025725;11354.716132096764;11592.594259200887;11609.767804644029 07:25:57 INFO - PROCESS | 1664 | __end_tp_report 07:25:57 INFO - PROCESS | 1664 | __start_cc_report 07:25:57 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1271 07:25:57 INFO - PROCESS | 1664 | __end_cc_report 07:25:57 INFO - PROCESS | 1664 | __startTimestamp1470752757575__endTimestamp 07:25:57 INFO - PROCESS | 1664 | 07:25:57 INFO - PROCESS | 1664 | ------- Summary: start ------- 07:25:57 INFO - PROCESS | 1664 | Number of tests: 6 07:25:57 INFO - PROCESS | 1664 | 07:25:57 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5807.53 Median:6077.70 stddev:630.82 (10.4%) stddev-sans-first:602.72 07:25:57 INFO - PROCESS | 1664 | Values: 3355.5 3390.3 3418.7 3421.1 3456.2 5667.7 5726.0 5779.8 5805.9 5819.4 5748.5 5754.5 5867.6 5881.6 5932.3 5179.9 5246.6 5263.1 5266.1 5296.5 5356.3 5371.1 5380.2 5382.9 5421.1 5203.5 5253.4 5259.7 5293.8 5303.3 5292.5 5306.0 5306.4 5310.2 5323.8 5181.8 5206.2 5213.2 5226.1 5287.5 5734.9 5809.6 5819.2 5871.3 5905.0 6152.2 6258.8 6285.8 6316.4 6322.3 6243.8 6263.1 6279.2 6293.1 6314.4 5961.2 5980.6 5988.1 5994.9 6001.4 6315.8 6321.9 6336.4 6343.0 6344.3 6068.8 6077.7 6121.7 6139.3 6268.7 6257.5 6268.5 6277.2 6285.4 6294.2 6083.0 6213.7 6239.1 6242.0 6254.4 6145.3 6208.0 6253.0 6265.8 6285.7 5036.1 5048.1 5048.2 5057.3 5100.4 4485.5 4489.2 4499.8 4538.1 4555.9 5630.9 5675.2 5696.5 5757.9 5789.0 6207.3 6211.8 6276.3 6285.5 6299.4 5709.6 5768.8 5783.8 5784.9 5829.0 5531.7 5533.0 5533.3 5534.9 5541.0 6198.9 6222.3 6268.0 6295.4 6422.8 6257.7 6274.3 6277.3 6287.1 6288.2 6382.2 6384.8 6394.6 6402.6 6440.2 6149.4 6192.3 6205.2 6225.6 6266.9 6257.7 6303.5 6306.6 6308.6 6310.3 5255.0 6239.7 6240.7 6249.5 6250.4 6077.7 6104.1 6157.0 6159.7 6207.7 6113.1 6122.9 6134.1 6145.4 6148.3 6182.3 6189.6 6238.3 6261.2 6265.0 5106.0 5946.9 5986.6 6015.5 6022.4 07:25:57 INFO - PROCESS | 1664 | 07:25:57 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:72352.38 Median:38126.33 stddev:158285.70 (415.2%) stddev-sans-first:158637.75 07:25:57 INFO - PROCESS | 1664 | Values: 479.6 517.1 523.3 542.0 551.7 31036.0 31340.4 32629.5 40467.4 41840.0 43215.8 43584.1 43707.0 43734.3 43745.9 9565.5 9729.6 9747.2 9749.8 9750.5 8725.0 8915.7 9555.0 11819.6 11966.9 11930.7 11988.0 12002.2 12007.0 12027.3 11886.3 11969.2 11973.5 11973.6 11990.3 11845.3 11910.6 11915.5 11934.5 11961.7 40292.4 40530.8 40662.2 40731.0 40731.4 3696.3 3754.2 3936.0 4130.4 4311.1 31857.0 32363.0 33066.3 33150.2 33229.0 3250.7 3278.7 3338.9 3377.4 3404.0 423792.0 522797.4 523532.0 524898.0 525390.0 61279.4 61560.0 61599.4 61602.7 61612.0 63951.0 64107.0 64133.0 64179.7 64312.0 16567.9 16777.6 16786.6 16808.0 16809.7 12851.7 12892.7 12895.5 12909.7 12958.2 13799.2 14873.6 15266.9 16567.7 16949.0 5457.8 5474.8 6448.2 6522.5 6533.2 897.9 933.5 985.6 1008.4 1048.2 29821.9 29980.3 30306.2 30658.7 30685.7 921.8 1088.4 1125.6 1138.6 1138.8 14002.3 15718.4 15762.6 15861.8 15896.4 592678.0 650564.0 662729.0 665890.0 669275.0 52439.0 53369.7 59243.0 59726.1 59959.4 1366.8 1387.7 1420.0 1424.7 1424.9 30734.8 31400.7 31971.3 32342.9 32429.5 52060.7 52414.7 52560.2 52623.5 52764.7 610042.0 613286.0 613491.6 613559.0 613752.9 26632.3 27511.9 27533.6 28274.9 41152.4 48348.8 48763.0 49208.8 49615.5 50085.7 33982.7 36499.0 39691.0 39947.4 41248.8 39400.8 39581.4 39733.8 40707.4 41071.0 37951.0 38043.2 38209.4 38735.0 38933.4 31617.0 34531.5 34800.8 35165.8 35283.0 25478.2 25534.2 25775.6 26082.7 26241.7 07:25:57 INFO - PROCESS | 1664 | 07:25:57 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:29478.58 Median:377.18 stddev:75037.98 (19894.6%) stddev-sans-first:75216.61 07:25:57 INFO - PROCESS | 1664 | Values: 353.8 372.8 374.9 379.4 400.5 15266.9 15660.9 20260.7 20800.9 20804.0 20495.8 20798.7 20831.6 20839.1 20853.5 4850.9 5708.4 5840.4 6113.7 6118.1 5835.2 5927.6 5945.7 5950.6 5960.6 5765.5 5819.2 5891.6 5898.8 5923.0 5935.3 5985.6 5987.8 5990.9 5996.4 4950.6 5152.6 5191.9 5201.7 5220.8 24334.9 24474.0 24505.5 24703.5 24729.3 2221.8 2363.0 2871.5 3102.1 3223.4 14337.3 14822.7 15233.0 15587.4 15610.1 1648.7 1680.6 1833.8 1924.9 1931.1 86726.0 108789.5 112838.0 114145.0 115221.4 8317.8 9378.8 9885.7 9907.3 9994.5 12269.8 12363.3 12367.3 12378.9 12404.8 7717.9 7915.0 7986.7 8036.8 8303.8 7168.4 8516.7 8591.6 8598.4 8728.0 3826.3 3886.1 3922.2 3946.3 3988.2 1877.4 1910.4 1910.4 1910.5 1913.3 817.2 856.9 878.9 892.7 965.4 20116.8 21440.2 21460.0 21488.7 21687.7 804.5 882.6 939.6 1004.7 1069.4 7918.4 11084.7 11122.7 11183.3 11240.8 301776.0 306052.0 306105.0 567345.0 599759.0 98710.5 121049.4 136287.0 140933.0 148464.8 935.3 952.9 978.9 979.7 1017.4 18523.5 18763.9 19441.9 19449.5 19456.5 49983.5 50194.7 50831.5 51194.0 51618.7 69672.7 73326.0 75889.2 79371.6 80204.6 8005.6 8156.5 8178.5 8302.6 8433.4 12092.5 13028.8 13031.3 13521.7 13523.0 11091.8 11122.8 11492.3 11606.9 11648.4 11015.2 11402.3 11461.3 11474.9 11635.6 11335.9 11474.5 11907.7 11958.4 11965.5 6976.9 7884.6 8123.6 8446.0 8600.3 6130.9 7579.4 7968.0 8337.8 9669.6 07:25:57 INFO - PROCESS | 1664 | 07:25:57 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5643.52 Median:4845.20 stddev:3159.89 (65.2%) stddev-sans-first:3153.65 07:25:57 INFO - PROCESS | 1664 | Values: 1533.1 1565.4 1756.3 1885.7 1902.2 7514.4 8293.3 8834.0 8837.9 8854.4 7797.0 7997.2 8425.0 8629.2 8631.7 2331.9 2360.4 2362.2 2363.3 2364.8 2334.7 2343.1 2379.0 2383.2 2385.9 2351.3 2362.5 2367.0 2379.9 2393.3 2129.3 2187.5 2343.8 2352.5 2369.7 2341.0 2351.5 2353.4 2360.5 2362.1 8759.7 8822.9 8877.8 8886.1 8904.6 5147.5 5184.2 5264.4 5295.0 5320.3 3444.2 3564.3 3646.7 3649.5 3657.2 1053.4 1089.6 1092.8 1110.6 1111.2 11441.3 11544.3 11562.5 11574.6 11578.5 4447.6 4567.3 4704.3 4735.8 4739.3 9812.4 9830.6 9845.4 9849.0 9858.5 5284.2 5313.4 5319.6 5319.7 5332.9 4381.8 4527.1 4703.7 4802.3 4888.1 3356.4 3857.5 3904.7 3971.3 4004.3 1270.7 1278.6 1278.6 1283.2 1291.5 858.6 930.4 937.0 940.2 991.6 5739.5 5877.9 5897.9 5956.8 5969.1 432.4 447.7 448.5 449.7 454.5 3982.8 4007.1 4130.1 4141.8 4146.0 10007.7 10384.8 10536.8 10676.0 10685.2 10393.4 10625.6 10636.2 10662.4 10680.0 8117.9 8174.8 8272.3 8288.4 8308.0 5824.4 5913.4 5960.2 5974.9 6025.8 9994.6 10048.9 10049.9 10059.5 10073.8 9536.4 9909.9 9928.1 10121.4 10124.8 6068.2 6916.8 7115.7 7463.8 7621.6 7059.4 7842.1 7853.8 7910.4 8328.8 7160.8 7505.2 7506.2 7537.1 7603.8 7328.1 7332.2 7397.7 7455.7 7509.9 6772.0 6791.0 6904.2 6912.9 6919.1 4926.4 4972.9 4999.3 5033.4 5053.5 4609.8 4989.5 5031.6 5112.8 5139.4 07:25:57 INFO - PROCESS | 1664 | 07:25:57 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4376.08 Median:4959.94 stddev:1351.47 (27.2%) stddev-sans-first:1320.18 07:25:57 INFO - PROCESS | 1664 | Values: 299.9 301.2 313.4 315.3 318.0 4513.4 5035.8 5163.8 5289.9 5297.6 4638.0 4940.1 5103.3 5115.6 5150.7 3264.0 3942.2 3975.6 3980.9 3997.6 3691.6 3977.2 3982.3 4013.7 4015.2 3896.2 3906.4 3915.8 3923.5 3947.9 3898.5 3904.3 3924.7 3924.9 3935.1 3373.6 3381.6 3384.6 3394.7 3408.8 3705.4 4652.5 4943.4 4996.4 5000.2 3876.6 4435.9 4452.3 4464.4 4517.8 4412.1 4471.4 4509.0 5016.0 5208.9 3489.7 3739.5 3772.5 3778.6 3779.9 4097.8 4657.3 5666.4 5695.8 5714.5 2993.6 3176.4 3182.6 3796.2 3803.4 3278.5 3840.8 3841.0 3846.5 3856.7 4229.2 4401.8 4491.6 4510.8 4533.6 4748.5 5195.8 5470.8 5502.9 5523.5 1082.5 1121.0 1149.5 1231.5 1301.7 701.8 775.0 855.2 861.9 880.7 5021.4 5037.0 5052.6 5072.0 5116.4 5336.6 5446.3 5544.9 5556.4 5600.8 4979.5 4983.9 4995.2 5002.5 5037.9 2550.4 2862.7 2904.5 2916.0 2925.6 4719.3 5094.9 5441.7 5669.6 5744.7 4960.5 5401.1 5621.4 5623.4 5652.6 5187.6 5322.1 5688.4 5694.0 5696.5 4626.9 5218.3 5334.3 5712.7 5829.8 4584.4 4718.6 5619.2 5651.3 5654.4 5471.9 5901.0 5926.2 5929.9 5986.8 3852.0 3941.7 3966.6 3968.4 3996.9 5028.4 5386.4 5615.6 5636.3 5644.8 5240.8 5508.8 5513.0 5559.2 5568.6 4039.9 4602.7 5328.6 5379.2 5476.2 4959.4 5154.4 5170.4 5189.2 5327.0 4621.5 5499.1 5512.8 5516.3 5557.4 4613.3 5417.9 5421.8 5421.8 5436.3 07:25:57 INFO - PROCESS | 1664 | 07:25:57 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:25859.31 Median:3713.59 stddev:41777.64 (1125.0%) stddev-sans-first:41852.34 07:25:57 INFO - PROCESS | 1664 | Values: 763.5 782.8 791.0 823.7 824.2 15132.8 16318.0 16346.5 16352.8 16355.1 14712.7 14860.4 14869.8 14883.0 14885.1 702.0 858.8 872.0 890.4 893.1 885.2 887.7 889.8 889.9 890.8 936.3 936.4 938.2 939.7 940.9 718.1 878.8 899.9 913.8 924.6 688.3 688.4 688.8 689.3 693.2 14883.6 14888.1 14889.9 14895.0 14898.6 14071.2 14289.1 14301.4 14305.0 14659.0 13051.0 13263.0 13305.9 13544.5 13634.2 4546.3 4620.5 4799.2 4850.2 4855.9 117592.8 120313.4 120778.3 121011.0 121400.4 10947.4 11244.5 11294.3 11332.8 11590.5 20306.0 21051.8 21090.7 22853.9 22922.3 8126.3 8162.1 8207.4 8413.8 8468.2 4381.7 4398.1 4457.3 4460.4 4462.8 3663.8 3763.4 3799.0 3806.2 3807.0 552.4 674.4 674.9 684.1 699.6 595.6 648.0 653.9 680.4 685.4 9066.5 9427.4 9524.3 9561.0 9634.6 591.3 597.2 687.6 696.3 709.8 4353.3 4638.8 4668.9 4681.6 4776.6 152774.0 162712.4 168016.0 168175.0 176020.0 115003.0 117191.4 117815.0 132251.3 146764.0 107378.0 111916.9 112017.4 112350.0 116615.0 9335.2 9895.7 9921.3 9944.3 9961.3 52202.0 64056.9 64838.1 65527.0 66426.3 80483.0 92838.0 97746.0 99597.5 99911.5 13072.3 13157.6 13410.3 13695.9 13816.4 14856.4 14896.1 14982.4 15018.2 15027.3 13681.9 13845.6 13875.3 14048.6 14549.7 13686.2 13720.5 13751.0 13947.9 14299.4 13105.7 13121.7 13679.7 13682.3 13734.7 10749.6 11359.3 11398.2 11436.0 11698.6 10178.3 10291.9 11354.7 11592.6 11609.8 07:25:57 INFO - PROCESS | 1664 | -------- Summary: end -------- 07:25:57 INFO - PROCESS | 1664 | 07:25:58 INFO - TEST-INFO | 1664: exit 0 07:25:58 INFO - TEST-OK | dromaeo_css | took 1117755ms 07:25:58 INFO - TEST-START | kraken 07:25:58 INFO - operating with platform_type : mac_ 07:25:58 INFO - Initialising browser for kraken test... 07:25:58 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpI0Uu4M/profile http://localhost:49274/getInfo.html) 07:26:00 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 07:26:00 INFO - PROCESS | 1671 | colorDepth:24 07:26:00 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 07:26:00 INFO - PROCESS | 1671 | __metrics 07:26:00 INFO - PROCESS | 1671 | 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" 07:26:00 INFO - PROCESS | 1671 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:26:01 INFO - TEST-INFO | 1671: exit 0 07:26:01 INFO - Browser initialized. 07:26:01 INFO - Running cycle 1/1 for kraken test... 07:26:01 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpI0Uu4M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:13 INFO - PROCESS | 1672 | RSS: Main: 244715520 07:26:13 INFO - PROCESS | 1672 | 07:26:16 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 07:26:17 INFO - PROCESS | 1672 | RSS: Main: 293752832 07:26:17 INFO - PROCESS | 1672 | 07:26:19 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 07:26:20 INFO - PROCESS | 1672 | RSS: Main: 304123904 07:26:20 INFO - PROCESS | 1672 | 07:26:24 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 07:26:24 INFO - PROCESS | 1672 | RSS: Main: 398553088 07:26:24 INFO - PROCESS | 1672 | 07:26:26 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 07:26:27 INFO - PROCESS | 1672 | RSS: Main: 298545152 07:26:27 INFO - PROCESS | 1672 | 07:26:29 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:26:30 INFO - PROCESS | 1672 | RSS: Main: 302247936 07:26:30 INFO - PROCESS | 1672 | 07:26:32 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 07:26:33 INFO - PROCESS | 1672 | RSS: Main: 340086784 07:26:33 INFO - PROCESS | 1672 | 07:26:36 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 07:26:37 INFO - PROCESS | 1672 | RSS: Main: 342646784 07:26:37 INFO - PROCESS | 1672 | 07:26:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 07:26:40 INFO - PROCESS | 1672 | RSS: Main: 342016000 07:26:40 INFO - PROCESS | 1672 | 07:26:41 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:42 INFO - PROCESS | 1672 | RSS: Main: 314982400 07:26:42 INFO - PROCESS | 1672 | 07:26:44 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:45 INFO - PROCESS | 1672 | RSS: Main: 320958464 07:26:45 INFO - PROCESS | 1672 | 07:26:47 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:48 INFO - PROCESS | 1672 | RSS: Main: 324550656 07:26:48 INFO - PROCESS | 1672 | 07:26:50 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:51 INFO - PROCESS | 1672 | RSS: Main: 330338304 07:26:51 INFO - PROCESS | 1672 | 07:26:54 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:55 INFO - PROCESS | 1672 | RSS: Main: 331755520 07:26:55 INFO - PROCESS | 1672 | 07:26:56 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 07:26:57 INFO - PROCESS | 1672 | RSS: Main: 374996992 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | __start_tp_report 07:26:57 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 07:26:57 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 07:26:57 INFO - PROCESS | 1672 | |i|pagename|runs| 07:26:57 INFO - PROCESS | 1672 | |0;ai-astar;101;114;113;112;112;112;113;114;112;112 07:26:57 INFO - PROCESS | 1672 | |1;audio-beat-detection;146;112;138;203;105;128;126;106;157;107 07:26:57 INFO - PROCESS | 1672 | |2;audio-dft;252;256;183;186;183;182;176;192;182;183 07:26:57 INFO - PROCESS | 1672 | |3;audio-fft;76;74;88;110;58;58;65;57;97;58 07:26:57 INFO - PROCESS | 1672 | |4;audio-oscillator;81;69;100;71;71;68;96;70;67;102 07:26:57 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;86;85;134;123;86;83;123;76;95;124 07:26:57 INFO - PROCESS | 1672 | |6;imaging-darkroom;92;92;93;92;92;92;92;92;92;92 07:26:57 INFO - PROCESS | 1672 | |7;imaging-desaturate;86;86;85;85;84;83;79;85;80;83 07:26:57 INFO - PROCESS | 1672 | |8;json-parse-financial;56;55;55;54;53;55;52;52;55;55 07:26:57 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;66;67;77;78;72;70;71;71;70;73 07:26:57 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;83;85;85;86;85;82;83;87;83;82 07:26:57 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;139;136;139;136;135;141;129;136;153;138 07:26:57 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;165;165;169;219;195;170;165;163;160;163 07:26:57 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;58;82;91;68;61;64;82;83;77;65 07:26:57 INFO - PROCESS | 1672 | __end_tp_report 07:26:57 INFO - PROCESS | 1672 | __start_cc_report 07:26:57 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,2080 07:26:57 INFO - PROCESS | 1672 | __end_cc_report 07:26:57 INFO - PROCESS | 1672 | __startTimestamp1470752817121__endTimestamp 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | ------- Summary: start ------- 07:26:57 INFO - PROCESS | 1672 | Number of tests: 14 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:3.78 (3.4%) stddev-sans-first:0.87 07:26:57 INFO - PROCESS | 1672 | Values: 101.0 114.0 113.0 112.0 112.0 112.0 113.0 114.0 112.0 112.0 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:133.00 stddev:30.50 (22.9%) stddev-sans-first:31.98 07:26:57 INFO - PROCESS | 1672 | Values: 146.0 112.0 138.0 203.0 105.0 128.0 126.0 106.0 157.0 107.0 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:197.50 Median:184.50 stddev:30.05 (16.3%) stddev-sans-first:24.57 07:26:57 INFO - PROCESS | 1672 | Values: 252.0 256.0 183.0 186.0 183.0 182.0 176.0 192.0 182.0 183.0 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:74.10 Median:69.50 stddev:18.75 (27.0%) stddev-sans-first:19.87 07:26:57 INFO - PROCESS | 1672 | Values: 76.0 74.0 88.0 110.0 58.0 58.0 65.0 57.0 97.0 58.0 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:70.50 stddev:14.28 (20.3%) stddev-sans-first:15.13 07:26:57 INFO - PROCESS | 1672 | Values: 81.0 69.0 100.0 71.0 71.0 68.0 96.0 70.0 67.0 102.0 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:101.50 Median:84.00 stddev:21.79 (25.9%) stddev-sans-first:22.38 07:26:57 INFO - PROCESS | 1672 | Values: 86.0 85.0 134.0 123.0 86.0 83.0 123.0 76.0 95.0 124.0 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:92.10 Median:92.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:26:57 INFO - PROCESS | 1672 | Values: 92.0 92.0 93.0 92.0 92.0 92.0 92.0 92.0 92.0 92.0 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:83.60 Median:85.00 stddev:2.41 (2.8%) stddev-sans-first:2.40 07:26:57 INFO - PROCESS | 1672 | Values: 86.0 86.0 85.0 85.0 84.0 83.0 79.0 85.0 80.0 83.0 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:1.40 (2.5%) stddev-sans-first:1.32 07:26:57 INFO - PROCESS | 1672 | Values: 56.0 55.0 55.0 54.0 53.0 55.0 52.0 52.0 55.0 55.0 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.50 stddev:3.81 (5.3%) stddev-sans-first:3.48 07:26:57 INFO - PROCESS | 1672 | Values: 66.0 67.0 77.0 78.0 72.0 70.0 71.0 71.0 70.0 73.0 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:85.00 stddev:1.73 (2.0%) stddev-sans-first:1.79 07:26:57 INFO - PROCESS | 1672 | Values: 83.0 85.0 85.0 86.0 85.0 82.0 83.0 87.0 83.0 82.0 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:138.50 stddev:6.12 (4.4%) stddev-sans-first:6.49 07:26:57 INFO - PROCESS | 1672 | Values: 139.0 136.0 139.0 136.0 135.0 141.0 129.0 136.0 153.0 138.0 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:167.00 stddev:18.81 (11.3%) stddev-sans-first:19.70 07:26:57 INFO - PROCESS | 1672 | Values: 165.0 165.0 169.0 219.0 195.0 170.0 165.0 163.0 160.0 163.0 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:79.50 stddev:11.26 (14.2%) stddev-sans-first:10.53 07:26:57 INFO - PROCESS | 1672 | Values: 58.0 82.0 91.0 68.0 61.0 64.0 82.0 83.0 77.0 65.0 07:26:57 INFO - PROCESS | 1672 | -------- Summary: end -------- 07:26:57 INFO - PROCESS | 1672 | 07:26:57 INFO - TEST-INFO | 1672: exit 0 07:26:57 INFO - TEST-OK | kraken | took 59774ms 07:26:57 INFO - SUITE-END | took 1177s 07:26:58 INFO - Completed test suite (00:19:37) 07:26:58 INFO - javascript benchmark 07:26:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3355.530225768393, 3390.2541440882997, 3418.675225853543, 3421.144713821544, 3456.222349971257, 5667.659940403579, 5726.0, 5779.797707080253, 5805.941940580593, 5819.418058194178, 5748.511376532989, 5754.510866576346, 5867.55993300502, 5881.558883083764, 5932.3474417814, 5179.896402071956, 5246.554042906358, 5263.105272103732, 5266.104762190437, 5296.523312901838, 5356.330458692663, 5371.140617501201, 5380.21986811912, 5382.91925621116, 5421.1326187809955, 5203.505666961632, 5253.4221235664045, 5259.684418934838, 5293.761780719877, 5303.310569625944, 5292.497212764782, 5305.973470132663, 5306.416294207634, 5310.20346947957, 5323.813666521692, 5181.844544663666, 5206.193040078794, 5213.165893457029, 5226.05930932432, 5287.524122828964, 5734.913976290359, 5809.622374545684, 5819.156222347779, 5871.266091738533, 5904.996150654399, 6152.2002139722, 6258.843528911768, 6285.779997700059, 6316.431521163117, 6322.304546499881, 6243.843903902393, 6263.060540918853, 6279.183706118175, 6293.087502312139, 6314.368563143649, 5961.225040744675, 5980.641161530322, 5988.071848863433, 5994.910076348859, 6001.399860013964, 6315.778947736899, 6321.936780632135, 6336.398042185985, 6343.016832390987, 6344.270408902943, 6068.760084398659, 6077.696115194222, 6121.727351053096, 6139.259792094406, 6268.749250029948, 6257.4994000480765, 6268.529860260499, 6277.1525844010475, 6285.43431091204, 6294.244690637152, 6083.0, 6213.65824879636, 6239.126522286883, 6241.96879015602, 6254.3745625437095, 6145.310039739018, 6207.975684012178, 6252.968735156386, 6265.8120256392385, 6285.685715714196, 5036.093503169464, 5048.116579598555, 5048.167052436307, 5057.291979122926, 5100.438951715309, 4485.48416932057, 4489.191945449785, 4499.820007199741, 4538.137753826828, 4555.908881822345, 5630.915536266959, 5675.205471233948, 5696.515796157373, 5757.8560535986935, 5788.957987562279, 6207.317195108534, 6211.751529938751, 6276.309605943343, 6285.497160227171, 6299.433051025429, 5709.600327977002, 5768.7692492300675, 5783.768649254067, 5784.913226301609, 5829.038208695518, 5531.668099914018, 5533.03171944908, 5533.280673512418, 5534.916976245359, 5540.972295138498, 6198.907016394667, 6222.315545289924, 6268.028455589391, 6295.401936815995, 6422.775202867877, 6257.655828929453, 6274.278457977391, 6277.30949595535, 6287.088372186099, 6288.245410550763, 6382.170317858649, 6384.776532821329, 6394.616323020634, 6402.647854368054, 6440.162778838721, 6149.446549810538, 6192.2569291683485, 6205.193324867739, 6225.62646241227, 6266.937330626818, 6257.7184026719815, 6303.527235457451, 6306.621602703853, 6308.558400911892, 6310.305866354789, 5255.004766444342, 6239.688015599293, 6240.719167637558, 6249.468795152281, 6250.4374606285655, 6077.696115194134, 6104.095385180791, 6157.0456579230295, 6159.6612186330185, 6207.6585787782105, 6113.050656958906, 6122.877542449215, 6134.141220229082, 6145.35473775265, 6148.323684394623, 6182.319944806158, 6189.566730329014, 6238.344973777688, 6261.217347831521, 6264.9976003839165, 5106.0, 5946.910796338145, 5986.55100867428, 6015.548833837567, 6022.427869352405], "value": 5767.686565182367, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.57317986991586, 517.0795983149994, 523.2831021500543, 541.9620626556143, 551.7296524702896, 31036.0, 31340.373192536135, 32629.51055734166, 40467.392989105116, 41840.0, 43215.78392108043, 43584.128317433635, 43707.0, 43734.343984840256, 43745.906352341204, 9565.521723913795, 9729.610815567368, 9747.220222382193, 9749.756256093584, 9750.512474376288, 8725.0, 8915.68795092172, 9555.0, 11819.586314478995, 11966.940165299206, 11930.701732456671, 11988.0, 12002.159848810543, 12006.979406750394, 12027.278363298186, 11886.346250956194, 11969.222000569935, 11973.521059157623, 11973.640790776291, 11990.280583165038, 11845.348505832177, 11910.642680719593, 11915.523379064827, 11934.462949167308, 11961.684214736371, 40292.39561406552, 40530.79734601337, 40662.18675626501, 40731.0, 40731.38902916429, 3696.2792255510185, 3754.1928485375774, 3936.0478946951175, 4130.421740956269, 4311.094670119279, 31857.0, 32363.0, 33066.338673226404, 33150.17124571881, 33229.0, 3250.707436330718, 3278.6885245901603, 3338.88313909012, 3377.4427219508752, 3404.0, 423792.0, 522797.3860130713, 523532.0, 524898.0, 525390.0, 61279.38720612826, 61560.0, 61599.38400616026, 61602.69198653978, 61612.0, 63951.04073438902, 64107.03839442412, 64133.0, 64179.67910160513, 64312.03531947025, 16567.91716041412, 16777.580560486087, 16786.580335491468, 16808.0, 16809.663806724042, 12851.742965140646, 12892.742145157044, 12895.484180632857, 12909.677258068623, 12958.22250664963, 13799.2410417428, 14873.628159296104, 15266.923665381602, 16567.66864662724, 16949.0, 5457.836264912059, 5474.753636086386, 6448.161738973997, 6522.543421960418, 6533.150690410216, 897.8877640294963, 933.5332333833084, 985.6451677396132, 1008.4302369161547, 1048.2086025051037, 29821.85089074541, 29980.250493737833, 30306.242343941576, 30658.69341306603, 30685.69314306873, 921.7925966657449, 1088.3905013192636, 1125.6285425809463, 1138.5787258714329, 1138.8213199338645, 14002.299885005708, 15718.371265149495, 15762.605934851492, 15861.841381586268, 15896.364145434285, 592678.0, 650564.0, 662729.0, 665890.0, 669275.0, 52439.0, 53369.733151334774, 59243.0, 59726.104108438405, 59959.40040599538, 1366.8496465388798, 1387.6877702517054, 1420.0201860716072, 1424.7008128293176, 1424.9358778854976, 30734.846325768227, 31400.685993139778, 31971.282440992774, 32342.8679996199, 32429.513557296188, 52060.73969630127, 52414.737926310125, 52560.21159682531, 52623.47376526186, 52764.736176318875, 610042.0, 613286.0, 613491.5952521431, 613559.0, 613752.931235341, 26632.33419164459, 27511.899524018816, 27533.586996194674, 28274.86900523956, 41152.38271425871, 48348.75825620849, 48763.02473950572, 49208.753956229986, 49615.50384496109, 50085.74957125191, 33982.66017339894, 36499.0, 39691.00772480711, 39947.40078898761, 41248.762537123934, 39400.802995984835, 39581.40627890641, 39733.80133099316, 40707.38938915859, 41071.0, 37951.0, 38043.23913521769, 38209.4268585977, 38735.0, 38933.415998759476, 31617.0, 34531.4820277691, 34800.777938463274, 35165.82417087898, 35283.0, 25478.23565293044, 25534.23397298084, 25775.6133657999, 26082.73917260803, 26241.737582624693], "value": 20597.10340922579, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.8177838413216, 372.83781555023586, 374.94750734897116, 379.40812332760896, 400.5313782874037, 15266.923665381672, 15660.903736738434, 20260.696089558667, 20800.89599552, 20803.95980200988, 20495.795042049576, 20798.688019679717, 20831.583368332624, 20839.0622421991, 20853.47866303343, 4850.9029819403595, 5708.372079071299, 5840.3575606683235, 6113.724882380281, 6118.1434599156155, 5835.183074369592, 5927.555433342495, 5945.702714864239, 5950.55370847186, 5960.582759206857, 5765.538756899459, 5819.243498345209, 5891.617044892089, 5898.7640494380175, 5922.97038514809, 5935.347111817697, 5985.6109352892145, 5987.790427335022, 5990.861736270094, 5996.430339117776, 4950.554450099472, 5152.562032227265, 5191.870203244949, 5201.739913004335, 5220.791168353261, 24334.904929278226, 24474.0, 24505.509889802102, 24703.50592988148, 24729.25812225636, 2221.8111460525874, 2362.9527409451885, 2871.540553511449, 3102.115896969353, 3223.4197844388, 14337.283135843167, 14822.703545929022, 15233.0, 15587.376504939788, 15610.141442220673, 1648.7032334179844, 1680.6302613425028, 1833.7982821889582, 1924.9037548122537, 1931.0730849192466, 86726.0, 108789.45605271924, 112838.0, 114145.0, 115221.42389288083, 8317.8336433271, 9378.765530861647, 9885.703428897144, 9907.306488545733, 9994.450305233282, 12269.754604907852, 12363.32001739895, 12367.319797411228, 12378.938105309597, 12404.75190496185, 7717.884231736529, 7915.047402163488, 7986.680532778624, 8036.758897233092, 8303.750887473385, 7168.354848063699, 8516.74449766508, 8591.613377398033, 8598.398112132216, 8728.0, 3826.323199873108, 3886.067343837515, 3922.2155568886337, 3946.2502124596235, 3988.1824226034173, 1877.3898482992809, 1910.3504808364944, 1910.3982245592595, 1910.503269150031, 1913.3494611832043, 817.2481317188201, 856.9185927336893, 878.8549889268199, 892.7327375146808, 965.4014511003082, 20116.798832011784, 21440.24959126423, 21460.0, 21488.677669834964, 21687.67468487974, 804.4650307545417, 882.580774132282, 939.5818860607101, 1004.6584161385164, 1069.4492336446735, 7918.406119541058, 11084.667459976214, 11122.721931951766, 11183.273087249303, 11240.831387529193, 301776.0, 306052.0, 306105.0, 567345.0, 599759.0, 98710.5064474673, 121049.39475302567, 136286.95569566466, 140933.0, 148464.77302840466, 935.3312381647019, 952.9332946693803, 978.9363691360039, 979.7452662307709, 1017.4353233955226, 18523.536911577317, 18763.90618046901, 19441.902790485958, 19449.51376215606, 19456.513587160433, 49983.50016499789, 50194.749026254634, 50831.49168508268, 51194.0, 51618.74190629173, 69672.65163674149, 73326.0, 75889.24110758821, 79371.60314198393, 80204.59897700707, 8005.559694216874, 8156.469829461066, 8178.5092894426525, 8302.584870756316, 8433.409661323649, 12092.45583948742, 13028.804567931678, 13031.348432578523, 13521.729565408834, 13523.0, 11091.778164436828, 11122.777544449227, 11492.310461372344, 11606.941965290458, 11648.359340236368, 11015.228933974866, 11402.315861048364, 11461.255018423775, 11474.885251147381, 11635.5927542539, 11335.923087306694, 11474.483648235682, 11907.702307442383, 11958.402079895797, 11965.521379144737, 6976.883698608199, 7884.566348850868, 8123.634436450492, 8445.986481622245, 8600.311975041857, 6130.938690613215, 7579.393648508217, 7967.960160199162, 8337.83324333522, 9669.613215471303], "value": 9308.893788218042, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1533.1491022482521, 1565.389498095743, 1756.2974810075968, 1885.6700077486437, 1902.2010755482688, 7514.4364172687065, 8293.253607175353, 8833.984091829441, 8837.91162088378, 8854.42446240994, 7796.961015194916, 7997.240262175099, 8425.0, 8629.180227878358, 8631.74104776856, 2331.941701457464, 2360.3745007573007, 2362.196853069956, 2363.314638754759, 2364.84628499147, 2334.673145759595, 2343.144752165456, 2378.9762102379013, 2383.2135395319588, 2385.9284221473386, 2351.341624345186, 2362.492064206195, 2366.9763302367014, 2379.916702915398, 2393.3059412770276, 2129.2547608337113, 2187.50781074257, 2343.800776933963, 2352.517733864562, 2369.7393286738443, 2340.9648855267014, 2351.4709190432186, 2353.423411264234, 2360.516094200702, 2362.11420717231, 8759.693410730657, 8822.911770882338, 8877.778055548599, 8886.111388861127, 8904.643814247422, 5147.485251474823, 5184.222366645034, 5264.394594621629, 5295.0468915595175, 5320.281761962125, 3444.2078321986082, 3564.322778672044, 3646.6717995380545, 3649.4525821127045, 3657.1954170082804, 1053.3890343600692, 1089.5587287148637, 1092.7541303206795, 1110.5835311758092, 1111.2054880760215, 11441.256318339281, 11544.307341559534, 11562.53749850005, 11574.594889178838, 11578.536858525733, 4447.6219521341045, 4567.314902764546, 4704.317873908264, 4735.8342458014495, 4739.336492890929, 9812.362196457207, 9830.606775728891, 9845.409275443497, 9849.015098490094, 9858.507074646239, 5284.154535274338, 5313.388960269541, 5319.5744340452675, 5319.6808191508635, 5332.893342133136, 4381.824727010884, 4527.09458108373, 4703.741294228782, 4802.255650374128, 4888.144574699413, 3356.3790698720813, 3857.5370955485523, 3904.72666913319, 3971.285168669667, 4004.2592120457807, 1270.6632742323293, 1278.5525066226746, 1278.5652878021517, 1283.2492991599831, 1291.4575878131207, 858.6479543387181, 930.3952430919821, 936.9995060545784, 940.1679513630486, 991.6231831903831, 5739.483446489752, 5877.853053673607, 5897.882042359129, 5956.821295361146, 5969.074793407029, 432.3968064549935, 447.66872514339804, 448.54696756276394, 449.68522034575926, 454.5272916167215, 3982.820773065161, 4007.0583412897945, 4130.070734084807, 4141.772202528829, 4146.004958809864, 10007.699769006796, 10384.792304153874, 10536.789264214673, 10676.0, 10685.198610104273, 10393.428361440194, 10625.628103016357, 10636.202284828514, 10662.41356725372, 10679.985401386855, 8117.878231826528, 8174.836503269901, 8272.33821294307, 8288.378371622153, 8308.003039635283, 5824.446677565625, 5913.438223368773, 5960.165576819336, 5974.850628734316, 6025.849353766191, 9994.550245238835, 10048.949755251177, 10049.949750251202, 10059.49702514886, 10073.848892266475, 9536.380135291183, 9909.851352229867, 9928.106470417697, 10121.443320617142, 10124.848127278245, 6068.21113255274, 6916.757913473004, 7115.715371385087, 7463.776086717407, 7621.618919054136, 7059.364657180673, 7842.058952925686, 7853.764387068397, 7910.446268761361, 8328.791780205544, 7160.785176444715, 7505.211952744883, 7506.174320824595, 7537.095548534211, 7603.809904752205, 7328.083989501312, 7332.193458719643, 7397.667104980181, 7455.701771929279, 7509.887351689838, 6771.966140169267, 6791.0, 6904.240533541407, 6912.93087069143, 6919.065926099912, 4926.359573255454, 4972.8508144755715, 4999.300097986212, 5033.370828646419, 5053.519915608012, 4609.769511524478, 4989.476105008922, 5031.597472202142, 5112.846614601568, 5139.408967968731], "value": 4480.281765525578, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.8965356951852, 301.24387786655495, 313.3716897620271, 315.27486780405064, 317.98887038953643, 4513.435820522434, 5035.823746168876, 5163.812323165675, 5289.936924599409, 5297.563120964356, 4638.028837743954, 4940.086084074449, 5103.260027296049, 5115.616328775338, 5150.69095854249, 3264.0, 3942.231264903338, 3975.6223158799867, 3980.8606698765548, 3997.560268370477, 3691.563568045091, 3977.164795392971, 3982.283189025974, 4013.7190396672245, 4015.19696060789, 3896.2207558488276, 3906.448986930223, 3915.8237879295357, 3923.470331505253, 3947.8815635530837, 3898.4542164097047, 3904.3362628353248, 3924.725269231141, 3924.862629807943, 3935.05558665921, 3373.5951685797863, 3381.611114721814, 3384.5769278840144, 3394.7114495267933, 3408.7954722716718, 3705.40713485841, 4652.5114862939245, 4943.431505376891, 4996.378350026212, 5000.249962505617, 3876.612338766129, 4435.866923992286, 4452.28763397858, 4464.374987501752, 4517.841875534374, 4412.146898302689, 4471.39636149119, 4508.977455112737, 5015.974920125413, 5208.869778255536, 3489.685928266468, 3739.5325584301963, 3772.5095737554216, 3778.5843557208686, 3779.8677046303246, 4097.7541347519245, 4657.254839225708, 5666.385080252149, 5695.77216911323, 5714.485696287313, 2993.6407631084408, 3176.428242916251, 3182.602174728159, 3796.1648437343742, 3803.372443546784, 3278.49183376577, 3840.7887566184127, 3841.0013396516547, 3846.538415390171, 3856.6721828644318, 4229.217594744982, 4401.757903315284, 4491.573300536444, 4510.774461276923, 4533.591976722045, 4748.501407352178, 5195.818146364934, 5470.769076957653, 5502.862428439321, 5523.530499907552, 1082.53992053377, 1120.9775804484027, 1149.5172027748365, 1231.5258625429094, 1301.7243101760328, 701.7614011236102, 774.9845003099906, 855.2431098477767, 861.9310455163571, 880.700561808988, 5021.422536408287, 5037.042961837239, 5052.621053421009, 5071.96024814912, 5116.386033675908, 5336.573074154058, 5446.311643390562, 5544.944550554524, 5556.416576259516, 5600.803971860965, 4979.502049794992, 4983.90032199354, 4995.175795993693, 5002.549770520671, 5037.916847877651, 2550.4006558458746, 2862.685104638488, 2904.5062339402352, 2915.9854200729283, 2925.6196694429586, 4719.33357652925, 5094.949050509522, 5441.673499589958, 5669.631473954262, 5744.684042377626, 4960.528749768766, 5401.109611635975, 5621.381648018714, 5623.409541998113, 5652.63257888236, 5187.636865419385, 5322.14845624706, 5688.431156884196, 5694.003549378842, 5696.487316141567, 4626.884327891695, 5218.269442278008, 5334.333208348957, 5712.685802280915, 5829.793613512636, 4584.449866015966, 4718.575328220477, 5619.185218143428, 5651.321841379061, 5654.378018417889, 5471.863203419787, 5900.970495147497, 5926.1999630049395, 5929.911051334319, 5986.820395388146, 3852.016211651058, 3941.6846652267177, 3966.643002129822, 3968.3849003404516, 3996.86010989614, 5028.396592408934, 5386.353637563518, 5615.550755939434, 5636.323641163087, 5644.8024319148635, 5240.829298274489, 5508.834734957958, 5513.0, 5559.19391688211, 5568.582356323211, 4039.8788036358956, 4602.650495281927, 5328.57371410294, 5379.246905433164, 5476.233327334096, 4959.355283813081, 5154.433012368561, 5170.405403378509, 5189.223765285554, 5327.0, 4621.491635919979, 5499.120140777456, 5512.80705175317, 5516.3380394352935, 5557.388687244481, 4613.270023741097, 5417.918731218956, 5421.783128674809, 5421.810236641699, 5436.287569415622], "value": 3943.4770188352645, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.496092578898, 782.8311568779783, 790.9525428474292, 823.6993497373459, 824.2416976381728, 15132.848671513295, 16318.0, 16346.509604711862, 16352.83647163531, 16355.100469474175, 14712.705745885076, 14860.405583776635, 14869.776953345709, 14883.0, 14885.106893586366, 701.9649017549127, 858.772425307291, 872.0, 890.3500444675391, 893.1158153428092, 885.1679421343948, 887.7159309021116, 889.8264838356523, 889.9021107678183, 890.768400215942, 936.3492372800906, 936.4053825820619, 938.2306508662865, 939.7227817793733, 940.8588711693267, 718.1274751177344, 878.7846977490556, 899.9100089991014, 913.8172365526921, 924.6440120553601, 688.2738710660251, 688.4148473797283, 688.7830333444949, 689.334791925794, 693.19935474527, 14883.627909302246, 14888.106713597219, 14889.925550372178, 14895.031822931584, 14898.553043408716, 14071.226082565454, 14289.142651440843, 14301.427942882272, 14305.0, 14659.047161934546, 13051.0, 13263.005274604444, 13305.866941330656, 13544.525941591997, 13634.181949083088, 4546.340780586829, 4620.514845941161, 4799.18413869643, 4850.151223535867, 4855.902881942341, 117592.82407175904, 120313.39843300727, 120778.29882115357, 121011.0, 121400.39299803533, 10947.418733289802, 11244.49399777012, 11294.265872718248, 11332.773344533063, 11590.478428470738, 20306.0, 21051.78948210498, 21090.683639745417, 22853.857307134578, 22922.31233063011, 8126.309263712533, 8162.061362943219, 8207.425480216447, 8413.831723365498, 8468.237858592633, 4381.737095774264, 4398.118218075879, 4457.331400289982, 4460.442444694413, 4462.754548499864, 3663.7618554793853, 3763.41667041609, 3799.031247031989, 3806.1816709407058, 3806.980965095157, 552.4282367749361, 674.430106559956, 674.8684006618662, 684.1209046375483, 699.566268913277, 595.6128516464246, 647.9805605831832, 653.9444147247442, 680.4284401103097, 685.3576401576121, 9066.546672666473, 9427.434353938786, 9524.285678574135, 9560.952195238979, 9634.566444510014, 591.2845456997081, 597.2206270816627, 687.6149356360454, 696.2914263514931, 709.8260926073145, 4353.325234588644, 4638.79125439356, 4668.929966050512, 4681.555252251031, 4776.59398951093, 152774.0, 162712.3728762721, 168016.0, 168175.0, 176020.0, 115003.0, 117191.41404292925, 117815.0, 132251.33874330568, 146764.0, 107378.0, 111916.88083119228, 112017.43991280155, 112350.0, 116615.0, 9335.159835614828, 9895.656684556072, 9921.305508614616, 9944.254180936603, 9961.302708810314, 52201.95596088133, 64056.85448953492, 64838.10971341735, 65527.0, 66426.33573664201, 80483.0, 92838.0, 97746.0, 99597.50603741095, 99911.50044249732, 13072.281024543741, 13157.60527184186, 13410.32948352598, 13695.931520342334, 13816.447342106203, 14856.405743770129, 14896.061840593215, 14982.40070397172, 15018.174000430081, 15027.323770430137, 13681.863181368457, 13845.584632461043, 13875.306234688023, 14048.578542643738, 14549.709005819612, 13686.178829270275, 13720.519781807589, 13751.0, 13947.860521394656, 14299.428022878968, 13105.737885242432, 13121.73756524845, 13679.726405471636, 13682.31588420595, 13734.725305494034, 10749.62376316825, 11359.261647992855, 11398.20212585111, 11436.027937625395, 11698.575799555552, 10178.287519873538, 10291.94854025725, 11354.716132096764, 11592.594259200887, 11609.767804644029], "value": 8087.933873268543, "unit": "score"}], "name": "dromaeo_css", "value": 7352.972107505414, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 114.0, 113.0, 112.0, 112.0, 112.0, 113.0, 114.0, 112.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 112.0, 138.0, 203.0, 105.0, 128.0, 126.0, 106.0, 157.0, 107.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [252.0, 256.0, 183.0, 186.0, 183.0, 182.0, 176.0, 192.0, 182.0, 183.0], "value": 197.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 88.0, 110.0, 58.0, 58.0, 65.0, 57.0, 97.0, 58.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 69.0, 100.0, 71.0, 71.0, 68.0, 96.0, 70.0, 67.0, 102.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 134.0, 123.0, 86.0, 83.0, 123.0, 76.0, 95.0, 124.0], "value": 101.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 92.0, 92.0, 92.0, 92.0, 92.0, 92.0, 92.0], "value": 92.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 85.0, 84.0, 83.0, 79.0, 85.0, 80.0, 83.0], "value": 83.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 54.0, 53.0, 55.0, 52.0, 52.0, 55.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 77.0, 78.0, 72.0, 70.0, 71.0, 71.0, 70.0, 73.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 85.0, 86.0, 85.0, 82.0, 83.0, 87.0, 83.0, 82.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 139.0, 136.0, 135.0, 141.0, 129.0, 136.0, 153.0, 138.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 169.0, 219.0, 195.0, 170.0, 165.0, 163.0, 160.0, 163.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 82.0, 91.0, 68.0, 61.0, 64.0, 82.0, 83.0, 77.0, 65.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1467.1000000000001, "alertThreshold": 2.0}]} 07:26:58 INFO - Return code: 0 07:26:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:26:58 INFO - # TBPL SUCCESS # 07:26:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:26:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:26:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:26:58 INFO - 2016-08-09 07:26:58.446 screenresolution[1676:10913] starting screenresolution argv=screenresolution get 07:26:58 INFO - 2016-08-09 07:26:58.449 screenresolution[1676:10913] Display 0: 1600x1200x32@60 07:26:58 INFO - 2016-08-09 07:26:58.455 screenresolution[1677:10916] starting screenresolution argv=screenresolution list 07:26:58 INFO - Available Modes on Display 0 07:26:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:26:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:26:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:26:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:26:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:26:58 INFO - Intel Iris: 07:26:58 INFO - Chipset Model: Intel Iris 07:26:58 INFO - Type: GPU 07:26:58 INFO - Bus: Built-In 07:26:58 INFO - VRAM (Dynamic, Max): 1536 MB 07:26:58 INFO - Vendor: Intel (0x8086) 07:26:58 INFO - Device ID: 0x0a2e 07:26:58 INFO - Revision ID: 0x0009 07:26:58 INFO - Displays: 07:26:58 INFO - Display: 07:26:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:26:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:26:58 INFO - Display Serial Number: 1600x1200 60 07:26:58 INFO - Main Display: Yes 07:26:58 INFO - Mirror: Off 07:26:58 INFO - Online: Yes 07:26:58 INFO - Rotation: Supported 07:26:58 INFO - Return code: 0 07:26:58 INFO - Running post-action listener: _resource_record_post_action 07:26:58 INFO - [mozharness: 2016-08-09 14:26:58.689724Z] Finished run-tests step (success) 07:26:58 INFO - Running post-run listener: _resource_record_post_run 07:26:58 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 33205248; Write bytes: 707998208; Read time: 319; Write time: 2095 07:26:58 INFO - TinderboxPrint: CPU usage
53.2% 07:26:58 INFO - TinderboxPrint: I/O read bytes / time
33,205,248 / 319 07:26:58 INFO - TinderboxPrint: I/O write bytes / time
707,998,208 / 2,095 07:26:58 INFO - TinderboxPrint: CPU idle
2,270.8 (46.8%) 07:26:58 INFO - TinderboxPrint: CPU system
962.0 (19.8%) 07:26:58 INFO - TinderboxPrint: CPU user
1,620.9 (33.4%) 07:26:58 INFO - TinderboxPrint: Swap in / out
436,776,960 / 0 07:26:58 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 390158848; Write bytes: 383969280; Read time: 29469; Write time: 686 07:26:58 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 32263168; Write bytes: 298707456; Read time: 304; Write time: 1359 07:26:59 INFO - Running post-run listener: _upload_blobber_files 07:26:59 INFO - Blob upload gear active. 07:26:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:26:59 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 07:26:59 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'] 07:26:59 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 07:26:59 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:26:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:00 INFO - (blobuploader) - INFO - Done attempting. 07:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:27:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:01 INFO - (blobuploader) - INFO - Done attempting. 07:27:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:27:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:27:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:04 INFO - (blobuploader) - INFO - Done attempting. 07:27:04 INFO - (blobuploader) - INFO - Iteration through files over. 07:27:04 INFO - Return code: 0 07:27:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:27:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:27:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/235f2a44c952420ec979640913142e7acbeb6eac7a1c64714f12ba5deafb57416475994c3fa065b43c3d4e8788a1adbcc1cf111219ba8977055448cf32954a5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad9c31923373d43829bdf6d57cc058860b90396ab659affd3c740556b5fa989d58966a31bf00fa2de1efe9792887e7c33f668ce126f48632f29134d518491861", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e1e45c9ef983ea41953932a2ee8ee4cbe1af2495c9823f1372264c705a9f47f3734c372d656dcab659ccbb32b58a52eec3907474f6781a8c56c45005c2e9596"} 07:27:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:27:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:27:04 INFO - Contents: 07:27:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/235f2a44c952420ec979640913142e7acbeb6eac7a1c64714f12ba5deafb57416475994c3fa065b43c3d4e8788a1adbcc1cf111219ba8977055448cf32954a5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad9c31923373d43829bdf6d57cc058860b90396ab659affd3c740556b5fa989d58966a31bf00fa2de1efe9792887e7c33f668ce126f48632f29134d518491861", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e1e45c9ef983ea41953932a2ee8ee4cbe1af2495c9823f1372264c705a9f47f3734c372d656dcab659ccbb32b58a52eec3907474f6781a8c56c45005c2e9596"} 07:27:04 INFO - Running post-run listener: copy_logs_to_upload_dir 07:27:04 INFO - Copying logs to upload dir... 07:27:04 INFO - mkdir: /builds/slave/test/build/upload/logs 07:27:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.640116 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-09 07:27:04.125193) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 07:27:04.128923) ========= 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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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/235f2a44c952420ec979640913142e7acbeb6eac7a1c64714f12ba5deafb57416475994c3fa065b43c3d4e8788a1adbcc1cf111219ba8977055448cf32954a5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad9c31923373d43829bdf6d57cc058860b90396ab659affd3c740556b5fa989d58966a31bf00fa2de1efe9792887e7c33f668ce126f48632f29134d518491861", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e1e45c9ef983ea41953932a2ee8ee4cbe1af2495c9823f1372264c705a9f47f3734c372d656dcab659ccbb32b58a52eec3907474f6781a8c56c45005c2e9596"} build_url:https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011083 build_url: 'https://queue.taskcluster.net/v1/task/LTxvbTt-RGqMQz91mm4qeA/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/235f2a44c952420ec979640913142e7acbeb6eac7a1c64714f12ba5deafb57416475994c3fa065b43c3d4e8788a1adbcc1cf111219ba8977055448cf32954a5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad9c31923373d43829bdf6d57cc058860b90396ab659affd3c740556b5fa989d58966a31bf00fa2de1efe9792887e7c33f668ce126f48632f29134d518491861", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e1e45c9ef983ea41953932a2ee8ee4cbe1af2495c9823f1372264c705a9f47f3734c372d656dcab659ccbb32b58a52eec3907474f6781a8c56c45005c2e9596"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 07:27:04.160745) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 07:27:04.161023) ========= 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.FQ6TphZ1hO/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.SWWWStKXBd/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.005132 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 07:27:04.208959) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 07:27:04.209227) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 07:27:04.209508) ========= ========= Total master_lag: 0.18 =========