builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0072 starttime: 1470659085.45 results: success (0) buildid: 20160808025952 builduid: 11a7928b0f4c4b74b71a9b3e92985edd revision: e78975b53563d80c99ebfbdf8a9fbf6b829a8a48 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:24:45.451467) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:24:45.452513) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:24:45.453144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:24:45.479776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:24:45.480467) ========= 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.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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-08 05:24:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 27.8M=0s 2016-08-08 05:24:45 (27.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108909 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:24:45.615922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:24:45.616533) ========= 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.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.027754 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:24:45.667924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:24:45.668730) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e78975b53563d80c99ebfbdf8a9fbf6b829a8a48 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e78975b53563d80c99ebfbdf8a9fbf6b829a8a48 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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-08 05:24:45,746 truncating revision to first 12 chars 2016-08-08 05:24:45,747 Setting DEBUG logging. 2016-08-08 05:24:45,747 attempt 1/10 2016-08-08 05:24:45,747 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e78975b53563?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 05:24:47,297 unpacking tar archive at: mozilla-central-e78975b53563/testing/mozharness/ program finished with exit code 0 elapsedTime=1.822762 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:24:47.519036) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:24:47.519806) ========= script_repo_revision: e78975b53563d80c99ebfbdf8a9fbf6b829a8a48 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:24:47.520855) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:24:47.521551) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:24:47.541951) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-08 05:24:47.542668) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:24:47 INFO - MultiFileLogger online at 20160808 05:24:47 in /builds/slave/test 05:24:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:24:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:24:47 INFO - {'append_to_log': False, 05:24:47 INFO - 'base_work_dir': '/builds/slave/test', 05:24:47 INFO - 'blob_upload_branch': 'Firefox', 05:24:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:24:47 INFO - 'branch': 'Firefox', 05:24:47 INFO - 'buildbot_json_path': 'buildprops.json', 05:24:47 INFO - 'config_files': ('talos/mac_config.py',), 05:24:47 INFO - 'default_actions': ('clobber', 05:24:47 INFO - 'read-buildbot-config', 05:24:47 INFO - 'download-and-extract', 05:24:47 INFO - 'populate-webroot', 05:24:47 INFO - 'create-virtualenv', 05:24:47 INFO - 'install', 05:24:47 INFO - 'run-tests'), 05:24:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:24:47 INFO - 'download_minidump_stackwalk': True, 05:24:47 INFO - 'download_symbols': 'ondemand', 05:24:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:24:47 INFO - 'tooltool.py': '/tools/tooltool.py', 05:24:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:24:47 INFO - '/tools/misc-python/virtualenv.py')}, 05:24:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:24:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:24:47 INFO - 'installer_path': 'installer.exe', 05:24:47 INFO - 'log_level': 'info', 05:24:47 INFO - 'log_name': 'talos', 05:24:47 INFO - 'log_to_console': True, 05:24:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:24:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:24:47 INFO - 'opt_config_files': (), 05:24:47 INFO - 'pip_index': False, 05:24:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:24:47 INFO - 'cmd': ('bash', 05:24:47 INFO - '-c', 05:24:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:24:47 INFO - 'enabled': True, 05:24:47 INFO - 'halt_on_failure': False, 05:24:47 INFO - 'name': 'check_screen_resolution'},), 05:24:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:24:47 INFO - 'cmd': ('bash', 05:24:47 INFO - '-c', 05:24:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:24:47 INFO - 'enabled': True, 05:24:47 INFO - 'halt_on_failure': False, 05:24:47 INFO - 'name': 'check_screen_resolution'},), 05:24:47 INFO - 'run_cmd_checks_enabled': True, 05:24:47 INFO - 'sps_profile': False, 05:24:47 INFO - 'sps_profile_interval': 0, 05:24:47 INFO - 'suite': 'dromaeojs-e10s', 05:24:47 INFO - 'system_bits': '32', 05:24:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:24:47 INFO - 'title': 't-yosemite-r7-0072', 05:24:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:24:47 INFO - 'use_talos_json': True, 05:24:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:24:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:24:47 INFO - 'work_dir': 'build'} 05:24:47 INFO - [mozharness: 2016-08-08 12:24:47.739795Z] Running clobber step. 05:24:47 INFO - Running pre-action listener: _resource_record_pre_action 05:24:47 INFO - Running main action method: clobber 05:24:47 INFO - rmtree: /builds/slave/test/build 05:24:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:24:49 INFO - Running post-action listener: _resource_record_post_action 05:24:49 INFO - [mozharness: 2016-08-08 12:24:49.291636Z] Finished clobber step (success) 05:24:49 INFO - [mozharness: 2016-08-08 12:24:49.291793Z] Running read-buildbot-config step. 05:24:49 INFO - Running pre-action listener: _resource_record_pre_action 05:24:49 INFO - Running main action method: read_buildbot_config 05:24:49 INFO - Using buildbot properties: 05:24:49 INFO - { 05:24:49 INFO - "project": "", 05:24:49 INFO - "product": "firefox", 05:24:49 INFO - "script_repo_revision": "production", 05:24:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:24:49 INFO - "repository": "", 05:24:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:24:49 INFO - "buildid": "20160808025952", 05:24:49 INFO - "pgo_build": "False", 05:24:49 INFO - "basedir": "/builds/slave/test", 05:24:49 INFO - "buildnumber": 19, 05:24:49 INFO - "slavename": "t-yosemite-r7-0072", 05:24:49 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:24:49 INFO - "platform": "yosemite_r7", 05:24:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:24:49 INFO - "branch": "mozilla-central", 05:24:49 INFO - "repo_path": "mozilla-central", 05:24:49 INFO - "revision": "e78975b53563d80c99ebfbdf8a9fbf6b829a8a48", 05:24:49 INFO - "stage_platform": "macosx64", 05:24:49 INFO - "builduid": "11a7928b0f4c4b74b71a9b3e92985edd", 05:24:49 INFO - "slavebuilddir": "test" 05:24:49 INFO - } 05:24:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:24:49 INFO - Running post-action listener: _resource_record_post_action 05:24:49 INFO - [mozharness: 2016-08-08 12:24:49.295185Z] Finished read-buildbot-config step (success) 05:24:49 INFO - [mozharness: 2016-08-08 12:24:49.295295Z] Running download-and-extract step. 05:24:49 INFO - Running pre-action listener: _resource_record_pre_action 05:24:49 INFO - Running main action method: download_and_extract 05:24:49 INFO - mkdir: /builds/slave/test/build/tests 05:24:49 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')]} 05:24:49 INFO - trying https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:24:49 INFO - Downloading https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/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 05:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/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 05:24:50 INFO - Downloaded 1199 bytes. 05:24:50 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:24:50 INFO - Using the following test package requirements: 05:24:50 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:24:50 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:24:50 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:24:50 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:24:50 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:24:50 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:24:50 INFO - u'jsshell-mac.zip'], 05:24:50 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:24:50 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:24:50 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:24:50 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:24:50 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:24:50 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:24:50 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:24:50 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:24:50 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:24:50 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:24:50 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:24:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:50 INFO - trying https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:24:50 INFO - Downloading https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/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 05:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/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 05:24:51 INFO - Downloaded 16324245 bytes. 05:24:51 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'] 05:24:51 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 05:24:54 INFO - Return code: 0 05:24:54 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 05:24:54 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')]} 05:24:54 INFO - trying https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:24:54 INFO - Downloading https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/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 05:24:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/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 05:24:55 INFO - Downloaded 16324245 bytes. 05:24:55 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'] 05:24:55 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 05:24:58 INFO - Return code: 0 05:24: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')]} 05:24:58 INFO - trying https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:24:58 INFO - Downloading https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/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 05:24:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/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 05:24:59 INFO - Downloaded 14413723 bytes. 05:24:59 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'] 05:24:59 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 05:24:59 INFO - Return code: 0 05:24:59 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')]} 05:24:59 INFO - trying https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:24:59 INFO - Downloading https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:24:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/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 05:25:03 INFO - Downloaded 111885214 bytes. 05:25:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:25:03 INFO - mkdir: /builds/slave/test/properties 05:25:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:25:03 INFO - Writing to file /builds/slave/test/properties/build_url 05:25:03 INFO - Contents: 05:25:03 INFO - build_url:https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:25:04 INFO - Running post-action listener: _resource_record_post_action 05:25:04 INFO - Running post-action listener: set_extra_try_arguments 05:25:04 INFO - [mozharness: 2016-08-08 12:25:04.237525Z] Finished download-and-extract step (success) 05:25:04 INFO - [mozharness: 2016-08-08 12:25:04.237641Z] Running populate-webroot step. 05:25:04 INFO - Running pre-action listener: _resource_record_pre_action 05:25:04 INFO - Running main action method: populate_webroot 05:25:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:25:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:25:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:25:04 INFO - '--tppagecycles', 05:25:04 INFO - '7'], 05:25:04 INFO - 'tests': ['tsvgm']}}, 05:25:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:25:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:25:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:25:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:25:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:25:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:25:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:04 INFO - 'talos_options': ['--disable-e10s'], 05:25:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:04 INFO - 'talos_options': ['--disable-e10s'], 05:25:04 INFO - 'tests': ['damp', 'tps']}, 05:25:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:04 INFO - 'tests': ['damp', 'tps']}, 05:25:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:25:04 INFO - 'tests': ['dromaeo_dom']}, 05:25:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:25:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:25:04 INFO - 'tests': ['basic_compositor_video']}, 05:25:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:25:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:25:04 INFO - 'tests': ['a11yr', 05:25:04 INFO - 'ts_paint', 05:25:04 INFO - 'tpaint', 05:25:04 INFO - 'sessionrestore', 05:25:04 INFO - 'sessionrestore_no_auto_restore', 05:25:04 INFO - 'tabpaint']}, 05:25:04 INFO - 'other-e10s': {'tests': ['a11yr', 05:25:04 INFO - 'ts_paint', 05:25:04 INFO - 'tpaint', 05:25:04 INFO - 'sessionrestore', 05:25:04 INFO - 'sessionrestore_no_auto_restore', 05:25:04 INFO - 'tabpaint']}, 05:25:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:25:04 INFO - 'ts_paint', 05:25:04 INFO - 'tpaint', 05:25:04 INFO - 'sessionrestore', 05:25:04 INFO - 'sessionrestore_no_auto_restore', 05:25:04 INFO - 'tabpaint']}, 05:25:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:25:04 INFO - 'ts_paint', 05:25:04 INFO - 'tpaint', 05:25:04 INFO - 'sessionrestore', 05:25:04 INFO - 'sessionrestore_no_auto_restore', 05:25:04 INFO - 'tabpaint']}, 05:25:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:25:04 INFO - 'tests': ['a11yr', 05:25:04 INFO - 'ts_paint', 05:25:04 INFO - 'tpaint', 05:25:04 INFO - 'sessionrestore', 05:25:04 INFO - 'sessionrestore_no_auto_restore', 05:25:04 INFO - 'tabpaint']}, 05:25:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:25:04 INFO - 'tests': ['a11yr', 05:25:04 INFO - 'ts_paint', 05:25:04 INFO - 'tpaint', 05:25:04 INFO - 'sessionrestore', 05:25:04 INFO - 'sessionrestore_no_auto_restore', 05:25:04 INFO - 'tabpaint']}, 05:25:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:25:04 INFO - 'tests': ['tsvgx', 05:25:04 INFO - 'tsvgr_opacity', 05:25:04 INFO - 'tart', 05:25:04 INFO - 'tscrollx', 05:25:04 INFO - 'cart']}, 05:25:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:25:04 INFO - 'tsvgr_opacity', 05:25:04 INFO - 'tart', 05:25:04 INFO - 'tscrollx', 05:25:04 INFO - 'cart']}, 05:25:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:04 INFO - 'talos_options': ['--disable-e10s'], 05:25:04 INFO - 'tests': ['tp5o']}, 05:25:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:04 INFO - 'tests': ['tp5o']}, 05:25:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:04 INFO - 'talos_options': ['--disable-e10s', 05:25:04 INFO - '--xperf_path', 05:25:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:04 INFO - 'tests': ['tp5n']}, 05:25:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:04 INFO - 'talos_options': ['--xperf_path', 05:25:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:04 INFO - 'tests': ['tp5n']}}, 05:25:04 INFO - 'talos.zip': {'path': '', 05:25:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:25:04 INFO - Running post-action listener: _resource_record_post_action 05:25:04 INFO - [mozharness: 2016-08-08 12:25:04.256377Z] Finished populate-webroot step (success) 05:25:04 INFO - [mozharness: 2016-08-08 12:25:04.256490Z] Running create-virtualenv step. 05:25:04 INFO - Running pre-action listener: _resource_record_pre_action 05:25:04 INFO - Running main action method: create_virtualenv 05:25:04 INFO - Creating virtualenv /builds/slave/test/build/venv 05:25:04 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 05:25:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:25:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:25:04 INFO - Using real prefix '/tools/python27' 05:25:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:25:05 INFO - Installing distribute.............................................................................................................................................................................................done. 05:25:07 INFO - Installing pip.................done. 05:25:07 INFO - Return code: 0 05:25:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:25: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')]} 05:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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')]} 05:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:07 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 0x10ba47a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10badc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9409d67a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9abd30>, '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 0x10b710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9a3b20>, '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.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:25:07 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 05:25:07 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 05:25:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QLxUvP7lJ4/Render', 05:25:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:07 INFO - 'HOME': '/Users/cltbld', 05:25:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:07 INFO - 'LOGNAME': 'cltbld', 05:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:07 INFO - 'MOZ_NO_REMOTE': '1', 05:25:07 INFO - 'NO_EM_RESTART': '1', 05:25:07 INFO - 'PAGER': '/bin/cat', 05:25:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:07 INFO - 'PWD': '/builds/slave/test', 05:25:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:07 INFO - 'SHELL': '/bin/bash', 05:25:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4jdTtnTgUB/Listeners', 05:25:07 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:25:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:07 INFO - 'USER': 'cltbld', 05:25:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:07 INFO - 'XPC_FLAGS': '0x0', 05:25:07 INFO - 'XPC_SERVICE_NAME': '0', 05:25:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:08 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 05:25:08 INFO - Cleaning up... 05:25:08 INFO - Return code: 0 05:25:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:25: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')]} 05:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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')]} 05:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:08 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 0x10ba47a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10badc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9409d67a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9abd30>, '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 0x10b710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9a3b20>, '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.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:25:08 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 05:25:08 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 05:25:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QLxUvP7lJ4/Render', 05:25:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:08 INFO - 'HOME': '/Users/cltbld', 05:25:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:08 INFO - 'LOGNAME': 'cltbld', 05:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:08 INFO - 'MOZ_NO_REMOTE': '1', 05:25:08 INFO - 'NO_EM_RESTART': '1', 05:25:08 INFO - 'PAGER': '/bin/cat', 05:25:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:08 INFO - 'PWD': '/builds/slave/test', 05:25:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:08 INFO - 'SHELL': '/bin/bash', 05:25:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4jdTtnTgUB/Listeners', 05:25:08 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:25:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:08 INFO - 'USER': 'cltbld', 05:25:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:08 INFO - 'XPC_FLAGS': '0x0', 05:25:08 INFO - 'XPC_SERVICE_NAME': '0', 05:25:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:08 INFO - Downloading/unpacking psutil>=3.1.1 05:25:08 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 05:25:08 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 05:25:08 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 05:25:08 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 05:25:08 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 05:25:08 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 05:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:25:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:11 INFO - Installing collected packages: psutil 05:25:11 INFO - Running setup.py install for psutil 05:25:11 INFO - building 'psutil._psutil_osx' extension 05:25:11 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 05:25:12 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 05:25:12 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 05:25:12 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 05:25:12 INFO - building 'psutil._psutil_posix' extension 05:25:12 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 05:25:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:25:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:25:12 INFO - ^ 05:25:12 INFO - 1 warning generated. 05:25:12 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 05:25:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:13 INFO - Successfully installed psutil 05:25:13 INFO - Cleaning up... 05:25:13 INFO - Return code: 0 05:25:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:25:13 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')]} 05:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:13 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')]} 05:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:13 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 0x10ba47a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10badc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9409d67a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9abd30>, '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 0x10b710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9a3b20>, '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.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:25:13 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 05:25:13 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 05:25:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QLxUvP7lJ4/Render', 05:25:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:13 INFO - 'HOME': '/Users/cltbld', 05:25:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:13 INFO - 'LOGNAME': 'cltbld', 05:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:13 INFO - 'MOZ_NO_REMOTE': '1', 05:25:13 INFO - 'NO_EM_RESTART': '1', 05:25:13 INFO - 'PAGER': '/bin/cat', 05:25:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:13 INFO - 'PWD': '/builds/slave/test', 05:25:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:13 INFO - 'SHELL': '/bin/bash', 05:25:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4jdTtnTgUB/Listeners', 05:25:13 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:25:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:13 INFO - 'USER': 'cltbld', 05:25:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:13 INFO - 'XPC_FLAGS': '0x0', 05:25:13 INFO - 'XPC_SERVICE_NAME': '0', 05:25:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:25:15 INFO - Installing collected packages: mozsystemmonitor 05:25:15 INFO - Running setup.py install for mozsystemmonitor 05:25:15 INFO - Successfully installed mozsystemmonitor 05:25:15 INFO - Cleaning up... 05:25:16 INFO - Return code: 0 05:25:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:25: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')]} 05:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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')]} 05:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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', '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 0x10ba47a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10badc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9409d67a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9abd30>, '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 0x10b710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9a3b20>, '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.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:25: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:25: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 jsonschema==2.5.1 05:25:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QLxUvP7lJ4/Render', 05:25:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:16 INFO - 'HOME': '/Users/cltbld', 05:25:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:16 INFO - 'LOGNAME': 'cltbld', 05:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:16 INFO - 'MOZ_NO_REMOTE': '1', 05:25:16 INFO - 'NO_EM_RESTART': '1', 05:25:16 INFO - 'PAGER': '/bin/cat', 05:25:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:16 INFO - 'PWD': '/builds/slave/test', 05:25:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:16 INFO - 'SHELL': '/bin/bash', 05:25:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4jdTtnTgUB/Listeners', 05:25:16 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:25:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:16 INFO - 'USER': 'cltbld', 05:25:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:16 INFO - 'XPC_FLAGS': '0x0', 05:25:16 INFO - 'XPC_SERVICE_NAME': '0', 05:25:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:16 INFO - Downloading/unpacking jsonschema==2.5.1 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:25:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:25:18 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 05:25:18 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 05:25:18 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 05:25:18 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 05:25:18 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 05:25:18 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 05:25:19 INFO - Downloading functools32-3.2.3-2.tar.gz 05:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:25:19 INFO - warning: no files found matching '*.txt' 05:25:19 INFO - no previously-included directories found matching 'build' 05:25:19 INFO - no previously-included directories found matching 'dist' 05:25:19 INFO - no previously-included directories found matching '.git*' 05:25:19 INFO - Installing collected packages: jsonschema, functools32 05:25:19 INFO - Running setup.py install for functools32 05:25:19 INFO - warning: no files found matching '*.txt' 05:25:19 INFO - no previously-included directories found matching 'build' 05:25:19 INFO - no previously-included directories found matching 'dist' 05:25:19 INFO - no previously-included directories found matching '.git*' 05:25:19 INFO - Successfully installed jsonschema functools32 05:25:19 INFO - Cleaning up... 05:25:19 INFO - Return code: 0 05:25:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ba47a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10badc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9409d67a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9abd30>, '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 0x10b710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9a3b20>, '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.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:25:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QLxUvP7lJ4/Render', 05:25:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:19 INFO - 'HOME': '/Users/cltbld', 05:25:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:19 INFO - 'LOGNAME': 'cltbld', 05:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:19 INFO - 'MOZ_NO_REMOTE': '1', 05:25:19 INFO - 'NO_EM_RESTART': '1', 05:25:19 INFO - 'PAGER': '/bin/cat', 05:25:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:19 INFO - 'PWD': '/builds/slave/test', 05:25:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:19 INFO - 'SHELL': '/bin/bash', 05:25:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4jdTtnTgUB/Listeners', 05:25:19 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:25:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:19 INFO - 'USER': 'cltbld', 05:25:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:19 INFO - 'XPC_FLAGS': '0x0', 05:25:19 INFO - 'XPC_SERVICE_NAME': '0', 05:25:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:25:19 INFO - Cleaning up... 05:25:19 INFO - Return code: 0 05:25:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ba47a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10badc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9409d67a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9abd30>, '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 0x10b710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9a3b20>, '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.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:25:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QLxUvP7lJ4/Render', 05:25:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:19 INFO - 'HOME': '/Users/cltbld', 05:25:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:19 INFO - 'LOGNAME': 'cltbld', 05:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:19 INFO - 'MOZ_NO_REMOTE': '1', 05:25:19 INFO - 'NO_EM_RESTART': '1', 05:25:19 INFO - 'PAGER': '/bin/cat', 05:25:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:19 INFO - 'PWD': '/builds/slave/test', 05:25:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:19 INFO - 'SHELL': '/bin/bash', 05:25:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4jdTtnTgUB/Listeners', 05:25:19 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:25:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:19 INFO - 'USER': 'cltbld', 05:25:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:19 INFO - 'XPC_FLAGS': '0x0', 05:25:19 INFO - 'XPC_SERVICE_NAME': '0', 05:25:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:20 INFO - Downloading/unpacking blobuploader==1.2.4 05:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:22 INFO - Downloading blobuploader-1.2.4.tar.gz 05:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:25:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:25:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:23 INFO - Downloading docopt-0.6.1.tar.gz 05:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:25:23 INFO - Installing collected packages: blobuploader, requests, docopt 05:25:23 INFO - Running setup.py install for blobuploader 05:25:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:25:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:25:23 INFO - Running setup.py install for requests 05:25:24 INFO - Running setup.py install for docopt 05:25:24 INFO - Successfully installed blobuploader requests docopt 05:25:24 INFO - Cleaning up... 05:25:24 INFO - Return code: 0 05:25:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25: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')]} 05:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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')]} 05:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:24 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 0x10ba47a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10badc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9409d67a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9abd30>, '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 0x10b710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9a3b20>, '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.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:25:24 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 05:25:24 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 05:25:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QLxUvP7lJ4/Render', 05:25:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:24 INFO - 'HOME': '/Users/cltbld', 05:25:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:24 INFO - 'LOGNAME': 'cltbld', 05:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:24 INFO - 'MOZ_NO_REMOTE': '1', 05:25:24 INFO - 'NO_EM_RESTART': '1', 05:25:24 INFO - 'PAGER': '/bin/cat', 05:25:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:24 INFO - 'PWD': '/builds/slave/test', 05:25:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:24 INFO - 'SHELL': '/bin/bash', 05:25:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4jdTtnTgUB/Listeners', 05:25:24 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:25:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:24 INFO - 'USER': 'cltbld', 05:25:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:24 INFO - 'XPC_FLAGS': '0x0', 05:25:24 INFO - 'XPC_SERVICE_NAME': '0', 05:25:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:24 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-TWdSDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:25 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-SEmWX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:25 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-lGoYTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:25 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-LZiz5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:25 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-1BlViq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:25 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-K91JyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:25 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-TUm3qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:25 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-KDlmh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:25 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Ey1YzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:25 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-NuFUTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:25 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-05mOGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:26 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-9nJIvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:26 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-A3X994-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:25:26 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-4ndrMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:26 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Mx2NDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:25:26 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-gbyj_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:25:26 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-31wmxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:25:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:25:26 INFO - Running setup.py install for manifestparser 05:25:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:25:26 INFO - Running setup.py install for mozcrash 05:25:26 INFO - Running setup.py install for mozdebug 05:25:27 INFO - Running setup.py install for mozdevice 05:25:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:25:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:25:27 INFO - Running setup.py install for mozfile 05:25:27 INFO - Running setup.py install for mozhttpd 05:25:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:25:27 INFO - Running setup.py install for mozinfo 05:25:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:25:27 INFO - Running setup.py install for mozInstall 05:25:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:25:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:25:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:25:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:25:27 INFO - Running setup.py install for mozleak 05:25:28 INFO - Running setup.py install for mozlog 05:25:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:25:28 INFO - Running setup.py install for moznetwork 05:25:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:25:28 INFO - Running setup.py install for mozprocess 05:25:28 INFO - Running setup.py install for mozprofile 05:25:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:25:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:25:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:25:28 INFO - Running setup.py install for mozrunner 05:25:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:25:28 INFO - Running setup.py install for mozscreenshot 05:25:28 INFO - Running setup.py install for moztest 05:25:29 INFO - Running setup.py install for mozversion 05:25:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:25:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:25:29 INFO - Cleaning up... 05:25:29 INFO - Return code: 0 05:25:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:29 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')]} 05:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:29 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')]} 05:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:29 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 0x10ba47a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10badc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9409d67a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9abd30>, '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 0x10b710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9a3b20>, '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.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:25:29 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 05:25:29 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 05:25:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QLxUvP7lJ4/Render', 05:25:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:29 INFO - 'HOME': '/Users/cltbld', 05:25:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:29 INFO - 'LOGNAME': 'cltbld', 05:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:29 INFO - 'MOZ_NO_REMOTE': '1', 05:25:29 INFO - 'NO_EM_RESTART': '1', 05:25:29 INFO - 'PAGER': '/bin/cat', 05:25:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:29 INFO - 'PWD': '/builds/slave/test', 05:25:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:29 INFO - 'SHELL': '/bin/bash', 05:25:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4jdTtnTgUB/Listeners', 05:25:29 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:25:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:29 INFO - 'USER': 'cltbld', 05:25:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:29 INFO - 'XPC_FLAGS': '0x0', 05:25:29 INFO - 'XPC_SERVICE_NAME': '0', 05:25:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:29 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-wSkfRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:29 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)) 05:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:29 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-MqvHYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:29 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)) 05:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:29 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-R1d3wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:29 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)) 05:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:29 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-zG6RLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:29 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)) 05:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:29 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-yQMAU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:30 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)) 05:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:30 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-RW5GHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:30 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)) 05:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:30 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-t_TtG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25:30 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)) 05:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:30 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Oj2a3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25:30 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)) 05:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:30 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-NyFwOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25:30 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)) 05:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:30 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Jha3Rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25:30 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)) 05:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:30 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-8cIftS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25:30 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)) 05:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:30 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-oADq9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25:30 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)) 05:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:30 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-IGBrqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:25:30 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)) 05:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:25:30 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-NdHox0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:31 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-DnSoYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:25:31 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-jPpF5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:25:31 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)) 05:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:25:31 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-tjTpn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:25:31 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)) 05:25:31 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)) 05:25:31 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)) 05:25:31 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)) 05:25:31 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)) 05:25:31 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)) 05:25:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:33 INFO - Downloading blessings-1.6.tar.gz 05:25:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:25:33 INFO - Installing collected packages: blessings 05:25:33 INFO - Running setup.py install for blessings 05:25:34 INFO - Successfully installed blessings 05:25:34 INFO - Cleaning up... 05:25:34 INFO - Return code: 0 05:25:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:25:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:25:34 INFO - Reading from file tmpfile_stdout 05:25:34 INFO - Current package versions: 05:25:34 INFO - blessings == 1.6 05:25:34 INFO - blobuploader == 1.2.4 05:25:34 INFO - docopt == 0.6.1 05:25:34 INFO - functools32 == 3.2.3-2 05:25:34 INFO - jsonschema == 2.5.1 05:25:34 INFO - manifestparser == 1.1 05:25:34 INFO - mozInstall == 1.12 05:25:34 INFO - mozcrash == 0.17 05:25:34 INFO - mozdebug == 0.1 05:25:34 INFO - mozdevice == 0.48 05:25:34 INFO - mozfile == 1.2 05:25:34 INFO - mozhttpd == 0.7 05:25:34 INFO - mozinfo == 0.9 05:25:34 INFO - mozleak == 0.1 05:25:34 INFO - mozlog == 3.3 05:25:34 INFO - moznetwork == 0.27 05:25:34 INFO - mozprocess == 0.23 05:25:34 INFO - mozprofile == 0.28 05:25:34 INFO - mozrunner == 6.12 05:25:34 INFO - mozscreenshot == 0.1 05:25:34 INFO - mozsystemmonitor == 0.3 05:25:34 INFO - moztest == 0.7 05:25:34 INFO - mozversion == 1.4 05:25:34 INFO - psutil == 3.1.1 05:25:34 INFO - requests == 1.2.3 05:25:34 INFO - wsgiref == 0.1.2 05:25:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:34 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 0x10ba47a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10badc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9409d67a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9abd30>, '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 0x10b710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9a3b20>, '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.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:25:34 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 05:25:34 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 05:25:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QLxUvP7lJ4/Render', 05:25:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:34 INFO - 'HOME': '/Users/cltbld', 05:25:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:34 INFO - 'LOGNAME': 'cltbld', 05:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:34 INFO - 'MOZ_NO_REMOTE': '1', 05:25:34 INFO - 'NO_EM_RESTART': '1', 05:25:34 INFO - 'PAGER': '/bin/cat', 05:25:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:34 INFO - 'PWD': '/builds/slave/test', 05:25:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:34 INFO - 'SHELL': '/bin/bash', 05:25:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4jdTtnTgUB/Listeners', 05:25:34 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:25:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:34 INFO - 'USER': 'cltbld', 05:25:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:34 INFO - 'XPC_FLAGS': '0x0', 05:25:34 INFO - 'XPC_SERVICE_NAME': '0', 05:25:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 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)) 05:25:34 INFO - Cleaning up... 05:25:34 INFO - Return code: 0 05:25:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba47a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10badc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9409d67a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9abd30>, '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 0x10b710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9a3b20>, '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.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:25:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:25:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QLxUvP7lJ4/Render', 05:25:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:34 INFO - 'HOME': '/Users/cltbld', 05:25:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:34 INFO - 'LOGNAME': 'cltbld', 05:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:34 INFO - 'MOZ_NO_REMOTE': '1', 05:25:34 INFO - 'NO_EM_RESTART': '1', 05:25:34 INFO - 'PAGER': '/bin/cat', 05:25:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:34 INFO - 'PWD': '/builds/slave/test', 05:25:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:34 INFO - 'SHELL': '/bin/bash', 05:25:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4jdTtnTgUB/Listeners', 05:25:34 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:25:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:34 INFO - 'USER': 'cltbld', 05:25:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:34 INFO - 'XPC_FLAGS': '0x0', 05:25:34 INFO - 'XPC_SERVICE_NAME': '0', 05:25:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:25:35 INFO - Cleaning up... 05:25:35 INFO - Return code: 0 05:25:35 INFO - Running post-action listener: _resource_record_post_action 05:25:35 INFO - Running post-action listener: _start_resource_monitoring 05:25:35 INFO - Starting resource monitoring. 05:25:35 INFO - [mozharness: 2016-08-08 12:25:35.061205Z] Finished create-virtualenv step (success) 05:25:35 INFO - [mozharness: 2016-08-08 12:25:35.061979Z] Running install step. 05:25:35 INFO - Running pre-action listener: _resource_record_pre_action 05:25:35 INFO - Running main action method: install 05:25:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:25:35 INFO - Reading from file tmpfile_stdout 05:25:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:25:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:25:35 INFO - Reading from file tmpfile_stdout 05:25:35 INFO - Output received: 05:25:35 INFO - Usage: mozinstall [options] installer 05:25:35 INFO - Options: 05:25:35 INFO - -h, --help show this help message and exit 05:25:35 INFO - -d DEST, --destination=DEST 05:25:35 INFO - Directory to install application into. [default: 05:25:35 INFO - "/builds/slave/test"] 05:25:35 INFO - --app=APP Application being installed. [default: firefox] 05:25:35 INFO - mkdir: /builds/slave/test/build/application 05:25:35 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'] 05:25:35 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 05:26:10 INFO - Reading from file tmpfile_stdout 05:26:10 INFO - Output received: 05:26:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:26:10 INFO - Running post-action listener: _resource_record_post_action 05:26:10 INFO - [mozharness: 2016-08-08 12:26:10.327936Z] Finished install step (success) 05:26:10 INFO - [mozharness: 2016-08-08 12:26:10.328080Z] Running run-tests step. 05:26:10 INFO - Running pre-action listener: _resource_record_pre_action 05:26:10 INFO - Running main action method: run_tests 05:26:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:26:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:26:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:26:10 INFO - 2016-08-08 05:26:10.342 screenresolution[1638:7653] starting screenresolution argv=screenresolution get 05:26:10 INFO - 2016-08-08 05:26:10.345 screenresolution[1638:7653] Display 0: 1600x1200x32@60 05:26:10 INFO - 2016-08-08 05:26:10.350 screenresolution[1639:7656] starting screenresolution argv=screenresolution list 05:26:10 INFO - Available Modes on Display 0 05:26:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:26:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:26:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:26:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:26:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:26:10 INFO - Intel Iris: 05:26:10 INFO - Chipset Model: Intel Iris 05:26:10 INFO - Type: GPU 05:26:10 INFO - Bus: Built-In 05:26:10 INFO - VRAM (Dynamic, Max): 1536 MB 05:26:10 INFO - Vendor: Intel (0x8086) 05:26:10 INFO - Device ID: 0x0a2e 05:26:10 INFO - Revision ID: 0x0009 05:26:10 INFO - Displays: 05:26:10 INFO - Display: 05:26:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:26:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:26:10 INFO - Display Serial Number: 1600x1200 60 05:26:10 INFO - Main Display: Yes 05:26:10 INFO - Mirror: Off 05:26:10 INFO - Online: Yes 05:26:10 INFO - Rotation: Supported 05:26:10 INFO - Return code: 0 05:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:26:10 INFO - Python 2.7.3 05:26:10 INFO - Return code: 0 05:26:10 INFO - grabbing minidump binary from tooltool 05:26:10 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')]} 05:26:10 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 0x10b9abd30>, '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 0x10b710db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9a3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:26:10 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 05:26:10 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 05:26:10 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 05:26:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:26:10 INFO - Return code: 0 05:26:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:26:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:26:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:26:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:26:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0072 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:26:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QLxUvP7lJ4/Render', 05:26:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:10 INFO - 'HOME': '/Users/cltbld', 05:26:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:10 INFO - 'LOGNAME': 'cltbld', 05:26:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:26:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:10 INFO - 'MOZ_NO_REMOTE': '1', 05:26:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:26:10 INFO - 'NO_EM_RESTART': '1', 05:26:10 INFO - 'PAGER': '/bin/cat', 05:26:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:10 INFO - 'PWD': '/builds/slave/test', 05:26:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:26:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:10 INFO - 'SHELL': '/bin/bash', 05:26:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4jdTtnTgUB/Listeners', 05:26:10 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:26:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:10 INFO - 'USER': 'cltbld', 05:26:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:10 INFO - 'XPC_FLAGS': '0x0', 05:26:10 INFO - 'XPC_SERVICE_NAME': '0', 05:26:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:26:10 INFO - mozversion application_buildid: 20160808025952 05:26:10 INFO - mozversion application_changeset: e78975b53563d80c99ebfbdf8a9fbf6b829a8a48 05:26:10 INFO - mozversion application_display_name: Nightly 05:26:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:26:10 INFO - mozversion application_name: Firefox 05:26:10 INFO - mozversion application_remotingname: firefox 05:26:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:26:10 INFO - mozversion application_vendor: Mozilla 05:26:10 INFO - mozversion application_version: 51.0a1 05:26:10 INFO - mozversion platform_buildid: 20160808025952 05:26:10 INFO - mozversion platform_changeset: e78975b53563d80c99ebfbdf8a9fbf6b829a8a48 05:26:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:26:10 INFO - mozversion platform_version: 51.0a1 05:26:10 INFO - using testdate: 1470659170 05:26:10 INFO - actual date: 1470659170 05:26:10 INFO - starting webserver on 'localhost:49273' 05:26:10 INFO - SUITE-START | Running 2 tests 05:26:10 INFO - TEST-START | dromaeo_css 05:26:10 INFO - operating with platform_type : mac_ 05:26:10 INFO - Initialising browser for dromaeo_css test... 05:26:10 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpSfLSDh/profile http://localhost:49273/getInfo.html) 05:26:13 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 05:26:13 INFO - PROCESS | 1649 | colorDepth:24 05:26:13 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 05:26:13 INFO - PROCESS | 1649 | __metrics 05:26:13 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:26:14 INFO - TEST-INFO | 1649: exit 0 05:26:14 INFO - Browser initialized. 05:26:14 INFO - Running cycle 1/1 for dromaeo_css test... 05:26:14 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpSfLSDh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:26 INFO - PROCESS | 1652 | RSS: Main: 254660608 05:26:26 INFO - PROCESS | 1652 | 05:27:16 INFO - PROCESS | 1652 | 1470659236243 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] 05:29:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 05:29:30 INFO - PROCESS | 1652 | RSS: Main: 265818112 05:29:30 INFO - PROCESS | 1652 | 05:32:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 05:32:33 INFO - PROCESS | 1652 | RSS: Main: 280117248 05:32:33 INFO - PROCESS | 1652 | 05:35:35 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 05:35:36 INFO - PROCESS | 1652 | RSS: Main: 287506432 05:35:36 INFO - PROCESS | 1652 | 05:38:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 05:38:38 INFO - PROCESS | 1652 | RSS: Main: 287477760 05:38:38 INFO - PROCESS | 1652 | 05:41:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 05:41:42 INFO - PROCESS | 1652 | RSS: Main: 292122624 05:41:42 INFO - PROCESS | 1652 | 05:44:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 05:44:45 INFO - PROCESS | 1652 | RSS: Main: 291995648 05:44:45 INFO - PROCESS | 1652 | 05:44:45 INFO - PROCESS | 1652 | __start_tp_report 05:44:45 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 05:44:45 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 05:44:45 INFO - PROCESS | 1652 | |i|pagename|runs| 05:44:45 INFO - PROCESS | 1652 | |0;dojo.html;2909.781766367522;3472.6700963408475;3494.580650321962;3503.456964170554;3510.19265568919;4903.264510323454;5864.0324346482885;5895.086261629449;5902.704864756761;5945.583809133363;5975.492083172925;5999.370066143058;6082.330943596212;6089.791226975012;6108.511319094473;5375.274337964373;5446.91829622556;5471.288732464774;5553.305836770403;5575.581831362664;5516.089845175541;5526.972365138168;5591.9720401397935;5596.132599447093;5599.1041433370665;4623.930641040387;5344.412114667403;5441.29263195782;5442.074847275972;5445.918311225335;4633.86098417048;5336.599755018389;5389.676619402849;5495.560355171577;5527.834164975057;5438.755256013489;5448.727563621843;5481.534069604048;5481.561475081984;5487.341519017744;5742.712864356766;6068.423499767559;6087.969560152215;6104.542159338067;6112.113743507167;6224.190855188842;6277.569902034707;6331.8733625327695;6354.015127655221;6355.586886852339;5534.335879694462;6258.561900666955;6344.397282258178;6434.742610295582;6436.613803171825;6100.207047561361;6163.167972323679;6170.81487555374;6175.938240617626;6183.84540386494;6532.477401807844;6580.374864387875;6580.967095164494;6607.504437167232;6639.966800165968;6193.071039344134;6236.345183755731;6272.310045895039;6386.457151142205;6390.169277993831;6272.2473303203;6296.43332100104;6325.746970121236;6341.080543321193;6401.647909364937;6290;6345.1434056401795;6355.555111142268;6357.4914006879335;6390.392912673288;5920.407959204132;6328;6343.9365606343345;6347.238331400169;6349.047642853517;5076.568491678248;5153.149730294459;5153.407358153785;5169.948300517022;5210.348706411699;4600.35595016698;4643;4645.488996210414;4652.488226295105;4674.439067311944;6025.975584150705;6086.573939824169;6101.237345331833;6105.908411373833;6113.633182009094;6240.968795155995;6293.496520278367;6305.779297724557;6360.968195158995;6385.744570217233;5103.795848166106;6090.878182436327;6094.177286066324;6096.055111457731;6097.908531372033;5575.107982722826;5658.151277308354;5659.037963546207;5662.85842853932;5670;6337.207849018872;6447.065175549613;6473.061406096184;6513.674316284261;6572;6334.588251763621;6378.489720822416;6389.456896163878;6390.616563006049;6395.328490508616;5502.339719233718;5569.498745112959;6509.218893732783;6545.869082618226;6548.279689234276;5416.404195538409;6261.186045814015;6309.211348581427;6324.715387807468;6375.776847810304;5393.27190829233;6351.809445716636;6381.744730210925;6416.13382193398;6418.486521078209;6335.208098987627;6375.203099612549;6375.808725738235;6376.426121649074;6381.776637817654;5098.566621837185;6012.969935150296;6208.689565521796;6209.565330427007;6213.720382582705;4706.176419126571;5909.172715819875;6236.968815155895;6256.687165641791;6302.117703521419;6283.120363149254;6318;6334.3665633436285;6345.206849143857;6348.523860710373;6142.815715528542;6164.630122192682;6205.22434695663;6207.534434917309;6300.59046161998 05:44:45 INFO - PROCESS | 1652 | |1;ext.html;475.7193255978972;502.37454369310205;502.8918782461772;516.233393410785;533.1443033930541;37635.81182094089;40266.59066932658;40439.393409098884;40446;40503.392449113286;41639.37540936881;42119;42276.57723422765;42298;42324.15351692964;9467.479288639122;9550.997145299747;9626.181774549137;9675.661351852686;9679.080487353725;9615.903840961571;9618.855717164248;9631.66289179879;9634.56644450998;9649.179819715333;9657.806843863118;9676.75808104796;9733.951330243339;9749.610015599368;9770.755731106708;9660.420374777535;9687.564059617334;9694.321397502143;9736.075072868067;9809.558569864374;8363.540005299707;8611.009733880559;9577.952110239474;9631.662891798753;9668.613255469772;34082.97751067472;36248.093797655005;39402.80298598488;39728.40407393892;39821.80089099565;3385.8984230473125;3425.5546778918583;3594.1733401317842;3957.960420395817;3999.460072890152;22856.428589285235;31409.84295078533;32025.6797432025;32740.508892366634;32765.6723432765;2667.5198464276423;3265.6081270247487;3272.6072871255365;3311.106001379638;3335.7664963452567;363921;402921;404150;404552;405792;33042.17394565155;33887.322253555285;34654.653453465144;56977.14534281989;57450.13824792631;34585.65414345875;34833.30333393318;34986.12534686653;35026.82486587551;35060;14696.632584185481;14822.481213157487;14856.851431485547;14866;14874.702505949821;10574.788504230026;12115.939420302842;12499.875001250053;12600.495980160875;12626.810597840857;7546.547207167588;7698.884516732253;7710.34462070719;7750.379969602418;7760;2777.8194417362806;3172.7303179230025;3200.391925534141;3235.0780027691994;3253.5933008373954;897.4839467306325;956.063058202965;967.7580604848788;984.5126662302206;996.9601215951426;25926;28955.276118097216;29308.413831723246;30047.849760751495;30791;959.9856002159974;1041.141058626636;1053.4732633683159;1072.9141668666489;1133.926294790836;15290.541283761506;15787;15792.842071579367;15817.05097694142;15832.68334633301;691579;694668;698441;700760;702307;58016.70991645015;58388.41611583915;58902.705486472296;59016;59384;1368.835739711241;1399.7690381087007;1404.3259235566782;1405.2341473896752;1414.7736362182206;26067.348316292246;28430.004949826656;29276.268093297836;29826.55260171056;30352.55360739812;44351.77824110859;45428.77285613551;48987.75506122589;48989;49250.01499970052;519624;521279;594692.0265398645;594868;595830;21740.673889891346;25770.613440798777;26066.609000864624;26122.477550449265;26146.607800883383;46601;46969.765151175394;47017.52982470268;47835.56493305206;48442.757786210845;32476;33461.665383345855;40077.37711422975;40105.79947100246;41148.382774257814;31745.888893889525;37498.625013749515;38844.80577597094;38878.611213887496;40272.395914060726;38273.808630956664;38404.80797595994;39227.62703305485;39331.410028850165;40540.59459405486;29154;31462.52806207863;35229;35240.647593524765;35351.823240883634;24367.634485482376;24523.63214551819;26038;26288.737112629395;26567.33581660474 05:44:45 INFO - PROCESS | 1652 | |2;jquery.html;371.29083450609323;380.2565983502253;381.92743378758036;393.48060560060696;397.8388752555216;19204.71192932107;21804.563908721855;21821.890890545546;22114.778852211493;22272.55454890901;16697.415590454337;17448.651026979485;20430.795692043073;21461.141554337806;21549.922503874823;5610.747516361764;5902.586818922677;5933.19901813254;5977.1034344848185;6021.208707777356;4131.21506913687;5858.853528661796;5910.586258961875;5913.639862831551;6237.282712488054;6436.581622194542;6556.344365563453;6558.409743123118;6574.3754343337305;6574.769883054094;6431.581947173466;6442.291347951745;6501.967490162542;6566.901496477557;6573.342665733437;5607.887842243133;5670.886582268373;5696.6866822324755;5701.429857014306;5707.914381284284;20804.583908321747;25916.222513324443;26158.476830463474;26180.73819261802;26430.86784566065;2292.415434064303;2385.7017872765905;2421.406755344934;2512.522620702061;2922.4885645012037;14191.858081419261;14386.237690866328;15651.373945042185;15837.841621583751;15981.961172523865;1826.5068431523548;1856.6101118765075;1888.254139614858;1914.5883635018538;1940.2045161483725;111815;115032;115107.27339089921;115140.42429787881;115330.84669153369;10648.094911932418;10697.786044279226;10829.29609575375;11141.387223702774;11376.772464550828;13579.592612221451;13762.793558096637;13881.861181388258;13890.930545347208;13910.165390076629;7025;8633.69782057625;8644.222020018104;8823.073577274423;8863.955680221557;8536.402451828313;8672.56637168139;8715.172058654418;8839.29285657146;8862;5243.9213411798855;6586.27550969393;6711.664416779142;6716.83207919806;6723.260441351447;1600.5438450041681;1699.0994772770453;1871.6631006418975;1871.7753869535743;1902.0869982408244;733.9412846972336;807.7778610882054;868.1231955724763;891.5734824281099;895.6775560798108;20515.38453846387;21162.047707853184;21943.561128777335;21944.341669749934;22012.559748804935;797.6211299632744;880.9296704504059;958.6884262614678;970.8009857979098;1033.3231733214757;8897.599608017656;11123.499442525106;11364.920174021709;11500.137489688306;11568;449676;501203;515889;577900;608574;102354.95290094157;126244.36877815552;149638;150936;152128;864.9956750216082;981.8870829854516;1002.0830939690102;1010.1716592394313;1025.6666583360288;17784.73322900132;19704.719193252393;20110.49723756918;20185.798142018393;20226.39320820378;54828.45171548393;55138.621534461956;55883.72058139683;56233;56796;81751.59124204579;81876.3624727514;82746.75879861927;83272.58363708385;83351.51234429562;7896.131425543301;7921.683132674629;8057.476264042818;8061.798455038671;8116.75649730509;12485.384626866444;12525.616034387891;12608.306543140216;12953.870461295643;12955.935220323838;10871.184661150288;11154.051905588116;11197.66407007791;11242.606508772154;11345.489452974802;10659.94670026645;11038.073802461497;11202.83195752048;11661.35862527569;11730.472128754398;11497.252678575866;11712.824307635563;11856.525738970344;11885;11961.521539138337;7998.760037198661;8198;8215.671373145246;8262.876056859272;8380.790480238044;9886.50567471638;11105.500252488819;11386.861313868547;11395.316281023164;11633.243839150427 05:44:45 INFO - PROCESS | 1652 | |3;mootools.html;1478.5786050975473;1531.096652974745;1734.1502663694785;1853.6107417442345;1864.8135186481345;7836.960815195916;8136.1050284468665;8289.08820029797;8825.646974121035;8832.160944710251;6956.860862782754;6979.511434199608;8583.442076265053;8660.437071590342;8685.305175585954;2313.2944451942194;2349.4126468382906;2355.882205889707;2363.0075368345338;2363.4800343924308;2323.9419014524688;2326.8720220387872;2379.6668466414717;2380.6310021946624;2382.95234095318;2341.84777989431;2353.2704861492907;2359.245041586693;2366.503034362786;2373.774491423321;2316.096722278313;2320.1995311617466;2334.941626459335;2337.5909215887236;2358.327876555191;1778.7509748635202;2129.55279391328;2341.1688850458013;2344.4138965258685;2354.446705024318;8660.783480412978;8676.913230867674;8702.347323950666;8774.73675789721;8782.868256976151;4536.455625324949;5021.39743230811;5114.974425127851;5281.9207711884355;5285.022270879899;2846.4307138572162;3460.653934606544;3508.1888693935084;3611.656892595199;3743.569489508714;1041.44282808697;1064.2550214849637;1080.7460246841986;1082.5940272397852;1082.7563798145434;9706.61173553057;11429.885471187858;11545.499085118881;11558.884411155948;11589.478473468715;4530.750808705487;4675.158471475167;4725.503822098699;4793.5685788279225;4797.616190704735;9713.805723885484;9732.367396119229;9825.803483930424;9848.655297064712;9853.408795472295;5183.922241166386;5251.789928402897;5256.342957130359;5264.105102132647;5268.28878101459;4343.457067866517;4684.273937539687;4740.004599034241;4823.975880120577;4838.322634831126;3729.6270372962485;3816.2749077675153;3857.1514266861245;3863.1307955710304;3920.4119382092913;1283.1531189415127;1296.857345691973;1301.947922083106;1304.8890844278342;1305.4060402516832;921.6774129054777;930.50683137937;940.5532372123323;958.2908647600725;970.9563069661882;4729.266963620645;5722.599418040697;5943.821685349447;6019.2175017248355;6064.848378790477;954.71358592422;961.6057416459219;975.2782940624029;978.3347323819728;990.9842411528098;3913.3934240192816;4019.5351199040124;4124.649404800565;4148.253314403436;4148.8133034012935;10352.741181470523;10741.570337186426;10791.136709063256;10796;10809.40548269837;10746.032857042903;10755.516001779939;10764.677059688065;10804.891951080388;10805.891941080647;7691.730789422343;8072.152423995513;8100.927643784787;8179.591020448954;8242.516347057468;5777;5855.3559108498885;5982.820515384546;5984.311804142405;6005.759769609167;9819.410835349901;9960.954099819415;10007.249456290661;10068;10086.79826403453;9038.864417033617;9928;10002.499875006366;10093.243006774668;10224;6520.7391704333195;6875.140607424072;6929.7228110875;7119.572825630479;7131.179914309713;8360.163983601591;8419.031811341529;8491.5329656867;8493.278071364004;8500.97988241415;7441.255874412515;7549.0941087069905;7582.279683430065;7668.118166410711;7702.5763583001235;7274.127104747464;7355.264473552602;7393.482456228013;7507.986421832983;7514.398848092249;6927.3419025192525;7038.2609825969585;7044.15470143586;7046.964765176142;7062.682179302046;4666.696664716783;4918.286848407032;4972.378452693413;5101.234814777813;5161.277421161116;4404.933925991048;4934.259861020875;4950.8267210647455;4972.651914366104;5192.740362981911 05:44:45 INFO - PROCESS | 1652 | |4;prototype.html;262.15716471543993;264.54498262987664;307.7522594311579;316.38463189097206;319.66594908320803;5729.369769325376;5848.67832269225;5852.970735146329;5861.765529378825;5879.617824841383;4626.65300102492;5658.009848276545;5703.714814259291;5706.543476521879;5748.396418376073;3568.8572457101814;3810.8757916414725;3913.823877925486;4306.397104405386;4342.023044814907;4308.526062133163;4329;4338.652907767371;4345.8478953236645;4352.93353128484;3735.2359254151866;3817.4464702618243;4034.5475628773765;4076.266272071026;4322.84870029549;3781.6029316921877;3948.4472173895533;3992.580779018205;4042.8787136385954;4323.524412314643;3710.2579484103017;3724.571674257468;3729.515163028816;3732.5520937487404;3734.047817806442;5556.527695145917;5566.803137325454;5584.5811564132855;5627.831165065014;5650.547956163538;4774.092922344744;4963.305137280783;5029.673071250357;5046.1421558334805;5063.822766203202;5242.318498595197;5647.463490968352;6033.4871535919065;6040.275166979946;6044.395560443964;3402.8468718907707;3585.4621806728937;4158.334666453383;4175.791210439465;4189.476315460567;5297.973510132463;5574.554035677136;5891.79378721747;6314.463270622003;6389.488840892764;3561.5370001899587;3627.347077526018;3817.255635151119;4196.748195108304;4218.261804184255;3864.7101467390057;3989.840406383712;4391.8682439526865;4392.616325857345;4413.889652758642;4202.432671589297;4436.173520951594;4732.645051621143;5084.694918304914;5100.668456550312;6113.484746270823;6121.418465245794;6124.703236286393;6137.355577664371;6170.845728856814;1375.8624137586162;1388.8819500302152;1463.9121652700871;1490.2772155504572;1492.1497343294454;838.3125836813754;901.8602116671926;908.5956749246521;922.7831459606987;929.3401684803865;5281.656692314988;5382.623216374816;5617.550595952314;5636.323641163087;5654.984960677964;5559.388467268597;6275.341089185661;6278.277998030194;6305.464035556937;6312.715927783261;4791.856244312677;5005.798608333974;5085.160948443466;5627.352854421794;5683.9715801420725;2656.72104429036;2702.932426689309;2732.961474639664;2991.5512673098774;3250.2686895448337;5626.43735626434;5694.886102277931;6288.748450062038;6505.642189679613;6517.641529715911;5347.566857080019;6361.650109244036;6416.294207637156;6441.742330306829;6459.806205813833;5044.9495505045215;6127.356627554132;6468.029795530708;6471.579347342407;6517.674116294166;4743.335932969456;5564.304461942257;5871.570630159968;6247.875042499216;6296.5592408530965;5237.46471131992;5740.454656807597;5911.822645320647;6071.878562428638;6206.317305096345;5053.231369020813;5330.081170778439;5975.611585246945;6056.70167448215;6531.836704082436;3132.765042621858;3135.5296705494357;3159.9256252874134;3598.4990431649753;3621.3300539400293;4697.553732395417;5023.648344615842;5345.65253258537;5354.848707527744;5360.678359298455;3935.5670876204167;4574.565416285448;5022.723750193628;5200.4279529251;5212.843614691566;4341.415383385105;4380.189664912002;5056.191009438472;5129;5180.171172612364;4197.664186865105;4667.529728135626;4743.881402964954;5054.368203974504;5725.312962444534;5814.476697097281;6037.335893051673;6052.515798736179;6078.170752425944;6096.542759293159;5207.791688332576;5348.171033489815;5433.320834895638;5497.87293604802;5590.552755779447 05:44:45 INFO - PROCESS | 1652 | |5;yui.html;712.6757325416936;728.6174758251917;776.3323541754093;778.2256654628644;778.5367706214801;15307.311170997318;15710.057396556214;15864.68270634588;15873.84126158738;15896.20518974051;11265.549378024869;14235.572932812032;14326;14340.928295358508;14362.928185359058;689.7241103558566;692.5567636712508;844.5988155626089;868.8132051608903;872.3283072034529;863.5768473447997;877.5085951866943;878.0429332028089;879.0155026370473;882.0297672560197;781.7928249014016;937.2501998401286;937.7374335186124;939.1359948847042;942.7171848445473;926.0137953080016;929.3773171974793;931.352709866643;931.8322701913653;933.0436302789661;681.158768920383;688.9276625954303;696.314130581377;696.7561353526226;699.5068476723898;14504.70990580193;14696.26518674062;14757.18835464049;14758.48345307909;14760.557183284518;14573;14657.267136643126;14689.853101468956;14739.263036848115;14891.47879824201;11994.940025299818;12265.38673066352;12502.312372819491;12516.81224781629;12624.17942833713;3826.5025546678753;3857.4792403025513;4057.634812866856;4083.2241874044134;4088.8364465421346;111411;112965;113370.43314783456;114328.85671143266;119520.40239798745;11285.153613478858;11354;11380.089592832554;11381;11673.949344558861;23130.884345578164;23530.76469235286;23600.64599031016;23670.289891303288;23811.285661430185;7946.562939038408;8007.199280071946;8028.624399702177;8053.395995300259;8076.919230807616;4285.871423857289;4428.911421771547;4437.711548749321;4452.1763473757455;4469.217886869785;3444.586649602064;3550.260372417497;3551.964480355215;3593.8742144025355;3599.280143971216;518.4659800405589;584.0305093544696;592.9031292109563;594.0821430889287;658.8122385120217;504.7249249159217;585.2771826793906;607.9270487541523;676.9507263741182;691.930806919304;8695.521746304014;9989.450580218157;10220.744481388025;10543.578256869792;10874.67375978722;655.4756195043946;678.2031113441686;691.1567887177636;710.1407297170379;722.4870342057093;4453.19842428366;4596.724196548218;4798.808047678054;4818.614510839125;4878.707277563358;141515.5848441523;147598;163472;169979;171597;117170.41414792872;134706.65293346942;136490.31754841164;137313;137866;78014.60992695;80579;99361;103158.42103947462;109904.90095099107;8890.621953597203;8941.239994600532;9251.306152038489;9482.241420686467;9542.809143817223;56686.58283542944;59730;60228.49428764316;61105.69447152736;66920.33079669336;63505.682471587344;64375.71248575096;84109;88413;90714.18571628399;13487.572236997043;13579.86420135786;13666.248356340497;13787.379567919266;14094.647633809236;12183.451744671334;13473.989450791425;14039.649008774453;14883.925580372028;15178.316975735897;14076.577702668936;14088.225147616979;14134.78797818013;14528.491502797351;14548.49080282185;9943.801123977335;13219.405126769127;13883.791743123658;14015.719685606027;14601.269936503344;11736.647900562997;13538.729225415633;13803.654908627364;14247.449423294007;14288.642783930485;10667.413292269;10845.891541084487;11025.889741102807;11085;11334.94332528332;9994.450305233282;10523.94738026305;11483.770324593628;11783.175177737476;11789.882101178879 05:44:45 INFO - PROCESS | 1652 | __end_tp_report 05:44:45 INFO - PROCESS | 1652 | __start_cc_report 05:44:45 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,419 05:44:45 INFO - PROCESS | 1652 | __end_cc_report 05:44:45 INFO - PROCESS | 1652 | __startTimestamp1470660285174__endTimestamp 05:44:45 INFO - PROCESS | 1652 | 05:44:45 INFO - PROCESS | 1652 | ------- Summary: start ------- 05:44:45 INFO - PROCESS | 1652 | Number of tests: 6 05:44:45 INFO - PROCESS | 1652 | 05:44:45 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5893.25 Median:6163.17 stddev:669.47 (10.9%) stddev-sans-first:629.29 05:44:45 INFO - PROCESS | 1652 | Values: 2909.8 3472.7 3494.6 3503.5 3510.2 4903.3 5864.0 5895.1 5902.7 5945.6 5975.5 5999.4 6082.3 6089.8 6108.5 5375.3 5446.9 5471.3 5553.3 5575.6 5516.1 5527.0 5592.0 5596.1 5599.1 4623.9 5344.4 5441.3 5442.1 5445.9 4633.9 5336.6 5389.7 5495.6 5527.8 5438.8 5448.7 5481.5 5481.6 5487.3 5742.7 6068.4 6088.0 6104.5 6112.1 6224.2 6277.6 6331.9 6354.0 6355.6 5534.3 6258.6 6344.4 6434.7 6436.6 6100.2 6163.2 6170.8 6175.9 6183.8 6532.5 6580.4 6581.0 6607.5 6640.0 6193.1 6236.3 6272.3 6386.5 6390.2 6272.2 6296.4 6325.7 6341.1 6401.6 6290.0 6345.1 6355.6 6357.5 6390.4 5920.4 6328.0 6343.9 6347.2 6349.0 5076.6 5153.1 5153.4 5169.9 5210.3 4600.4 4643.0 4645.5 4652.5 4674.4 6026.0 6086.6 6101.2 6105.9 6113.6 6241.0 6293.5 6305.8 6361.0 6385.7 5103.8 6090.9 6094.2 6096.1 6097.9 5575.1 5658.2 5659.0 5662.9 5670.0 6337.2 6447.1 6473.1 6513.7 6572.0 6334.6 6378.5 6389.5 6390.6 6395.3 5502.3 5569.5 6509.2 6545.9 6548.3 5416.4 6261.2 6309.2 6324.7 6375.8 5393.3 6351.8 6381.7 6416.1 6418.5 6335.2 6375.2 6375.8 6376.4 6381.8 5098.6 6013.0 6208.7 6209.6 6213.7 4706.2 5909.2 6237.0 6256.7 6302.1 6283.1 6318.0 6334.4 6345.2 6348.5 6142.8 6164.6 6205.2 6207.5 6300.6 05:44:45 INFO - PROCESS | 1652 | 05:44:45 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:66911.01 Median:21843.18 stddev:152271.06 (697.1%) stddev-sans-first:152616.53 05:44:45 INFO - PROCESS | 1652 | Values: 475.7 502.4 502.9 516.2 533.1 37635.8 40266.6 40439.4 40446.0 40503.4 41639.4 42119.0 42276.6 42298.0 42324.2 9467.5 9551.0 9626.2 9675.7 9679.1 9615.9 9618.9 9631.7 9634.6 9649.2 9657.8 9676.8 9734.0 9749.6 9770.8 9660.4 9687.6 9694.3 9736.1 9809.6 8363.5 8611.0 9578.0 9631.7 9668.6 34083.0 36248.1 39402.8 39728.4 39821.8 3385.9 3425.6 3594.2 3958.0 3999.5 22856.4 31409.8 32025.7 32740.5 32765.7 2667.5 3265.6 3272.6 3311.1 3335.8 363921.0 402921.0 404150.0 404552.0 405792.0 33042.2 33887.3 34654.7 56977.1 57450.1 34585.7 34833.3 34986.1 35026.8 35060.0 14696.6 14822.5 14856.9 14866.0 14874.7 10574.8 12115.9 12499.9 12600.5 12626.8 7546.5 7698.9 7710.3 7750.4 7760.0 2777.8 3172.7 3200.4 3235.1 3253.6 897.5 956.1 967.8 984.5 997.0 25926.0 28955.3 29308.4 30047.8 30791.0 960.0 1041.1 1053.5 1072.9 1133.9 15290.5 15787.0 15792.8 15817.1 15832.7 691579.0 694668.0 698441.0 700760.0 702307.0 58016.7 58388.4 58902.7 59016.0 59384.0 1368.8 1399.8 1404.3 1405.2 1414.8 26067.3 28430.0 29276.3 29826.6 30352.6 44351.8 45428.8 48987.8 48989.0 49250.0 519624.0 521279.0 594692.0 594868.0 595830.0 21740.7 25770.6 26066.6 26122.5 26146.6 46601.0 46969.8 47017.5 47835.6 48442.8 32476.0 33461.7 40077.4 40105.8 41148.4 31745.9 37498.6 38844.8 38878.6 40272.4 38273.8 38404.8 39227.6 39331.4 40540.6 29154.0 31462.5 35229.0 35240.6 35351.8 24367.6 24523.6 26038.0 26288.7 26567.3 05:44:45 INFO - PROCESS | 1652 | 05:44:45 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:33751.50 Median:2466.96 stddev:89994.17 (3648.0%) stddev-sans-first:90211.73 05:44:45 INFO - PROCESS | 1652 | Values: 371.3 380.3 381.9 393.5 397.8 19204.7 21804.6 21821.9 22114.8 22272.6 16697.4 17448.7 20430.8 21461.1 21549.9 5610.7 5902.6 5933.2 5977.1 6021.2 4131.2 5858.9 5910.6 5913.6 6237.3 6436.6 6556.3 6558.4 6574.4 6574.8 6431.6 6442.3 6502.0 6566.9 6573.3 5607.9 5670.9 5696.7 5701.4 5707.9 20804.6 25916.2 26158.5 26180.7 26430.9 2292.4 2385.7 2421.4 2512.5 2922.5 14191.9 14386.2 15651.4 15837.8 15982.0 1826.5 1856.6 1888.3 1914.6 1940.2 111815.0 115032.0 115107.3 115140.4 115330.8 10648.1 10697.8 10829.3 11141.4 11376.8 13579.6 13762.8 13881.9 13890.9 13910.2 7025.0 8633.7 8644.2 8823.1 8864.0 8536.4 8672.6 8715.2 8839.3 8862.0 5243.9 6586.3 6711.7 6716.8 6723.3 1600.5 1699.1 1871.7 1871.8 1902.1 733.9 807.8 868.1 891.6 895.7 20515.4 21162.0 21943.6 21944.3 22012.6 797.6 880.9 958.7 970.8 1033.3 8897.6 11123.5 11364.9 11500.1 11568.0 449676.0 501203.0 515889.0 577900.0 608574.0 102355.0 126244.4 149638.0 150936.0 152128.0 865.0 981.9 1002.1 1010.2 1025.7 17784.7 19704.7 20110.5 20185.8 20226.4 54828.5 55138.6 55883.7 56233.0 56796.0 81751.6 81876.4 82746.8 83272.6 83351.5 7896.1 7921.7 8057.5 8061.8 8116.8 12485.4 12525.6 12608.3 12953.9 12955.9 10871.2 11154.1 11197.7 11242.6 11345.5 10659.9 11038.1 11202.8 11661.4 11730.5 11497.3 11712.8 11856.5 11885.0 11961.5 7998.8 8198.0 8215.7 8262.9 8380.8 9886.5 11105.5 11386.9 11395.3 11633.2 05:44:45 INFO - PROCESS | 1652 | 05:44:45 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5635.27 Median:4942.54 stddev:3143.70 (63.6%) stddev-sans-first:3137.00 05:44:45 INFO - PROCESS | 1652 | Values: 1478.6 1531.1 1734.2 1853.6 1864.8 7837.0 8136.1 8289.1 8825.6 8832.2 6956.9 6979.5 8583.4 8660.4 8685.3 2313.3 2349.4 2355.9 2363.0 2363.5 2323.9 2326.9 2379.7 2380.6 2383.0 2341.8 2353.3 2359.2 2366.5 2373.8 2316.1 2320.2 2334.9 2337.6 2358.3 1778.8 2129.6 2341.2 2344.4 2354.4 8660.8 8676.9 8702.3 8774.7 8782.9 4536.5 5021.4 5115.0 5281.9 5285.0 2846.4 3460.7 3508.2 3611.7 3743.6 1041.4 1064.3 1080.7 1082.6 1082.8 9706.6 11429.9 11545.5 11558.9 11589.5 4530.8 4675.2 4725.5 4793.6 4797.6 9713.8 9732.4 9825.8 9848.7 9853.4 5183.9 5251.8 5256.3 5264.1 5268.3 4343.5 4684.3 4740.0 4824.0 4838.3 3729.6 3816.3 3857.2 3863.1 3920.4 1283.2 1296.9 1301.9 1304.9 1305.4 921.7 930.5 940.6 958.3 971.0 4729.3 5722.6 5943.8 6019.2 6064.8 954.7 961.6 975.3 978.3 991.0 3913.4 4019.5 4124.6 4148.3 4148.8 10352.7 10741.6 10791.1 10796.0 10809.4 10746.0 10755.5 10764.7 10804.9 10805.9 7691.7 8072.2 8100.9 8179.6 8242.5 5777.0 5855.4 5982.8 5984.3 6005.8 9819.4 9961.0 10007.2 10068.0 10086.8 9038.9 9928.0 10002.5 10093.2 10224.0 6520.7 6875.1 6929.7 7119.6 7131.2 8360.2 8419.0 8491.5 8493.3 8501.0 7441.3 7549.1 7582.3 7668.1 7702.6 7274.1 7355.3 7393.5 7508.0 7514.4 6927.3 7038.3 7044.2 7047.0 7062.7 4666.7 4918.3 4972.4 5101.2 5161.3 4404.9 4934.3 4950.8 4972.7 5192.7 05:44:45 INFO - PROCESS | 1652 | 05:44:45 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4698.01 Median:5190.30 stddev:1496.47 (28.8%) stddev-sans-first:1463.16 05:44:45 INFO - PROCESS | 1652 | Values: 262.2 264.5 307.8 316.4 319.7 5729.4 5848.7 5853.0 5861.8 5879.6 4626.7 5658.0 5703.7 5706.5 5748.4 3568.9 3810.9 3913.8 4306.4 4342.0 4308.5 4329.0 4338.7 4345.8 4352.9 3735.2 3817.4 4034.5 4076.3 4322.8 3781.6 3948.4 3992.6 4042.9 4323.5 3710.3 3724.6 3729.5 3732.6 3734.0 5556.5 5566.8 5584.6 5627.8 5650.5 4774.1 4963.3 5029.7 5046.1 5063.8 5242.3 5647.5 6033.5 6040.3 6044.4 3402.8 3585.5 4158.3 4175.8 4189.5 5298.0 5574.6 5891.8 6314.5 6389.5 3561.5 3627.3 3817.3 4196.7 4218.3 3864.7 3989.8 4391.9 4392.6 4413.9 4202.4 4436.2 4732.6 5084.7 5100.7 6113.5 6121.4 6124.7 6137.4 6170.8 1375.9 1388.9 1463.9 1490.3 1492.1 838.3 901.9 908.6 922.8 929.3 5281.7 5382.6 5617.6 5636.3 5655.0 5559.4 6275.3 6278.3 6305.5 6312.7 4791.9 5005.8 5085.2 5627.4 5684.0 2656.7 2702.9 2733.0 2991.6 3250.3 5626.4 5694.9 6288.7 6505.6 6517.6 5347.6 6361.7 6416.3 6441.7 6459.8 5044.9 6127.4 6468.0 6471.6 6517.7 4743.3 5564.3 5871.6 6247.9 6296.6 5237.5 5740.5 5911.8 6071.9 6206.3 5053.2 5330.1 5975.6 6056.7 6531.8 3132.8 3135.5 3159.9 3598.5 3621.3 4697.6 5023.6 5345.7 5354.8 5360.7 3935.6 4574.6 5022.7 5200.4 5212.8 4341.4 4380.2 5056.2 5129.0 5180.2 4197.7 4667.5 4743.9 5054.4 5725.3 5814.5 6037.3 6052.5 6078.2 6096.5 5207.8 5348.2 5433.3 5497.9 5590.6 05:44:45 INFO - PROCESS | 1652 | 05:44:45 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:24637.08 Median:3572.92 stddev:39732.81 (1112.1%) stddev-sans-first:39803.66 05:44:45 INFO - PROCESS | 1652 | Values: 712.7 728.6 776.3 778.2 778.5 15307.3 15710.1 15864.7 15873.8 15896.2 11265.5 14235.6 14326.0 14340.9 14362.9 689.7 692.6 844.6 868.8 872.3 863.6 877.5 878.0 879.0 882.0 781.8 937.3 937.7 939.1 942.7 926.0 929.4 931.4 931.8 933.0 681.2 688.9 696.3 696.8 699.5 14504.7 14696.3 14757.2 14758.5 14760.6 14573.0 14657.3 14689.9 14739.3 14891.5 11994.9 12265.4 12502.3 12516.8 12624.2 3826.5 3857.5 4057.6 4083.2 4088.8 111411.0 112965.0 113370.4 114328.9 119520.4 11285.2 11354.0 11380.1 11381.0 11673.9 23130.9 23530.8 23600.6 23670.3 23811.3 7946.6 8007.2 8028.6 8053.4 8076.9 4285.9 4428.9 4437.7 4452.2 4469.2 3444.6 3550.3 3552.0 3593.9 3599.3 518.5 584.0 592.9 594.1 658.8 504.7 585.3 607.9 677.0 691.9 8695.5 9989.5 10220.7 10543.6 10874.7 655.5 678.2 691.2 710.1 722.5 4453.2 4596.7 4798.8 4818.6 4878.7 141515.6 147598.0 163472.0 169979.0 171597.0 117170.4 134706.7 136490.3 137313.0 137866.0 78014.6 80579.0 99361.0 103158.4 109904.9 8890.6 8941.2 9251.3 9482.2 9542.8 56686.6 59730.0 60228.5 61105.7 66920.3 63505.7 64375.7 84109.0 88413.0 90714.2 13487.6 13579.9 13666.2 13787.4 14094.6 12183.5 13474.0 14039.6 14883.9 15178.3 14076.6 14088.2 14134.8 14528.5 14548.5 9943.8 13219.4 13883.8 14015.7 14601.3 11736.6 13538.7 13803.7 14247.4 14288.6 10667.4 10845.9 11025.9 11085.0 11334.9 9994.5 10523.9 11483.8 11783.2 11789.9 05:44:45 INFO - PROCESS | 1652 | -------- Summary: end -------- 05:44:45 INFO - PROCESS | 1652 | 05:44:45 INFO - TEST-INFO | 1652: exit 0 05:44:45 INFO - TEST-OK | dromaeo_css | took 1114829ms 05:44:45 INFO - TEST-START | kraken 05:44:45 INFO - operating with platform_type : mac_ 05:44:45 INFO - Initialising browser for kraken test... 05:44:45 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpDlxthj/profile http://localhost:49273/getInfo.html) 05:44:48 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 05:44:48 INFO - PROCESS | 1665 | colorDepth:24 05:44:48 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 05:44:48 INFO - PROCESS | 1665 | __metrics 05:44:48 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:44:49 INFO - TEST-INFO | 1665: exit 0 05:44:49 INFO - Browser initialized. 05:44:49 INFO - Running cycle 1/1 for kraken test... 05:44:49 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpDlxthj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:00 INFO - PROCESS | 1667 | RSS: Main: 254627840 05:45:00 INFO - PROCESS | 1667 | 05:45:03 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 05:45:04 INFO - PROCESS | 1667 | RSS: Main: 267264000 05:45:04 INFO - PROCESS | 1667 | 05:45:07 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 05:45:07 INFO - PROCESS | 1667 | RSS: Main: 276107264 05:45:07 INFO - PROCESS | 1667 | 05:45:11 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 05:45:12 INFO - PROCESS | 1667 | RSS: Main: 278835200 05:45:12 INFO - PROCESS | 1667 | 05:45:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 05:45:14 INFO - PROCESS | 1667 | RSS: Main: 281227264 05:45:14 INFO - PROCESS | 1667 | 05:45:16 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:45:17 INFO - PROCESS | 1667 | RSS: Main: 281915392 05:45:17 INFO - PROCESS | 1667 | 05:45:20 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 05:45:20 INFO - PROCESS | 1667 | RSS: Main: 282632192 05:45:20 INFO - PROCESS | 1667 | 05:45:23 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 05:45:24 INFO - PROCESS | 1667 | RSS: Main: 282173440 05:45:24 INFO - PROCESS | 1667 | 05:45:27 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 05:45:28 INFO - PROCESS | 1667 | RSS: Main: 282927104 05:45:28 INFO - PROCESS | 1667 | 05:45:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:45:30 INFO - PROCESS | 1667 | RSS: Main: 282791936 05:45:30 INFO - PROCESS | 1667 | 05:45:32 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:45:33 INFO - PROCESS | 1667 | RSS: Main: 282775552 05:45:33 INFO - PROCESS | 1667 | 05:45:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:45:36 INFO - PROCESS | 1667 | RSS: Main: 282820608 05:45:36 INFO - PROCESS | 1667 | 05:45:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:45:39 INFO - PROCESS | 1667 | RSS: Main: 282738688 05:45:39 INFO - PROCESS | 1667 | 05:45:42 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:45:43 INFO - PROCESS | 1667 | RSS: Main: 282988544 05:45:43 INFO - PROCESS | 1667 | 05:45:44 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 05:45:45 INFO - PROCESS | 1667 | RSS: Main: 284209152 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | __start_tp_report 05:45:45 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 05:45:45 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 05:45:45 INFO - PROCESS | 1667 | |i|pagename|runs| 05:45:45 INFO - PROCESS | 1667 | |0;ai-astar;104;120;106;118;120;116;116;118;116;106 05:45:45 INFO - PROCESS | 1667 | |1;audio-beat-detection;176;149;144;168;108;126;133;110;161;114 05:45:45 INFO - PROCESS | 1667 | |2;audio-dft;202;199;205;238;201;230;281;196;270;278 05:45:45 INFO - PROCESS | 1667 | |3;audio-fft;70;84;76;147;64;62;59;65;138;60 05:45:45 INFO - PROCESS | 1667 | |4;audio-oscillator;69;73;126;72;73;82;117;71;88;153 05:45:45 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;90;91;90;77;138;121;89;88;132;88 05:45:45 INFO - PROCESS | 1667 | |6;imaging-darkroom;93;154;94;96;96;95;105;95;136;152 05:45:45 INFO - PROCESS | 1667 | |7;imaging-desaturate;146;134;91;93;93;90;99;92;132;154 05:45:45 INFO - PROCESS | 1667 | |8;json-parse-financial;55;58;56;58;56;57;57;56;56;56 05:45:45 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;68;70;77;69;75;82;66;76;97;103 05:45:45 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;85;90;81;76;105;105;109;103;87;88 05:45:45 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;153;163;146;151;134;165;162;149;136;159 05:45:45 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;158;175;168;165;170;225;226;185;150;145 05:45:45 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;68;69;66;69;68;65;66;68;68;60 05:45:45 INFO - PROCESS | 1667 | __end_tp_report 05:45:45 INFO - PROCESS | 1667 | __start_cc_report 05:45:45 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1045 05:45:45 INFO - PROCESS | 1667 | __end_cc_report 05:45:45 INFO - PROCESS | 1667 | __startTimestamp1470660345190__endTimestamp 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | ------- Summary: start ------- 05:45:45 INFO - PROCESS | 1667 | Number of tests: 14 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:114.00 Median:117.00 stddev:6.18 (5.3%) stddev-sans-first:5.40 05:45:45 INFO - PROCESS | 1667 | Values: 104.0 120.0 106.0 118.0 120.0 116.0 116.0 118.0 116.0 106.0 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:146.50 stddev:24.61 (16.8%) stddev-sans-first:22.14 05:45:45 INFO - PROCESS | 1667 | Values: 176.0 149.0 144.0 168.0 108.0 126.0 133.0 110.0 161.0 114.0 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:230.00 Median:234.00 stddev:34.86 (14.9%) stddev-sans-first:35.47 05:45:45 INFO - PROCESS | 1667 | Values: 202.0 199.0 205.0 238.0 201.0 230.0 281.0 196.0 270.0 278.0 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:82.50 Median:64.50 stddev:32.61 (50.6%) stddev-sans-first:34.27 05:45:45 INFO - PROCESS | 1667 | Values: 70.0 84.0 76.0 147.0 64.0 62.0 59.0 65.0 138.0 60.0 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:72.50 stddev:29.27 (40.4%) stddev-sans-first:29.79 05:45:45 INFO - PROCESS | 1667 | Values: 69.0 73.0 126.0 72.0 73.0 82.0 117.0 71.0 88.0 153.0 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:100.40 Median:88.50 stddev:21.41 (24.2%) stddev-sans-first:22.38 05:45:45 INFO - PROCESS | 1667 | Values: 90.0 91.0 90.0 77.0 138.0 121.0 89.0 88.0 132.0 88.0 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:111.60 Median:94.50 stddev:25.30 (26.8%) stddev-sans-first:25.93 05:45:45 INFO - PROCESS | 1667 | Values: 93.0 154.0 94.0 96.0 96.0 95.0 105.0 95.0 136.0 152.0 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:112.40 Median:91.50 stddev:25.86 (28.3%) stddev-sans-first:24.40 05:45:45 INFO - PROCESS | 1667 | Values: 146.0 134.0 91.0 93.0 93.0 90.0 99.0 92.0 132.0 154.0 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.50 stddev:0.97 (1.7%) stddev-sans-first:0.87 05:45:45 INFO - PROCESS | 1667 | Values: 55.0 58.0 56.0 58.0 56.0 57.0 57.0 56.0 56.0 56.0 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:78.30 Median:75.50 stddev:12.49 (16.5%) stddev-sans-first:12.68 05:45:45 INFO - PROCESS | 1667 | Values: 68.0 70.0 77.0 69.0 75.0 82.0 66.0 76.0 97.0 103.0 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:92.90 Median:83.00 stddev:11.60 (14.0%) stddev-sans-first:11.95 05:45:45 INFO - PROCESS | 1667 | Values: 85.0 90.0 81.0 76.0 105.0 105.0 109.0 103.0 87.0 88.0 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:156.00 stddev:10.88 (7.0%) stddev-sans-first:11.53 05:45:45 INFO - PROCESS | 1667 | Values: 153.0 163.0 146.0 151.0 134.0 165.0 162.0 149.0 136.0 159.0 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:172.50 stddev:28.21 (16.4%) stddev-sans-first:29.09 05:45:45 INFO - PROCESS | 1667 | Values: 158.0 175.0 168.0 165.0 170.0 225.0 226.0 185.0 150.0 145.0 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:68.00 stddev:2.71 (4.0%) stddev-sans-first:2.83 05:45:45 INFO - PROCESS | 1667 | Values: 68.0 69.0 66.0 69.0 68.0 65.0 66.0 68.0 68.0 60.0 05:45:45 INFO - PROCESS | 1667 | -------- Summary: end -------- 05:45:45 INFO - PROCESS | 1667 | 05:45:45 INFO - TEST-INFO | 1667: exit 0 05:45:46 INFO - TEST-OK | kraken | took 60263ms 05:45:46 INFO - SUITE-END | took 1175s 05:45:46 INFO - Completed test suite (00:19:35) 05:45:46 INFO - javascript benchmark 05:45:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7358.044894965036, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2909.781766367522, 3472.6700963408475, 3494.580650321962, 3503.456964170554, 3510.19265568919, 4903.264510323454, 5864.0324346482885, 5895.086261629449, 5902.704864756761, 5945.583809133363, 5975.492083172925, 5999.370066143058, 6082.330943596212, 6089.791226975012, 6108.511319094473, 5375.274337964373, 5446.91829622556, 5471.288732464774, 5553.305836770403, 5575.581831362664, 5516.089845175541, 5526.972365138168, 5591.9720401397935, 5596.132599447093, 5599.1041433370665, 4623.930641040387, 5344.412114667403, 5441.29263195782, 5442.074847275972, 5445.918311225335, 4633.86098417048, 5336.599755018389, 5389.676619402849, 5495.560355171577, 5527.834164975057, 5438.755256013489, 5448.727563621843, 5481.534069604048, 5481.561475081984, 5487.341519017744, 5742.712864356766, 6068.423499767559, 6087.969560152215, 6104.542159338067, 6112.113743507167, 6224.190855188842, 6277.569902034707, 6331.8733625327695, 6354.015127655221, 6355.586886852339, 5534.335879694462, 6258.561900666955, 6344.397282258178, 6434.742610295582, 6436.613803171825, 6100.207047561361, 6163.167972323679, 6170.81487555374, 6175.938240617626, 6183.84540386494, 6532.477401807844, 6580.374864387875, 6580.967095164494, 6607.504437167232, 6639.966800165968, 6193.071039344134, 6236.345183755731, 6272.310045895039, 6386.457151142205, 6390.169277993831, 6272.2473303203, 6296.43332100104, 6325.746970121236, 6341.080543321193, 6401.647909364937, 6290.0, 6345.1434056401795, 6355.555111142268, 6357.4914006879335, 6390.392912673288, 5920.407959204132, 6328.0, 6343.9365606343345, 6347.238331400169, 6349.047642853517, 5076.568491678248, 5153.149730294459, 5153.407358153785, 5169.948300517022, 5210.348706411699, 4600.35595016698, 4643.0, 4645.488996210414, 4652.488226295105, 4674.439067311944, 6025.975584150705, 6086.573939824169, 6101.237345331833, 6105.908411373833, 6113.633182009094, 6240.968795155995, 6293.496520278367, 6305.779297724557, 6360.968195158995, 6385.744570217233, 5103.795848166106, 6090.878182436327, 6094.177286066324, 6096.055111457731, 6097.908531372033, 5575.107982722826, 5658.151277308354, 5659.037963546207, 5662.85842853932, 5670.0, 6337.207849018872, 6447.065175549613, 6473.061406096184, 6513.674316284261, 6572.0, 6334.588251763621, 6378.489720822416, 6389.456896163878, 6390.616563006049, 6395.328490508616, 5502.339719233718, 5569.498745112959, 6509.218893732783, 6545.869082618226, 6548.279689234276, 5416.404195538409, 6261.186045814015, 6309.211348581427, 6324.715387807468, 6375.776847810304, 5393.27190829233, 6351.809445716636, 6381.744730210925, 6416.13382193398, 6418.486521078209, 6335.208098987627, 6375.203099612549, 6375.808725738235, 6376.426121649074, 6381.776637817654, 5098.566621837185, 6012.969935150296, 6208.689565521796, 6209.565330427007, 6213.720382582705, 4706.176419126571, 5909.172715819875, 6236.968815155895, 6256.687165641791, 6302.117703521419, 6283.120363149254, 6318.0, 6334.3665633436285, 6345.206849143857, 6348.523860710373, 6142.815715528542, 6164.630122192682, 6205.22434695663, 6207.534434917309, 6300.59046161998], "value": 5852.876829444157, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.7193255978972, 502.37454369310205, 502.8918782461772, 516.233393410785, 533.1443033930541, 37635.81182094089, 40266.59066932658, 40439.393409098884, 40446.0, 40503.392449113286, 41639.37540936881, 42119.0, 42276.57723422765, 42298.0, 42324.15351692964, 9467.479288639122, 9550.997145299747, 9626.181774549137, 9675.661351852686, 9679.080487353725, 9615.903840961571, 9618.855717164248, 9631.66289179879, 9634.56644450998, 9649.179819715333, 9657.806843863118, 9676.75808104796, 9733.951330243339, 9749.610015599368, 9770.755731106708, 9660.420374777535, 9687.564059617334, 9694.321397502143, 9736.075072868067, 9809.558569864374, 8363.540005299707, 8611.009733880559, 9577.952110239474, 9631.662891798753, 9668.613255469772, 34082.97751067472, 36248.093797655005, 39402.80298598488, 39728.40407393892, 39821.80089099565, 3385.8984230473125, 3425.5546778918583, 3594.1733401317842, 3957.960420395817, 3999.460072890152, 22856.428589285235, 31409.84295078533, 32025.6797432025, 32740.508892366634, 32765.6723432765, 2667.5198464276423, 3265.6081270247487, 3272.6072871255365, 3311.106001379638, 3335.7664963452567, 363921.0, 402921.0, 404150.0, 404552.0, 405792.0, 33042.17394565155, 33887.322253555285, 34654.653453465144, 56977.14534281989, 57450.13824792631, 34585.65414345875, 34833.30333393318, 34986.12534686653, 35026.82486587551, 35060.0, 14696.632584185481, 14822.481213157487, 14856.851431485547, 14866.0, 14874.702505949821, 10574.788504230026, 12115.939420302842, 12499.875001250053, 12600.495980160875, 12626.810597840857, 7546.547207167588, 7698.884516732253, 7710.34462070719, 7750.379969602418, 7760.0, 2777.8194417362806, 3172.7303179230025, 3200.391925534141, 3235.0780027691994, 3253.5933008373954, 897.4839467306325, 956.063058202965, 967.7580604848788, 984.5126662302206, 996.9601215951426, 25926.0, 28955.276118097216, 29308.413831723246, 30047.849760751495, 30791.0, 959.9856002159974, 1041.141058626636, 1053.4732633683159, 1072.9141668666489, 1133.926294790836, 15290.541283761506, 15787.0, 15792.842071579367, 15817.05097694142, 15832.68334633301, 691579.0, 694668.0, 698441.0, 700760.0, 702307.0, 58016.70991645015, 58388.41611583915, 58902.705486472296, 59016.0, 59384.0, 1368.835739711241, 1399.7690381087007, 1404.3259235566782, 1405.2341473896752, 1414.7736362182206, 26067.348316292246, 28430.004949826656, 29276.268093297836, 29826.55260171056, 30352.55360739812, 44351.77824110859, 45428.77285613551, 48987.75506122589, 48989.0, 49250.01499970052, 519624.0, 521279.0, 594692.0265398645, 594868.0, 595830.0, 21740.673889891346, 25770.613440798777, 26066.609000864624, 26122.477550449265, 26146.607800883383, 46601.0, 46969.765151175394, 47017.52982470268, 47835.56493305206, 48442.757786210845, 32476.0, 33461.665383345855, 40077.37711422975, 40105.79947100246, 41148.382774257814, 31745.888893889525, 37498.625013749515, 38844.80577597094, 38878.611213887496, 40272.395914060726, 38273.808630956664, 38404.80797595994, 39227.62703305485, 39331.410028850165, 40540.59459405486, 29154.0, 31462.52806207863, 35229.0, 35240.647593524765, 35351.823240883634, 24367.634485482376, 24523.63214551819, 26038.0, 26288.737112629395, 26567.33581660474], "value": 18274.961048153484, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.29083450609323, 380.2565983502253, 381.92743378758036, 393.48060560060696, 397.8388752555216, 19204.71192932107, 21804.563908721855, 21821.890890545546, 22114.778852211493, 22272.55454890901, 16697.415590454337, 17448.651026979485, 20430.795692043073, 21461.141554337806, 21549.922503874823, 5610.747516361764, 5902.586818922677, 5933.19901813254, 5977.1034344848185, 6021.208707777356, 4131.21506913687, 5858.853528661796, 5910.586258961875, 5913.639862831551, 6237.282712488054, 6436.581622194542, 6556.344365563453, 6558.409743123118, 6574.3754343337305, 6574.769883054094, 6431.581947173466, 6442.291347951745, 6501.967490162542, 6566.901496477557, 6573.342665733437, 5607.887842243133, 5670.886582268373, 5696.6866822324755, 5701.429857014306, 5707.914381284284, 20804.583908321747, 25916.222513324443, 26158.476830463474, 26180.73819261802, 26430.86784566065, 2292.415434064303, 2385.7017872765905, 2421.406755344934, 2512.522620702061, 2922.4885645012037, 14191.858081419261, 14386.237690866328, 15651.373945042185, 15837.841621583751, 15981.961172523865, 1826.5068431523548, 1856.6101118765075, 1888.254139614858, 1914.5883635018538, 1940.2045161483725, 111815.0, 115032.0, 115107.27339089921, 115140.42429787881, 115330.84669153369, 10648.094911932418, 10697.786044279226, 10829.29609575375, 11141.387223702774, 11376.772464550828, 13579.592612221451, 13762.793558096637, 13881.861181388258, 13890.930545347208, 13910.165390076629, 7025.0, 8633.69782057625, 8644.222020018104, 8823.073577274423, 8863.955680221557, 8536.402451828313, 8672.56637168139, 8715.172058654418, 8839.29285657146, 8862.0, 5243.9213411798855, 6586.27550969393, 6711.664416779142, 6716.83207919806, 6723.260441351447, 1600.5438450041681, 1699.0994772770453, 1871.6631006418975, 1871.7753869535743, 1902.0869982408244, 733.9412846972336, 807.7778610882054, 868.1231955724763, 891.5734824281099, 895.6775560798108, 20515.38453846387, 21162.047707853184, 21943.561128777335, 21944.341669749934, 22012.559748804935, 797.6211299632744, 880.9296704504059, 958.6884262614678, 970.8009857979098, 1033.3231733214757, 8897.599608017656, 11123.499442525106, 11364.920174021709, 11500.137489688306, 11568.0, 449676.0, 501203.0, 515889.0, 577900.0, 608574.0, 102354.95290094157, 126244.36877815552, 149638.0, 150936.0, 152128.0, 864.9956750216082, 981.8870829854516, 1002.0830939690102, 1010.1716592394313, 1025.6666583360288, 17784.73322900132, 19704.719193252393, 20110.49723756918, 20185.798142018393, 20226.39320820378, 54828.45171548393, 55138.621534461956, 55883.72058139683, 56233.0, 56796.0, 81751.59124204579, 81876.3624727514, 82746.75879861927, 83272.58363708385, 83351.51234429562, 7896.131425543301, 7921.683132674629, 8057.476264042818, 8061.798455038671, 8116.75649730509, 12485.384626866444, 12525.616034387891, 12608.306543140216, 12953.870461295643, 12955.935220323838, 10871.184661150288, 11154.051905588116, 11197.66407007791, 11242.606508772154, 11345.489452974802, 10659.94670026645, 11038.073802461497, 11202.83195752048, 11661.35862527569, 11730.472128754398, 11497.252678575866, 11712.824307635563, 11856.525738970344, 11885.0, 11961.521539138337, 7998.760037198661, 8198.0, 8215.671373145246, 8262.876056859272, 8380.790480238044, 9886.50567471638, 11105.500252488819, 11386.861313868547, 11395.316281023164, 11633.243839150427], "value": 9830.441478252358, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.5786050975473, 1531.096652974745, 1734.1502663694785, 1853.6107417442345, 1864.8135186481345, 7836.960815195916, 8136.1050284468665, 8289.08820029797, 8825.646974121035, 8832.160944710251, 6956.860862782754, 6979.511434199608, 8583.442076265053, 8660.437071590342, 8685.305175585954, 2313.2944451942194, 2349.4126468382906, 2355.882205889707, 2363.0075368345338, 2363.4800343924308, 2323.9419014524688, 2326.8720220387872, 2379.6668466414717, 2380.6310021946624, 2382.95234095318, 2341.84777989431, 2353.2704861492907, 2359.245041586693, 2366.503034362786, 2373.774491423321, 2316.096722278313, 2320.1995311617466, 2334.941626459335, 2337.5909215887236, 2358.327876555191, 1778.7509748635202, 2129.55279391328, 2341.1688850458013, 2344.4138965258685, 2354.446705024318, 8660.783480412978, 8676.913230867674, 8702.347323950666, 8774.73675789721, 8782.868256976151, 4536.455625324949, 5021.39743230811, 5114.974425127851, 5281.9207711884355, 5285.022270879899, 2846.4307138572162, 3460.653934606544, 3508.1888693935084, 3611.656892595199, 3743.569489508714, 1041.44282808697, 1064.2550214849637, 1080.7460246841986, 1082.5940272397852, 1082.7563798145434, 9706.61173553057, 11429.885471187858, 11545.499085118881, 11558.884411155948, 11589.478473468715, 4530.750808705487, 4675.158471475167, 4725.503822098699, 4793.5685788279225, 4797.616190704735, 9713.805723885484, 9732.367396119229, 9825.803483930424, 9848.655297064712, 9853.408795472295, 5183.922241166386, 5251.789928402897, 5256.342957130359, 5264.105102132647, 5268.28878101459, 4343.457067866517, 4684.273937539687, 4740.004599034241, 4823.975880120577, 4838.322634831126, 3729.6270372962485, 3816.2749077675153, 3857.1514266861245, 3863.1307955710304, 3920.4119382092913, 1283.1531189415127, 1296.857345691973, 1301.947922083106, 1304.8890844278342, 1305.4060402516832, 921.6774129054777, 930.50683137937, 940.5532372123323, 958.2908647600725, 970.9563069661882, 4729.266963620645, 5722.599418040697, 5943.821685349447, 6019.2175017248355, 6064.848378790477, 954.71358592422, 961.6057416459219, 975.2782940624029, 978.3347323819728, 990.9842411528098, 3913.3934240192816, 4019.5351199040124, 4124.649404800565, 4148.253314403436, 4148.8133034012935, 10352.741181470523, 10741.570337186426, 10791.136709063256, 10796.0, 10809.40548269837, 10746.032857042903, 10755.516001779939, 10764.677059688065, 10804.891951080388, 10805.891941080647, 7691.730789422343, 8072.152423995513, 8100.927643784787, 8179.591020448954, 8242.516347057468, 5777.0, 5855.3559108498885, 5982.820515384546, 5984.311804142405, 6005.759769609167, 9819.410835349901, 9960.954099819415, 10007.249456290661, 10068.0, 10086.79826403453, 9038.864417033617, 9928.0, 10002.499875006366, 10093.243006774668, 10224.0, 6520.7391704333195, 6875.140607424072, 6929.7228110875, 7119.572825630479, 7131.179914309713, 8360.163983601591, 8419.031811341529, 8491.5329656867, 8493.278071364004, 8500.97988241415, 7441.255874412515, 7549.0941087069905, 7582.279683430065, 7668.118166410711, 7702.5763583001235, 7274.127104747464, 7355.264473552602, 7393.482456228013, 7507.986421832983, 7514.398848092249, 6927.3419025192525, 7038.2609825969585, 7044.15470143586, 7046.964765176142, 7062.682179302046, 4666.696664716783, 4918.286848407032, 4972.378452693413, 5101.234814777813, 5161.277421161116, 4404.933925991048, 4934.259861020875, 4950.8267210647455, 4972.651914366104, 5192.740362981911], "value": 4552.82622388893, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.15716471543993, 264.54498262987664, 307.7522594311579, 316.38463189097206, 319.66594908320803, 5729.369769325376, 5848.67832269225, 5852.970735146329, 5861.765529378825, 5879.617824841383, 4626.65300102492, 5658.009848276545, 5703.714814259291, 5706.543476521879, 5748.396418376073, 3568.8572457101814, 3810.8757916414725, 3913.823877925486, 4306.397104405386, 4342.023044814907, 4308.526062133163, 4329.0, 4338.652907767371, 4345.8478953236645, 4352.93353128484, 3735.2359254151866, 3817.4464702618243, 4034.5475628773765, 4076.266272071026, 4322.84870029549, 3781.6029316921877, 3948.4472173895533, 3992.580779018205, 4042.8787136385954, 4323.524412314643, 3710.2579484103017, 3724.571674257468, 3729.515163028816, 3732.5520937487404, 3734.047817806442, 5556.527695145917, 5566.803137325454, 5584.5811564132855, 5627.831165065014, 5650.547956163538, 4774.092922344744, 4963.305137280783, 5029.673071250357, 5046.1421558334805, 5063.822766203202, 5242.318498595197, 5647.463490968352, 6033.4871535919065, 6040.275166979946, 6044.395560443964, 3402.8468718907707, 3585.4621806728937, 4158.334666453383, 4175.791210439465, 4189.476315460567, 5297.973510132463, 5574.554035677136, 5891.79378721747, 6314.463270622003, 6389.488840892764, 3561.5370001899587, 3627.347077526018, 3817.255635151119, 4196.748195108304, 4218.261804184255, 3864.7101467390057, 3989.840406383712, 4391.8682439526865, 4392.616325857345, 4413.889652758642, 4202.432671589297, 4436.173520951594, 4732.645051621143, 5084.694918304914, 5100.668456550312, 6113.484746270823, 6121.418465245794, 6124.703236286393, 6137.355577664371, 6170.845728856814, 1375.8624137586162, 1388.8819500302152, 1463.9121652700871, 1490.2772155504572, 1492.1497343294454, 838.3125836813754, 901.8602116671926, 908.5956749246521, 922.7831459606987, 929.3401684803865, 5281.656692314988, 5382.623216374816, 5617.550595952314, 5636.323641163087, 5654.984960677964, 5559.388467268597, 6275.341089185661, 6278.277998030194, 6305.464035556937, 6312.715927783261, 4791.856244312677, 5005.798608333974, 5085.160948443466, 5627.352854421794, 5683.9715801420725, 2656.72104429036, 2702.932426689309, 2732.961474639664, 2991.5512673098774, 3250.2686895448337, 5626.43735626434, 5694.886102277931, 6288.748450062038, 6505.642189679613, 6517.641529715911, 5347.566857080019, 6361.650109244036, 6416.294207637156, 6441.742330306829, 6459.806205813833, 5044.9495505045215, 6127.356627554132, 6468.029795530708, 6471.579347342407, 6517.674116294166, 4743.335932969456, 5564.304461942257, 5871.570630159968, 6247.875042499216, 6296.5592408530965, 5237.46471131992, 5740.454656807597, 5911.822645320647, 6071.878562428638, 6206.317305096345, 5053.231369020813, 5330.081170778439, 5975.611585246945, 6056.70167448215, 6531.836704082436, 3132.765042621858, 3135.5296705494357, 3159.9256252874134, 3598.4990431649753, 3621.3300539400293, 4697.553732395417, 5023.648344615842, 5345.65253258537, 5354.848707527744, 5360.678359298455, 3935.5670876204167, 4574.565416285448, 5022.723750193628, 5200.4279529251, 5212.843614691566, 4341.415383385105, 4380.189664912002, 5056.191009438472, 5129.0, 5180.171172612364, 4197.664186865105, 4667.529728135626, 4743.881402964954, 5054.368203974504, 5725.312962444534, 5814.476697097281, 6037.335893051673, 6052.515798736179, 6078.170752425944, 6096.542759293159, 5207.791688332576, 5348.171033489815, 5433.320834895638, 5497.87293604802, 5590.552755779447], "value": 4219.384161636475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.6757325416936, 728.6174758251917, 776.3323541754093, 778.2256654628644, 778.5367706214801, 15307.311170997318, 15710.057396556214, 15864.68270634588, 15873.84126158738, 15896.20518974051, 11265.549378024869, 14235.572932812032, 14326.0, 14340.928295358508, 14362.928185359058, 689.7241103558566, 692.5567636712508, 844.5988155626089, 868.8132051608903, 872.3283072034529, 863.5768473447997, 877.5085951866943, 878.0429332028089, 879.0155026370473, 882.0297672560197, 781.7928249014016, 937.2501998401286, 937.7374335186124, 939.1359948847042, 942.7171848445473, 926.0137953080016, 929.3773171974793, 931.352709866643, 931.8322701913653, 933.0436302789661, 681.158768920383, 688.9276625954303, 696.314130581377, 696.7561353526226, 699.5068476723898, 14504.70990580193, 14696.26518674062, 14757.18835464049, 14758.48345307909, 14760.557183284518, 14573.0, 14657.267136643126, 14689.853101468956, 14739.263036848115, 14891.47879824201, 11994.940025299818, 12265.38673066352, 12502.312372819491, 12516.81224781629, 12624.17942833713, 3826.5025546678753, 3857.4792403025513, 4057.634812866856, 4083.2241874044134, 4088.8364465421346, 111411.0, 112965.0, 113370.43314783456, 114328.85671143266, 119520.40239798745, 11285.153613478858, 11354.0, 11380.089592832554, 11381.0, 11673.949344558861, 23130.884345578164, 23530.76469235286, 23600.64599031016, 23670.289891303288, 23811.285661430185, 7946.562939038408, 8007.199280071946, 8028.624399702177, 8053.395995300259, 8076.919230807616, 4285.871423857289, 4428.911421771547, 4437.711548749321, 4452.1763473757455, 4469.217886869785, 3444.586649602064, 3550.260372417497, 3551.964480355215, 3593.8742144025355, 3599.280143971216, 518.4659800405589, 584.0305093544696, 592.9031292109563, 594.0821430889287, 658.8122385120217, 504.7249249159217, 585.2771826793906, 607.9270487541523, 676.9507263741182, 691.930806919304, 8695.521746304014, 9989.450580218157, 10220.744481388025, 10543.578256869792, 10874.67375978722, 655.4756195043946, 678.2031113441686, 691.1567887177636, 710.1407297170379, 722.4870342057093, 4453.19842428366, 4596.724196548218, 4798.808047678054, 4818.614510839125, 4878.707277563358, 141515.5848441523, 147598.0, 163472.0, 169979.0, 171597.0, 117170.41414792872, 134706.65293346942, 136490.31754841164, 137313.0, 137866.0, 78014.60992695, 80579.0, 99361.0, 103158.42103947462, 109904.90095099107, 8890.621953597203, 8941.239994600532, 9251.306152038489, 9482.241420686467, 9542.809143817223, 56686.58283542944, 59730.0, 60228.49428764316, 61105.69447152736, 66920.33079669336, 63505.682471587344, 64375.71248575096, 84109.0, 88413.0, 90714.18571628399, 13487.572236997043, 13579.86420135786, 13666.248356340497, 13787.379567919266, 14094.647633809236, 12183.451744671334, 13473.989450791425, 14039.649008774453, 14883.925580372028, 15178.316975735897, 14076.577702668936, 14088.225147616979, 14134.78797818013, 14528.491502797351, 14548.49080282185, 9943.801123977335, 13219.405126769127, 13883.791743123658, 14015.719685606027, 14601.269936503344, 11736.647900562997, 13538.729225415633, 13803.654908627364, 14247.449423294007, 14288.642783930485, 10667.413292269, 10845.891541084487, 11025.889741102807, 11085.0, 11334.94332528332, 9994.450305233282, 10523.94738026305, 11483.770324593628, 11783.175177737476, 11789.882101178879], "value": 7856.045601870383, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1605.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 120.0, 106.0, 118.0, 120.0, 116.0, 116.0, 118.0, 116.0, 106.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 149.0, 144.0, 168.0, 108.0, 126.0, 133.0, 110.0, 161.0, 114.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 199.0, 205.0, 238.0, 201.0, 230.0, 281.0, 196.0, 270.0, 278.0], "value": 230.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 84.0, 76.0, 147.0, 64.0, 62.0, 59.0, 65.0, 138.0, 60.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 126.0, 72.0, 73.0, 82.0, 117.0, 71.0, 88.0, 153.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 90.0, 77.0, 138.0, 121.0, 89.0, 88.0, 132.0, 88.0], "value": 100.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 154.0, 94.0, 96.0, 96.0, 95.0, 105.0, 95.0, 136.0, 152.0], "value": 111.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 134.0, 91.0, 93.0, 93.0, 90.0, 99.0, 92.0, 132.0, 154.0], "value": 112.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 56.0, 58.0, 56.0, 57.0, 57.0, 56.0, 56.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 77.0, 69.0, 75.0, 82.0, 66.0, 76.0, 97.0, 103.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 81.0, 76.0, 105.0, 105.0, 109.0, 103.0, 87.0, 88.0], "value": 92.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 163.0, 146.0, 151.0, 134.0, 165.0, 162.0, 149.0, 136.0, 159.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 175.0, 168.0, 165.0, 170.0, 225.0, 226.0, 185.0, 150.0, 145.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 66.0, 69.0, 68.0, 65.0, 66.0, 68.0, 68.0, 60.0], "value": 66.7, "unit": "score"}]}]} 05:45:46 INFO - Return code: 0 05:45:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:45:46 ERROR - # TBPL SUCCESS # 05:45:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:45:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:45:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:45:46 INFO - 2016-08-08 05:45:46.540 screenresolution[1672:10629] starting screenresolution argv=screenresolution get 05:45:46 INFO - 2016-08-08 05:45:46.542 screenresolution[1672:10629] Display 0: 1600x1200x32@60 05:45:46 INFO - 2016-08-08 05:45:46.548 screenresolution[1673:10632] starting screenresolution argv=screenresolution list 05:45:46 INFO - Available Modes on Display 0 05:45:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:45:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:45:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:45:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:45:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:45:46 INFO - Intel Iris: 05:45:46 INFO - Chipset Model: Intel Iris 05:45:46 INFO - Type: GPU 05:45:46 INFO - Bus: Built-In 05:45:46 INFO - VRAM (Dynamic, Max): 1536 MB 05:45:46 INFO - Vendor: Intel (0x8086) 05:45:46 INFO - Device ID: 0x0a2e 05:45:46 INFO - Revision ID: 0x0009 05:45:46 INFO - Displays: 05:45:46 INFO - Display: 05:45:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:45:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:45:46 INFO - Display Serial Number: 1600x1200 60 05:45:46 INFO - Main Display: Yes 05:45:46 INFO - Mirror: Off 05:45:46 INFO - Online: Yes 05:45:46 INFO - Rotation: Supported 05:45:46 INFO - Return code: 0 05:45:46 INFO - Running post-action listener: _resource_record_post_action 05:45:46 INFO - [mozharness: 2016-08-08 12:45:46.790076Z] Finished run-tests step (success) 05:45:46 INFO - Running post-run listener: _resource_record_post_run 05:45:46 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 38257664; Write bytes: 710573568; Read time: 390; Write time: 2014 05:45:46 INFO - TinderboxPrint: CPU usage
54.4% 05:45:46 INFO - TinderboxPrint: I/O read bytes / time
38,257,664 / 390 05:45:46 INFO - TinderboxPrint: I/O write bytes / time
710,573,568 / 2,014 05:45:46 INFO - TinderboxPrint: CPU idle
2,209.3 (45.6%) 05:45:46 INFO - TinderboxPrint: CPU system
983.9 (20.3%) 05:45:46 INFO - TinderboxPrint: CPU user
1,652.4 (34.1%) 05:45:46 INFO - TinderboxPrint: Swap in / out
445,198,336 / 0 05:45:46 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 404718080; Write bytes: 398218752; Read time: 30011; Write time: 718 05:45:46 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 34636800; Write bytes: 297619456; Read time: 359; Write time: 1211 05:45:47 INFO - Running post-run listener: _upload_blobber_files 05:45:47 INFO - Blob upload gear active. 05:45:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:45:47 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 05:45:47 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:45:47 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:45:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:45:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:45:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:45:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:48 INFO - (blobuploader) - INFO - Done attempting. 05:45:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:45:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:45:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:49 INFO - (blobuploader) - INFO - Done attempting. 05:45:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:45:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:45:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:51 INFO - (blobuploader) - INFO - Done attempting. 05:45:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:45:51 INFO - Return code: 0 05:45:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:45:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:45:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad239562de0358705f6f22a6089cb1f906c0d9d4fea46cf6b504378af166674500812bf17fa93e1907ed8fb78ed59bb3b56f329f7f61de5de14c074e7a4fad8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fb4b8a8cbf172ad84cea1ddae32b8630a8a5d9533b051bd37ff019d55d9f1c82acd3292a7c67f709c8fb4d936ee86aeed9845f4ab44148d961440a648c06b5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae5a02c6ebad2216d86bf2bf45309c95a87adacf7fa4fb2dbb06c07f80ca74bc1bebc7aee4a339b047d1231f4574ab1f7c3ebd449c25a389b2cfe6f960dfe235"} 05:45:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:45:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:45:51 INFO - Contents: 05:45:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad239562de0358705f6f22a6089cb1f906c0d9d4fea46cf6b504378af166674500812bf17fa93e1907ed8fb78ed59bb3b56f329f7f61de5de14c074e7a4fad8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fb4b8a8cbf172ad84cea1ddae32b8630a8a5d9533b051bd37ff019d55d9f1c82acd3292a7c67f709c8fb4d936ee86aeed9845f4ab44148d961440a648c06b5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae5a02c6ebad2216d86bf2bf45309c95a87adacf7fa4fb2dbb06c07f80ca74bc1bebc7aee4a339b047d1231f4574ab1f7c3ebd449c25a389b2cfe6f960dfe235"} 05:45:51 INFO - Running post-run listener: copy_logs_to_upload_dir 05:45:51 INFO - Copying logs to upload dir... 05:45:51 INFO - mkdir: /builds/slave/test/build/upload/logs 05:45:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.399705 ========= master_lag: 0.87 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-08 05:45:52.807859) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 05:45:52.814741) ========= 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.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad239562de0358705f6f22a6089cb1f906c0d9d4fea46cf6b504378af166674500812bf17fa93e1907ed8fb78ed59bb3b56f329f7f61de5de14c074e7a4fad8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fb4b8a8cbf172ad84cea1ddae32b8630a8a5d9533b051bd37ff019d55d9f1c82acd3292a7c67f709c8fb4d936ee86aeed9845f4ab44148d961440a648c06b5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae5a02c6ebad2216d86bf2bf45309c95a87adacf7fa4fb2dbb06c07f80ca74bc1bebc7aee4a339b047d1231f4574ab1f7c3ebd449c25a389b2cfe6f960dfe235"} build_url:https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011105 build_url: 'https://queue.taskcluster.net/v1/task/MrHUC6uTSviN_bWKDhUMCA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad239562de0358705f6f22a6089cb1f906c0d9d4fea46cf6b504378af166674500812bf17fa93e1907ed8fb78ed59bb3b56f329f7f61de5de14c074e7a4fad8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fb4b8a8cbf172ad84cea1ddae32b8630a8a5d9533b051bd37ff019d55d9f1c82acd3292a7c67f709c8fb4d936ee86aeed9845f4ab44148d961440a648c06b5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae5a02c6ebad2216d86bf2bf45309c95a87adacf7fa4fb2dbb06c07f80ca74bc1bebc7aee4a339b047d1231f4574ab1f7c3ebd449c25a389b2cfe6f960dfe235"}' ========= master_lag: 0.67 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 05:45:53.493874) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:45:53.494201) ========= 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.QLxUvP7lJ4/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.4jdTtnTgUB/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005286 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:45:53.524293) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 05:45:53.524618) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 05:45:53.524930) ========= ========= Total master_lag: 1.64 =========