builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0071 starttime: 1471988980.31 results: success (0) buildid: 20160823114814 builduid: 5735b99542ef4d80920bca28f12ee019 revision: 5bde9ecced2bce88700dec6f5a8beeeb98766774 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 14:49:40.312260) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 14:49:40.312687) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 14:49:40.312977) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 14:49:40.341273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:49:40.341656) ========= 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.xfOuIih9f2/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.Nhrj80MsmN/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-23 14:49:40-- 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% 15.2M=0.001s 2016-08-23 14:49:40 (15.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140671 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:49:40.505813) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:49:40.506199) ========= 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.xfOuIih9f2/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.Nhrj80MsmN/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.027411 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 14:49:40.558428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 14:49:40.560845) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 5bde9ecced2bce88700dec6f5a8beeeb98766774 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 5bde9ecced2bce88700dec6f5a8beeeb98766774 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xfOuIih9f2/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.Nhrj80MsmN/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-23 14:49:40,632 truncating revision to first 12 chars 2016-08-23 14:49:40,632 Setting DEBUG logging. 2016-08-23 14:49:40,632 attempt 1/10 2016-08-23 14:49:40,632 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/5bde9ecced2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 14:49:41,670 unpacking tar archive at: autoland-5bde9ecced2b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.287970 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 14:49:41.874173) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 14:49:41.874901) ========= script_repo_revision: 5bde9ecced2bce88700dec6f5a8beeeb98766774 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 14:49:41.875825) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 14:49:41.876480) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 14:49:41.896164) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-23 14:49:41.896564) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xfOuIih9f2/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.Nhrj80MsmN/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 14:49:42 INFO - MultiFileLogger online at 20160823 14:49:42 in /builds/slave/test 14:49:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 14:49:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:49:42 INFO - {'append_to_log': False, 14:49:42 INFO - 'base_work_dir': '/builds/slave/test', 14:49:42 INFO - 'blob_upload_branch': 'Autoland', 14:49:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:49:42 INFO - 'branch': 'Autoland', 14:49:42 INFO - 'buildbot_json_path': 'buildprops.json', 14:49:42 INFO - 'config_files': ('talos/mac_config.py',), 14:49:42 INFO - 'default_actions': ('clobber', 14:49:42 INFO - 'read-buildbot-config', 14:49:42 INFO - 'download-and-extract', 14:49:42 INFO - 'populate-webroot', 14:49:42 INFO - 'create-virtualenv', 14:49:42 INFO - 'install', 14:49:42 INFO - 'run-tests'), 14:49:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:49:42 INFO - 'download_minidump_stackwalk': True, 14:49:42 INFO - 'download_symbols': 'ondemand', 14:49:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:49:42 INFO - 'tooltool.py': '/tools/tooltool.py', 14:49:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:49:42 INFO - '/tools/misc-python/virtualenv.py')}, 14:49:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:49:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:49:42 INFO - 'installer_path': 'installer.exe', 14:49:42 INFO - 'log_level': 'info', 14:49:42 INFO - 'log_name': 'talos', 14:49:42 INFO - 'log_to_console': True, 14:49:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:49:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:49:42 INFO - 'opt_config_files': (), 14:49:42 INFO - 'pip_index': False, 14:49:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:49:42 INFO - 'cmd': ('bash', 14:49:42 INFO - '-c', 14:49:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:49:42 INFO - 'enabled': True, 14:49:42 INFO - 'halt_on_failure': False, 14:49:42 INFO - 'name': 'check_screen_resolution'},), 14:49:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:49:42 INFO - 'cmd': ('bash', 14:49:42 INFO - '-c', 14:49:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:49:42 INFO - 'enabled': True, 14:49:42 INFO - 'halt_on_failure': False, 14:49:42 INFO - 'name': 'check_screen_resolution'},), 14:49:42 INFO - 'run_cmd_checks_enabled': True, 14:49:42 INFO - 'sps_profile': False, 14:49:42 INFO - 'sps_profile_interval': 0, 14:49:42 INFO - 'suite': 'dromaeojs-e10s', 14:49:42 INFO - 'system_bits': '32', 14:49:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:49:42 INFO - 'title': 't-yosemite-r7-0071', 14:49:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:49:42 INFO - 'use_talos_json': True, 14:49:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:49:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:49:42 INFO - 'work_dir': 'build'} 14:49:42 INFO - [mozharness: 2016-08-23 21:49:42.091446Z] Running clobber step. 14:49:42 INFO - Running pre-action listener: _resource_record_pre_action 14:49:42 INFO - Running main action method: clobber 14:49:42 INFO - rmtree: /builds/slave/test/build 14:49:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:49:44 INFO - Running post-action listener: _resource_record_post_action 14:49:44 INFO - [mozharness: 2016-08-23 21:49:44.261301Z] Finished clobber step (success) 14:49:44 INFO - [mozharness: 2016-08-23 21:49:44.261420Z] Running read-buildbot-config step. 14:49:44 INFO - Running pre-action listener: _resource_record_pre_action 14:49:44 INFO - Running main action method: read_buildbot_config 14:49:44 INFO - Using buildbot properties: 14:49:44 INFO - { 14:49:44 INFO - "project": "", 14:49:44 INFO - "product": "firefox", 14:49:44 INFO - "script_repo_revision": "production", 14:49:44 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 14:49:44 INFO - "repository": "", 14:49:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 14:49:44 INFO - "buildid": "20160823114814", 14:49:44 INFO - "pgo_build": "False", 14:49:44 INFO - "basedir": "/builds/slave/test", 14:49:44 INFO - "buildnumber": 142, 14:49:44 INFO - "slavename": "t-yosemite-r7-0071", 14:49:44 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 14:49:44 INFO - "platform": "yosemite_r7", 14:49:44 INFO - "scheduler": "tests-autoland-macosx64-talos-7-3600", 14:49:44 INFO - "branch": "autoland", 14:49:44 INFO - "repo_path": "integration/autoland", 14:49:44 INFO - "revision": "5bde9ecced2bce88700dec6f5a8beeeb98766774", 14:49:44 INFO - "stage_platform": "macosx64", 14:49:44 INFO - "builduid": "5735b99542ef4d80920bca28f12ee019", 14:49:44 INFO - "slavebuilddir": "test" 14:49:44 INFO - } 14:49:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 14:49:44 INFO - Running post-action listener: _resource_record_post_action 14:49:44 INFO - [mozharness: 2016-08-23 21:49:44.264710Z] Finished read-buildbot-config step (success) 14:49:44 INFO - [mozharness: 2016-08-23 21:49:44.264812Z] Running download-and-extract step. 14:49:44 INFO - Running pre-action listener: _resource_record_pre_action 14:49:44 INFO - Running main action method: download_and_extract 14:49:44 INFO - mkdir: /builds/slave/test/build/tests 14:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:44 INFO - trying https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 14:49:44 INFO - Downloading https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/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 14:49:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/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 14:49:45 INFO - Downloaded 1199 bytes. 14:49:45 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:49:45 INFO - Using the following test package requirements: 14:49:45 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:49:45 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:49:45 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 14:49:45 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:49:45 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 14:49:45 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:49:45 INFO - u'jsshell-mac.zip'], 14:49:45 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:49:45 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 14:49:45 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:49:45 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:49:45 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 14:49:45 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:49:45 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 14:49:45 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:49:45 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 14:49:45 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:49:45 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 14:49:45 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:45 INFO - trying https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:49:45 INFO - Downloading https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/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 14:49:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/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 14:49:46 INFO - Downloaded 16346223 bytes. 14:49:46 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 14:49:53 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 14:49:53 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')]} 14:49:53 INFO - trying https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:49:53 INFO - Downloading https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/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 14:49:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/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 14:49:54 INFO - Downloaded 16346223 bytes. 14:49:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 14:50:01 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')]} 14:50:01 INFO - trying https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:50:01 INFO - Downloading https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/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 14:50:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/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 14:50:02 INFO - Downloaded 14413981 bytes. 14:50:02 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 14:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:02 INFO - trying https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:50:02 INFO - Downloading https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 14:50:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/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 14:50:05 INFO - Downloaded 111512422 bytes. 14:50:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:50:05 INFO - mkdir: /builds/slave/test/properties 14:50:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:50:05 INFO - Writing to file /builds/slave/test/properties/build_url 14:50:05 INFO - Contents: 14:50:05 INFO - build_url:https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:50:05 INFO - Running post-action listener: _resource_record_post_action 14:50:05 INFO - Running post-action listener: set_extra_try_arguments 14:50:05 INFO - [mozharness: 2016-08-23 21:50:05.917135Z] Finished download-and-extract step (success) 14:50:05 INFO - [mozharness: 2016-08-23 21:50:05.917279Z] Running populate-webroot step. 14:50:05 INFO - Running pre-action listener: _resource_record_pre_action 14:50:05 INFO - Running main action method: populate_webroot 14:50:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:50:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:50:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:50:05 INFO - '--tppagecycles', 14:50:05 INFO - '7'], 14:50:05 INFO - 'tests': ['tsvgm']}}, 14:50:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:50:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:50:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:50:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:50:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:50:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:50:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:05 INFO - 'talos_options': ['--disable-e10s'], 14:50:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:50:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:50:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:05 INFO - 'talos_options': ['--disable-e10s'], 14:50:05 INFO - 'tests': ['damp', 'tps']}, 14:50:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:05 INFO - 'tests': ['damp', 'tps']}, 14:50:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:50:05 INFO - 'tests': ['dromaeo_dom']}, 14:50:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:50:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:50:05 INFO - 'tests': ['basic_compositor_video']}, 14:50:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:50:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:50:05 INFO - 'tests': ['a11yr', 14:50:05 INFO - 'ts_paint', 14:50:05 INFO - 'tpaint', 14:50:05 INFO - 'sessionrestore', 14:50:05 INFO - 'sessionrestore_no_auto_restore', 14:50:05 INFO - 'tabpaint']}, 14:50:05 INFO - 'other-e10s': {'tests': ['a11yr', 14:50:05 INFO - 'ts_paint', 14:50:05 INFO - 'tpaint', 14:50:05 INFO - 'sessionrestore', 14:50:05 INFO - 'sessionrestore_no_auto_restore', 14:50:05 INFO - 'tabpaint']}, 14:50:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:50:05 INFO - 'ts_paint', 14:50:05 INFO - 'tpaint', 14:50:05 INFO - 'sessionrestore', 14:50:05 INFO - 'sessionrestore_no_auto_restore', 14:50:05 INFO - 'tabpaint']}, 14:50:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:50:05 INFO - 'ts_paint', 14:50:05 INFO - 'tpaint', 14:50:05 INFO - 'sessionrestore', 14:50:05 INFO - 'sessionrestore_no_auto_restore', 14:50:05 INFO - 'tabpaint']}, 14:50:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:50:05 INFO - 'tests': ['a11yr', 14:50:05 INFO - 'ts_paint', 14:50:05 INFO - 'tpaint', 14:50:05 INFO - 'sessionrestore', 14:50:05 INFO - 'sessionrestore_no_auto_restore', 14:50:05 INFO - 'tabpaint']}, 14:50:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:50:05 INFO - 'tests': ['a11yr', 14:50:05 INFO - 'ts_paint', 14:50:05 INFO - 'tpaint', 14:50:05 INFO - 'sessionrestore', 14:50:05 INFO - 'sessionrestore_no_auto_restore', 14:50:05 INFO - 'tabpaint']}, 14:50:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:50:05 INFO - 'tests': ['tsvgx', 14:50:05 INFO - 'tsvgr_opacity', 14:50:05 INFO - 'tart', 14:50:05 INFO - 'tscrollx', 14:50:05 INFO - 'cart']}, 14:50:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:50:05 INFO - 'tsvgr_opacity', 14:50:05 INFO - 'tart', 14:50:05 INFO - 'tscrollx', 14:50:05 INFO - 'cart']}, 14:50:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:05 INFO - 'talos_options': ['--disable-e10s'], 14:50:05 INFO - 'tests': ['tp5o']}, 14:50:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:05 INFO - 'tests': ['tp5o']}, 14:50:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:05 INFO - 'talos_options': ['--disable-e10s', 14:50:05 INFO - '--xperf_path', 14:50:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:50:05 INFO - 'tests': ['tp5n']}, 14:50:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:05 INFO - 'talos_options': ['--xperf_path', 14:50:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:50:05 INFO - 'tests': ['tp5n']}}, 14:50:05 INFO - 'talos.zip': {'path': '', 14:50:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:50:05 INFO - Running post-action listener: _resource_record_post_action 14:50:05 INFO - [mozharness: 2016-08-23 21:50:05.936345Z] Finished populate-webroot step (success) 14:50:05 INFO - [mozharness: 2016-08-23 21:50:05.936487Z] Running create-virtualenv step. 14:50:05 INFO - Running pre-action listener: _resource_record_pre_action 14:50:05 INFO - Running main action method: create_virtualenv 14:50:05 INFO - Creating virtualenv /builds/slave/test/build/venv 14:50:05 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 14:50:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:50:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:50:06 INFO - Using real prefix '/tools/python27' 14:50:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:50:06 INFO - Installing distribute.............................................................................................................................................................................................done. 14:50:09 INFO - Installing pip.................done. 14:50:09 INFO - Return code: 0 14:50:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:50:09 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')]} 14:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:09 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')]} 14:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:09 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 0x10568ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b4b477f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055f2d30>, '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 0x105357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055eab20>, '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.xfOuIih9f2/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.Nhrj80MsmN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 14:50:09 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 14:50:09 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 14:50:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfOuIih9f2/Render', 14:50:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:50:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:50:09 INFO - 'HOME': '/Users/cltbld', 14:50:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:50:09 INFO - 'LOGNAME': 'cltbld', 14:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:09 INFO - 'MOZ_NO_REMOTE': '1', 14:50:09 INFO - 'NO_EM_RESTART': '1', 14:50:09 INFO - 'PAGER': '/bin/cat', 14:50:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:09 INFO - 'PWD': '/builds/slave/test', 14:50:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:50:09 INFO - 'SHELL': '/bin/bash', 14:50:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nhrj80MsmN/Listeners', 14:50:09 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:50:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:50:09 INFO - 'USER': 'cltbld', 14:50:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:50:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:09 INFO - 'XPC_FLAGS': '0x0', 14:50:09 INFO - 'XPC_SERVICE_NAME': '0', 14:50:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:09 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 14:50:09 INFO - Cleaning up... 14:50:09 INFO - Return code: 0 14:50:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:50:09 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')]} 14:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:09 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')]} 14:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:09 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 0x10568ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b4b477f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055f2d30>, '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 0x105357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055eab20>, '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.xfOuIih9f2/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.Nhrj80MsmN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 14:50:09 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 14:50:09 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 14:50:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfOuIih9f2/Render', 14:50:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:50:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:50:09 INFO - 'HOME': '/Users/cltbld', 14:50:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:50:09 INFO - 'LOGNAME': 'cltbld', 14:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:09 INFO - 'MOZ_NO_REMOTE': '1', 14:50:09 INFO - 'NO_EM_RESTART': '1', 14:50:09 INFO - 'PAGER': '/bin/cat', 14:50:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:09 INFO - 'PWD': '/builds/slave/test', 14:50:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:50:09 INFO - 'SHELL': '/bin/bash', 14:50:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nhrj80MsmN/Listeners', 14:50:09 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:50:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:50:09 INFO - 'USER': 'cltbld', 14:50:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:50:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:09 INFO - 'XPC_FLAGS': '0x0', 14:50:09 INFO - 'XPC_SERVICE_NAME': '0', 14:50:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:10 INFO - Downloading/unpacking psutil>=3.1.1 14:50:10 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 14:50:10 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 14:50:10 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 14:50:10 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 14:50:10 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 14:50:10 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 14:50:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:50:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:50:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:50:13 INFO - Installing collected packages: psutil 14:50:13 INFO - Running setup.py install for psutil 14:50:13 INFO - building 'psutil._psutil_osx' extension 14:50:13 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 14:50:13 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 14:50:13 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 14:50:13 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 14:50:14 INFO - building 'psutil._psutil_posix' extension 14:50:14 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 14:50:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:50:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:50:14 INFO - ^ 14:50:14 INFO - 1 warning generated. 14:50:14 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 14:50:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:50:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:50:14 INFO - Successfully installed psutil 14:50:14 INFO - Cleaning up... 14:50:14 INFO - Return code: 0 14:50:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:50:14 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')]} 14:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:14 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')]} 14:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:14 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 0x10568ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b4b477f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055f2d30>, '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 0x105357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055eab20>, '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.xfOuIih9f2/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.Nhrj80MsmN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 14:50:14 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 14:50:14 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 14:50:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfOuIih9f2/Render', 14:50:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:50:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:50:14 INFO - 'HOME': '/Users/cltbld', 14:50:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:50:14 INFO - 'LOGNAME': 'cltbld', 14:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:14 INFO - 'MOZ_NO_REMOTE': '1', 14:50:14 INFO - 'NO_EM_RESTART': '1', 14:50:14 INFO - 'PAGER': '/bin/cat', 14:50:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:14 INFO - 'PWD': '/builds/slave/test', 14:50:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:50:14 INFO - 'SHELL': '/bin/bash', 14:50:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nhrj80MsmN/Listeners', 14:50:14 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:50:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:50:14 INFO - 'USER': 'cltbld', 14:50:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:50:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:14 INFO - 'XPC_FLAGS': '0x0', 14:50:14 INFO - 'XPC_SERVICE_NAME': '0', 14:50:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:50:14 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 14:50:14 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 14:50:14 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 14:50:14 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 14:50:14 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 14:50:14 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 14:50:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:50:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:50:17 INFO - Installing collected packages: mozsystemmonitor 14:50:17 INFO - Running setup.py install for mozsystemmonitor 14:50:17 INFO - Successfully installed mozsystemmonitor 14:50:17 INFO - Cleaning up... 14:50:17 INFO - Return code: 0 14:50:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10568ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b4b477f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055f2d30>, '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 0x105357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055eab20>, '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.xfOuIih9f2/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.Nhrj80MsmN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 14:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:50:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfOuIih9f2/Render', 14:50:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:50:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:50:17 INFO - 'HOME': '/Users/cltbld', 14:50:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:50:17 INFO - 'LOGNAME': 'cltbld', 14:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:17 INFO - 'MOZ_NO_REMOTE': '1', 14:50:17 INFO - 'NO_EM_RESTART': '1', 14:50:17 INFO - 'PAGER': '/bin/cat', 14:50:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:17 INFO - 'PWD': '/builds/slave/test', 14:50:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:50:17 INFO - 'SHELL': '/bin/bash', 14:50:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nhrj80MsmN/Listeners', 14:50:17 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:50:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:50:17 INFO - 'USER': 'cltbld', 14:50:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:50:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:17 INFO - 'XPC_FLAGS': '0x0', 14:50:17 INFO - 'XPC_SERVICE_NAME': '0', 14:50:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:50:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:17 INFO - Downloading/unpacking jsonschema==2.5.1 14:50:17 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 14:50:17 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 14:50:17 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 14:50:17 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 14:50:17 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 14:50:17 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 14:50:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:50:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:50:19 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 14:50:19 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 14:50:19 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 14:50:19 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 14:50:19 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 14:50:19 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 14:50:20 INFO - Downloading functools32-3.2.3-2.tar.gz 14:50:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:50:20 INFO - warning: no files found matching '*.txt' 14:50:20 INFO - no previously-included directories found matching 'build' 14:50:20 INFO - no previously-included directories found matching 'dist' 14:50:20 INFO - no previously-included directories found matching '.git*' 14:50:20 INFO - Installing collected packages: jsonschema, functools32 14:50:20 INFO - Running setup.py install for functools32 14:50:20 INFO - warning: no files found matching '*.txt' 14:50:20 INFO - no previously-included directories found matching 'build' 14:50:20 INFO - no previously-included directories found matching 'dist' 14:50:20 INFO - no previously-included directories found matching '.git*' 14:50:20 INFO - Successfully installed jsonschema functools32 14:50:20 INFO - Cleaning up... 14:50:20 INFO - Return code: 0 14:50:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10568ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b4b477f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055f2d30>, '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 0x105357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055eab20>, '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.xfOuIih9f2/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.Nhrj80MsmN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 14:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:50:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfOuIih9f2/Render', 14:50:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:50:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:50:20 INFO - 'HOME': '/Users/cltbld', 14:50:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:50:20 INFO - 'LOGNAME': 'cltbld', 14:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:20 INFO - 'MOZ_NO_REMOTE': '1', 14:50:20 INFO - 'NO_EM_RESTART': '1', 14:50:20 INFO - 'PAGER': '/bin/cat', 14:50:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:20 INFO - 'PWD': '/builds/slave/test', 14:50:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:50:20 INFO - 'SHELL': '/bin/bash', 14:50:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nhrj80MsmN/Listeners', 14:50:20 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:50:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:50:20 INFO - 'USER': 'cltbld', 14:50:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:50:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:20 INFO - 'XPC_FLAGS': '0x0', 14:50:20 INFO - 'XPC_SERVICE_NAME': '0', 14:50:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:50:20 INFO - Cleaning up... 14:50:21 INFO - Return code: 0 14:50:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10568ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b4b477f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055f2d30>, '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 0x105357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055eab20>, '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.xfOuIih9f2/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.Nhrj80MsmN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 14:50:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:50:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:50:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfOuIih9f2/Render', 14:50:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:50:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:50:21 INFO - 'HOME': '/Users/cltbld', 14:50:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:50:21 INFO - 'LOGNAME': 'cltbld', 14:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:21 INFO - 'MOZ_NO_REMOTE': '1', 14:50:21 INFO - 'NO_EM_RESTART': '1', 14:50:21 INFO - 'PAGER': '/bin/cat', 14:50:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:21 INFO - 'PWD': '/builds/slave/test', 14:50:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:50:21 INFO - 'SHELL': '/bin/bash', 14:50:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nhrj80MsmN/Listeners', 14:50:21 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:50:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:50:21 INFO - 'USER': 'cltbld', 14:50:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:50:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:21 INFO - 'XPC_FLAGS': '0x0', 14:50:21 INFO - 'XPC_SERVICE_NAME': '0', 14:50:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:21 INFO - Downloading/unpacking blobuploader==1.2.4 14:50:21 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 14:50:21 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 14:50:21 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 14:50:21 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 14:50:21 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 14:50:21 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 14:50:23 INFO - Downloading blobuploader-1.2.4.tar.gz 14:50:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:50:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:50: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 14:50: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 14:50: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 14:50: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 14:50: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 14:50: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 14:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:50:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:50:24 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 14:50:24 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 14:50:24 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 14:50:24 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 14:50:24 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 14:50:24 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 14:50:24 INFO - Downloading docopt-0.6.1.tar.gz 14:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:50:24 INFO - Installing collected packages: blobuploader, requests, docopt 14:50:24 INFO - Running setup.py install for blobuploader 14:50:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:50:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:50:25 INFO - Running setup.py install for requests 14:50:25 INFO - Running setup.py install for docopt 14:50:25 INFO - Successfully installed blobuploader requests docopt 14:50:25 INFO - Cleaning up... 14:50:25 INFO - Return code: 0 14:50:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:25 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 0x10568ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b4b477f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055f2d30>, '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 0x105357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055eab20>, '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.xfOuIih9f2/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.Nhrj80MsmN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 14:50:25 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 14:50:25 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 14:50:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfOuIih9f2/Render', 14:50:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:50:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:50:25 INFO - 'HOME': '/Users/cltbld', 14:50:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:50:25 INFO - 'LOGNAME': 'cltbld', 14:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:25 INFO - 'MOZ_NO_REMOTE': '1', 14:50:25 INFO - 'NO_EM_RESTART': '1', 14:50:25 INFO - 'PAGER': '/bin/cat', 14:50:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:25 INFO - 'PWD': '/builds/slave/test', 14:50:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:50:25 INFO - 'SHELL': '/bin/bash', 14:50:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nhrj80MsmN/Listeners', 14:50:25 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:50:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:50:25 INFO - 'USER': 'cltbld', 14:50:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:50:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:25 INFO - 'XPC_FLAGS': '0x0', 14:50:25 INFO - 'XPC_SERVICE_NAME': '0', 14:50:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:50:26 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-KK4iOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:50:26 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-IvUlei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:50:26 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-f8DHYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:50:26 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-dpJDFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:50:26 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-_1wF43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:50:26 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Za09_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:50:26 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-yavBGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:50:26 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-qgLYRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:50:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-4SGH8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:50:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-o1d0iB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:50:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-h6BD83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:50:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-5mJ1N1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:50:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-UGVTcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:50:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-8EZGMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:50:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-_Lpen5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:50:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-xxDkLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:50:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-2XVSa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:50:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:50:27 INFO - Running setup.py install for manifestparser 14:50:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:50:28 INFO - Running setup.py install for mozcrash 14:50:28 INFO - Running setup.py install for mozdebug 14:50:28 INFO - Running setup.py install for mozdevice 14:50:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:50:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:50:28 INFO - Running setup.py install for mozfile 14:50:28 INFO - Running setup.py install for mozhttpd 14:50:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:50:28 INFO - Running setup.py install for mozinfo 14:50:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:50:28 INFO - Running setup.py install for mozInstall 14:50:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:50:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:50:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:50:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:50:29 INFO - Running setup.py install for mozleak 14:50:29 INFO - Running setup.py install for mozlog 14:50:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:50:29 INFO - Running setup.py install for moznetwork 14:50:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:50:29 INFO - Running setup.py install for mozprocess 14:50:29 INFO - Running setup.py install for mozprofile 14:50:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:50:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:50:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:50:29 INFO - Running setup.py install for mozrunner 14:50:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:50:30 INFO - Running setup.py install for mozscreenshot 14:50:30 INFO - Running setup.py install for moztest 14:50:30 INFO - Running setup.py install for mozversion 14:50:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:50:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:50:30 INFO - Cleaning up... 14:50:30 INFO - Return code: 0 14:50:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:50:30 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')]} 14:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:30 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')]} 14:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:30 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 0x10568ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b4b477f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055f2d30>, '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 0x105357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055eab20>, '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.xfOuIih9f2/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.Nhrj80MsmN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 14:50:30 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 14:50:30 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 14:50:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfOuIih9f2/Render', 14:50:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:50:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:50:30 INFO - 'HOME': '/Users/cltbld', 14:50:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:50:30 INFO - 'LOGNAME': 'cltbld', 14:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:30 INFO - 'MOZ_NO_REMOTE': '1', 14:50:30 INFO - 'NO_EM_RESTART': '1', 14:50:30 INFO - 'PAGER': '/bin/cat', 14:50:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:30 INFO - 'PWD': '/builds/slave/test', 14:50:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:50:30 INFO - 'SHELL': '/bin/bash', 14:50:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nhrj80MsmN/Listeners', 14:50:30 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:50:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:50:30 INFO - 'USER': 'cltbld', 14:50:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:50:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:30 INFO - 'XPC_FLAGS': '0x0', 14:50:30 INFO - 'XPC_SERVICE_NAME': '0', 14:50:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:50:30 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-prV1GT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:50:30 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)) 14:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:50:30 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-5chAgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:50:31 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)) 14:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:50:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-iiyVAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:50:31 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)) 14:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:50:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-67irqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:50:31 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)) 14:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:50:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-L6SDx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:50:31 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)) 14:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:50:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-3lqysW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:50:31 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)) 14:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:50:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-WrLLp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:50:31 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)) 14:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:50:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-VBlSv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:50:31 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)) 14:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:50:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-xVWrG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:50:31 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)) 14:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:50:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-UEV3mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:50:31 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)) 14:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:50:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-AubzQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:50:31 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)) 14:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:50:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-AEsn1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:50:32 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)) 14:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:50:32 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Vq89gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:50:32 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)) 14:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:50:32 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ngWcZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:50:32 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)) 14:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:50:32 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-JyYeZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:50:32 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)) 14:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:50:32 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-qQ98dW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:50:32 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)) 14:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:50:32 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-UULDIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:50:32 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)) 14:50:32 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)) 14:50:32 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)) 14:50:32 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)) 14:50:32 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)) 14:50:32 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)) 14:50:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:35 INFO - Downloading blessings-1.6.tar.gz 14:50:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:50:35 INFO - Installing collected packages: blessings 14:50:35 INFO - Running setup.py install for blessings 14:50:35 INFO - Successfully installed blessings 14:50:35 INFO - Cleaning up... 14:50:35 INFO - Return code: 0 14:50:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:50:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:50:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:50:35 INFO - Reading from file tmpfile_stdout 14:50:35 INFO - Current package versions: 14:50:35 INFO - blessings == 1.6 14:50:35 INFO - blobuploader == 1.2.4 14:50:35 INFO - docopt == 0.6.1 14:50:35 INFO - functools32 == 3.2.3-2 14:50:35 INFO - jsonschema == 2.5.1 14:50:35 INFO - manifestparser == 1.1 14:50:35 INFO - mozInstall == 1.12 14:50:35 INFO - mozcrash == 0.17 14:50:35 INFO - mozdebug == 0.1 14:50:35 INFO - mozdevice == 0.48 14:50:35 INFO - mozfile == 1.2 14:50:35 INFO - mozhttpd == 0.7 14:50:35 INFO - mozinfo == 0.9 14:50:35 INFO - mozleak == 0.1 14:50:35 INFO - mozlog == 3.3 14:50:35 INFO - moznetwork == 0.27 14:50:35 INFO - mozprocess == 0.23 14:50:35 INFO - mozprofile == 0.28 14:50:35 INFO - mozrunner == 6.12 14:50:35 INFO - mozscreenshot == 0.1 14:50:35 INFO - mozsystemmonitor == 0.3 14:50:35 INFO - moztest == 0.7 14:50:35 INFO - mozversion == 1.4 14:50:35 INFO - psutil == 3.1.1 14:50:35 INFO - requests == 1.2.3 14:50:35 INFO - wsgiref == 0.1.2 14:50:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:36 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')]} 14:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:36 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 0x10568ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b4b477f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055f2d30>, '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 0x105357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055eab20>, '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.xfOuIih9f2/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.Nhrj80MsmN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 14:50:36 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 14:50:36 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 14:50:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfOuIih9f2/Render', 14:50:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:50:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:50:36 INFO - 'HOME': '/Users/cltbld', 14:50:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:50:36 INFO - 'LOGNAME': 'cltbld', 14:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:36 INFO - 'MOZ_NO_REMOTE': '1', 14:50:36 INFO - 'NO_EM_RESTART': '1', 14:50:36 INFO - 'PAGER': '/bin/cat', 14:50:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:36 INFO - 'PWD': '/builds/slave/test', 14:50:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:50:36 INFO - 'SHELL': '/bin/bash', 14:50:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nhrj80MsmN/Listeners', 14:50:36 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:50:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:50:36 INFO - 'USER': 'cltbld', 14:50:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:50:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:36 INFO - 'XPC_FLAGS': '0x0', 14:50:36 INFO - 'XPC_SERVICE_NAME': '0', 14:50:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:36 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)) 14:50:36 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)) 14:50:36 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)) 14:50:36 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)) 14:50:36 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)) 14:50:36 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)) 14:50:36 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)) 14:50:36 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)) 14:50:36 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)) 14:50:36 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)) 14:50:36 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)) 14:50:36 INFO - Cleaning up... 14:50:36 INFO - Return code: 0 14:50:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:50:36 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')]} 14:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:36 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')]} 14:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:36 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 0x10568ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b4b477f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055f2d30>, '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 0x105357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055eab20>, '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.xfOuIih9f2/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.Nhrj80MsmN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 14:50:36 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 14:50:36 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 14:50:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfOuIih9f2/Render', 14:50:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:50:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:50:36 INFO - 'HOME': '/Users/cltbld', 14:50:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:50:36 INFO - 'LOGNAME': 'cltbld', 14:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:36 INFO - 'MOZ_NO_REMOTE': '1', 14:50:36 INFO - 'NO_EM_RESTART': '1', 14:50:36 INFO - 'PAGER': '/bin/cat', 14:50:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:36 INFO - 'PWD': '/builds/slave/test', 14:50:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:50:36 INFO - 'SHELL': '/bin/bash', 14:50:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nhrj80MsmN/Listeners', 14:50:36 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:50:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:50:36 INFO - 'USER': 'cltbld', 14:50:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:50:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:36 INFO - 'XPC_FLAGS': '0x0', 14:50:36 INFO - 'XPC_SERVICE_NAME': '0', 14:50:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:50:36 INFO - Cleaning up... 14:50:36 INFO - Return code: 0 14:50:36 INFO - Running post-action listener: _resource_record_post_action 14:50:36 INFO - Running post-action listener: _start_resource_monitoring 14:50:36 INFO - Starting resource monitoring. 14:50:36 INFO - [mozharness: 2016-08-23 21:50:36.693139Z] Finished create-virtualenv step (success) 14:50:36 INFO - [mozharness: 2016-08-23 21:50:36.694092Z] Running install step. 14:50:36 INFO - Running pre-action listener: _resource_record_pre_action 14:50:36 INFO - Running main action method: install 14:50:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:50:36 INFO - Reading from file tmpfile_stdout 14:50:36 INFO - Detecting whether we're running mozinstall >=1.0... 14:50:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:50:37 INFO - Reading from file tmpfile_stdout 14:50:37 INFO - Output received: 14:50:37 INFO - Usage: mozinstall [options] installer 14:50:37 INFO - Options: 14:50:37 INFO - -h, --help show this help message and exit 14:50:37 INFO - -d DEST, --destination=DEST 14:50:37 INFO - Directory to install application into. [default: 14:50:37 INFO - "/builds/slave/test"] 14:50:37 INFO - --app=APP Application being installed. [default: firefox] 14:50:37 INFO - mkdir: /builds/slave/test/build/application 14:50:37 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'] 14:50:37 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 14:51:11 INFO - Reading from file tmpfile_stdout 14:51:11 INFO - Output received: 14:51:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:51:11 INFO - Running post-action listener: _resource_record_post_action 14:51:11 INFO - [mozharness: 2016-08-23 21:51:11.222458Z] Finished install step (success) 14:51:11 INFO - [mozharness: 2016-08-23 21:51:11.222597Z] Running run-tests step. 14:51:11 INFO - Running pre-action listener: _resource_record_pre_action 14:51:11 INFO - Running main action method: run_tests 14:51:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:51:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:51:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:51:11 INFO - 2016-08-23 14:51:11.236 screenresolution[1628:7567] starting screenresolution argv=screenresolution get 14:51:11 INFO - 2016-08-23 14:51:11.239 screenresolution[1628:7567] Display 0: 1600x1200x32@60 14:51:11 INFO - 2016-08-23 14:51:11.245 screenresolution[1629:7570] starting screenresolution argv=screenresolution list 14:51:11 INFO - Available Modes on Display 0 14:51:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:51:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:51:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:51:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:51:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:51:11 INFO - Intel Iris: 14:51:11 INFO - Chipset Model: Intel Iris 14:51:11 INFO - Type: GPU 14:51:11 INFO - Bus: Built-In 14:51:11 INFO - VRAM (Dynamic, Max): 1536 MB 14:51:11 INFO - Vendor: Intel (0x8086) 14:51:11 INFO - Device ID: 0x0a2e 14:51:11 INFO - Revision ID: 0x0009 14:51:11 INFO - Displays: 14:51:11 INFO - Display: 14:51:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:51:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:51:11 INFO - Display Serial Number: 1600x1200 60 14:51:11 INFO - Main Display: Yes 14:51:11 INFO - Mirror: Off 14:51:11 INFO - Online: Yes 14:51:11 INFO - Rotation: Supported 14:51:11 INFO - Return code: 0 14:51:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:51:11 INFO - Python 2.7.3 14:51:11 INFO - Return code: 0 14:51:11 INFO - grabbing minidump binary from tooltool 14:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:11 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 0x1055f2d30>, '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 0x105357db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055eab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:51:11 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 14:51:11 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 14:51:11 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 14:51:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:51:11 INFO - Return code: 0 14:51:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:51:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:51:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:51:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:51:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:51:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--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 14:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0071 --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 14:51:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xfOuIih9f2/Render', 14:51:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:11 INFO - 'HOME': '/Users/cltbld', 14:51:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:11 INFO - 'LOGNAME': 'cltbld', 14:51:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:51:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:11 INFO - 'MOZ_NO_REMOTE': '1', 14:51:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:51:11 INFO - 'NO_EM_RESTART': '1', 14:51:11 INFO - 'PAGER': '/bin/cat', 14:51:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:11 INFO - 'PWD': '/builds/slave/test', 14:51:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:51:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:11 INFO - 'SHELL': '/bin/bash', 14:51:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nhrj80MsmN/Listeners', 14:51:11 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 14:51:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:11 INFO - 'USER': 'cltbld', 14:51:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:11 INFO - 'XPC_FLAGS': '0x0', 14:51:11 INFO - 'XPC_SERVICE_NAME': '0', 14:51:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--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 14:51:11 INFO - mozversion application_buildid: 20160823114814 14:51:11 INFO - mozversion application_changeset: 5bde9ecced2bce88700dec6f5a8beeeb98766774 14:51:11 INFO - mozversion application_display_name: Nightly 14:51:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:51:11 INFO - mozversion application_name: Firefox 14:51:11 INFO - mozversion application_remotingname: firefox 14:51:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:51:11 INFO - mozversion application_vendor: Mozilla 14:51:11 INFO - mozversion application_version: 51.0a1 14:51:11 INFO - mozversion platform_buildid: 20160823114814 14:51:11 INFO - mozversion platform_changeset: 5bde9ecced2bce88700dec6f5a8beeeb98766774 14:51:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:51:11 INFO - mozversion platform_version: 51.0a1 14:51:11 INFO - using testdate: 1471989071 14:51:11 INFO - actual date: 1471989071 14:51:11 INFO - starting webserver on 'localhost:49275' 14:51:11 INFO - SUITE-START | Running 2 tests 14:51:11 INFO - TEST-START | dromaeo_css 14:51:11 INFO - operating with platform_type : mac_ 14:51:11 INFO - Initialising browser for dromaeo_css test... 14:51:11 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmp19mkZi/profile http://localhost:49275/getInfo.html) 14:51:14 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 14:51:14 INFO - PROCESS | 1639 | colorDepth:24 14:51:14 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 14:51:14 INFO - PROCESS | 1639 | __metrics 14:51:14 ERROR - PROCESS | 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 14:51:15 INFO - TEST-INFO | 1639: exit 0 14:51:15 INFO - Browser initialized. 14:51:15 INFO - Running cycle 1/1 for dromaeo_css test... 14:51:15 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmp19mkZi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:27 INFO - PROCESS | 1642 | RSS: Main: 246833152 14:51:27 INFO - PROCESS | 1642 | 14:52:17 INFO - PROCESS | 1642 | 1471989137399 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] 14:54:29 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 14:54:30 INFO - PROCESS | 1642 | RSS: Main: 265707520 14:54:30 INFO - PROCESS | 1642 | 14:57:32 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 14:57:33 INFO - PROCESS | 1642 | RSS: Main: 272330752 14:57:33 INFO - PROCESS | 1642 | 15:00:35 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 15:00:35 INFO - PROCESS | 1642 | RSS: Main: 278151168 15:00:35 INFO - PROCESS | 1642 | 15:03:37 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 15:03:38 INFO - PROCESS | 1642 | RSS: Main: 274870272 15:03:38 INFO - PROCESS | 1642 | 15:06:41 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 15:06:41 INFO - PROCESS | 1642 | RSS: Main: 280649728 15:06:41 INFO - PROCESS | 1642 | 15:09:44 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 15:09:44 INFO - PROCESS | 1642 | RSS: Main: 283389952 15:09:44 INFO - PROCESS | 1642 | 15:09:44 INFO - PROCESS | 1642 | __start_tp_report 15:09:44 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 15:09:44 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 15:09:44 INFO - PROCESS | 1642 | |i|pagename|runs| 15:09:44 INFO - PROCESS | 1642 | |0;dojo.html;2707.9458410831785;3279.8360081995893;3346.9832650836756;3349.313390754895;3352.178716214528;5504.14685723713;5521.558275337973;5524.58565607579;5587.273654424919;5603.971980140103;5413.485718856712;5541.695206763627;5563.499285064343;5623.578231632623;5631.1271752878265;4092.5088989321325;4967.776450059756;5123.5388815006645;5136.409312929024;5204.739763011853;4962.727050012248;5237.8428647140645;5254;5254.894902101955;5257.316548848645;4984.87537811554;4985.326980857574;5043.848684539451;5078.847634570969;5109.054824857413;5068.290439338459;5068.974655126701;5074.213496907985;5110.565601923841;5122.590192784568;5054.595632349403;5055.620828437845;5062.519060689228;5082.669626474304;5087.26234695967;5382.138857782775;5415.702136382497;5463.453654634504;5518.806841760519;5539.25220095286;5803.709814509258;6108.358622344679;6119.441623354618;6136.23297087864;6164.291106522763;6174.938250617482;6180.443760061616;6192.071189321593;6208.192934918477;6236;5571.832845014696;5641.971790141105;5666.631668941505;5738.885222295572;5773.769049238025;6268.122462855204;6271.655058971709;6281.937180628227;6283.748650054038;6298.811035668938;5948.762049517971;6003.339632640406;6032.819015429544;6049.879002420015;6108.205933228652;5246.554042906319;5999.070144127667;6049.425304596057;6128.261531017909;6153.2947009976915;5913.29040515141;6045.78839740607;6046.032634778414;6125.052321061979;6127.479164271087;6152.600080994811;6157.6613286269685;6159.96920015406;6170.074488826622;6175.382461753788;4809.639277054235;4843.176659967814;4849.951500485021;4852.393450818648;4902.803887844518;3535.5580552430947;4242.5121111072;4290.420793192941;4319.589638984291;4327.480702315742;5511.669299842022;5612.915806262909;5617.775288988477;5624.775008999594;5644.943550564524;5087.491250874957;6112.17485639433;6156.445919867144;6195.287541932646;6208.751649933952;4656.278276867023;5042.621803364689;5240.71176085319;5704.372519022904;5711.286089238845;4808.951910480921;4826.32431459596;5272.367315922113;5291.391489978625;5296.364436267672;5565.415631358649;6246.625202487774;6277.937220627827;6289.7484100635465;6299.96850015747;5169.405518365285;5872.148538461985;6102.428659372175;6118.071005858243;6201.488397199141;5721.855628874158;5726.484616384545;6258.780942666985;6270.310265870659;6298.811035668938;6020.608660437058;6022.90965635507;6089.208402907594;6106.786262480792;6114.847128821815;5988.520918326436;6124.930239974474;6128.571000029955;6170.6914654268;6206.224221972254;5947.078202878561;6034.849128771641;6039.402511041531;6056.90914636272;6082.635041897501;5196.948030519647;5926.703664816828;6046.153538504701;6085.391460853879;6086.3305036446845;5379.4082650907585;5643.689597072036;5761.222234998221;5772.19189313488;5916.3492015877355;5925.644461332334;5926.555508336978;5946.43508866657;5948.821535353946;5962.19510366095;5778.855528611818;5779.422057794187;5804.361520232856;5847;5862.062070068769 15:09:44 INFO - PROCESS | 1642 | |1;ext.html;480.69475882814413;482.3030720608722;530.8142150247414;534.4495169974924;534.9491798279162;35717.74987875425;38793.224135517274;40208.19583608326;41390.96522586933;41406.17187656249;42499.78750106245;43141.56858431415;43152.70541883741;43184.56815431853;43197;9773.902260977406;9983.201343892508;10006.799864002716;10007.29948903577;10043.497825108752;9888.555015024305;9974.950125249363;9999.950000249988;10003.849942250872;10022.298439109265;9942.10521053105;9976;9979.650712225073;9998.650047248348;10003.14973227273;9941.403515789076;9959.203263738884;9965.750856228617;10001.79996400068;10031.996800319983;9816.165625921805;9875.259355548362;9893;9903.25725570585;9918.25613079022;40980.79509602433;41240.38139427881;41261.381079283834;41445.58554414478;41475.377869331984;3451.0682115828586;3515.3848076586496;3531.523244362004;3868.9806550967346;4040.9695527640556;31651;31884;32130;32929;33355.833220833985;3284.1132894118455;3298.7690861639694;3320.4189266878443;3321.4353559894876;3422.9144271393166;432652;434262;436371;437321.9999999968;438066;52370.73814630903;56768.71615641978;61776.38223617796;61817.581890172565;61853.381466184765;34814.30371392558;35263.82368088143;35704.82147589245;36545.634543654225;64626.676866615366;16074;16101.27544260511;16221.918890405472;16267.918660406622;16302.429414970657;9931.801363972825;10682.89317106819;10685.412302323446;12191.085668574715;12369.814452783216;15635.530934071996;19361.903190483958;19404.514887127934;19407.73849699765;19498.70751938722;6578.605283682994;6763.323667633197;7836.255555722198;8031.959840200761;8069.754659471273;869.5999840073637;875.6453636277317;993.2947607198826;994.22450488619;1027.198784947742;28729.281767955552;29862.701372986427;29868;30452.238694032385;30538.694613053583;1030.4950574218578;1082.951267192978;1111.5498223219608;1118.5190368141614;1230.329470438613;15081.472148474752;15782.342854000395;15791.526254212393;15843.128627925344;16066.518004459886;167085;167904;169409;169556;170255.1487242556;57382;57482;58173.41826581764;58248.417515825146;58444;1208.383724300613;1347.3263368315843;1347.4946894914408;1382.792581112821;1385.8059871617982;27578.862105689343;28773.136805895858;29580.96466623744;29591.852040739657;30196.698033020268;51556.844315568145;51774.741126294124;51799.48200517947;51805.7409712949;51810.22284665658;505527;506819;507019;507076;508981.45509272214;26867;26910.865445672647;27153.456930861666;27230.863845680644;27292.04477843266;46335.88090120192;46559.53440465687;47016.7649161752;47124.764376177896;48244.517554824;37469.250614988094;37641.87074387773;38102.42846357251;38605;39211.6078839208;37635.2472950534;38118.428223577226;38626.42060369041;39029;39343.80328098341;37430.06424839292;38009.239815202985;38136.618633813305;38468.42297365598;39451.81644550668;31113.066608001795;33601.15997100092;33859.83070084634;33981.66018339884;34007.82996085004;24676.506469870863;24728;25198;26168.345791354608;26684.466310673288 15:09:44 INFO - PROCESS | 1642 | |2;jquery.html;315.2607136265458;339.90312760863145;376.4485029431882;381.1139101588805;383.3062157494936;19233;20111.195552177913;20375.898120509413;20823.687644685342;21043.473913152142;19962.30131945382;20178.293759718414;20359.59280814383;20641.587168256665;20748;4527.298268768346;5785.5082318002915;5929.555283353744;5969.313528944183;5972.313183983854;5792.942070579283;5891.5286777057945;5895.852603684921;5899.616524925866;5902.852428689295;5711.143328500737;5717.828465146053;5829.067349224125;5832.650040997532;5851.912221316662;5693.971530142344;5786.855328616776;5838.824835254949;5842.919059973919;5845.357010728816;5033.295338652591;5045.697258164522;5078.289039534468;5097.923531147036;5102.234664800272;19645.214191432326;20032.09695078965;25201.62197567038;25325.240242792745;25828.612570811452;2186.9015894284635;2291.7822806833324;2517.509085728284;2597.9740202597923;2691.9596206056926;12607.991360691214;15145.848541514664;15313.846861531465;15385.999910005814;15710.45013424536;1651.306451290461;1815.8365747082826;1881.4825922871182;1977.6736838421643;1993.3421970749762;107580.46209768901;114078;116182;116194;117362.99999999914;9366.782318298578;10337.534810933526;10566.577336906437;10638.202134839918;10708.571657133783;10942.288751231144;12828.55100071493;13069;13275.73448531024;13323.533676321282;8310.459820111795;8359.58202089893;8401.933294347642;8518.063013068557;8536.70121545743;8367.95816020916;8404.621792019374;8457.703980360659;8618.525981070976;8621.137886211329;5331.973340133274;6429.485641148697;6471.0940468334475;6481.740730370827;6486.286508484063;1844.1609067874085;1858.1173942377534;1886.226647074693;1886.7169924511434;1888.169205549554;863.0851297624538;879.71122305821;993.5222350276159;1069.8823129455754;1075.2150929821273;21160.365189044354;21479;21506.354809355744;21555.568888622453;21688.56622867534;806.5080301016376;942.7972985808084;974.91713204377;976.916962058233;989.6091044037565;11224.540809694687;11254.887451125547;11450.885491144982;11566.884331156582;11581.88418115825;576941;597154;605592;606696;607067;107341.46329268304;107413;113643.4317828422;114177.4291128539;125827;958.2286259560981;962.1773383756787;1040.8022475729588;1079.605943830512;1083.009046722256;18375.908120459313;18645.627087458448;18771.90614046921;19158.61682766365;19219.39827581879;55633;56450.71774641101;56807.43192568021;56886.7155664219;57341;79567.60216199113;83515;83642.16357836587;83942.58028709817;84825;7889.526628402315;8001.8399632008195;8152.388570857091;8212.83574328498;8393.622286997223;9129.269658427444;12014.939925300318;12908.741825163632;12914.547990820276;13065.412056457291;9351.251899847859;10775.94612026935;11278.887211127783;11371.886281137082;11498.597549085742;9260.351775375659;9372.67195648149;10289.707293666255;11073.335599864035;11253.437328133725;11343.376114313462;11350.205485615928;11400.087992960378;11467.541298347973;11572.074234061423;6337.271213810471;8261.17388261169;8291.08798032228;8368.288695460955;8427.662893484438;9727.9027209727;10350.482475876326;10527.736806579896;11298.774024519627;11596.362200079077 15:09:44 INFO - PROCESS | 1642 | |3;mootools.html;1323.2589749740146;1482.4508388733768;1672.8494435500802;1703.3101593854494;1747.4844920748378;7612.314891659749;7808.336291415237;8321.459105158168;8488.320934325255;8850.955745221281;7243;7442.218567050463;8619.65521379144;8634.956825215864;8656.220940115389;2326.43002464396;2366.4438856868624;2368.632861906399;2372.0748907925836;2372.3120295114395;2338.5206032763244;2361.9055237790467;2383.6067048936993;2395.7604239576076;2400.1719406804623;2006.2175751456944;2341.0635745701684;2342.3090188394463;2349.530093981202;2358.7759162879497;2335.4278201840657;2345.6716059751648;2347.3427440316736;2353.7057867766443;2360.3273067175946;2344.788968992799;2354.658574506687;2365.065799009382;2368.7749663781915;2369.158948573266;8619.482831030158;8714.738557843275;8771.298296136294;8772.166644168858;8774.254188393994;5175.896482070375;5245.396779370383;5273.709945952971;5316.441773613792;5329.546988505982;3540.8583656653705;3649.4708267301094;3678.521792167001;3718.888433347004;3725.3853114236117;1070.8019016481976;1106.5352551928208;1118.669992352258;1128.4583399968062;1128.5880653561392;11361.659150225423;11427.028702560208;11490.195686301962;11495.367754773484;11497.597584084517;4301.924518870283;4435.933460998088;4617.238155704271;4782.856514304576;4816.95183048165;9687.806243875082;9799.314048016571;9811.215102791759;9813.018698130272;9825.213982881352;5240.68555886648;5264.447233040476;5286.682799031993;5288.312519372457;5290.127129023668;4198;4696.436427628706;4823.083614113307;4853.587445067138;4862.124817532807;3152.8896488622786;3780.827943337574;3913.726039177287;3942.6254505821903;4051.1492586556565;1093.3494570730402;1297.0596317669615;1298.487097596463;1304.2239867278954;1330.527662679754;833.8374017066614;901.589776651622;915.839728047589;926.2728757924997;948.2793077261331;5607.579431542651;5709.543236541067;5884.264466941632;5945.16767652529;6018.21763170785;434.6001678455765;443.5564435564436;450.9188346097668;952.3238500664468;981.79873126009;3324.8171350575467;3923.1761330120426;3927.430522574268;4048.6153815387493;4098.385242213632;10379.11777498921;10613.628523001813;10654.786904262026;10683.465826708634;10699.946500267604;10611.098056665116;10624.521896514676;10630.09644180238;10643.254972151875;10675.412852293199;7956.045274566974;8047.195280471906;8081.4747041442115;8102.432829701982;8111.594420278962;5140.948590514047;5221.138512145453;5597.580181486323;5785;5831.271091113611;7694.230576942261;9754.268429867647;9920.355176913477;9927.602895884083;9955.50222488887;8232.50604963704;9833.901660983585;9853.704388868346;10025.348352357074;10026.949865250626;6754.358335958076;7278.927210727825;7379.262073792578;7403;7562.584057876649;8327.20891515305;8427;8432.283255923316;8442.53566053873;8457.78855528592;7314.195438501654;7399.3340599344165;7436.219196984239;7478.6260686966525;7532.962335188289;7321.963390183015;7397.926020739724;7475.289847464483;7487.876818477272;7539.698412063456;6785.423239024738;6817.147856517935;6895.620740859301;6948.096747422803;6992.1259842519685;4681.648876334357;4868.269759536098;5087.949120508895;5201.635885488131;5202.115640341075;4981.4022317320705;5025.883951949814;5174.689518628894;5288.65623734456;5378.462153784591 15:09:44 INFO - PROCESS | 1642 | |4;prototype.html;301.29947871199465;305.5340605576496;312.32381893201216;315.03127881763584;316.1511342046605;4838.830640927568;5341.1187154119525;5548.805791797288;5575.553955683546;5583.944160558393;4667.486576476585;5440.945590544094;5482.095454250044;5502.129276046144;5560.915621453808;3684.613115622861;4217.578242175781;4232.703710740249;4255.1915136124035;4267.231898258312;3732.0406786437065;4170.291050521419;4182.602652747984;4257.084726783741;4268.829246830123;3844.442555829403;3848.5946283572766;3939.8621048263317;4172.915042089064;4175.726403446947;4009.3785463253244;4161.542230354644;4203.684723645708;4205.537390887;4266.637335826458;3649.7445178837493;3659.743817932746;3661.0115268877253;3669.1837540417664;3698.223373091654;4475.261581838992;5160.716160611165;5219.973900130513;5385.569154467633;5412.972935135338;4673.836415725467;4746.504850971933;4805.5434733700595;4818.855434336975;4853.3447984522345;5543.196236545718;5831.88336233273;5831.970840145772;5839.445252700986;5881.735321910524;3990.221906728189;4003.919921601581;4006.579309172553;4008.7995600220165;4027.7986100695143;5489.835304940818;6134.386561343875;6182.876342473125;6183.938160618426;6212.968935155295;3262.510623406508;3853.7687738735767;4071.4096456014304;4082.714210005271;4113.753174809521;3273.787203831743;3899.6100389961343;4011.7392369495888;4093.97953010239;4133.7106402551535;4449.3993310902615;4522.45730512334;4817.8313759018965;4826.0830442215865;4853.199222128309;5167.560757335594;5553.527950124204;5885.705714714247;5892.469677729025;5903.409659034148;1147.52377763229;1182.184292837939;1260.9156125731863;1271.9300438475973;1409.563035459011;890.4390234152443;894.6197865906963;935.93596023243;960.702182323468;961.024560071528;5265.341832270966;5315.893682126336;5344.4922732340365;5362.839114826562;5392.514673679388;5410.83767486976;5613.326400831845;5663.348714897757;5931.673757943268;5961.552883533753;4170.47869016373;4749.453812811502;5089.287499750038;5361.865953351197;5428.891422171534;2633.210036988896;2902.1438675590753;3077.984265192481;3120.953185702216;3132.9060128196193;5376.709589698444;5591.903036361365;6262.655553944485;6280.434760871543;6285.465735412541;5844.240248767633;5863.332183856335;6086.573939824259;6143.801958618026;6181.567290289637;6037.939620603738;6228.408301211468;6234.688265586612;6269.78055768055;6281.811545653638;4829.106615276185;5555.72221388937;5622.690752008679;5862.765489380377;5941;5863.589548731547;5917.970410147922;5919.792807251898;5925.259342582177;5952.910706339322;5263.473652634706;5527.474889885454;5866.767978724516;6247.314084690055;6256.687165641791;3678.319510890494;3955.169414423003;3985.242803867256;3992.640662340403;4013.438118663331;4937.604991600735;5824.883502330014;5948.524118070631;6021.789237376671;6048.002079656807;5106.948930510647;5306.442823503631;5605.355384130714;5647.632903861236;5837.6497410155525;5099.69401835891;5474.932388184266;5915.733791979457;5920.881582368243;5964.940350596438;4721.5750582447745;4725.173094708481;5235.240890070842;5500.87232117423;5876.764929402947;5163.4062082860955;5322.247815290134;5884.705764711833;5915.940840591711;5978.8206353809455;5013.373328333958;5750.166225897138;5781.132830075522;5794.537321638371;5839.8540036497725 15:09:44 INFO - PROCESS | 1642 | |5;yui.html;657.3525077798367;729.0413106764601;750.9173990861008;785.4305628419397;834.5118105908045;15398;16461.341546338146;16608.16959152042;16638.66722665546;17236.396726114588;16586.58533536659;17011.234494447748;17105.144742762845;17132.743008854875;17153.91423042886;854.8204876975842;871.7036207689384;873.5326600268858;873.6942070275385;875.264777586827;681.6114814555705;846.8729690546405;865.9004214515317;882.8984666763308;893.1381217125472;929.7582628516601;932.911373419524;933.1788026536639;933.9346245762799;936.5083331251113;926.1155596405484;926.4395041000199;926.4811705444905;926.8563372677246;929.4005366538579;687.6183718036488;694.2190036209265;694.7950354645392;696.9094017777708;697.5221972948547;15596.454124105716;15761.527154185278;15792;15799.763003554956;15820.525384238492;14461.349239284153;14514.129152250898;14543.70912581753;14579.70840583193;14640.780388294184;11837.467313970892;12123;12169.2698438094;12250.264984100982;12269.20250183744;3487.511748355232;3818.713596480275;3873.7482063666052;3877.495925529663;3884.8251828667494;123937.38031309877;125901;126150;126310.36844815809;129578;11060.834087488694;11103.611373601885;11136.443177841076;11319.490622921989;11477.311361318347;22622.66066009011;22798;22798.31605051851;22838.543229135325;22906.770932290798;6975.9302406975285;7974.362051035903;8094.878576821352;8101.713190367802;8315.792105197419;4535.727856328631;4562.406887104655;4593.122794407607;4595.793189306489;4615.892185875366;3613.4941108244866;3728.198437335986;3737.1965027519213;3745.026293163797;3746.0260332313796;644.4168027934727;651.931547187548;652.7128063651978;657.0899304463353;664.3887623386496;548.7695168029437;674.7739507265023;693.1335830212234;694.8818700820772;719.6221983458726;8996.550172491348;9514.714558563253;9607.231421486264;9731.464769437749;9746.805063898682;603.864130570618;643.520577170002;668.7057694614355;675.5743881354813;703.5462126928103;4395.230834603932;4424.761066901273;4696.882577935579;4722.24444088951;4735.692180008288;107603.46198268958;154247;156957.43042569427;163396;165688.17155914142;106298.46850765852;109279;117883;124881.37559312327;147818;88851.55574222088;100291;111709;114301;114996.85003149862;8243.670253189804;9319.813603727753;9771.169450596779;9848.852267215854;9945.801083978424;47281.29078063901;49220.507794923025;60182.69908650429;65263;66003.33996659971;80895.19104808876;94298.05701942893;99798;100183.99632007464;103998;13096.345182740633;13195.80206296887;13277.601671949857;13341.466341346237;13544.916941547071;11567;14048.578542643738;14819.703605928036;14995.17526536051;15031.661273993963;13698.589042328746;13921.4431422746;14057.859421406065;14147;14593.978421510392;14019;14093.577192684235;14110.717785644434;14395.640108997359;14709.41162353494;13867;14016.78974815399;14084.78872816888;14256.643583910485;14402.639934001734;9666.178374838217;10811.648543932008;11251.887481125412;11346.659600212008;11720.296782193096;7567.545947243183;8918.955405222932;9444.763880903032;10898.945505272422;11257.437128143723 15:09:44 INFO - PROCESS | 1642 | __end_tp_report 15:09:44 INFO - PROCESS | 1642 | __start_cc_report 15:09:44 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,432 15:09:44 INFO - PROCESS | 1642 | __end_cc_report 15:09:44 INFO - PROCESS | 1642 | __startTimestamp1471990184610__endTimestamp 15:09:44 INFO - PROCESS | 1642 | 15:09:44 INFO - PROCESS | 1642 | ------- Summary: start ------- 15:09:44 INFO - PROCESS | 1642 | Number of tests: 6 15:09:44 INFO - PROCESS | 1642 | 15:09:44 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5575.83 Median:5738.89 stddev:678.99 (11.8%) stddev-sans-first:642.72 15:09:44 INFO - PROCESS | 1642 | Values: 2707.9 3279.8 3347.0 3349.3 3352.2 5504.1 5521.6 5524.6 5587.3 5604.0 5413.5 5541.7 5563.5 5623.6 5631.1 4092.5 4967.8 5123.5 5136.4 5204.7 4962.7 5237.8 5254.0 5254.9 5257.3 4984.9 4985.3 5043.8 5078.8 5109.1 5068.3 5069.0 5074.2 5110.6 5122.6 5054.6 5055.6 5062.5 5082.7 5087.3 5382.1 5415.7 5463.5 5518.8 5539.3 5803.7 6108.4 6119.4 6136.2 6164.3 6174.9 6180.4 6192.1 6208.2 6236.0 5571.8 5642.0 5666.6 5738.9 5773.8 6268.1 6271.7 6281.9 6283.7 6298.8 5948.8 6003.3 6032.8 6049.9 6108.2 5246.6 5999.1 6049.4 6128.3 6153.3 5913.3 6045.8 6046.0 6125.1 6127.5 6152.6 6157.7 6160.0 6170.1 6175.4 4809.6 4843.2 4850.0 4852.4 4902.8 3535.6 4242.5 4290.4 4319.6 4327.5 5511.7 5612.9 5617.8 5624.8 5644.9 5087.5 6112.2 6156.4 6195.3 6208.8 4656.3 5042.6 5240.7 5704.4 5711.3 4809.0 4826.3 5272.4 5291.4 5296.4 5565.4 6246.6 6277.9 6289.7 6300.0 5169.4 5872.1 6102.4 6118.1 6201.5 5721.9 5726.5 6258.8 6270.3 6298.8 6020.6 6022.9 6089.2 6106.8 6114.8 5988.5 6124.9 6128.6 6170.7 6206.2 5947.1 6034.8 6039.4 6056.9 6082.6 5196.9 5926.7 6046.2 6085.4 6086.3 5379.4 5643.7 5761.2 5772.2 5916.3 5925.6 5926.6 5946.4 5948.8 5962.2 5778.9 5779.4 5804.4 5847.0 5862.1 15:09:44 INFO - PROCESS | 1642 | 15:09:44 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:53189.40 Median:38055.83 stddev:106183.22 (279.0%) stddev-sans-first:106407.35 15:09:44 INFO - PROCESS | 1642 | Values: 480.7 482.3 530.8 534.4 534.9 35717.7 38793.2 40208.2 41391.0 41406.2 42499.8 43141.6 43152.7 43184.6 43197.0 9773.9 9983.2 10006.8 10007.3 10043.5 9888.6 9975.0 10000.0 10003.8 10022.3 9942.1 9976.0 9979.7 9998.7 10003.1 9941.4 9959.2 9965.8 10001.8 10032.0 9816.2 9875.3 9893.0 9903.3 9918.3 40980.8 41240.4 41261.4 41445.6 41475.4 3451.1 3515.4 3531.5 3869.0 4041.0 31651.0 31884.0 32130.0 32929.0 33355.8 3284.1 3298.8 3320.4 3321.4 3422.9 432652.0 434262.0 436371.0 437322.0 438066.0 52370.7 56768.7 61776.4 61817.6 61853.4 34814.3 35263.8 35704.8 36545.6 64626.7 16074.0 16101.3 16221.9 16267.9 16302.4 9931.8 10682.9 10685.4 12191.1 12369.8 15635.5 19361.9 19404.5 19407.7 19498.7 6578.6 6763.3 7836.3 8032.0 8069.8 869.6 875.6 993.3 994.2 1027.2 28729.3 29862.7 29868.0 30452.2 30538.7 1030.5 1083.0 1111.5 1118.5 1230.3 15081.5 15782.3 15791.5 15843.1 16066.5 167085.0 167904.0 169409.0 169556.0 170255.1 57382.0 57482.0 58173.4 58248.4 58444.0 1208.4 1347.3 1347.5 1382.8 1385.8 27578.9 28773.1 29581.0 29591.9 30196.7 51556.8 51774.7 51799.5 51805.7 51810.2 505527.0 506819.0 507019.0 507076.0 508981.5 26867.0 26910.9 27153.5 27230.9 27292.0 46335.9 46559.5 47016.8 47124.8 48244.5 37469.3 37641.9 38102.4 38605.0 39211.6 37635.2 38118.4 38626.4 39029.0 39343.8 37430.1 38009.2 38136.6 38468.4 39451.8 31113.1 33601.2 33859.8 33981.7 34007.8 24676.5 24728.0 25198.0 26168.3 26684.5 15:09:44 INFO - PROCESS | 1642 | 15:09:44 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:34777.19 Median:25576.93 stddev:99593.00 (389.4%) stddev-sans-first:99838.77 15:09:44 INFO - PROCESS | 1642 | Values: 315.3 339.9 376.4 381.1 383.3 19233.0 20111.2 20375.9 20823.7 21043.5 19962.3 20178.3 20359.6 20641.6 20748.0 4527.3 5785.5 5929.6 5969.3 5972.3 5792.9 5891.5 5895.9 5899.6 5902.9 5711.1 5717.8 5829.1 5832.7 5851.9 5694.0 5786.9 5838.8 5842.9 5845.4 5033.3 5045.7 5078.3 5097.9 5102.2 19645.2 20032.1 25201.6 25325.2 25828.6 2186.9 2291.8 2517.5 2598.0 2692.0 12608.0 15145.8 15313.8 15386.0 15710.5 1651.3 1815.8 1881.5 1977.7 1993.3 107580.5 114078.0 116182.0 116194.0 117363.0 9366.8 10337.5 10566.6 10638.2 10708.6 10942.3 12828.6 13069.0 13275.7 13323.5 8310.5 8359.6 8401.9 8518.1 8536.7 8368.0 8404.6 8457.7 8618.5 8621.1 5332.0 6429.5 6471.1 6481.7 6486.3 1844.2 1858.1 1886.2 1886.7 1888.2 863.1 879.7 993.5 1069.9 1075.2 21160.4 21479.0 21506.4 21555.6 21688.6 806.5 942.8 974.9 976.9 989.6 11224.5 11254.9 11450.9 11566.9 11581.9 576941.0 597154.0 605592.0 606696.0 607067.0 107341.5 107413.0 113643.4 114177.4 125827.0 958.2 962.2 1040.8 1079.6 1083.0 18375.9 18645.6 18771.9 19158.6 19219.4 55633.0 56450.7 56807.4 56886.7 57341.0 79567.6 83515.0 83642.2 83942.6 84825.0 7889.5 8001.8 8152.4 8212.8 8393.6 9129.3 12014.9 12908.7 12914.5 13065.4 9351.3 10775.9 11278.9 11371.9 11498.6 9260.4 9372.7 10289.7 11073.3 11253.4 11343.4 11350.2 11400.1 11467.5 11572.1 6337.3 8261.2 8291.1 8368.3 8427.7 9727.9 10350.5 10527.7 11298.8 11596.4 15:09:44 INFO - PROCESS | 1642 | 15:09:44 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5611.08 Median:5157.82 stddev:3131.75 (60.7%) stddev-sans-first:3123.95 15:09:44 INFO - PROCESS | 1642 | Values: 1323.3 1482.5 1672.8 1703.3 1747.5 7612.3 7808.3 8321.5 8488.3 8851.0 7243.0 7442.2 8619.7 8635.0 8656.2 2326.4 2366.4 2368.6 2372.1 2372.3 2338.5 2361.9 2383.6 2395.8 2400.2 2006.2 2341.1 2342.3 2349.5 2358.8 2335.4 2345.7 2347.3 2353.7 2360.3 2344.8 2354.7 2365.1 2368.8 2369.2 8619.5 8714.7 8771.3 8772.2 8774.3 5175.9 5245.4 5273.7 5316.4 5329.5 3540.9 3649.5 3678.5 3718.9 3725.4 1070.8 1106.5 1118.7 1128.5 1128.6 11361.7 11427.0 11490.2 11495.4 11497.6 4301.9 4435.9 4617.2 4782.9 4817.0 9687.8 9799.3 9811.2 9813.0 9825.2 5240.7 5264.4 5286.7 5288.3 5290.1 4198.0 4696.4 4823.1 4853.6 4862.1 3152.9 3780.8 3913.7 3942.6 4051.1 1093.3 1297.1 1298.5 1304.2 1330.5 833.8 901.6 915.8 926.3 948.3 5607.6 5709.5 5884.3 5945.2 6018.2 434.6 443.6 450.9 952.3 981.8 3324.8 3923.2 3927.4 4048.6 4098.4 10379.1 10613.6 10654.8 10683.5 10699.9 10611.1 10624.5 10630.1 10643.3 10675.4 7956.0 8047.2 8081.5 8102.4 8111.6 5140.9 5221.1 5597.6 5785.0 5831.3 7694.2 9754.3 9920.4 9927.6 9955.5 8232.5 9833.9 9853.7 10025.3 10026.9 6754.4 7278.9 7379.3 7403.0 7562.6 8327.2 8427.0 8432.3 8442.5 8457.8 7314.2 7399.3 7436.2 7478.6 7533.0 7322.0 7397.9 7475.3 7487.9 7539.7 6785.4 6817.1 6895.6 6948.1 6992.1 4681.6 4868.3 5087.9 5201.6 5202.1 4981.4 5025.9 5174.7 5288.7 5378.5 15:09:44 INFO - PROCESS | 1642 | 15:09:44 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4694.85 Median:5311.17 stddev:1457.63 (27.4%) stddev-sans-first:1423.93 15:09:44 INFO - PROCESS | 1642 | Values: 301.3 305.5 312.3 315.0 316.2 4838.8 5341.1 5548.8 5575.6 5583.9 4667.5 5440.9 5482.1 5502.1 5560.9 3684.6 4217.6 4232.7 4255.2 4267.2 3732.0 4170.3 4182.6 4257.1 4268.8 3844.4 3848.6 3939.9 4172.9 4175.7 4009.4 4161.5 4203.7 4205.5 4266.6 3649.7 3659.7 3661.0 3669.2 3698.2 4475.3 5160.7 5220.0 5385.6 5413.0 4673.8 4746.5 4805.5 4818.9 4853.3 5543.2 5831.9 5832.0 5839.4 5881.7 3990.2 4003.9 4006.6 4008.8 4027.8 5489.8 6134.4 6182.9 6183.9 6213.0 3262.5 3853.8 4071.4 4082.7 4113.8 3273.8 3899.6 4011.7 4094.0 4133.7 4449.4 4522.5 4817.8 4826.1 4853.2 5167.6 5553.5 5885.7 5892.5 5903.4 1147.5 1182.2 1260.9 1271.9 1409.6 890.4 894.6 935.9 960.7 961.0 5265.3 5315.9 5344.5 5362.8 5392.5 5410.8 5613.3 5663.3 5931.7 5961.6 4170.5 4749.5 5089.3 5361.9 5428.9 2633.2 2902.1 3078.0 3121.0 3132.9 5376.7 5591.9 6262.7 6280.4 6285.5 5844.2 5863.3 6086.6 6143.8 6181.6 6037.9 6228.4 6234.7 6269.8 6281.8 4829.1 5555.7 5622.7 5862.8 5941.0 5863.6 5918.0 5919.8 5925.3 5952.9 5263.5 5527.5 5866.8 6247.3 6256.7 3678.3 3955.2 3985.2 3992.6 4013.4 4937.6 5824.9 5948.5 6021.8 6048.0 5106.9 5306.4 5605.4 5647.6 5837.6 5099.7 5474.9 5915.7 5920.9 5964.9 4721.6 4725.2 5235.2 5500.9 5876.8 5163.4 5322.2 5884.7 5915.9 5978.8 5013.4 5750.2 5781.1 5794.5 5839.9 15:09:44 INFO - PROCESS | 1642 | 15:09:44 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:25208.10 Median:3741.11 stddev:40300.43 (1077.2%) stddev-sans-first:40371.32 15:09:44 INFO - PROCESS | 1642 | Values: 657.4 729.0 750.9 785.4 834.5 15398.0 16461.3 16608.2 16638.7 17236.4 16586.6 17011.2 17105.1 17132.7 17153.9 854.8 871.7 873.5 873.7 875.3 681.6 846.9 865.9 882.9 893.1 929.8 932.9 933.2 933.9 936.5 926.1 926.4 926.5 926.9 929.4 687.6 694.2 694.8 696.9 697.5 15596.5 15761.5 15792.0 15799.8 15820.5 14461.3 14514.1 14543.7 14579.7 14640.8 11837.5 12123.0 12169.3 12250.3 12269.2 3487.5 3818.7 3873.7 3877.5 3884.8 123937.4 125901.0 126150.0 126310.4 129578.0 11060.8 11103.6 11136.4 11319.5 11477.3 22622.7 22798.0 22798.3 22838.5 22906.8 6975.9 7974.4 8094.9 8101.7 8315.8 4535.7 4562.4 4593.1 4595.8 4615.9 3613.5 3728.2 3737.2 3745.0 3746.0 644.4 651.9 652.7 657.1 664.4 548.8 674.8 693.1 694.9 719.6 8996.6 9514.7 9607.2 9731.5 9746.8 603.9 643.5 668.7 675.6 703.5 4395.2 4424.8 4696.9 4722.2 4735.7 107603.5 154247.0 156957.4 163396.0 165688.2 106298.5 109279.0 117883.0 124881.4 147818.0 88851.6 100291.0 111709.0 114301.0 114996.9 8243.7 9319.8 9771.2 9848.9 9945.8 47281.3 49220.5 60182.7 65263.0 66003.3 80895.2 94298.1 99798.0 100184.0 103998.0 13096.3 13195.8 13277.6 13341.5 13544.9 11567.0 14048.6 14819.7 14995.2 15031.7 13698.6 13921.4 14057.9 14147.0 14594.0 14019.0 14093.6 14110.7 14395.6 14709.4 13867.0 14016.8 14084.8 14256.6 14402.6 9666.2 10811.6 11251.9 11346.7 11720.3 7567.5 8919.0 9444.8 10898.9 11257.4 15:09:44 INFO - PROCESS | 1642 | -------- Summary: end -------- 15:09:44 INFO - PROCESS | 1642 | 15:09:45 INFO - TEST-INFO | 1642: exit 0 15:09:45 INFO - TEST-OK | dromaeo_css | took 1113496ms 15:09:45 INFO - TEST-START | kraken 15:09:45 INFO - operating with platform_type : mac_ 15:09:45 INFO - Initialising browser for kraken test... 15:09:45 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpVsKNc8/profile http://localhost:49275/getInfo.html) 15:09:48 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 15:09:48 INFO - PROCESS | 1653 | colorDepth:24 15:09:48 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 15:09:48 INFO - PROCESS | 1653 | __metrics 15:09:48 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 15:09:48 INFO - TEST-INFO | 1653: exit 0 15:09:48 INFO - Browser initialized. 15:09:48 INFO - Running cycle 1/1 for kraken test... 15:09:48 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpVsKNc8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:10:01 INFO - PROCESS | 1655 | RSS: Main: 247115776 15:10:01 INFO - PROCESS | 1655 | 15:10:03 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 15:10:04 INFO - PROCESS | 1655 | RSS: Main: 259874816 15:10:04 INFO - PROCESS | 1655 | 15:10:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 15:10:08 INFO - PROCESS | 1655 | RSS: Main: 268476416 15:10:08 INFO - PROCESS | 1655 | 15:10:11 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 15:10:12 INFO - PROCESS | 1655 | RSS: Main: 265781248 15:10:12 INFO - PROCESS | 1655 | 15:10:14 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 15:10:14 INFO - PROCESS | 1655 | RSS: Main: 267567104 15:10:14 INFO - PROCESS | 1655 | 15:10:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:10:17 INFO - PROCESS | 1655 | RSS: Main: 268263424 15:10:17 INFO - PROCESS | 1655 | 15:10:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 15:10:20 INFO - PROCESS | 1655 | RSS: Main: 268435456 15:10:20 INFO - PROCESS | 1655 | 15:10:23 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 15:10:24 INFO - PROCESS | 1655 | RSS: Main: 268541952 15:10:24 INFO - PROCESS | 1655 | 15:10:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 15:10:28 INFO - PROCESS | 1655 | RSS: Main: 269905920 15:10:28 INFO - PROCESS | 1655 | 15:10:29 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:10:30 INFO - PROCESS | 1655 | RSS: Main: 269463552 15:10:30 INFO - PROCESS | 1655 | 15:10:32 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:10:33 INFO - PROCESS | 1655 | RSS: Main: 269635584 15:10:33 INFO - PROCESS | 1655 | 15:10:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:10:35 INFO - PROCESS | 1655 | RSS: Main: 269885440 15:10:35 INFO - PROCESS | 1655 | 15:10:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:10:39 INFO - PROCESS | 1655 | RSS: Main: 270491648 15:10:39 INFO - PROCESS | 1655 | 15:10:42 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:10:43 INFO - PROCESS | 1655 | RSS: Main: 270417920 15:10:43 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 15:10:45 INFO - PROCESS | 1655 | RSS: Main: 272547840 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | __start_tp_report 15:10:45 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 15:10:45 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 15:10:45 INFO - PROCESS | 1655 | |i|pagename|runs| 15:10:45 INFO - PROCESS | 1655 | |0;ai-astar;108;116;116;114;118;117;116;119;115;147 15:10:45 INFO - PROCESS | 1655 | |1;audio-beat-detection;148;112;136;189;141;129;129;112;158;110 15:10:45 INFO - PROCESS | 1655 | |2;audio-dft;205;214;213;237;276;218;193;198;198;216 15:10:45 INFO - PROCESS | 1655 | |3;audio-fft;73;84;79;148;59;60;60;64;136;60 15:10:45 INFO - PROCESS | 1655 | |4;audio-oscillator;69;73;118;71;73;87;111;70;74;115 15:10:45 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;89;89;88;85;90;85;89;86;88;87 15:10:45 INFO - PROCESS | 1655 | |6;imaging-darkroom;95;117;120;96;95;96;95;96;95;94 15:10:45 INFO - PROCESS | 1655 | |7;imaging-desaturate;101;149;137;99;79;102;148;147;97;152 15:10:45 INFO - PROCESS | 1655 | |8;json-parse-financial;49;48;49;51;62;50;57;83;48;52 15:10:45 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;67;71;67;70;75;78;75;70;67;72 15:10:45 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;89;90;92;90;88;85;89;103;109;84 15:10:45 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;153;157;155;150;166;163;155;158;153;141 15:10:45 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;183;211;173;169;176;229;174;226;241;167 15:10:45 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;69;66;74;86;76;68;66;72;68;67 15:10:45 INFO - PROCESS | 1655 | __end_tp_report 15:10:45 INFO - PROCESS | 1655 | __start_cc_report 15:10:45 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1078 15:10:45 INFO - PROCESS | 1655 | __end_cc_report 15:10:45 INFO - PROCESS | 1655 | __startTimestamp1471990245419__endTimestamp 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | ------- Summary: start ------- 15:10:45 INFO - PROCESS | 1655 | Number of tests: 14 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:118.60 Median:116.50 stddev:10.42 (8.9%) stddev-sans-first:10.32 15:10:45 INFO - PROCESS | 1655 | Values: 108.0 116.0 116.0 114.0 118.0 117.0 116.0 119.0 115.0 147.0 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:138.50 stddev:24.46 (17.7%) stddev-sans-first:25.59 15:10:45 INFO - PROCESS | 1655 | Values: 148.0 112.0 136.0 189.0 141.0 129.0 129.0 112.0 158.0 110.0 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:216.80 Median:215.00 stddev:24.38 (11.3%) stddev-sans-first:25.48 15:10:45 INFO - PROCESS | 1655 | Values: 205.0 214.0 213.0 237.0 276.0 218.0 193.0 198.0 198.0 216.0 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:82.30 Median:62.00 stddev:32.78 (52.9%) stddev-sans-first:34.59 15:10:45 INFO - PROCESS | 1655 | Values: 73.0 84.0 79.0 148.0 59.0 60.0 60.0 64.0 136.0 60.0 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:86.10 Median:72.00 stddev:20.39 (28.3%) stddev-sans-first:20.67 15:10:45 INFO - PROCESS | 1655 | Values: 69.0 73.0 118.0 71.0 73.0 87.0 111.0 70.0 74.0 115.0 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:1.78 (2.0%) stddev-sans-first:1.81 15:10:45 INFO - PROCESS | 1655 | Values: 89.0 89.0 88.0 85.0 90.0 85.0 89.0 86.0 88.0 87.0 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:95.00 stddev:9.85 (10.4%) stddev-sans-first:10.28 15:10:45 INFO - PROCESS | 1655 | Values: 95.0 117.0 120.0 96.0 95.0 96.0 95.0 96.0 95.0 94.0 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:121.10 Median:150.50 stddev:27.87 (18.5%) stddev-sans-first:28.60 15:10:45 INFO - PROCESS | 1655 | Values: 101.0 149.0 137.0 99.0 79.0 102.0 148.0 147.0 97.0 152.0 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:51.50 stddev:10.84 (21.0%) stddev-sans-first:11.28 15:10:45 INFO - PROCESS | 1655 | Values: 49.0 48.0 49.0 51.0 62.0 50.0 57.0 83.0 48.0 52.0 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.50 stddev:3.82 (5.3%) stddev-sans-first:3.74 15:10:45 INFO - PROCESS | 1655 | Values: 67.0 71.0 67.0 70.0 75.0 78.0 75.0 70.0 67.0 72.0 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:89.00 stddev:7.92 (8.9%) stddev-sans-first:8.33 15:10:45 INFO - PROCESS | 1655 | Values: 89.0 90.0 92.0 90.0 88.0 85.0 89.0 103.0 109.0 84.0 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:155.10 Median:156.00 stddev:6.89 (4.4%) stddev-sans-first:7.26 15:10:45 INFO - PROCESS | 1655 | Values: 153.0 157.0 155.0 150.0 166.0 163.0 155.0 158.0 153.0 141.0 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.90 Median:197.00 stddev:28.63 (14.5%) stddev-sans-first:30.04 15:10:45 INFO - PROCESS | 1655 | Values: 183.0 211.0 173.0 169.0 176.0 229.0 174.0 226.0 241.0 167.0 15:10:45 INFO - PROCESS | 1655 | 15:10:45 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:70.50 stddev:6.21 (8.8%) stddev-sans-first:6.54 15:10:45 INFO - PROCESS | 1655 | Values: 69.0 66.0 74.0 86.0 76.0 68.0 66.0 72.0 68.0 67.0 15:10:45 INFO - PROCESS | 1655 | -------- Summary: end -------- 15:10:45 INFO - PROCESS | 1655 | 15:10:46 INFO - TEST-INFO | 1655: exit 0 15:10:46 INFO - TEST-OK | kraken | took 60922ms 15:10:46 INFO - SUITE-END | took 1174s 15:10:46 INFO - Completed test suite (00:19:34) 15:10:46 INFO - javascript benchmark 15:10:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7315.924506170808, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2707.9458410831785, 3279.8360081995893, 3346.9832650836756, 3349.313390754895, 3352.178716214528, 5504.14685723713, 5521.558275337973, 5524.58565607579, 5587.273654424919, 5603.971980140103, 5413.485718856712, 5541.695206763627, 5563.499285064343, 5623.578231632623, 5631.1271752878265, 4092.5088989321325, 4967.776450059756, 5123.5388815006645, 5136.409312929024, 5204.739763011853, 4962.727050012248, 5237.8428647140645, 5254.0, 5254.894902101955, 5257.316548848645, 4984.87537811554, 4985.326980857574, 5043.848684539451, 5078.847634570969, 5109.054824857413, 5068.290439338459, 5068.974655126701, 5074.213496907985, 5110.565601923841, 5122.590192784568, 5054.595632349403, 5055.620828437845, 5062.519060689228, 5082.669626474304, 5087.26234695967, 5382.138857782775, 5415.702136382497, 5463.453654634504, 5518.806841760519, 5539.25220095286, 5803.709814509258, 6108.358622344679, 6119.441623354618, 6136.23297087864, 6164.291106522763, 6174.938250617482, 6180.443760061616, 6192.071189321593, 6208.192934918477, 6236.0, 5571.832845014696, 5641.971790141105, 5666.631668941505, 5738.885222295572, 5773.769049238025, 6268.122462855204, 6271.655058971709, 6281.937180628227, 6283.748650054038, 6298.811035668938, 5948.762049517971, 6003.339632640406, 6032.819015429544, 6049.879002420015, 6108.205933228652, 5246.554042906319, 5999.070144127667, 6049.425304596057, 6128.261531017909, 6153.2947009976915, 5913.29040515141, 6045.78839740607, 6046.032634778414, 6125.052321061979, 6127.479164271087, 6152.600080994811, 6157.6613286269685, 6159.96920015406, 6170.074488826622, 6175.382461753788, 4809.639277054235, 4843.176659967814, 4849.951500485021, 4852.393450818648, 4902.803887844518, 3535.5580552430947, 4242.5121111072, 4290.420793192941, 4319.589638984291, 4327.480702315742, 5511.669299842022, 5612.915806262909, 5617.775288988477, 5624.775008999594, 5644.943550564524, 5087.491250874957, 6112.17485639433, 6156.445919867144, 6195.287541932646, 6208.751649933952, 4656.278276867023, 5042.621803364689, 5240.71176085319, 5704.372519022904, 5711.286089238845, 4808.951910480921, 4826.32431459596, 5272.367315922113, 5291.391489978625, 5296.364436267672, 5565.415631358649, 6246.625202487774, 6277.937220627827, 6289.7484100635465, 6299.96850015747, 5169.405518365285, 5872.148538461985, 6102.428659372175, 6118.071005858243, 6201.488397199141, 5721.855628874158, 5726.484616384545, 6258.780942666985, 6270.310265870659, 6298.811035668938, 6020.608660437058, 6022.90965635507, 6089.208402907594, 6106.786262480792, 6114.847128821815, 5988.520918326436, 6124.930239974474, 6128.571000029955, 6170.6914654268, 6206.224221972254, 5947.078202878561, 6034.849128771641, 6039.402511041531, 6056.90914636272, 6082.635041897501, 5196.948030519647, 5926.703664816828, 6046.153538504701, 6085.391460853879, 6086.3305036446845, 5379.4082650907585, 5643.689597072036, 5761.222234998221, 5772.19189313488, 5916.3492015877355, 5925.644461332334, 5926.555508336978, 5946.43508866657, 5948.821535353946, 5962.19510366095, 5778.855528611818, 5779.422057794187, 5804.361520232856, 5847.0, 5862.062070068769], "value": 5531.178384913165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.69475882814413, 482.3030720608722, 530.8142150247414, 534.4495169974924, 534.9491798279162, 35717.74987875425, 38793.224135517274, 40208.19583608326, 41390.96522586933, 41406.17187656249, 42499.78750106245, 43141.56858431415, 43152.70541883741, 43184.56815431853, 43197.0, 9773.902260977406, 9983.201343892508, 10006.799864002716, 10007.29948903577, 10043.497825108752, 9888.555015024305, 9974.950125249363, 9999.950000249988, 10003.849942250872, 10022.298439109265, 9942.10521053105, 9976.0, 9979.650712225073, 9998.650047248348, 10003.14973227273, 9941.403515789076, 9959.203263738884, 9965.750856228617, 10001.79996400068, 10031.996800319983, 9816.165625921805, 9875.259355548362, 9893.0, 9903.25725570585, 9918.25613079022, 40980.79509602433, 41240.38139427881, 41261.381079283834, 41445.58554414478, 41475.377869331984, 3451.0682115828586, 3515.3848076586496, 3531.523244362004, 3868.9806550967346, 4040.9695527640556, 31651.0, 31884.0, 32130.0, 32929.0, 33355.833220833985, 3284.1132894118455, 3298.7690861639694, 3320.4189266878443, 3321.4353559894876, 3422.9144271393166, 432652.0, 434262.0, 436371.0, 437321.9999999968, 438066.0, 52370.73814630903, 56768.71615641978, 61776.38223617796, 61817.581890172565, 61853.381466184765, 34814.30371392558, 35263.82368088143, 35704.82147589245, 36545.634543654225, 64626.676866615366, 16074.0, 16101.27544260511, 16221.918890405472, 16267.918660406622, 16302.429414970657, 9931.801363972825, 10682.89317106819, 10685.412302323446, 12191.085668574715, 12369.814452783216, 15635.530934071996, 19361.903190483958, 19404.514887127934, 19407.73849699765, 19498.70751938722, 6578.605283682994, 6763.323667633197, 7836.255555722198, 8031.959840200761, 8069.754659471273, 869.5999840073637, 875.6453636277317, 993.2947607198826, 994.22450488619, 1027.198784947742, 28729.281767955552, 29862.701372986427, 29868.0, 30452.238694032385, 30538.694613053583, 1030.4950574218578, 1082.951267192978, 1111.5498223219608, 1118.5190368141614, 1230.329470438613, 15081.472148474752, 15782.342854000395, 15791.526254212393, 15843.128627925344, 16066.518004459886, 167085.0, 167904.0, 169409.0, 169556.0, 170255.1487242556, 57382.0, 57482.0, 58173.41826581764, 58248.417515825146, 58444.0, 1208.383724300613, 1347.3263368315843, 1347.4946894914408, 1382.792581112821, 1385.8059871617982, 27578.862105689343, 28773.136805895858, 29580.96466623744, 29591.852040739657, 30196.698033020268, 51556.844315568145, 51774.741126294124, 51799.48200517947, 51805.7409712949, 51810.22284665658, 505527.0, 506819.0, 507019.0, 507076.0, 508981.45509272214, 26867.0, 26910.865445672647, 27153.456930861666, 27230.863845680644, 27292.04477843266, 46335.88090120192, 46559.53440465687, 47016.7649161752, 47124.764376177896, 48244.517554824, 37469.250614988094, 37641.87074387773, 38102.42846357251, 38605.0, 39211.6078839208, 37635.2472950534, 38118.428223577226, 38626.42060369041, 39029.0, 39343.80328098341, 37430.06424839292, 38009.239815202985, 38136.618633813305, 38468.42297365598, 39451.81644550668, 31113.066608001795, 33601.15997100092, 33859.83070084634, 33981.66018339884, 34007.82996085004, 24676.506469870863, 24728.0, 25198.0, 26168.345791354608, 26684.466310673288], "value": 19027.082980058225, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.2607136265458, 339.90312760863145, 376.4485029431882, 381.1139101588805, 383.3062157494936, 19233.0, 20111.195552177913, 20375.898120509413, 20823.687644685342, 21043.473913152142, 19962.30131945382, 20178.293759718414, 20359.59280814383, 20641.587168256665, 20748.0, 4527.298268768346, 5785.5082318002915, 5929.555283353744, 5969.313528944183, 5972.313183983854, 5792.942070579283, 5891.5286777057945, 5895.852603684921, 5899.616524925866, 5902.852428689295, 5711.143328500737, 5717.828465146053, 5829.067349224125, 5832.650040997532, 5851.912221316662, 5693.971530142344, 5786.855328616776, 5838.824835254949, 5842.919059973919, 5845.357010728816, 5033.295338652591, 5045.697258164522, 5078.289039534468, 5097.923531147036, 5102.234664800272, 19645.214191432326, 20032.09695078965, 25201.62197567038, 25325.240242792745, 25828.612570811452, 2186.9015894284635, 2291.7822806833324, 2517.509085728284, 2597.9740202597923, 2691.9596206056926, 12607.991360691214, 15145.848541514664, 15313.846861531465, 15385.999910005814, 15710.45013424536, 1651.306451290461, 1815.8365747082826, 1881.4825922871182, 1977.6736838421643, 1993.3421970749762, 107580.46209768901, 114078.0, 116182.0, 116194.0, 117362.99999999914, 9366.782318298578, 10337.534810933526, 10566.577336906437, 10638.202134839918, 10708.571657133783, 10942.288751231144, 12828.55100071493, 13069.0, 13275.73448531024, 13323.533676321282, 8310.459820111795, 8359.58202089893, 8401.933294347642, 8518.063013068557, 8536.70121545743, 8367.95816020916, 8404.621792019374, 8457.703980360659, 8618.525981070976, 8621.137886211329, 5331.973340133274, 6429.485641148697, 6471.0940468334475, 6481.740730370827, 6486.286508484063, 1844.1609067874085, 1858.1173942377534, 1886.226647074693, 1886.7169924511434, 1888.169205549554, 863.0851297624538, 879.71122305821, 993.5222350276159, 1069.8823129455754, 1075.2150929821273, 21160.365189044354, 21479.0, 21506.354809355744, 21555.568888622453, 21688.56622867534, 806.5080301016376, 942.7972985808084, 974.91713204377, 976.916962058233, 989.6091044037565, 11224.540809694687, 11254.887451125547, 11450.885491144982, 11566.884331156582, 11581.88418115825, 576941.0, 597154.0, 605592.0, 606696.0, 607067.0, 107341.46329268304, 107413.0, 113643.4317828422, 114177.4291128539, 125827.0, 958.2286259560981, 962.1773383756787, 1040.8022475729588, 1079.605943830512, 1083.009046722256, 18375.908120459313, 18645.627087458448, 18771.90614046921, 19158.61682766365, 19219.39827581879, 55633.0, 56450.71774641101, 56807.43192568021, 56886.7155664219, 57341.0, 79567.60216199113, 83515.0, 83642.16357836587, 83942.58028709817, 84825.0, 7889.526628402315, 8001.8399632008195, 8152.388570857091, 8212.83574328498, 8393.622286997223, 9129.269658427444, 12014.939925300318, 12908.741825163632, 12914.547990820276, 13065.412056457291, 9351.251899847859, 10775.94612026935, 11278.887211127783, 11371.886281137082, 11498.597549085742, 9260.351775375659, 9372.67195648149, 10289.707293666255, 11073.335599864035, 11253.437328133725, 11343.376114313462, 11350.205485615928, 11400.087992960378, 11467.541298347973, 11572.074234061423, 6337.271213810471, 8261.17388261169, 8291.08798032228, 8368.288695460955, 8427.662893484438, 9727.9027209727, 10350.482475876326, 10527.736806579896, 11298.774024519627, 11596.362200079077], "value": 9615.486163178673, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.2589749740146, 1482.4508388733768, 1672.8494435500802, 1703.3101593854494, 1747.4844920748378, 7612.314891659749, 7808.336291415237, 8321.459105158168, 8488.320934325255, 8850.955745221281, 7243.0, 7442.218567050463, 8619.65521379144, 8634.956825215864, 8656.220940115389, 2326.43002464396, 2366.4438856868624, 2368.632861906399, 2372.0748907925836, 2372.3120295114395, 2338.5206032763244, 2361.9055237790467, 2383.6067048936993, 2395.7604239576076, 2400.1719406804623, 2006.2175751456944, 2341.0635745701684, 2342.3090188394463, 2349.530093981202, 2358.7759162879497, 2335.4278201840657, 2345.6716059751648, 2347.3427440316736, 2353.7057867766443, 2360.3273067175946, 2344.788968992799, 2354.658574506687, 2365.065799009382, 2368.7749663781915, 2369.158948573266, 8619.482831030158, 8714.738557843275, 8771.298296136294, 8772.166644168858, 8774.254188393994, 5175.896482070375, 5245.396779370383, 5273.709945952971, 5316.441773613792, 5329.546988505982, 3540.8583656653705, 3649.4708267301094, 3678.521792167001, 3718.888433347004, 3725.3853114236117, 1070.8019016481976, 1106.5352551928208, 1118.669992352258, 1128.4583399968062, 1128.5880653561392, 11361.659150225423, 11427.028702560208, 11490.195686301962, 11495.367754773484, 11497.597584084517, 4301.924518870283, 4435.933460998088, 4617.238155704271, 4782.856514304576, 4816.95183048165, 9687.806243875082, 9799.314048016571, 9811.215102791759, 9813.018698130272, 9825.213982881352, 5240.68555886648, 5264.447233040476, 5286.682799031993, 5288.312519372457, 5290.127129023668, 4198.0, 4696.436427628706, 4823.083614113307, 4853.587445067138, 4862.124817532807, 3152.8896488622786, 3780.827943337574, 3913.726039177287, 3942.6254505821903, 4051.1492586556565, 1093.3494570730402, 1297.0596317669615, 1298.487097596463, 1304.2239867278954, 1330.527662679754, 833.8374017066614, 901.589776651622, 915.839728047589, 926.2728757924997, 948.2793077261331, 5607.579431542651, 5709.543236541067, 5884.264466941632, 5945.16767652529, 6018.21763170785, 434.6001678455765, 443.5564435564436, 450.9188346097668, 952.3238500664468, 981.79873126009, 3324.8171350575467, 3923.1761330120426, 3927.430522574268, 4048.6153815387493, 4098.385242213632, 10379.11777498921, 10613.628523001813, 10654.786904262026, 10683.465826708634, 10699.946500267604, 10611.098056665116, 10624.521896514676, 10630.09644180238, 10643.254972151875, 10675.412852293199, 7956.045274566974, 8047.195280471906, 8081.4747041442115, 8102.432829701982, 8111.594420278962, 5140.948590514047, 5221.138512145453, 5597.580181486323, 5785.0, 5831.271091113611, 7694.230576942261, 9754.268429867647, 9920.355176913477, 9927.602895884083, 9955.50222488887, 8232.50604963704, 9833.901660983585, 9853.704388868346, 10025.348352357074, 10026.949865250626, 6754.358335958076, 7278.927210727825, 7379.262073792578, 7403.0, 7562.584057876649, 8327.20891515305, 8427.0, 8432.283255923316, 8442.53566053873, 8457.78855528592, 7314.195438501654, 7399.3340599344165, 7436.219196984239, 7478.6260686966525, 7532.962335188289, 7321.963390183015, 7397.926020739724, 7475.289847464483, 7487.876818477272, 7539.698412063456, 6785.423239024738, 6817.147856517935, 6895.620740859301, 6948.096747422803, 6992.1259842519685, 4681.648876334357, 4868.269759536098, 5087.949120508895, 5201.635885488131, 5202.115640341075, 4981.4022317320705, 5025.883951949814, 5174.689518628894, 5288.65623734456, 5378.462153784591], "value": 4493.928897792478, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.29947871199465, 305.5340605576496, 312.32381893201216, 315.03127881763584, 316.1511342046605, 4838.830640927568, 5341.1187154119525, 5548.805791797288, 5575.553955683546, 5583.944160558393, 4667.486576476585, 5440.945590544094, 5482.095454250044, 5502.129276046144, 5560.915621453808, 3684.613115622861, 4217.578242175781, 4232.703710740249, 4255.1915136124035, 4267.231898258312, 3732.0406786437065, 4170.291050521419, 4182.602652747984, 4257.084726783741, 4268.829246830123, 3844.442555829403, 3848.5946283572766, 3939.8621048263317, 4172.915042089064, 4175.726403446947, 4009.3785463253244, 4161.542230354644, 4203.684723645708, 4205.537390887, 4266.637335826458, 3649.7445178837493, 3659.743817932746, 3661.0115268877253, 3669.1837540417664, 3698.223373091654, 4475.261581838992, 5160.716160611165, 5219.973900130513, 5385.569154467633, 5412.972935135338, 4673.836415725467, 4746.504850971933, 4805.5434733700595, 4818.855434336975, 4853.3447984522345, 5543.196236545718, 5831.88336233273, 5831.970840145772, 5839.445252700986, 5881.735321910524, 3990.221906728189, 4003.919921601581, 4006.579309172553, 4008.7995600220165, 4027.7986100695143, 5489.835304940818, 6134.386561343875, 6182.876342473125, 6183.938160618426, 6212.968935155295, 3262.510623406508, 3853.7687738735767, 4071.4096456014304, 4082.714210005271, 4113.753174809521, 3273.787203831743, 3899.6100389961343, 4011.7392369495888, 4093.97953010239, 4133.7106402551535, 4449.3993310902615, 4522.45730512334, 4817.8313759018965, 4826.0830442215865, 4853.199222128309, 5167.560757335594, 5553.527950124204, 5885.705714714247, 5892.469677729025, 5903.409659034148, 1147.52377763229, 1182.184292837939, 1260.9156125731863, 1271.9300438475973, 1409.563035459011, 890.4390234152443, 894.6197865906963, 935.93596023243, 960.702182323468, 961.024560071528, 5265.341832270966, 5315.893682126336, 5344.4922732340365, 5362.839114826562, 5392.514673679388, 5410.83767486976, 5613.326400831845, 5663.348714897757, 5931.673757943268, 5961.552883533753, 4170.47869016373, 4749.453812811502, 5089.287499750038, 5361.865953351197, 5428.891422171534, 2633.210036988896, 2902.1438675590753, 3077.984265192481, 3120.953185702216, 3132.9060128196193, 5376.709589698444, 5591.903036361365, 6262.655553944485, 6280.434760871543, 6285.465735412541, 5844.240248767633, 5863.332183856335, 6086.573939824259, 6143.801958618026, 6181.567290289637, 6037.939620603738, 6228.408301211468, 6234.688265586612, 6269.78055768055, 6281.811545653638, 4829.106615276185, 5555.72221388937, 5622.690752008679, 5862.765489380377, 5941.0, 5863.589548731547, 5917.970410147922, 5919.792807251898, 5925.259342582177, 5952.910706339322, 5263.473652634706, 5527.474889885454, 5866.767978724516, 6247.314084690055, 6256.687165641791, 3678.319510890494, 3955.169414423003, 3985.242803867256, 3992.640662340403, 4013.438118663331, 4937.604991600735, 5824.883502330014, 5948.524118070631, 6021.789237376671, 6048.002079656807, 5106.948930510647, 5306.442823503631, 5605.355384130714, 5647.632903861236, 5837.6497410155525, 5099.69401835891, 5474.932388184266, 5915.733791979457, 5920.881582368243, 5964.940350596438, 4721.5750582447745, 4725.173094708481, 5235.240890070842, 5500.87232117423, 5876.764929402947, 5163.4062082860955, 5322.247815290134, 5884.705764711833, 5915.940840591711, 5978.8206353809455, 5013.373328333958, 5750.166225897138, 5781.132830075522, 5794.537321638371, 5839.8540036497725], "value": 4224.064051710641, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.3525077798367, 729.0413106764601, 750.9173990861008, 785.4305628419397, 834.5118105908045, 15398.0, 16461.341546338146, 16608.16959152042, 16638.66722665546, 17236.396726114588, 16586.58533536659, 17011.234494447748, 17105.144742762845, 17132.743008854875, 17153.91423042886, 854.8204876975842, 871.7036207689384, 873.5326600268858, 873.6942070275385, 875.264777586827, 681.6114814555705, 846.8729690546405, 865.9004214515317, 882.8984666763308, 893.1381217125472, 929.7582628516601, 932.911373419524, 933.1788026536639, 933.9346245762799, 936.5083331251113, 926.1155596405484, 926.4395041000199, 926.4811705444905, 926.8563372677246, 929.4005366538579, 687.6183718036488, 694.2190036209265, 694.7950354645392, 696.9094017777708, 697.5221972948547, 15596.454124105716, 15761.527154185278, 15792.0, 15799.763003554956, 15820.525384238492, 14461.349239284153, 14514.129152250898, 14543.70912581753, 14579.70840583193, 14640.780388294184, 11837.467313970892, 12123.0, 12169.2698438094, 12250.264984100982, 12269.20250183744, 3487.511748355232, 3818.713596480275, 3873.7482063666052, 3877.495925529663, 3884.8251828667494, 123937.38031309877, 125901.0, 126150.0, 126310.36844815809, 129578.0, 11060.834087488694, 11103.611373601885, 11136.443177841076, 11319.490622921989, 11477.311361318347, 22622.66066009011, 22798.0, 22798.31605051851, 22838.543229135325, 22906.770932290798, 6975.9302406975285, 7974.362051035903, 8094.878576821352, 8101.713190367802, 8315.792105197419, 4535.727856328631, 4562.406887104655, 4593.122794407607, 4595.793189306489, 4615.892185875366, 3613.4941108244866, 3728.198437335986, 3737.1965027519213, 3745.026293163797, 3746.0260332313796, 644.4168027934727, 651.931547187548, 652.7128063651978, 657.0899304463353, 664.3887623386496, 548.7695168029437, 674.7739507265023, 693.1335830212234, 694.8818700820772, 719.6221983458726, 8996.550172491348, 9514.714558563253, 9607.231421486264, 9731.464769437749, 9746.805063898682, 603.864130570618, 643.520577170002, 668.7057694614355, 675.5743881354813, 703.5462126928103, 4395.230834603932, 4424.761066901273, 4696.882577935579, 4722.24444088951, 4735.692180008288, 107603.46198268958, 154247.0, 156957.43042569427, 163396.0, 165688.17155914142, 106298.46850765852, 109279.0, 117883.0, 124881.37559312327, 147818.0, 88851.55574222088, 100291.0, 111709.0, 114301.0, 114996.85003149862, 8243.670253189804, 9319.813603727753, 9771.169450596779, 9848.852267215854, 9945.801083978424, 47281.29078063901, 49220.507794923025, 60182.69908650429, 65263.0, 66003.33996659971, 80895.19104808876, 94298.05701942893, 99798.0, 100183.99632007464, 103998.0, 13096.345182740633, 13195.80206296887, 13277.601671949857, 13341.466341346237, 13544.916941547071, 11567.0, 14048.578542643738, 14819.703605928036, 14995.17526536051, 15031.661273993963, 13698.589042328746, 13921.4431422746, 14057.859421406065, 14147.0, 14593.978421510392, 14019.0, 14093.577192684235, 14110.717785644434, 14395.640108997359, 14709.41162353494, 13867.0, 14016.78974815399, 14084.78872816888, 14256.643583910485, 14402.639934001734, 9666.178374838217, 10811.648543932008, 11251.887481125412, 11346.659600212008, 11720.296782193096, 7567.545947243183, 8918.955405222932, 9444.763880903032, 10898.945505272422, 11257.437128143723], "value": 7980.926017312757, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 116.0, 114.0, 118.0, 117.0, 116.0, 119.0, 115.0, 147.0], "value": 118.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 112.0, 136.0, 189.0, 141.0, 129.0, 129.0, 112.0, 158.0, 110.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 214.0, 213.0, 237.0, 276.0, 218.0, 193.0, 198.0, 198.0, 216.0], "value": 216.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 84.0, 79.0, 148.0, 59.0, 60.0, 60.0, 64.0, 136.0, 60.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 118.0, 71.0, 73.0, 87.0, 111.0, 70.0, 74.0, 115.0], "value": 86.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 85.0, 90.0, 85.0, 89.0, 86.0, 88.0, 87.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 117.0, 120.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 94.0], "value": 99.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 149.0, 137.0, 99.0, 79.0, 102.0, 148.0, 147.0, 97.0, 152.0], "value": 121.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 49.0, 51.0, 62.0, 50.0, 57.0, 83.0, 48.0, 52.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 67.0, 70.0, 75.0, 78.0, 75.0, 70.0, 67.0, 72.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 92.0, 90.0, 88.0, 85.0, 89.0, 103.0, 109.0, 84.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 157.0, 155.0, 150.0, 166.0, 163.0, 155.0, 158.0, 153.0, 141.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 211.0, 173.0, 169.0, 176.0, 229.0, 174.0, 226.0, 241.0, 167.0], "value": 194.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 74.0, 86.0, 76.0, 68.0, 66.0, 72.0, 68.0, 67.0], "value": 71.2, "unit": "score"}]}]} 15:10:46 INFO - Return code: 0 15:10:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:10:46 ERROR - # TBPL SUCCESS # 15:10:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:10:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:10:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:10:46 INFO - 2016-08-23 15:10:46.778 screenresolution[1660:10706] starting screenresolution argv=screenresolution get 15:10:46 INFO - 2016-08-23 15:10:46.781 screenresolution[1660:10706] Display 0: 1600x1200x32@60 15:10:46 INFO - 2016-08-23 15:10:46.787 screenresolution[1661:10709] starting screenresolution argv=screenresolution list 15:10:46 INFO - Available Modes on Display 0 15:10:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:10:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:10:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:10:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:10:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:10:47 INFO - Intel Iris: 15:10:47 INFO - Chipset Model: Intel Iris 15:10:47 INFO - Type: GPU 15:10:47 INFO - Bus: Built-In 15:10:47 INFO - VRAM (Dynamic, Max): 1536 MB 15:10:47 INFO - Vendor: Intel (0x8086) 15:10:47 INFO - Device ID: 0x0a2e 15:10:47 INFO - Revision ID: 0x0009 15:10:47 INFO - Displays: 15:10:47 INFO - Display: 15:10:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:10:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:10:47 INFO - Display Serial Number: 1600x1200 60 15:10:47 INFO - Main Display: Yes 15:10:47 INFO - Mirror: Off 15:10:47 INFO - Online: Yes 15:10:47 INFO - Rotation: Supported 15:10:47 INFO - Return code: 0 15:10:47 INFO - Running post-action listener: _resource_record_post_action 15:10:47 INFO - [mozharness: 2016-08-23 22:10:47.021203Z] Finished run-tests step (success) 15:10:47 INFO - Running post-run listener: _resource_record_post_run 15:10:47 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 38306816; Write bytes: 707225088; Read time: 376; Write time: 2165 15:10:47 INFO - TinderboxPrint: CPU usage
54.4% 15:10:47 INFO - TinderboxPrint: I/O read bytes / time
38,306,816 / 376 15:10:47 INFO - TinderboxPrint: I/O write bytes / time
707,225,088 / 2,165 15:10:47 INFO - TinderboxPrint: CPU idle
2,206.7 (45.6%) 15:10:47 INFO - TinderboxPrint: CPU system
977.6 (20.2%) 15:10:47 INFO - TinderboxPrint: CPU user
1,653.3 (34.2%) 15:10:47 INFO - TinderboxPrint: Swap in / out
443,899,904 / 0 15:10:47 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 397066752; Write bytes: 390571520; Read time: 29650; Write time: 746 15:10:47 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 36299776; Write bytes: 297689088; Read time: 354; Write time: 1354 15:10:47 INFO - Running post-run listener: _upload_blobber_files 15:10:47 INFO - Blob upload gear active. 15:10:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:10: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 15:10: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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:10: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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:10:47 INFO - (blobuploader) - INFO - Open directory for files ... 15:10:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:10:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:10:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:49 INFO - (blobuploader) - INFO - Done attempting. 15:10:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:10:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:10:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:50 INFO - (blobuploader) - INFO - Done attempting. 15:10:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:10:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:10:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:52 INFO - (blobuploader) - INFO - Done attempting. 15:10:52 INFO - (blobuploader) - INFO - Iteration through files over. 15:10:52 INFO - Return code: 0 15:10:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:10:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:10:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9ecb8639bebb3778916b7b0be124a1f39cc6aa9069c2f447d314fe1698ba55b090afdd73acee43d201542f4637684610567af436bdc4045ccba17634fd1bbc7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6c9afecf8020dd472ebbabd6427177a51d641fb34f5b2e1819dfc43e85af92b8fa0f13306e3387ec8b8c76a9478deed91f7bbb9a5122657301b835980b803845", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bba1078c0b5c31449e1c99b30d7a76458ee7ec54d569f9e8e4fffe4301322ba11222e7f9491c0b9ffb7e8eec0f28dd4e307c4b31b9be81a71313045c42266c02"} 15:10:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:10:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:10:52 INFO - Contents: 15:10:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9ecb8639bebb3778916b7b0be124a1f39cc6aa9069c2f447d314fe1698ba55b090afdd73acee43d201542f4637684610567af436bdc4045ccba17634fd1bbc7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6c9afecf8020dd472ebbabd6427177a51d641fb34f5b2e1819dfc43e85af92b8fa0f13306e3387ec8b8c76a9478deed91f7bbb9a5122657301b835980b803845", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bba1078c0b5c31449e1c99b30d7a76458ee7ec54d569f9e8e4fffe4301322ba11222e7f9491c0b9ffb7e8eec0f28dd4e307c4b31b9be81a71313045c42266c02"} 15:10:52 INFO - Running post-run listener: copy_logs_to_upload_dir 15:10:52 INFO - Copying logs to upload dir... 15:10:52 INFO - mkdir: /builds/slave/test/build/upload/logs 15:10:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.645982 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-23 15:10:52.599385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 15:10:52.604071) ========= 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.xfOuIih9f2/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.Nhrj80MsmN/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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/Autoland/sha512/9ecb8639bebb3778916b7b0be124a1f39cc6aa9069c2f447d314fe1698ba55b090afdd73acee43d201542f4637684610567af436bdc4045ccba17634fd1bbc7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6c9afecf8020dd472ebbabd6427177a51d641fb34f5b2e1819dfc43e85af92b8fa0f13306e3387ec8b8c76a9478deed91f7bbb9a5122657301b835980b803845", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bba1078c0b5c31449e1c99b30d7a76458ee7ec54d569f9e8e4fffe4301322ba11222e7f9491c0b9ffb7e8eec0f28dd4e307c4b31b9be81a71313045c42266c02"} build_url:https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011060 build_url: 'https://queue.taskcluster.net/v1/task/UwTr2vokQrutpOBFSxhfwA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9ecb8639bebb3778916b7b0be124a1f39cc6aa9069c2f447d314fe1698ba55b090afdd73acee43d201542f4637684610567af436bdc4045ccba17634fd1bbc7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6c9afecf8020dd472ebbabd6427177a51d641fb34f5b2e1819dfc43e85af92b8fa0f13306e3387ec8b8c76a9478deed91f7bbb9a5122657301b835980b803845", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bba1078c0b5c31449e1c99b30d7a76458ee7ec54d569f9e8e4fffe4301322ba11222e7f9491c0b9ffb7e8eec0f28dd4e307c4b31b9be81a71313045c42266c02"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 15:10:52.641672) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 15:10:52.642100) ========= 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.xfOuIih9f2/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.Nhrj80MsmN/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005072 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 15:10:52.694531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 15:10:52.697904) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 15:10:52.698284) ========= ========= Total master_lag: 0.20 =========