builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0155 starttime: 1472842247.49 results: success (0) buildid: 20160902095849 builduid: 622b57a8f6894c51936ff198d1210de0 revision: 0907f97ba5e3ec9aaeb58c69651e8e6927472f1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 11:50:47.494548) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 11:50:47.494986) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 11:50:47.495273) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 11:50:47.594263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 11:50:47.594653) ========= 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.1tsK8t9ZBj/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.oE1GysClBU/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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-09-02 11:50:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.3M=0.001s 2016-09-02 11:50:48 (15.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.582650 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 11:50:48.201577) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 11:50:48.201894) ========= 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.1tsK8t9ZBj/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.oE1GysClBU/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.029749 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 11:50:48.253690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 11:50:48.254099) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0907f97ba5e3ec9aaeb58c69651e8e6927472f1b --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 0907f97ba5e3ec9aaeb58c69651e8e6927472f1b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1tsK8t9ZBj/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.oE1GysClBU/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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-09-02 11:50:48,336 truncating revision to first 12 chars 2016-09-02 11:50:48,336 Setting DEBUG logging. 2016-09-02 11:50:48,336 attempt 1/10 2016-09-02 11:50:48,336 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0907f97ba5e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 11:50:49,021 unpacking tar archive at: autoland-0907f97ba5e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.943549 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 11:50:49.220487) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 11:50:49.220798) ========= script_repo_revision: 0907f97ba5e3ec9aaeb58c69651e8e6927472f1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 11:50:49.221200) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 11:50:49.221482) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 11:50:49.240994) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-02 11:50:49.241431) ========= /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.1tsK8t9ZBj/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.oE1GysClBU/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:50:49 INFO - MultiFileLogger online at 20160902 11:50:49 in /builds/slave/test 11:50:49 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 11:50:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:50:49 INFO - {'append_to_log': False, 11:50:49 INFO - 'base_work_dir': '/builds/slave/test', 11:50:49 INFO - 'blob_upload_branch': 'Autoland', 11:50:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:50:49 INFO - 'branch': 'Autoland', 11:50:49 INFO - 'buildbot_json_path': 'buildprops.json', 11:50:49 INFO - 'config_files': ('talos/mac_config.py',), 11:50:49 INFO - 'default_actions': ('clobber', 11:50:49 INFO - 'read-buildbot-config', 11:50:49 INFO - 'download-and-extract', 11:50:49 INFO - 'populate-webroot', 11:50:49 INFO - 'create-virtualenv', 11:50:49 INFO - 'install', 11:50:49 INFO - 'run-tests'), 11:50:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:50:49 INFO - 'download_minidump_stackwalk': True, 11:50:49 INFO - 'download_symbols': 'ondemand', 11:50:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:50:49 INFO - 'tooltool.py': '/tools/tooltool.py', 11:50:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:50:49 INFO - '/tools/misc-python/virtualenv.py')}, 11:50:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:50:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:50:49 INFO - 'installer_path': 'installer.exe', 11:50:49 INFO - 'log_level': 'info', 11:50:49 INFO - 'log_name': 'talos', 11:50:49 INFO - 'log_to_console': True, 11:50:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:50:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:50:49 INFO - 'opt_config_files': (), 11:50:49 INFO - 'pip_index': False, 11:50:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:50:49 INFO - 'cmd': ('bash', 11:50:49 INFO - '-c', 11:50:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:50:49 INFO - 'enabled': True, 11:50:49 INFO - 'halt_on_failure': False, 11:50:49 INFO - 'name': 'check_screen_resolution'},), 11:50:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:50:49 INFO - 'cmd': ('bash', 11:50:49 INFO - '-c', 11:50:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:50:49 INFO - 'enabled': True, 11:50:49 INFO - 'halt_on_failure': False, 11:50:49 INFO - 'name': 'check_screen_resolution'},), 11:50:49 INFO - 'run_cmd_checks_enabled': True, 11:50:49 INFO - 'sps_profile': False, 11:50:49 INFO - 'sps_profile_interval': 0, 11:50:49 INFO - 'suite': 'dromaeojs-e10s', 11:50:49 INFO - 'system_bits': '32', 11:50:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:50:49 INFO - 'title': 't-yosemite-r7-0155', 11:50:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:50:49 INFO - 'use_talos_json': True, 11:50:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:50:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:50:49 INFO - 'work_dir': 'build'} 11:50:49 INFO - [mozharness: 2016-09-02 18:50:49.470337Z] Running clobber step. 11:50:49 INFO - Running pre-action listener: _resource_record_pre_action 11:50:49 INFO - Running main action method: clobber 11:50:49 INFO - rmtree: /builds/slave/test/build 11:50:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:50:51 INFO - Running post-action listener: _resource_record_post_action 11:50:51 INFO - [mozharness: 2016-09-02 18:50:51.787905Z] Finished clobber step (success) 11:50:51 INFO - [mozharness: 2016-09-02 18:50:51.788032Z] Running read-buildbot-config step. 11:50:51 INFO - Running pre-action listener: _resource_record_pre_action 11:50:51 INFO - Running main action method: read_buildbot_config 11:50:51 INFO - Using buildbot properties: 11:50:51 INFO - { 11:50:51 INFO - "project": "", 11:50:51 INFO - "product": "firefox", 11:50:51 INFO - "script_repo_revision": "production", 11:50:51 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 11:50:51 INFO - "repository": "", 11:50:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 11:50:51 INFO - "buildid": "20160902095849", 11:50:51 INFO - "pgo_build": "False", 11:50:51 INFO - "basedir": "/builds/slave/test", 11:50:51 INFO - "buildnumber": 160, 11:50:51 INFO - "slavename": "t-yosemite-r7-0155", 11:50:51 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 11:50:51 INFO - "platform": "yosemite_r7", 11:50:51 INFO - "scheduler": "tests-autoland-macosx64-talos-7-3600", 11:50:51 INFO - "branch": "autoland", 11:50:51 INFO - "repo_path": "integration/autoland", 11:50:51 INFO - "revision": "0907f97ba5e3ec9aaeb58c69651e8e6927472f1b", 11:50:51 INFO - "stage_platform": "macosx64", 11:50:51 INFO - "builduid": "622b57a8f6894c51936ff198d1210de0", 11:50:51 INFO - "slavebuilddir": "test" 11:50:51 INFO - } 11:50:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:50:51 INFO - Running post-action listener: _resource_record_post_action 11:50:51 INFO - [mozharness: 2016-09-02 18:50:51.791478Z] Finished read-buildbot-config step (success) 11:50:51 INFO - [mozharness: 2016-09-02 18:50:51.791566Z] Running download-and-extract step. 11:50:51 INFO - Running pre-action listener: _resource_record_pre_action 11:50:51 INFO - Running main action method: download_and_extract 11:50:51 INFO - mkdir: /builds/slave/test/build/tests 11:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:51 INFO - trying https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:50:51 INFO - Downloading https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 11:50:52 INFO - Downloaded 1199 bytes. 11:50:52 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:50:52 INFO - Using the following test package requirements: 11:50:52 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:50:52 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:50:52 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:50:52 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'jsshell-mac.zip'], 11:50:52 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:50:52 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:50:52 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:50:52 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:50:52 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:50:52 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:50:52 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:50:52 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:52 INFO - trying https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:50:52 INFO - Downloading https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:50:53 INFO - Downloaded 16399363 bytes. 11:50:53 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:51:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:00 INFO - trying https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:51:00 INFO - Downloading https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:51:01 INFO - Downloaded 16399363 bytes. 11:51:01 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:08 INFO - trying https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:51:08 INFO - Downloading https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:51:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:51:10 INFO - Downloaded 14413998 bytes. 11:51:10 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 11:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:10 INFO - trying https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:51:10 INFO - Downloading https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 11:51:13 INFO - Downloaded 111625300 bytes. 11:51:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:51:13 INFO - mkdir: /builds/slave/test/properties 11:51:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:51:13 INFO - Writing to file /builds/slave/test/properties/build_url 11:51:13 INFO - Contents: 11:51:13 INFO - build_url:https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:51:14 INFO - Running post-action listener: _resource_record_post_action 11:51:14 INFO - Running post-action listener: set_extra_try_arguments 11:51:14 INFO - [mozharness: 2016-09-02 18:51:14.096256Z] Finished download-and-extract step (success) 11:51:14 INFO - [mozharness: 2016-09-02 18:51:14.096384Z] Running populate-webroot step. 11:51:14 INFO - Running pre-action listener: _resource_record_pre_action 11:51:14 INFO - Running main action method: populate_webroot 11:51:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:51:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:51:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:51:14 INFO - '--tppagecycles', 11:51:14 INFO - '7'], 11:51:14 INFO - 'tests': ['tsvgm']}}, 11:51:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:51:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:51:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:51:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:51:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:51:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:51:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:14 INFO - 'talos_options': ['--disable-e10s'], 11:51:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:14 INFO - 'talos_options': ['--disable-e10s'], 11:51:14 INFO - 'tests': ['damp', 'tps']}, 11:51:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:14 INFO - 'tests': ['damp', 'tps']}, 11:51:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:51:14 INFO - 'tests': ['dromaeo_dom']}, 11:51:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:51:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:51:14 INFO - 'tests': ['basic_compositor_video']}, 11:51:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:51:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:51:14 INFO - 'tests': ['a11yr', 11:51:14 INFO - 'ts_paint', 11:51:14 INFO - 'tpaint', 11:51:14 INFO - 'sessionrestore', 11:51:14 INFO - 'sessionrestore_no_auto_restore', 11:51:14 INFO - 'tabpaint']}, 11:51:14 INFO - 'other-e10s': {'tests': ['a11yr', 11:51:14 INFO - 'ts_paint', 11:51:14 INFO - 'tpaint', 11:51:14 INFO - 'sessionrestore', 11:51:14 INFO - 'sessionrestore_no_auto_restore', 11:51:14 INFO - 'tabpaint']}, 11:51:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:51:14 INFO - 'ts_paint', 11:51:14 INFO - 'tpaint', 11:51:14 INFO - 'sessionrestore', 11:51:14 INFO - 'sessionrestore_no_auto_restore', 11:51:14 INFO - 'tabpaint']}, 11:51:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:51:14 INFO - 'ts_paint', 11:51:14 INFO - 'tpaint', 11:51:14 INFO - 'sessionrestore', 11:51:14 INFO - 'sessionrestore_no_auto_restore', 11:51:14 INFO - 'tabpaint']}, 11:51:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:51:14 INFO - 'tests': ['a11yr', 11:51:14 INFO - 'ts_paint', 11:51:14 INFO - 'tpaint', 11:51:14 INFO - 'sessionrestore', 11:51:14 INFO - 'sessionrestore_no_auto_restore', 11:51:14 INFO - 'tabpaint']}, 11:51:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:51:14 INFO - 'tests': ['a11yr', 11:51:14 INFO - 'ts_paint', 11:51:14 INFO - 'tpaint', 11:51:14 INFO - 'sessionrestore', 11:51:14 INFO - 'sessionrestore_no_auto_restore', 11:51:14 INFO - 'tabpaint']}, 11:51:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:51:14 INFO - 'tests': ['tsvgx', 11:51:14 INFO - 'tsvgr_opacity', 11:51:14 INFO - 'tart', 11:51:14 INFO - 'tscrollx', 11:51:14 INFO - 'cart']}, 11:51:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:51:14 INFO - 'tsvgr_opacity', 11:51:14 INFO - 'tart', 11:51:14 INFO - 'tscrollx', 11:51:14 INFO - 'cart']}, 11:51:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:14 INFO - 'talos_options': ['--disable-e10s'], 11:51:14 INFO - 'tests': ['tp5o']}, 11:51:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:14 INFO - 'tests': ['tp5o']}, 11:51:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:14 INFO - 'talos_options': ['--disable-e10s', 11:51:14 INFO - '--xperf_path', 11:51:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:14 INFO - 'tests': ['tp5n']}, 11:51:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:14 INFO - 'talos_options': ['--xperf_path', 11:51:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:14 INFO - 'tests': ['tp5n']}}, 11:51:14 INFO - 'talos.zip': {'path': '', 11:51:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:51:14 INFO - Running post-action listener: _resource_record_post_action 11:51:14 INFO - [mozharness: 2016-09-02 18:51:14.115697Z] Finished populate-webroot step (success) 11:51:14 INFO - [mozharness: 2016-09-02 18:51:14.115788Z] Running create-virtualenv step. 11:51:14 INFO - Running pre-action listener: _resource_record_pre_action 11:51:14 INFO - Running main action method: create_virtualenv 11:51:14 INFO - Creating virtualenv /builds/slave/test/build/venv 11:51:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:51:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:51:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:51:14 INFO - Using real prefix '/tools/python27' 11:51:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:51:14 INFO - Installing distribute.............................................................................................................................................................................................done. 11:51:17 INFO - Installing pip.................done. 11:51:17 INFO - Return code: 0 11:51:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf62491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b910b20>, '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.1tsK8t9ZBj/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.oE1GysClBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:51: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', 'pip>=1.5'] in /builds/slave/test/build 11:51: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 pip>=1.5 11:51:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1tsK8t9ZBj/Render', 11:51:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:17 INFO - 'HOME': '/Users/cltbld', 11:51:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:17 INFO - 'LOGNAME': 'cltbld', 11:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:17 INFO - 'MOZ_NO_REMOTE': '1', 11:51:17 INFO - 'NO_EM_RESTART': '1', 11:51:17 INFO - 'PAGER': '/bin/cat', 11:51:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:17 INFO - 'PWD': '/builds/slave/test', 11:51:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:17 INFO - 'SHELL': '/bin/bash', 11:51:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oE1GysClBU/Listeners', 11:51:17 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:51:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:17 INFO - 'USER': 'cltbld', 11:51:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:17 INFO - 'XPC_FLAGS': '0x0', 11:51:17 INFO - 'XPC_SERVICE_NAME': '0', 11:51:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:51:18 INFO - Cleaning up... 11:51:18 INFO - Return code: 0 11:51:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:18 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 0x10b9b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf62491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b910b20>, '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.1tsK8t9ZBj/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.oE1GysClBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:51:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1tsK8t9ZBj/Render', 11:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:18 INFO - 'HOME': '/Users/cltbld', 11:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:18 INFO - 'LOGNAME': 'cltbld', 11:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:18 INFO - 'MOZ_NO_REMOTE': '1', 11:51:18 INFO - 'NO_EM_RESTART': '1', 11:51:18 INFO - 'PAGER': '/bin/cat', 11:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:18 INFO - 'PWD': '/builds/slave/test', 11:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:18 INFO - 'SHELL': '/bin/bash', 11:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oE1GysClBU/Listeners', 11:51:18 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:18 INFO - 'USER': 'cltbld', 11:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:18 INFO - 'XPC_FLAGS': '0x0', 11:51:18 INFO - 'XPC_SERVICE_NAME': '0', 11:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:18 INFO - Downloading/unpacking psutil>=3.1.1 11:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:51:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:51:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:51:21 INFO - Installing collected packages: psutil 11:51:21 INFO - Running setup.py install for psutil 11:51:21 INFO - building 'psutil._psutil_osx' extension 11:51:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:51:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:51:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:51:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:51:22 INFO - building 'psutil._psutil_posix' extension 11:51:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:51:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:51:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:51:22 INFO - ^ 11:51:22 INFO - 1 warning generated. 11:51:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:51:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:51:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:51:22 INFO - Successfully installed psutil 11:51:22 INFO - Cleaning up... 11:51:23 INFO - Return code: 0 11:51:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:23 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 0x10b9b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf62491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b910b20>, '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.1tsK8t9ZBj/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.oE1GysClBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1tsK8t9ZBj/Render', 11:51:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:23 INFO - 'HOME': '/Users/cltbld', 11:51:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:23 INFO - 'LOGNAME': 'cltbld', 11:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:23 INFO - 'MOZ_NO_REMOTE': '1', 11:51:23 INFO - 'NO_EM_RESTART': '1', 11:51:23 INFO - 'PAGER': '/bin/cat', 11:51:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:23 INFO - 'PWD': '/builds/slave/test', 11:51:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:23 INFO - 'SHELL': '/bin/bash', 11:51:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oE1GysClBU/Listeners', 11:51:23 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:23 INFO - 'USER': 'cltbld', 11:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:23 INFO - 'XPC_FLAGS': '0x0', 11:51:23 INFO - 'XPC_SERVICE_NAME': '0', 11:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:51:25 INFO - Installing collected packages: mozsystemmonitor 11:51:25 INFO - Running setup.py install for mozsystemmonitor 11:51:26 INFO - Successfully installed mozsystemmonitor 11:51:26 INFO - Cleaning up... 11:51:26 INFO - Return code: 0 11:51:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:26 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 0x10b9b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf62491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b910b20>, '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.1tsK8t9ZBj/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.oE1GysClBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1tsK8t9ZBj/Render', 11:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:26 INFO - 'HOME': '/Users/cltbld', 11:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:26 INFO - 'LOGNAME': 'cltbld', 11:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:26 INFO - 'MOZ_NO_REMOTE': '1', 11:51:26 INFO - 'NO_EM_RESTART': '1', 11:51:26 INFO - 'PAGER': '/bin/cat', 11:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:26 INFO - 'PWD': '/builds/slave/test', 11:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:26 INFO - 'SHELL': '/bin/bash', 11:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oE1GysClBU/Listeners', 11:51:26 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:26 INFO - 'USER': 'cltbld', 11:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:26 INFO - 'XPC_FLAGS': '0x0', 11:51:26 INFO - 'XPC_SERVICE_NAME': '0', 11:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:26 INFO - Downloading/unpacking jsonschema==2.5.1 11:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:51:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:29 INFO - Downloading functools32-3.2.3-2.tar.gz 11:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:51:29 INFO - warning: no files found matching '*.txt' 11:51:29 INFO - no previously-included directories found matching 'build' 11:51:29 INFO - no previously-included directories found matching 'dist' 11:51:29 INFO - no previously-included directories found matching '.git*' 11:51:29 INFO - Installing collected packages: jsonschema, functools32 11:51:29 INFO - Running setup.py install for functools32 11:51:29 INFO - warning: no files found matching '*.txt' 11:51:29 INFO - no previously-included directories found matching 'build' 11:51:29 INFO - no previously-included directories found matching 'dist' 11:51:29 INFO - no previously-included directories found matching '.git*' 11:51:29 INFO - Successfully installed jsonschema functools32 11:51:29 INFO - Cleaning up... 11:51:29 INFO - Return code: 0 11:51:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:29 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 0x10b9b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf62491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b910b20>, '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.1tsK8t9ZBj/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.oE1GysClBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1tsK8t9ZBj/Render', 11:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:29 INFO - 'HOME': '/Users/cltbld', 11:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:29 INFO - 'LOGNAME': 'cltbld', 11:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:29 INFO - 'MOZ_NO_REMOTE': '1', 11:51:29 INFO - 'NO_EM_RESTART': '1', 11:51:29 INFO - 'PAGER': '/bin/cat', 11:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:29 INFO - 'PWD': '/builds/slave/test', 11:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:29 INFO - 'SHELL': '/bin/bash', 11:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oE1GysClBU/Listeners', 11:51:29 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:29 INFO - 'USER': 'cltbld', 11:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:29 INFO - 'XPC_FLAGS': '0x0', 11:51:29 INFO - 'XPC_SERVICE_NAME': '0', 11:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:51:29 INFO - Cleaning up... 11:51:29 INFO - Return code: 0 11:51:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:29 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 0x10b9b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf62491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b910b20>, '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.1tsK8t9ZBj/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.oE1GysClBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1tsK8t9ZBj/Render', 11:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:29 INFO - 'HOME': '/Users/cltbld', 11:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:29 INFO - 'LOGNAME': 'cltbld', 11:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:29 INFO - 'MOZ_NO_REMOTE': '1', 11:51:29 INFO - 'NO_EM_RESTART': '1', 11:51:29 INFO - 'PAGER': '/bin/cat', 11:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:29 INFO - 'PWD': '/builds/slave/test', 11:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:29 INFO - 'SHELL': '/bin/bash', 11:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oE1GysClBU/Listeners', 11:51:29 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:29 INFO - 'USER': 'cltbld', 11:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:29 INFO - 'XPC_FLAGS': '0x0', 11:51:29 INFO - 'XPC_SERVICE_NAME': '0', 11:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:30 INFO - Downloading/unpacking blobuploader==1.2.4 11:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:32 INFO - Downloading blobuploader-1.2.4.tar.gz 11:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:51:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51: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 11:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:51:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:33 INFO - Downloading docopt-0.6.1.tar.gz 11:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:51:33 INFO - Installing collected packages: blobuploader, requests, docopt 11:51:33 INFO - Running setup.py install for blobuploader 11:51:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:51:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:51:33 INFO - Running setup.py install for requests 11:51:34 INFO - Running setup.py install for docopt 11:51:34 INFO - Successfully installed blobuploader requests docopt 11:51:34 INFO - Cleaning up... 11:51:34 INFO - Return code: 0 11:51:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:34 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 0x10b9b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf62491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b910b20>, '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.1tsK8t9ZBj/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.oE1GysClBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1tsK8t9ZBj/Render', 11:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:34 INFO - 'HOME': '/Users/cltbld', 11:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:34 INFO - 'LOGNAME': 'cltbld', 11:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:34 INFO - 'MOZ_NO_REMOTE': '1', 11:51:34 INFO - 'NO_EM_RESTART': '1', 11:51:34 INFO - 'PAGER': '/bin/cat', 11:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:34 INFO - 'PWD': '/builds/slave/test', 11:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:34 INFO - 'SHELL': '/bin/bash', 11:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oE1GysClBU/Listeners', 11:51:34 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:34 INFO - 'USER': 'cltbld', 11:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:34 INFO - 'XPC_FLAGS': '0x0', 11:51:34 INFO - 'XPC_SERVICE_NAME': '0', 11:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:35 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-U4sLL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:35 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-vOO6cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:35 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-uvoOyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:35 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-91Pekp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:35 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-XlDVOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:35 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-PIMUrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:35 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-bWune2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:35 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-s8AHwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:35 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-8th8tE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:35 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-U3Z47Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-hVpHXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-kjnauw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-YOXthd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-jUbwqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-f5imvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-XKj24K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Ch1TyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:51:36 INFO - Running setup.py install for manifestparser 11:51:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:51:36 INFO - Running setup.py install for mozcrash 11:51:37 INFO - Running setup.py install for mozdebug 11:51:37 INFO - Running setup.py install for mozdevice 11:51:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:51:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:51:37 INFO - Running setup.py install for mozfile 11:51:37 INFO - Running setup.py install for mozhttpd 11:51:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:51:37 INFO - Running setup.py install for mozinfo 11:51:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:51:37 INFO - Running setup.py install for mozInstall 11:51:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:51:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:51:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:51:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:51:37 INFO - Running setup.py install for mozleak 11:51:38 INFO - Running setup.py install for mozlog 11:51:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:51:38 INFO - Running setup.py install for moznetwork 11:51:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:51:38 INFO - Running setup.py install for mozprocess 11:51:38 INFO - Running setup.py install for mozprofile 11:51:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:51:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:51:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:51:38 INFO - Running setup.py install for mozrunner 11:51:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:51:38 INFO - Running setup.py install for mozscreenshot 11:51:39 INFO - Running setup.py install for moztest 11:51:39 INFO - Running setup.py install for mozversion 11:51:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:51:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:51:39 INFO - Cleaning up... 11:51:39 INFO - Return code: 0 11:51:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:39 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 0x10b9b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf62491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b910b20>, '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.1tsK8t9ZBj/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.oE1GysClBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1tsK8t9ZBj/Render', 11:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:39 INFO - 'HOME': '/Users/cltbld', 11:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:39 INFO - 'LOGNAME': 'cltbld', 11:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:39 INFO - 'MOZ_NO_REMOTE': '1', 11:51:39 INFO - 'NO_EM_RESTART': '1', 11:51:39 INFO - 'PAGER': '/bin/cat', 11:51:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:39 INFO - 'PWD': '/builds/slave/test', 11:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:39 INFO - 'SHELL': '/bin/bash', 11:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oE1GysClBU/Listeners', 11:51:39 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:39 INFO - 'USER': 'cltbld', 11:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:39 INFO - 'XPC_FLAGS': '0x0', 11:51:39 INFO - 'XPC_SERVICE_NAME': '0', 11:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:39 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-BYYCEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:39 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-xCFkUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:39 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-tdI7gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:40 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-96RXtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:40 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-vADHAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:40 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-6B21K5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:40 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-_3j_rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:40 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-RIrXMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:40 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-460y5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:40 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-tXvvZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:40 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Q5_hQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:40 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-yBc9e9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:40 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-8iqEQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:41 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-eX7krO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:41 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-AiNkmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:41 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-EXcp26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:41 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-CJj14i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:51:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:43 INFO - Downloading blessings-1.6.tar.gz 11:51:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:51:44 INFO - Installing collected packages: blessings 11:51:44 INFO - Running setup.py install for blessings 11:51:44 INFO - Successfully installed blessings 11:51:44 INFO - Cleaning up... 11:51:44 INFO - Return code: 0 11:51:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:51:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:44 INFO - Reading from file tmpfile_stdout 11:51:44 INFO - Current package versions: 11:51:44 INFO - blessings == 1.6 11:51:44 INFO - blobuploader == 1.2.4 11:51:44 INFO - docopt == 0.6.1 11:51:44 INFO - functools32 == 3.2.3-2 11:51:44 INFO - jsonschema == 2.5.1 11:51:44 INFO - manifestparser == 1.1 11:51:44 INFO - mozInstall == 1.12 11:51:44 INFO - mozcrash == 0.17 11:51:44 INFO - mozdebug == 0.1 11:51:44 INFO - mozdevice == 0.48 11:51:44 INFO - mozfile == 1.2 11:51:44 INFO - mozhttpd == 0.7 11:51:44 INFO - mozinfo == 0.9 11:51:44 INFO - mozleak == 0.1 11:51:44 INFO - mozlog == 3.3 11:51:44 INFO - moznetwork == 0.27 11:51:44 INFO - mozprocess == 0.23 11:51:44 INFO - mozprofile == 0.28 11:51:44 INFO - mozrunner == 6.12 11:51:44 INFO - mozscreenshot == 0.1 11:51:44 INFO - mozsystemmonitor == 0.3 11:51:44 INFO - moztest == 0.7 11:51:44 INFO - mozversion == 1.4 11:51:44 INFO - psutil == 3.1.1 11:51:44 INFO - requests == 1.2.3 11:51:44 INFO - wsgiref == 0.1.2 11:51:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf62491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b910b20>, '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.1tsK8t9ZBj/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.oE1GysClBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:51:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1tsK8t9ZBj/Render', 11:51:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:44 INFO - 'HOME': '/Users/cltbld', 11:51:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:44 INFO - 'LOGNAME': 'cltbld', 11:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:44 INFO - 'MOZ_NO_REMOTE': '1', 11:51:44 INFO - 'NO_EM_RESTART': '1', 11:51:44 INFO - 'PAGER': '/bin/cat', 11:51:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:44 INFO - 'PWD': '/builds/slave/test', 11:51:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:44 INFO - 'SHELL': '/bin/bash', 11:51:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oE1GysClBU/Listeners', 11:51:44 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:51:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:44 INFO - 'USER': 'cltbld', 11:51:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:44 INFO - 'XPC_FLAGS': '0x0', 11:51:44 INFO - 'XPC_SERVICE_NAME': '0', 11:51:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:51:44 INFO - Cleaning up... 11:51:44 INFO - Return code: 0 11:51:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51: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')]} 11:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:51:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba49618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf62491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b910b20>, '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.1tsK8t9ZBj/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.oE1GysClBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:51:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1tsK8t9ZBj/Render', 11:51:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:51:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:51:44 INFO - 'HOME': '/Users/cltbld', 11:51:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:51:44 INFO - 'LOGNAME': 'cltbld', 11:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:44 INFO - 'MOZ_NO_REMOTE': '1', 11:51:44 INFO - 'NO_EM_RESTART': '1', 11:51:44 INFO - 'PAGER': '/bin/cat', 11:51:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:44 INFO - 'PWD': '/builds/slave/test', 11:51:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:51:44 INFO - 'SHELL': '/bin/bash', 11:51:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oE1GysClBU/Listeners', 11:51:44 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:51:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:51:44 INFO - 'USER': 'cltbld', 11:51:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:51:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:44 INFO - 'XPC_FLAGS': '0x0', 11:51:44 INFO - 'XPC_SERVICE_NAME': '0', 11:51:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:51:45 INFO - Cleaning up... 11:51:45 INFO - Return code: 0 11:51:45 INFO - Running post-action listener: _resource_record_post_action 11:51:45 INFO - Running post-action listener: _start_resource_monitoring 11:51:45 INFO - Starting resource monitoring. 11:51:45 INFO - [mozharness: 2016-09-02 18:51:45.124623Z] Finished create-virtualenv step (success) 11:51:45 INFO - [mozharness: 2016-09-02 18:51:45.125622Z] Running install step. 11:51:45 INFO - Running pre-action listener: _resource_record_pre_action 11:51:45 INFO - Running main action method: install 11:51:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:45 INFO - Reading from file tmpfile_stdout 11:51:45 INFO - Detecting whether we're running mozinstall >=1.0... 11:51:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:51:45 INFO - Reading from file tmpfile_stdout 11:51:45 INFO - Output received: 11:51:45 INFO - Usage: mozinstall [options] installer 11:51:45 INFO - Options: 11:51:45 INFO - -h, --help show this help message and exit 11:51:45 INFO - -d DEST, --destination=DEST 11:51:45 INFO - Directory to install application into. [default: 11:51:45 INFO - "/builds/slave/test"] 11:51:45 INFO - --app=APP Application being installed. [default: firefox] 11:51:45 INFO - mkdir: /builds/slave/test/build/application 11:51:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:52:20 INFO - Reading from file tmpfile_stdout 11:52:20 INFO - Output received: 11:52:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:52:20 INFO - Running post-action listener: _resource_record_post_action 11:52:20 INFO - [mozharness: 2016-09-02 18:52:20.205463Z] Finished install step (success) 11:52:20 INFO - [mozharness: 2016-09-02 18:52:20.205631Z] Running run-tests step. 11:52:20 INFO - Running pre-action listener: _resource_record_pre_action 11:52:20 INFO - Running main action method: run_tests 11:52:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:52:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:52:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:52:20 INFO - 2016-09-02 11:52:20.219 screenresolution[1638:8057] starting screenresolution argv=screenresolution get 11:52:20 INFO - 2016-09-02 11:52:20.222 screenresolution[1638:8057] Display 0: 1600x1200x32@60 11:52:20 INFO - 2016-09-02 11:52:20.228 screenresolution[1639:8059] starting screenresolution argv=screenresolution list 11:52:20 INFO - Available Modes on Display 0 11:52:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:52:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:52:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:52:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:52:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:52:20 INFO - Intel Iris: 11:52:20 INFO - Chipset Model: Intel Iris 11:52:20 INFO - Type: GPU 11:52:20 INFO - Bus: Built-In 11:52:20 INFO - VRAM (Dynamic, Max): 1536 MB 11:52:20 INFO - Vendor: Intel (0x8086) 11:52:20 INFO - Device ID: 0x0a2e 11:52:20 INFO - Revision ID: 0x0009 11:52:20 INFO - Displays: 11:52:20 INFO - Display: 11:52:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:52:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:52:20 INFO - Display Serial Number: 1600x1200 60 11:52:20 INFO - Main Display: Yes 11:52:20 INFO - Mirror: Off 11:52:20 INFO - Online: Yes 11:52:20 INFO - Rotation: Supported 11:52:20 INFO - Return code: 0 11:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:52:20 INFO - Python 2.7.3 11:52:20 INFO - Return code: 0 11:52:20 INFO - grabbing minidump binary from tooltool 11:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b918d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b910b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:52:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:52:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:52:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:52:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:52:20 INFO - Return code: 0 11:52:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:52:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:52:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:52:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:52:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:52:20 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/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--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 11:52:20 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/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0155 --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 11:52:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1tsK8t9ZBj/Render', 11:52:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:20 INFO - 'HOME': '/Users/cltbld', 11:52:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:20 INFO - 'LOGNAME': 'cltbld', 11:52:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:52:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:20 INFO - 'MOZ_NO_REMOTE': '1', 11:52:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:52:20 INFO - 'NO_EM_RESTART': '1', 11:52:20 INFO - 'PAGER': '/bin/cat', 11:52:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:20 INFO - 'PWD': '/builds/slave/test', 11:52:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:52:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:20 INFO - 'SHELL': '/bin/bash', 11:52:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oE1GysClBU/Listeners', 11:52:20 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:52:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:20 INFO - 'USER': 'cltbld', 11:52:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:20 INFO - 'XPC_FLAGS': '0x0', 11:52:20 INFO - 'XPC_SERVICE_NAME': '0', 11:52:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:20 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/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--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 11:52:20 INFO - mozversion application_buildid: 20160902095849 11:52:20 INFO - mozversion application_changeset: 0907f97ba5e3ec9aaeb58c69651e8e6927472f1b 11:52:20 INFO - mozversion application_display_name: Nightly 11:52:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:52:20 INFO - mozversion application_name: Firefox 11:52:20 INFO - mozversion application_remotingname: firefox 11:52:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:52:20 INFO - mozversion application_vendor: Mozilla 11:52:20 INFO - mozversion application_version: 51.0a1 11:52:20 INFO - mozversion platform_buildid: 20160902095849 11:52:20 INFO - mozversion platform_changeset: 0907f97ba5e3ec9aaeb58c69651e8e6927472f1b 11:52:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:52:20 INFO - mozversion platform_version: 51.0a1 11:52:20 INFO - using testdate: 1472842340 11:52:20 INFO - actual date: 1472842340 11:52:20 INFO - starting webserver on 'localhost:49271' 11:52:20 INFO - SUITE-START | Running 2 tests 11:52:20 INFO - TEST-START | dromaeo_css 11:52:20 INFO - operating with platform_type : mac_ 11:52:20 INFO - Initialising browser for dromaeo_css test... 11:52:20 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmp2vjK76/profile http://localhost:49271/getInfo.html) 11:52:23 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 11:52:23 INFO - PROCESS | 1649 | colorDepth:24 11:52:23 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 11:52:23 INFO - PROCESS | 1649 | __metrics 11:52:23 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 11:52:24 INFO - TEST-INFO | 1649: exit 0 11:52:24 INFO - Browser initialized. 11:52:24 INFO - Running cycle 1/1 for dromaeo_css test... 11:52:24 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmp2vjK76/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:52:36 INFO - PROCESS | 1652 | RSS: Main: 245297152 11:52:36 INFO - PROCESS | 1652 | 11:53:26 INFO - PROCESS | 1652 | 1472842406311 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:55:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 11:55:39 INFO - PROCESS | 1652 | RSS: Main: 263376896 11:55:39 INFO - PROCESS | 1652 | 11:58:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 11:58:42 INFO - PROCESS | 1652 | RSS: Main: 271458304 11:58:42 INFO - PROCESS | 1652 | 12:01:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 12:01:45 INFO - PROCESS | 1652 | RSS: Main: 276312064 12:01:45 INFO - PROCESS | 1652 | 12:04:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 12:04:47 INFO - PROCESS | 1652 | RSS: Main: 273489920 12:04:47 INFO - PROCESS | 1652 | 12:07:50 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 12:07:51 INFO - PROCESS | 1652 | RSS: Main: 278671360 12:07:51 INFO - PROCESS | 1652 | 12:10:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 12:10:54 INFO - PROCESS | 1652 | RSS: Main: 281628672 12:10:54 INFO - PROCESS | 1652 | 12:10:54 INFO - PROCESS | 1652 | __start_tp_report 12:10:54 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 12:10:54 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 12:10:54 INFO - PROCESS | 1652 | |i|pagename|runs| 12:10:54 INFO - PROCESS | 1652 | |0;dojo.html;3229.4509933311338;3391.694747472727;3396.7452441066926;3411.641777613349;3442.6557344265575;4923;5166.509181627749;5620.690862002588;5669.0079236133715;5691.3739488656265;4679;5738.483536481715;5742.971285143569;5755.194272801811;5767.961766881959;4813.133635945528;5135.2297155426795;5200.895982080375;5203.68777873327;5369.5167434930845;5277.920831187535;5303.124984377592;5308.70802105884;5312.096943519611;5315.229291752694;5106.489351064883;5155.66488178271;5223.477652234784;5229.084910140748;5304.867378315535;4275.273203555403;4291.935620965688;5195.922061169085;5233.084210263189;5305.336832895888;3964.8215830287704;5149.253358263069;5206.24509446132;5221;5227.163653815409;5480.534154596864;5706.857328566777;5720.170575266563;5781.103928891029;5807.274090738658;4833.685810422347;6186.103015062836;6235.220597425322;6263.6868156592445;6265.530085243625;5623.353314368859;6112.602680825732;6267.2479302484;6308.053791931201;6323.430891219767;5176.068307704574;5769.624974376652;5820.1269809528485;5840.678762668094;5906.350301466835;6072.453479186895;6278.4035516625845;6287.46556542699;6296.527760417987;6305.96847015762;4793.969296601247;5237.764300606482;6185.195924529782;6189.876202475925;6191.226096737908;5484.369297530835;6001.5798894077;6171.56799024064;6180.6291622502795;6206.348333425016;6145.170401995673;6228.439440450381;6236.345183755731;6245.250569931637;6250.531210159256;6232.594881332699;6246.46905013079;6294.181756371642;6321.557490975588;6326.9683651581445;4653.837115700934;4842.15262329091;4888.242322440027;4906.288588154697;4967.552920237196;4382.298832186835;4453.821847126143;4456.220161471794;4471.709338892962;4506.031203291308;4544.7045942013665;5859.1797148399255;5884.323302820145;5906.3207731110615;5914.763409463573;6170.629762214281;6201.565890387629;6207.379262073757;6276.058591211355;6291.213598300213;5837.211976383219;5840.737166827503;5858.765649374062;5867.471927526543;5909.468147866713;5350.491703288181;5381.246625472437;5395.487428694346;5398.460153984649;5401.189821526802;6180.7527698891545;6199.28708198563;6228.906566401417;6338.461230795434;6343.429091381798;6267.905981410191;6271.811845644638;6275.96862015687;6276.623402595859;6286.245650521967;6310.810675679737;6325.082862984934;6329.461995730415;6336.651484168415;6340.524460665376;6130.785422510191;6142.754289828356;6154.076888466766;6182.7217775201125;6211.378862113753;6284;6286.685665716787;6291.842703932438;6292.3078461368295;6319.368063193644;5475.178723191553;6110.694465276807;6147.655285071169;6172.197614310111;6174.598651087845;5954.583179177416;6074.665893375906;6103.084537319438;6188.381161883775;6192.659403732658;5915.112733090071;5996.820095397145;6046.90929636047;6068.4841788448475;6113.327533971348;4497.942983398964;6085.756569737338;6155.630662160284;6163;6210.813675589739;5833.183354330482;5949.137375080676;5982.371850955761;6026.457618814153;6043.8186854394435 12:10:54 INFO - PROCESS | 1652 | |1;ext.html;524.708786623424;530.2602868997748;535.9705216213109;537.1030379266625;556.2296219735665;30602.693973060264;39027.60972390275;39088.41367379484;39122.80438597803;39154.80422597886;39784.40323395151;40304;40319.39520907189;40379.59620403795;40488.79755601225;9526.904730952705;9597.376170548892;9650;9697.515124243795;9733.270004749673;8380.455270407434;8384.496930184208;9604.855927161097;9717.416954982687;9816.656417025406;7761.844763104735;8173.223543763333;8537.975442946856;9742.512874356255;9779.70660880171;8248.876266855972;9567.760805979837;9664.565094570762;9728;9736.367136136128;9564.521773911276;9618.038196180396;9643.90356096437;9651.179649729782;9658.806823863553;32082.518762218584;38652;38713.61286387128;38996.44014239427;39233.60766392357;2829.589709492112;3336.282699219679;3386.762926595139;3568.37553428149;3699.6115407882053;31444.685553144405;31759.523607145682;32275.83862080698;32294;32455;3193.696598823108;3228.176814912182;3275.672432756729;3333.833308334598;3435.3129374125274;433825;435253;441779;446424;448168;62889.37110628927;63865.04202436967;63971.00362454693;63990.440382384186;64082.67958660177;34833.47749783755;35406.29187416237;35887.4616880747;36669.44995825065;36683.4497482538;16284.592885177964;16434.75347869783;16468.83531164697;16512.917435412746;16526.83473165253;12468;12527.37363131858;12568.743125687359;12600;12602.558910438274;17425;20192.69710954337;20260.696089558667;20288.492787680425;20485;8840.955795220983;8852.468851868909;8864.20222179994;8885.289176865836;8906.510141942255;848.7411339541499;919.4161707315769;993.9751506212402;1062.3148069495132;1105.9004689577976;25436.236912892644;29608.703912961024;29682.40635187284;29839.701602983692;29862.71219356774;929.2380248196414;976.1556253840376;997.187292356727;1069.198101423932;1134.5575225661999;14815.481458148914;15286.388544458097;15554.766678499831;15592.908955663526;16071.919640401957;472053;537883;539559;546422;551332;54058.729706351216;54318.72840635772;54346;54379.912401751746;54827.451725482235;1356.4641966423208;1384.6746014686541;1397.4619771387886;1407.8662527059912;1408.0988167572762;25877.741222588287;28237.294067648472;28838;29783.553246700885;29993;50928.74535627298;51477;51516.48483515117;51752.48247517627;51881.7405912968;517462;520895;522602;523761;525752;40846.79576602098;41333.58666413297;41877;42194.78902605467;42315.78842105893;45254;46361;46587.60237192889;46879.06241875212;46986;37997.62002380051;38357.80821095876;38430.03924901788;38625.80687096546;38868.416973744854;37604.81197593995;37713.43429848609;38605.80697096609;38661;38726;36392.81803590965;36788.81605592062;36946.63053369432;36966.815165923996;37361.43957840689;30918.22704432407;32375.838120809247;33642.831785840914;33956;34100.82949585236;20166.69749953781;23070.538589228458;24181.549107053634;24737.752622474265;24962 12:10:54 INFO - PROCESS | 1652 | |2;jquery.html;319.7665704036054;363.6890458657849;372.47667027825895;376.8040618878182;393.82081153075353;17945.910270448647;19296.614067718638;19905.60188796225;20089.497762555944;20784.272550460737;15203.847961520409;15956.601084972881;19764.90117549414;20239.696404553943;20266.493337666565;5742.827715168552;5834.241548598677;5999.310079340888;6017.849553761147;6059.303180134275;5606.074997625387;5665.3768085510565;5921.259842519685;5922.378150294222;5931.199288096095;5784.479396854283;5882.00005998979;5884.735186916599;5890.764369425217;5937.4656280934705;6031.698415079229;6064.96967515164;6174.536909731788;6176.258848938111;6188.969055154718;5760.423957604248;5844.064949608085;5945.613535120204;5974;6054.303755068179;12450.564230251988;12703.237805731686;12711.110222284444;12748.745025099446;12866.935665321613;2142.5393540388736;2272.363738153303;2290.541891621666;2637.709851916288;2685.8987814995953;9868.21054315653;10108.292419530635;12245.816312755316;14161.362738676784;14760.852391476055;1837.9448616541524;1853.2586965213889;1940.0687669918377;1943.7375954246138;1989.4031790462948;107508;108404.45797770961;110676;113169;116344.41827790807;10052.944440833753;10580.312279701795;10994.395308257963;11016.394098324508;11372.601958931398;14039.368228429745;14043.297835108204;14054.929725351512;14062.296885155905;14063;8068.47554908929;8258.380621453414;8275.462094963808;8296.460730052528;8415.831683366298;8071.556064416513;8162.510249385056;8172.223638754309;8317.958410208032;8338.70814521501;4075.5109386873173;4094.488188976378;4338.631216346583;4435.401220835211;4518.254488009507;1882.3341342911622;1925.1817977359847;1932.294712429953;1956.1295223625634;1969.9315718495523;748.1770052941721;779.8869163971192;854.8032754144248;878.512425603796;933.2207606648388;19678.21287148498;20318;20336.72928684963;20370.388888333375;20691.482712931997;889.1286539191628;905.8224308399055;916.3677062826629;958.434523631061;979.9363041402286;10269.3569028955;10610;10701;10720.73198170052;10723.517441715141;515336;517033;518848;527377;527586;114031;117240;118516;118646.40676796561;119948;851.8935133108362;980.3284749946453;981.4994352880083;1009.9293049486465;1042.9165666746642;17019.40432084871;17220.397286094925;17228.741568876227;17397.304107835545;17506.73739893877;46905.75462967603;48040;48582;51934.740326298124;52707.73646131745;60027.39972600218;68028.97956530756;70519.64740176266;71522.28477715157;73948;6965.721371145098;7625.504342217738;7801.297883190313;7861.213878612093;7870.606469676379;9457.763555911157;12381.00951923826;12458.563950261698;12763.617091487271;12913;8973.32700047486;10728.51721672511;11037.558497660004;11138.832917506083;11430.314181149157;10497.475126243504;10578.471076446302;11015.559377625126;11098.5560577576;11195.496202670736;10819.1344692426;11068.889311106786;11247.381394023407;11463.541458341906;11487.081033517132;7927.682892684459;7995.2804247618;8060.395470339865;8094.271515563628;8106;9597.28020398459;10945.179111566506;11266.436678166223;11322.886771132184;11422.200445968703 12:10:54 INFO - PROCESS | 1652 | |3;mootools.html;1476.8153980752406;1548.41934274647;1764.717645176772;1817.627386385791;1879.6522643310989;8011.5193088414735;8535.359848011401;8679.349048821332;9093.681721139754;9109.908900910988;7910.406719496032;8511.446755960873;8930.955345223265;8931.285497160228;8933.821323573524;2375.7505461926507;2388.426777573379;2402.147237730607;2405.4226985523524;2406;2329.5923213437663;2365.8462199957034;2375.429896824758;2376.4652953085592;2381.535600557892;2350.976490235093;2352.12971200656;2356.9764302357016;2357.9056837726557;2372.632242002492;2149.838762092834;2207.8629505804524;2338.9532209355802;2347.6243800991847;2363.2437619961706;2296.632538793785;2316.397736588482;2323.5236776460956;2329.720433547985;2332.090484710964;8930.240929520998;8987.955060224722;9005.234555062827;9021.458712477272;9045.954770226173;5259.790248242887;5301.60237982149;5385.461453854622;5408.59435542332;5416.268803711488;3059.6787337329483;3521.2605352875926;3615.4215325547784;3663.3955397359405;3721.771815300944;1038.2161468091542;1071.994640026795;1073.661796534097;1097.3361116524547;1099.6206308823444;11617.825732614017;11658.59194928182;11717.707057323634;11758.235714678518;11764;4582.633389328846;4721.6458765592715;4822.614190864722;4864.416270047617;4881.609471242292;9855.408675479493;9930.751731206634;9977.002299769965;9990.600375984879;10000.699979000641;5368.463153684678;5379.946200537945;5381.461853814665;5390.21841832932;5401.945980540223;4059.2693315202955;4436.3123715824095;4758.809647614126;4889.731064791399;4951.801927922843;3933.1347103637154;3941.2511622791576;4046.8988275293354;4069.491313585802;4107.938380924288;1293.838270216223;1301.0697351393799;1305.536534530228;1310.8885744711615;1314.2049060318561;787.5589669784939;884.7168905950163;891.9554022298859;919.7838507950627;971.7133445633555;4612.962083531179;5699.235870602754;5888;5917.792877249276;6106.572539922252;418.77804763475405;428.32538751466564;944.2210176604328;1011.8735158105237;1060.347886050089;3897.162110146332;3938.980305098456;4035.3543433050572;4061.8578349757618;4110.403991421287;10523.894761052445;10946.56213751457;10958.890411095947;10972.067374273116;10972.067374273116;10827.242093053568;10862;10865.51105200268;10873.293235939638;10876.129909607213;8126.228008339198;8129.837403251902;8149.511029338259;8222.054463736627;8244.8351032979;5702.942970570241;5808.448197421239;5870.706464676664;5885.764569417175;5915.881682366415;10046.899531004889;10073.597056117673;10119.392836429837;10130.898691012995;10205.591776328863;9939.950300248453;10158.898411015794;10287.794244114926;10323.81276153252;10398.168146548409;6623;6932.930670693228;7014.158301003912;7138.607376594337;7164.247753985756;8477.279431248413;8551.444156130081;8557.657693692183;8579.399442039246;8580.313574914117;7453.590052546945;7491.063617047869;7550.962245188959;7620.276073772982;7689.615519224129;6306.590071645328;7320.560766354036;7407.296306850841;7549.849003020019;7560.924390756022;7009.719611215494;7029.332213439715;7077.292270772881;7105.360517553445;7105.431565474853;4844;4888.315635810918;4890.217565189552;4906.803727850846;4967.528084831935;4585.151746926829;4606.401167848158;4690.648201384978;4761.428628564595;4762.190427627243 12:10:54 INFO - PROCESS | 1652 | |4;prototype.html;278.2487284332302;301.2814437566404;306.66420269804564;307.88300445830583;310.58381768430297;5248.0553500369915;5286.762095705692;5422.295101636787;5478.329519222121;5529.9999999999945;4902.80388784449;5247.475252474751;5294.867628309295;5420.566354691625;5455.972720136404;3180.538821870827;4156.5012198536215;4174.603412675799;4190.685698572619;4192.706510544263;3765.8305376258;4019.5779443158485;4150.854720084798;4173.061061261223;4184.623383895449;3330.7002369786715;3978.164585437047;3979.9453144916474;4002.2195671844;4024.3762216856435;3910.2179564087296;3968.591150141716;4009.7794621295816;4026.4765580474495;4062.801473565276;3077.4460597092516;3331.7001469867587;3486.2678837443914;3497.89506314811;3517.9120521987156;4226.154769046203;4273.273543497613;5027.245913113063;5259.0796610593;5276.7889284428575;4334.176506463762;4436.467623885154;4458.754768487732;4675.1299480207845;4691.3432119503295;4335.485418457287;4491.955080449186;5701.600887937846;5731.942680573183;5738.282714660668;3037.58992536007;3816.255830113129;3842.7117966152373;3854.325493038707;3860.285847118292;6024.879502409927;6027.578069535134;6058.818235452944;6062.9996050652035;6105.877882442326;3090.5209692497697;3331.8167500787204;3804.334241507725;3881.5342158941107;3904.2475055086097;3887.5723670396233;3891.591382904811;3917.196974620196;3968.305546529346;3977.482927219443;4175.164967006611;4437;4609.423822022247;4615.076984603025;4628;4359.760213188241;4951.480094590016;5745.368009518949;5767.769289228384;5813.563982701315;1189.0084109117195;1319.9802002969964;1339.7923321885123;1341.2824139085737;1349.5479014530242;665.7303791964263;669.8124525132971;746.4700062955254;794.4796158516181;808.3775492870457;4127.4015267786;4455.6435485161755;4523;4547.386102876136;4585.839495617637;4393.934090988638;4416.930233487759;4464.732116073046;4891.902161956741;4996.7001979881325;3831.8695984684587;3901.9609803902167;4381.430414046154;4577.084583083397;4595.287730401793;2241.3948233976735;2594.675665541807;2801;3051.649060358043;3097.7212050915527;4994.827250146198;5546.029444847136;5621.8594535136945;6072.271327440735;6098.451139397387;5741.7990370337675;6041.697915104227;6070.696465176724;6080.695965201722;6128.233970753656;5977.940220597825;6023.518118550418;6053.487802561887;6066.904839233588;6079.878402431927;5795.594308398372;5824.796132135355;5857.765689372548;5873.442023007808;5875.794347197828;5653.547716182778;5737.942620573741;5778.653280803165;5840.766369345179;5851.414858514115;5284.656497327662;6119.653676191231;6143.726821076051;6156.876862462816;6210.689465526615;3477.669621385964;3809.742784881038;3941.3693808990424;3962.881113566598;4001.5598284188136;4915.6067514598035;5841.357450680507;5861.238039054895;5865.677387743544;5869.442402971711;4525.230710779109;5014.899702005867;5149.716765577779;5294.126469132704;5695.288088988877;4878.09752198247;5040.815408378955;5079.263506791421;5196.818111366084;5369;4585.58729714314;5582.789895810007;5623.606347555632;5636.2100760124;5640.915386269127;4995.675281106716;5044.697318160922;5643.238162847963;5680.8638272346525;5694.943050569607;5152.381714194321;5549.611527193058;5583.525400340854;5635.943640563706;5663.688497132697 12:10:54 INFO - PROCESS | 1652 | |5;yui.html;681.9454443644506;695.9721611135554;703.2896774257999;716.7455553278589;761.4974117082727;15194.392224311014;15829.445969391074;15853.28660210289;15888.364465421384;15934.282957266922;14256.643583910407;14453.0605510642;14457.92771036146;14473.927630361834;14516.854831451708;659.241871847377;824.4888169335021;835.4444294544121;851.7955690634266;852.8507511185518;852.47146769003;859.1194026123243;862.7498025572577;863.2144748279068;867.761365624452;884.8982367027778;900.5182227508284;901.3510272603714;901.4366021236727;901.5086777706166;744.3710064995071;757.9545227286353;848.9235968762811;894.7628878347243;894.8076163624787;594.551113908996;626.5269721360389;673.7002034094829;673.8416472129046;674.1169068520205;12140.21088629245;14540.127592344494;14557.272136393138;14574.125552466887;14607.853921460755;14404.279786010762;14415.207163605997;14430.278486075655;14525.128492290496;14619.561413157622;10915.727106822314;10925.672229833117;10930.890691093146;10937.83593246102;11365.261258018203;3599.4420864766003;3666.3767159582935;3691.0218792020137;3715.64701353371;3814.6376094271277;80097;106287.40568891473;108295.45852270689;109229;112299.43850280778;10152.49237538135;10804.243702940876;10826.67519974402;10839.078678312431;11052.171087168495;22492.437689057577;22507.32478025662;22507.662385064235;22528.436789080402;22638.094476221097;7734.497257678346;7798.33714134305;7818.179091195457;7936.444448888522;7953.244441778022;4375.365571992043;4407.625351845129;4408.382826404306;4459.487158976694;4540.659450541222;3408.1309266136977;3527.6825085742407;3527.9118022049142;3529.3470707918605;3541.11472131967;473.4555261449292;602.5270162922085;603.4840211619003;619.2723549829022;627.3788948940607;564.1199728423672;621.6425555305717;656.5207398598953;661.632793799446;668.4952860590321;8718;8938.329625278131;9317.767055823659;9364.719058428258;9374.85937710935;563.5097465205216;568.7213265499958;611.7247238742584;625.3964923848417;672.9057931889539;3821.4840996465678;4481.305397663367;4551.789594624958;4619.452483418026;4644.5123262056995;110270;121667;126860.36569817092;129872.35063824621;130669;110503.44748276207;111291;112637;113220.43389783164;114115;89001.55499222592;90441;96147;98498.50750746201;99955.00044999456;8553.914460855562;8812.91187088121;8880.245179159843;8967.865482017645;9047;53197.46802531925;53472.465275346745;53708.19437708359;54230.728846357095;54418.286079961035;70948.64525677338;81822.59088704518;85281.57359213164;85376;87314.69027964458;11399;11439.370834604177;11453.942730286295;11473.827892581785;11773.823392648947;12267.178548933616;12369.381530923598;12387.318697471726;12445.115530566385;12496.87503124957;9055.36612437123;9303.671766619747;9763.902360976299;11853.697428742002;12169.574064907685;10620.628278010232;10729.46352682347;10960;11934.343611101473;12397.566085186974;11644.068474521848;12034.63896083119;12088;12192.695182620151;12315.692107697021;9816.460094694861;9894;10015.59937602517;10055.145312648507;10071.143952764098;8178.877316840133;8905.421147625384;9374.625014999323;10295.485225738832;10316.123129534073 12:10:54 INFO - PROCESS | 1652 | __end_tp_report 12:10:54 INFO - PROCESS | 1652 | __start_cc_report 12:10:54 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,382 12:10:54 INFO - PROCESS | 1652 | __end_cc_report 12:10:54 INFO - PROCESS | 1652 | __startTimestamp1472843454003__endTimestamp 12:10:54 INFO - PROCESS | 1652 | 12:10:54 INFO - PROCESS | 1652 | ------- Summary: start ------- 12:10:54 INFO - PROCESS | 1652 | Number of tests: 6 12:10:54 INFO - PROCESS | 1652 | 12:10:54 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5679.45 Median:5914.76 stddev:698.96 (11.8%) stddev-sans-first:674.16 12:10:54 INFO - PROCESS | 1652 | Values: 3229.5 3391.7 3396.7 3411.6 3442.7 4923.0 5166.5 5620.7 5669.0 5691.4 4679.0 5738.5 5743.0 5755.2 5768.0 4813.1 5135.2 5200.9 5203.7 5369.5 5277.9 5303.1 5308.7 5312.1 5315.2 5106.5 5155.7 5223.5 5229.1 5304.9 4275.3 4291.9 5195.9 5233.1 5305.3 3964.8 5149.3 5206.2 5221.0 5227.2 5480.5 5706.9 5720.2 5781.1 5807.3 4833.7 6186.1 6235.2 6263.7 6265.5 5623.4 6112.6 6267.2 6308.1 6323.4 5176.1 5769.6 5820.1 5840.7 5906.4 6072.5 6278.4 6287.5 6296.5 6306.0 4794.0 5237.8 6185.2 6189.9 6191.2 5484.4 6001.6 6171.6 6180.6 6206.3 6145.2 6228.4 6236.3 6245.3 6250.5 6232.6 6246.5 6294.2 6321.6 6327.0 4653.8 4842.2 4888.2 4906.3 4967.6 4382.3 4453.8 4456.2 4471.7 4506.0 4544.7 5859.2 5884.3 5906.3 5914.8 6170.6 6201.6 6207.4 6276.1 6291.2 5837.2 5840.7 5858.8 5867.5 5909.5 5350.5 5381.2 5395.5 5398.5 5401.2 6180.8 6199.3 6228.9 6338.5 6343.4 6267.9 6271.8 6276.0 6276.6 6286.2 6310.8 6325.1 6329.5 6336.7 6340.5 6130.8 6142.8 6154.1 6182.7 6211.4 6284.0 6286.7 6291.8 6292.3 6319.4 5475.2 6110.7 6147.7 6172.2 6174.6 5954.6 6074.7 6103.1 6188.4 6192.7 5915.1 5996.8 6046.9 6068.5 6113.3 4497.9 6085.8 6155.6 6163.0 6210.8 5833.2 5949.1 5982.4 6026.5 6043.8 12:10:54 INFO - PROCESS | 1652 | 12:10:54 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:63647.43 Median:39105.61 stddev:132872.03 (339.8%) stddev-sans-first:133160.24 12:10:54 INFO - PROCESS | 1652 | Values: 524.7 530.3 536.0 537.1 556.2 30602.7 39027.6 39088.4 39122.8 39154.8 39784.4 40304.0 40319.4 40379.6 40488.8 9526.9 9597.4 9650.0 9697.5 9733.3 8380.5 8384.5 9604.9 9717.4 9816.7 7761.8 8173.2 8538.0 9742.5 9779.7 8248.9 9567.8 9664.6 9728.0 9736.4 9564.5 9618.0 9643.9 9651.2 9658.8 32082.5 38652.0 38713.6 38996.4 39233.6 2829.6 3336.3 3386.8 3568.4 3699.6 31444.7 31759.5 32275.8 32294.0 32455.0 3193.7 3228.2 3275.7 3333.8 3435.3 433825.0 435253.0 441779.0 446424.0 448168.0 62889.4 63865.0 63971.0 63990.4 64082.7 34833.5 35406.3 35887.5 36669.4 36683.4 16284.6 16434.8 16468.8 16512.9 16526.8 12468.0 12527.4 12568.7 12600.0 12602.6 17425.0 20192.7 20260.7 20288.5 20485.0 8841.0 8852.5 8864.2 8885.3 8906.5 848.7 919.4 994.0 1062.3 1105.9 25436.2 29608.7 29682.4 29839.7 29862.7 929.2 976.2 997.2 1069.2 1134.6 14815.5 15286.4 15554.8 15592.9 16071.9 472053.0 537883.0 539559.0 546422.0 551332.0 54058.7 54318.7 54346.0 54379.9 54827.5 1356.5 1384.7 1397.5 1407.9 1408.1 25877.7 28237.3 28838.0 29783.6 29993.0 50928.7 51477.0 51516.5 51752.5 51881.7 517462.0 520895.0 522602.0 523761.0 525752.0 40846.8 41333.6 41877.0 42194.8 42315.8 45254.0 46361.0 46587.6 46879.1 46986.0 37997.6 38357.8 38430.0 38625.8 38868.4 37604.8 37713.4 38605.8 38661.0 38726.0 36392.8 36788.8 36946.6 36966.8 37361.4 30918.2 32375.8 33642.8 33956.0 34100.8 20166.7 23070.5 24181.5 24737.8 24962.0 12:10:54 INFO - PROCESS | 1652 | 12:10:54 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:31542.09 Median:2464.13 stddev:87265.24 (3541.4%) stddev-sans-first:87478.55 12:10:54 INFO - PROCESS | 1652 | Values: 319.8 363.7 372.5 376.8 393.8 17945.9 19296.6 19905.6 20089.5 20784.3 15203.8 15956.6 19764.9 20239.7 20266.5 5742.8 5834.2 5999.3 6017.8 6059.3 5606.1 5665.4 5921.3 5922.4 5931.2 5784.5 5882.0 5884.7 5890.8 5937.5 6031.7 6065.0 6174.5 6176.3 6189.0 5760.4 5844.1 5945.6 5974.0 6054.3 12450.6 12703.2 12711.1 12748.7 12866.9 2142.5 2272.4 2290.5 2637.7 2685.9 9868.2 10108.3 12245.8 14161.4 14760.9 1837.9 1853.3 1940.1 1943.7 1989.4 107508.0 108404.5 110676.0 113169.0 116344.4 10052.9 10580.3 10994.4 11016.4 11372.6 14039.4 14043.3 14054.9 14062.3 14063.0 8068.5 8258.4 8275.5 8296.5 8415.8 8071.6 8162.5 8172.2 8318.0 8338.7 4075.5 4094.5 4338.6 4435.4 4518.3 1882.3 1925.2 1932.3 1956.1 1969.9 748.2 779.9 854.8 878.5 933.2 19678.2 20318.0 20336.7 20370.4 20691.5 889.1 905.8 916.4 958.4 979.9 10269.4 10610.0 10701.0 10720.7 10723.5 515336.0 517033.0 518848.0 527377.0 527586.0 114031.0 117240.0 118516.0 118646.4 119948.0 851.9 980.3 981.5 1009.9 1042.9 17019.4 17220.4 17228.7 17397.3 17506.7 46905.8 48040.0 48582.0 51934.7 52707.7 60027.4 68029.0 70519.6 71522.3 73948.0 6965.7 7625.5 7801.3 7861.2 7870.6 9457.8 12381.0 12458.6 12763.6 12913.0 8973.3 10728.5 11037.6 11138.8 11430.3 10497.5 10578.5 11015.6 11098.6 11195.5 10819.1 11068.9 11247.4 11463.5 11487.1 7927.7 7995.3 8060.4 8094.3 8106.0 9597.3 10945.2 11266.4 11322.9 11422.2 12:10:54 INFO - PROCESS | 1652 | 12:10:54 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5716.97 Median:4706.15 stddev:3238.85 (68.8%) stddev-sans-first:3232.27 12:10:54 INFO - PROCESS | 1652 | Values: 1476.8 1548.4 1764.7 1817.6 1879.7 8011.5 8535.4 8679.3 9093.7 9109.9 7910.4 8511.4 8931.0 8931.3 8933.8 2375.8 2388.4 2402.1 2405.4 2406.0 2329.6 2365.8 2375.4 2376.5 2381.5 2351.0 2352.1 2357.0 2357.9 2372.6 2149.8 2207.9 2339.0 2347.6 2363.2 2296.6 2316.4 2323.5 2329.7 2332.1 8930.2 8988.0 9005.2 9021.5 9046.0 5259.8 5301.6 5385.5 5408.6 5416.3 3059.7 3521.3 3615.4 3663.4 3721.8 1038.2 1072.0 1073.7 1097.3 1099.6 11617.8 11658.6 11717.7 11758.2 11764.0 4582.6 4721.6 4822.6 4864.4 4881.6 9855.4 9930.8 9977.0 9990.6 10000.7 5368.5 5379.9 5381.5 5390.2 5401.9 4059.3 4436.3 4758.8 4889.7 4951.8 3933.1 3941.3 4046.9 4069.5 4107.9 1293.8 1301.1 1305.5 1310.9 1314.2 787.6 884.7 892.0 919.8 971.7 4613.0 5699.2 5888.0 5917.8 6106.6 418.8 428.3 944.2 1011.9 1060.3 3897.2 3939.0 4035.4 4061.9 4110.4 10523.9 10946.6 10958.9 10972.1 10972.1 10827.2 10862.0 10865.5 10873.3 10876.1 8126.2 8129.8 8149.5 8222.1 8244.8 5702.9 5808.4 5870.7 5885.8 5915.9 10046.9 10073.6 10119.4 10130.9 10205.6 9940.0 10158.9 10287.8 10323.8 10398.2 6623.0 6932.9 7014.2 7138.6 7164.2 8477.3 8551.4 8557.7 8579.4 8580.3 7453.6 7491.1 7551.0 7620.3 7689.6 6306.6 7320.6 7407.3 7549.8 7560.9 7009.7 7029.3 7077.3 7105.4 7105.4 4844.0 4888.3 4890.2 4906.8 4967.5 4585.2 4606.4 4690.6 4761.4 4762.2 12:10:54 INFO - PROCESS | 1652 | 12:10:54 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4483.89 Median:4885.00 stddev:1439.03 (29.5%) stddev-sans-first:1408.02 12:10:54 INFO - PROCESS | 1652 | Values: 278.2 301.3 306.7 307.9 310.6 5248.1 5286.8 5422.3 5478.3 5530.0 4902.8 5247.5 5294.9 5420.6 5456.0 3180.5 4156.5 4174.6 4190.7 4192.7 3765.8 4019.6 4150.9 4173.1 4184.6 3330.7 3978.2 3979.9 4002.2 4024.4 3910.2 3968.6 4009.8 4026.5 4062.8 3077.4 3331.7 3486.3 3497.9 3517.9 4226.2 4273.3 5027.2 5259.1 5276.8 4334.2 4436.5 4458.8 4675.1 4691.3 4335.5 4492.0 5701.6 5731.9 5738.3 3037.6 3816.3 3842.7 3854.3 3860.3 6024.9 6027.6 6058.8 6063.0 6105.9 3090.5 3331.8 3804.3 3881.5 3904.2 3887.6 3891.6 3917.2 3968.3 3977.5 4175.2 4437.0 4609.4 4615.1 4628.0 4359.8 4951.5 5745.4 5767.8 5813.6 1189.0 1320.0 1339.8 1341.3 1349.5 665.7 669.8 746.5 794.5 808.4 4127.4 4455.6 4523.0 4547.4 4585.8 4393.9 4416.9 4464.7 4891.9 4996.7 3831.9 3902.0 4381.4 4577.1 4595.3 2241.4 2594.7 2801.0 3051.6 3097.7 4994.8 5546.0 5621.9 6072.3 6098.5 5741.8 6041.7 6070.7 6080.7 6128.2 5977.9 6023.5 6053.5 6066.9 6079.9 5795.6 5824.8 5857.8 5873.4 5875.8 5653.5 5737.9 5778.7 5840.8 5851.4 5284.7 6119.7 6143.7 6156.9 6210.7 3477.7 3809.7 3941.4 3962.9 4001.6 4915.6 5841.4 5861.2 5865.7 5869.4 4525.2 5014.9 5149.7 5294.1 5695.3 4878.1 5040.8 5079.3 5196.8 5369.0 4585.6 5582.8 5623.6 5636.2 5640.9 4995.7 5044.7 5643.2 5680.9 5694.9 5152.4 5549.6 5583.5 5635.9 5663.7 12:10:54 INFO - PROCESS | 1652 | 12:10:54 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:22189.81 Median:4470.40 stddev:34472.76 (771.1%) stddev-sans-first:34531.64 12:10:54 INFO - PROCESS | 1652 | Values: 681.9 696.0 703.3 716.7 761.5 15194.4 15829.4 15853.3 15888.4 15934.3 14256.6 14453.1 14457.9 14473.9 14516.9 659.2 824.5 835.4 851.8 852.9 852.5 859.1 862.7 863.2 867.8 884.9 900.5 901.4 901.4 901.5 744.4 758.0 848.9 894.8 894.8 594.6 626.5 673.7 673.8 674.1 12140.2 14540.1 14557.3 14574.1 14607.9 14404.3 14415.2 14430.3 14525.1 14619.6 10915.7 10925.7 10930.9 10937.8 11365.3 3599.4 3666.4 3691.0 3715.6 3814.6 80097.0 106287.4 108295.5 109229.0 112299.4 10152.5 10804.2 10826.7 10839.1 11052.2 22492.4 22507.3 22507.7 22528.4 22638.1 7734.5 7798.3 7818.2 7936.4 7953.2 4375.4 4407.6 4408.4 4459.5 4540.7 3408.1 3527.7 3527.9 3529.3 3541.1 473.5 602.5 603.5 619.3 627.4 564.1 621.6 656.5 661.6 668.5 8718.0 8938.3 9317.8 9364.7 9374.9 563.5 568.7 611.7 625.4 672.9 3821.5 4481.3 4551.8 4619.5 4644.5 110270.0 121667.0 126860.4 129872.4 130669.0 110503.4 111291.0 112637.0 113220.4 114115.0 89001.6 90441.0 96147.0 98498.5 99955.0 8553.9 8812.9 8880.2 8967.9 9047.0 53197.5 53472.5 53708.2 54230.7 54418.3 70948.6 81822.6 85281.6 85376.0 87314.7 11399.0 11439.4 11453.9 11473.8 11773.8 12267.2 12369.4 12387.3 12445.1 12496.9 9055.4 9303.7 9763.9 11853.7 12169.6 10620.6 10729.5 10960.0 11934.3 12397.6 11644.1 12034.6 12088.0 12192.7 12315.7 9816.5 9894.0 10015.6 10055.1 10071.1 8178.9 8905.4 9374.6 10295.5 10316.1 12:10:54 INFO - PROCESS | 1652 | -------- Summary: end -------- 12:10:54 INFO - PROCESS | 1652 | 12:10:54 INFO - TEST-INFO | 1652: exit 0 12:10:54 INFO - TEST-OK | dromaeo_css | took 1113779ms 12:10:54 INFO - TEST-START | kraken 12:10:54 INFO - operating with platform_type : mac_ 12:10:54 INFO - Initialising browser for kraken test... 12:10:54 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpllZfGs/profile http://localhost:49271/getInfo.html) 12:10:57 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 12:10:57 INFO - PROCESS | 1662 | colorDepth:24 12:10:57 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 12:10:57 INFO - PROCESS | 1662 | __metrics 12:10:57 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 12:10:57 INFO - TEST-INFO | 1662: exit 0 12:10:57 INFO - Browser initialized. 12:10:57 INFO - Running cycle 1/1 for kraken test... 12:10:57 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpllZfGs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:11:09 INFO - PROCESS | 1664 | RSS: Main: 245137408 12:11:09 INFO - PROCESS | 1664 | 12:11:12 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 12:11:13 INFO - PROCESS | 1664 | RSS: Main: 258019328 12:11:13 INFO - PROCESS | 1664 | 12:11:16 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 12:11:17 INFO - PROCESS | 1664 | RSS: Main: 266817536 12:11:17 INFO - PROCESS | 1664 | 12:11:20 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 12:11:21 INFO - PROCESS | 1664 | RSS: Main: 265469952 12:11:21 INFO - PROCESS | 1664 | 12:11:23 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 12:11:23 INFO - PROCESS | 1664 | RSS: Main: 267808768 12:11:23 INFO - PROCESS | 1664 | 12:11:25 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:11:26 INFO - PROCESS | 1664 | RSS: Main: 268136448 12:11:26 INFO - PROCESS | 1664 | 12:11:29 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 12:11:29 INFO - PROCESS | 1664 | RSS: Main: 268464128 12:11:29 INFO - PROCESS | 1664 | 12:11:33 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 12:11:33 INFO - PROCESS | 1664 | RSS: Main: 268742656 12:11:33 INFO - PROCESS | 1664 | 12:11:36 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 12:11:37 INFO - PROCESS | 1664 | RSS: Main: 269074432 12:11:37 INFO - PROCESS | 1664 | 12:11:38 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:11:39 INFO - PROCESS | 1664 | RSS: Main: 268595200 12:11:39 INFO - PROCESS | 1664 | 12:11:41 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:11:42 INFO - PROCESS | 1664 | RSS: Main: 268685312 12:11:42 INFO - PROCESS | 1664 | 12:11:44 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:11:45 INFO - PROCESS | 1664 | RSS: Main: 268738560 12:11:45 INFO - PROCESS | 1664 | 12:11:48 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:11:48 INFO - PROCESS | 1664 | RSS: Main: 268902400 12:11:48 INFO - PROCESS | 1664 | 12:11:51 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:11:52 INFO - PROCESS | 1664 | RSS: Main: 269012992 12:11:52 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 12:11:54 INFO - PROCESS | 1664 | RSS: Main: 270831616 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | __start_tp_report 12:11:54 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 12:11:54 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 12:11:54 INFO - PROCESS | 1664 | |i|pagename|runs| 12:11:54 INFO - PROCESS | 1664 | |0;ai-astar;108;117;117;116;118;117;118;117;115;133 12:11:54 INFO - PROCESS | 1664 | |1;audio-beat-detection;143;110;166;159;115;159;162;112;158;109 12:11:54 INFO - PROCESS | 1664 | |2;audio-dft;196;213;230;201;255;239;202;200;195;217 12:11:54 INFO - PROCESS | 1664 | |3;audio-fft;66;110;103;173;73;61;60;60;140;56 12:11:54 INFO - PROCESS | 1664 | |4;audio-oscillator;55;84;149;100;88;87;115;70;75;110 12:11:54 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;90;90;91;88;91;87;92;94;135;86 12:11:54 INFO - PROCESS | 1664 | |6;imaging-darkroom;154;135;96;121;102;152;124;96;95;96 12:11:54 INFO - PROCESS | 1664 | |7;imaging-desaturate;90;95;90;90;91;75;147;151;92;92 12:11:54 INFO - PROCESS | 1664 | |8;json-parse-financial;51;51;83;90;66;59;59;59;58;56 12:11:54 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;67;83;93;109;117;114;104;70;68;72 12:11:54 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;90;90;90;89;90;97;117;109;85;86 12:11:54 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;142;147;149;160;155;155;163;167;175;143 12:11:54 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;209;170;177;172;173;169;175;236;173;173 12:11:54 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;70;69;68;70;70;65;67;69;70;67 12:11:54 INFO - PROCESS | 1664 | __end_tp_report 12:11:54 INFO - PROCESS | 1664 | __start_cc_report 12:11:54 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,953 12:11:54 INFO - PROCESS | 1664 | __end_cc_report 12:11:54 INFO - PROCESS | 1664 | __startTimestamp1472843514483__endTimestamp 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | ------- Summary: start ------- 12:11:54 INFO - PROCESS | 1664 | Number of tests: 14 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:117.60 Median:117.00 stddev:6.15 (5.3%) stddev-sans-first:5.45 12:11:54 INFO - PROCESS | 1664 | Values: 108.0 117.0 117.0 116.0 118.0 117.0 118.0 117.0 115.0 133.0 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:158.50 stddev:24.68 (15.6%) stddev-sans-first:26.14 12:11:54 INFO - PROCESS | 1664 | Values: 143.0 110.0 166.0 159.0 115.0 159.0 162.0 112.0 158.0 109.0 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:214.80 Median:215.00 stddev:20.44 (9.5%) stddev-sans-first:20.51 12:11:54 INFO - PROCESS | 1664 | Values: 196.0 213.0 230.0 201.0 255.0 239.0 202.0 200.0 195.0 217.0 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:90.20 Median:60.00 stddev:40.30 (67.2%) stddev-sans-first:41.79 12:11:54 INFO - PROCESS | 1664 | Values: 66.0 110.0 103.0 173.0 73.0 61.0 60.0 60.0 140.0 56.0 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:72.50 stddev:26.66 (36.8%) stddev-sans-first:24.41 12:11:54 INFO - PROCESS | 1664 | Values: 55.0 84.0 149.0 100.0 88.0 87.0 115.0 70.0 75.0 110.0 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:94.40 Median:90.50 stddev:14.46 (16.0%) stddev-sans-first:15.25 12:11:54 INFO - PROCESS | 1664 | Values: 90.0 90.0 91.0 88.0 91.0 87.0 92.0 94.0 135.0 86.0 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:117.10 Median:124.50 stddev:23.61 (19.0%) stddev-sans-first:20.92 12:11:54 INFO - PROCESS | 1664 | Values: 154.0 135.0 96.0 121.0 102.0 152.0 124.0 96.0 95.0 96.0 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:101.30 Median:90.50 stddev:25.72 (28.4%) stddev-sans-first:26.95 12:11:54 INFO - PROCESS | 1664 | Values: 90.0 95.0 90.0 90.0 91.0 75.0 147.0 151.0 92.0 92.0 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:59.00 stddev:13.11 (22.2%) stddev-sans-first:13.14 12:11:54 INFO - PROCESS | 1664 | Values: 51.0 51.0 83.0 90.0 66.0 59.0 59.0 59.0 58.0 56.0 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:89.70 Median:69.00 stddev:20.16 (29.2%) stddev-sans-first:19.63 12:11:54 INFO - PROCESS | 1664 | Values: 67.0 83.0 93.0 109.0 117.0 114.0 104.0 70.0 68.0 72.0 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:90.00 stddev:10.52 (11.7%) stddev-sans-first:11.04 12:11:54 INFO - PROCESS | 1664 | Values: 90.0 90.0 90.0 89.0 90.0 97.0 117.0 109.0 85.0 86.0 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:155.60 Median:157.50 stddev:10.76 (6.8%) stddev-sans-first:10.23 12:11:54 INFO - PROCESS | 1664 | Values: 142.0 147.0 149.0 160.0 155.0 155.0 163.0 167.0 175.0 143.0 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:174.00 stddev:22.04 (12.7%) stddev-sans-first:21.22 12:11:54 INFO - PROCESS | 1664 | Values: 209.0 170.0 177.0 172.0 173.0 169.0 175.0 236.0 173.0 173.0 12:11:54 INFO - PROCESS | 1664 | 12:11:54 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.50 stddev:1.72 (2.5%) stddev-sans-first:1.73 12:11:54 INFO - PROCESS | 1664 | Values: 70.0 69.0 68.0 70.0 70.0 65.0 67.0 69.0 70.0 67.0 12:11:54 INFO - PROCESS | 1664 | -------- Summary: end -------- 12:11:54 INFO - PROCESS | 1664 | 12:11:55 INFO - TEST-INFO | 1664: exit 0 12:11:55 INFO - TEST-OK | kraken | took 60725ms 12:11:55 INFO - SUITE-END | took 1174s 12:11:55 INFO - Completed test suite (00:19:34) 12:11:55 INFO - javascript benchmark 12:11:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7165.879720597765, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3229.4509933311338, 3391.694747472727, 3396.7452441066926, 3411.641777613349, 3442.6557344265575, 4923.0, 5166.509181627749, 5620.690862002588, 5669.0079236133715, 5691.3739488656265, 4679.0, 5738.483536481715, 5742.971285143569, 5755.194272801811, 5767.961766881959, 4813.133635945528, 5135.2297155426795, 5200.895982080375, 5203.68777873327, 5369.5167434930845, 5277.920831187535, 5303.124984377592, 5308.70802105884, 5312.096943519611, 5315.229291752694, 5106.489351064883, 5155.66488178271, 5223.477652234784, 5229.084910140748, 5304.867378315535, 4275.273203555403, 4291.935620965688, 5195.922061169085, 5233.084210263189, 5305.336832895888, 3964.8215830287704, 5149.253358263069, 5206.24509446132, 5221.0, 5227.163653815409, 5480.534154596864, 5706.857328566777, 5720.170575266563, 5781.103928891029, 5807.274090738658, 4833.685810422347, 6186.103015062836, 6235.220597425322, 6263.6868156592445, 6265.530085243625, 5623.353314368859, 6112.602680825732, 6267.2479302484, 6308.053791931201, 6323.430891219767, 5176.068307704574, 5769.624974376652, 5820.1269809528485, 5840.678762668094, 5906.350301466835, 6072.453479186895, 6278.4035516625845, 6287.46556542699, 6296.527760417987, 6305.96847015762, 4793.969296601247, 5237.764300606482, 6185.195924529782, 6189.876202475925, 6191.226096737908, 5484.369297530835, 6001.5798894077, 6171.56799024064, 6180.6291622502795, 6206.348333425016, 6145.170401995673, 6228.439440450381, 6236.345183755731, 6245.250569931637, 6250.531210159256, 6232.594881332699, 6246.46905013079, 6294.181756371642, 6321.557490975588, 6326.9683651581445, 4653.837115700934, 4842.15262329091, 4888.242322440027, 4906.288588154697, 4967.552920237196, 4382.298832186835, 4453.821847126143, 4456.220161471794, 4471.709338892962, 4506.031203291308, 4544.7045942013665, 5859.1797148399255, 5884.323302820145, 5906.3207731110615, 5914.763409463573, 6170.629762214281, 6201.565890387629, 6207.379262073757, 6276.058591211355, 6291.213598300213, 5837.211976383219, 5840.737166827503, 5858.765649374062, 5867.471927526543, 5909.468147866713, 5350.491703288181, 5381.246625472437, 5395.487428694346, 5398.460153984649, 5401.189821526802, 6180.7527698891545, 6199.28708198563, 6228.906566401417, 6338.461230795434, 6343.429091381798, 6267.905981410191, 6271.811845644638, 6275.96862015687, 6276.623402595859, 6286.245650521967, 6310.810675679737, 6325.082862984934, 6329.461995730415, 6336.651484168415, 6340.524460665376, 6130.785422510191, 6142.754289828356, 6154.076888466766, 6182.7217775201125, 6211.378862113753, 6284.0, 6286.685665716787, 6291.842703932438, 6292.3078461368295, 6319.368063193644, 5475.178723191553, 6110.694465276807, 6147.655285071169, 6172.197614310111, 6174.598651087845, 5954.583179177416, 6074.665893375906, 6103.084537319438, 6188.381161883775, 6192.659403732658, 5915.112733090071, 5996.820095397145, 6046.90929636047, 6068.4841788448475, 6113.327533971348, 4497.942983398964, 6085.756569737338, 6155.630662160284, 6163.0, 6210.813675589739, 5833.183354330482, 5949.137375080676, 5982.371850955761, 6026.457618814153, 6043.8186854394435], "value": 5637.34629384924, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.708786623424, 530.2602868997748, 535.9705216213109, 537.1030379266625, 556.2296219735665, 30602.693973060264, 39027.60972390275, 39088.41367379484, 39122.80438597803, 39154.80422597886, 39784.40323395151, 40304.0, 40319.39520907189, 40379.59620403795, 40488.79755601225, 9526.904730952705, 9597.376170548892, 9650.0, 9697.515124243795, 9733.270004749673, 8380.455270407434, 8384.496930184208, 9604.855927161097, 9717.416954982687, 9816.656417025406, 7761.844763104735, 8173.223543763333, 8537.975442946856, 9742.512874356255, 9779.70660880171, 8248.876266855972, 9567.760805979837, 9664.565094570762, 9728.0, 9736.367136136128, 9564.521773911276, 9618.038196180396, 9643.90356096437, 9651.179649729782, 9658.806823863553, 32082.518762218584, 38652.0, 38713.61286387128, 38996.44014239427, 39233.60766392357, 2829.589709492112, 3336.282699219679, 3386.762926595139, 3568.37553428149, 3699.6115407882053, 31444.685553144405, 31759.523607145682, 32275.83862080698, 32294.0, 32455.0, 3193.696598823108, 3228.176814912182, 3275.672432756729, 3333.833308334598, 3435.3129374125274, 433825.0, 435253.0, 441779.0, 446424.0, 448168.0, 62889.37110628927, 63865.04202436967, 63971.00362454693, 63990.440382384186, 64082.67958660177, 34833.47749783755, 35406.29187416237, 35887.4616880747, 36669.44995825065, 36683.4497482538, 16284.592885177964, 16434.75347869783, 16468.83531164697, 16512.917435412746, 16526.83473165253, 12468.0, 12527.37363131858, 12568.743125687359, 12600.0, 12602.558910438274, 17425.0, 20192.69710954337, 20260.696089558667, 20288.492787680425, 20485.0, 8840.955795220983, 8852.468851868909, 8864.20222179994, 8885.289176865836, 8906.510141942255, 848.7411339541499, 919.4161707315769, 993.9751506212402, 1062.3148069495132, 1105.9004689577976, 25436.236912892644, 29608.703912961024, 29682.40635187284, 29839.701602983692, 29862.71219356774, 929.2380248196414, 976.1556253840376, 997.187292356727, 1069.198101423932, 1134.5575225661999, 14815.481458148914, 15286.388544458097, 15554.766678499831, 15592.908955663526, 16071.919640401957, 472053.0, 537883.0, 539559.0, 546422.0, 551332.0, 54058.729706351216, 54318.72840635772, 54346.0, 54379.912401751746, 54827.451725482235, 1356.4641966423208, 1384.6746014686541, 1397.4619771387886, 1407.8662527059912, 1408.0988167572762, 25877.741222588287, 28237.294067648472, 28838.0, 29783.553246700885, 29993.0, 50928.74535627298, 51477.0, 51516.48483515117, 51752.48247517627, 51881.7405912968, 517462.0, 520895.0, 522602.0, 523761.0, 525752.0, 40846.79576602098, 41333.58666413297, 41877.0, 42194.78902605467, 42315.78842105893, 45254.0, 46361.0, 46587.60237192889, 46879.06241875212, 46986.0, 37997.62002380051, 38357.80821095876, 38430.03924901788, 38625.80687096546, 38868.416973744854, 37604.81197593995, 37713.43429848609, 38605.80697096609, 38661.0, 38726.0, 36392.81803590965, 36788.81605592062, 36946.63053369432, 36966.815165923996, 37361.43957840689, 30918.22704432407, 32375.838120809247, 33642.831785840914, 33956.0, 34100.82949585236, 20166.69749953781, 23070.538589228458, 24181.549107053634, 24737.752622474265, 24962.0], "value": 19566.48478987473, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.7665704036054, 363.6890458657849, 372.47667027825895, 376.8040618878182, 393.82081153075353, 17945.910270448647, 19296.614067718638, 19905.60188796225, 20089.497762555944, 20784.272550460737, 15203.847961520409, 15956.601084972881, 19764.90117549414, 20239.696404553943, 20266.493337666565, 5742.827715168552, 5834.241548598677, 5999.310079340888, 6017.849553761147, 6059.303180134275, 5606.074997625387, 5665.3768085510565, 5921.259842519685, 5922.378150294222, 5931.199288096095, 5784.479396854283, 5882.00005998979, 5884.735186916599, 5890.764369425217, 5937.4656280934705, 6031.698415079229, 6064.96967515164, 6174.536909731788, 6176.258848938111, 6188.969055154718, 5760.423957604248, 5844.064949608085, 5945.613535120204, 5974.0, 6054.303755068179, 12450.564230251988, 12703.237805731686, 12711.110222284444, 12748.745025099446, 12866.935665321613, 2142.5393540388736, 2272.363738153303, 2290.541891621666, 2637.709851916288, 2685.8987814995953, 9868.21054315653, 10108.292419530635, 12245.816312755316, 14161.362738676784, 14760.852391476055, 1837.9448616541524, 1853.2586965213889, 1940.0687669918377, 1943.7375954246138, 1989.4031790462948, 107508.0, 108404.45797770961, 110676.0, 113169.0, 116344.41827790807, 10052.944440833753, 10580.312279701795, 10994.395308257963, 11016.394098324508, 11372.601958931398, 14039.368228429745, 14043.297835108204, 14054.929725351512, 14062.296885155905, 14063.0, 8068.47554908929, 8258.380621453414, 8275.462094963808, 8296.460730052528, 8415.831683366298, 8071.556064416513, 8162.510249385056, 8172.223638754309, 8317.958410208032, 8338.70814521501, 4075.5109386873173, 4094.488188976378, 4338.631216346583, 4435.401220835211, 4518.254488009507, 1882.3341342911622, 1925.1817977359847, 1932.294712429953, 1956.1295223625634, 1969.9315718495523, 748.1770052941721, 779.8869163971192, 854.8032754144248, 878.512425603796, 933.2207606648388, 19678.21287148498, 20318.0, 20336.72928684963, 20370.388888333375, 20691.482712931997, 889.1286539191628, 905.8224308399055, 916.3677062826629, 958.434523631061, 979.9363041402286, 10269.3569028955, 10610.0, 10701.0, 10720.73198170052, 10723.517441715141, 515336.0, 517033.0, 518848.0, 527377.0, 527586.0, 114031.0, 117240.0, 118516.0, 118646.40676796561, 119948.0, 851.8935133108362, 980.3284749946453, 981.4994352880083, 1009.9293049486465, 1042.9165666746642, 17019.40432084871, 17220.397286094925, 17228.741568876227, 17397.304107835545, 17506.73739893877, 46905.75462967603, 48040.0, 48582.0, 51934.740326298124, 52707.73646131745, 60027.39972600218, 68028.97956530756, 70519.64740176266, 71522.28477715157, 73948.0, 6965.721371145098, 7625.504342217738, 7801.297883190313, 7861.213878612093, 7870.606469676379, 9457.763555911157, 12381.00951923826, 12458.563950261698, 12763.617091487271, 12913.0, 8973.32700047486, 10728.51721672511, 11037.558497660004, 11138.832917506083, 11430.314181149157, 10497.475126243504, 10578.471076446302, 11015.559377625126, 11098.5560577576, 11195.496202670736, 10819.1344692426, 11068.889311106786, 11247.381394023407, 11463.541458341906, 11487.081033517132, 7927.682892684459, 7995.2804247618, 8060.395470339865, 8094.271515563628, 8106.0, 9597.28020398459, 10945.179111566506, 11266.436678166223, 11322.886771132184, 11422.200445968703], "value": 9147.83087954114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1476.8153980752406, 1548.41934274647, 1764.717645176772, 1817.627386385791, 1879.6522643310989, 8011.5193088414735, 8535.359848011401, 8679.349048821332, 9093.681721139754, 9109.908900910988, 7910.406719496032, 8511.446755960873, 8930.955345223265, 8931.285497160228, 8933.821323573524, 2375.7505461926507, 2388.426777573379, 2402.147237730607, 2405.4226985523524, 2406.0, 2329.5923213437663, 2365.8462199957034, 2375.429896824758, 2376.4652953085592, 2381.535600557892, 2350.976490235093, 2352.12971200656, 2356.9764302357016, 2357.9056837726557, 2372.632242002492, 2149.838762092834, 2207.8629505804524, 2338.9532209355802, 2347.6243800991847, 2363.2437619961706, 2296.632538793785, 2316.397736588482, 2323.5236776460956, 2329.720433547985, 2332.090484710964, 8930.240929520998, 8987.955060224722, 9005.234555062827, 9021.458712477272, 9045.954770226173, 5259.790248242887, 5301.60237982149, 5385.461453854622, 5408.59435542332, 5416.268803711488, 3059.6787337329483, 3521.2605352875926, 3615.4215325547784, 3663.3955397359405, 3721.771815300944, 1038.2161468091542, 1071.994640026795, 1073.661796534097, 1097.3361116524547, 1099.6206308823444, 11617.825732614017, 11658.59194928182, 11717.707057323634, 11758.235714678518, 11764.0, 4582.633389328846, 4721.6458765592715, 4822.614190864722, 4864.416270047617, 4881.609471242292, 9855.408675479493, 9930.751731206634, 9977.002299769965, 9990.600375984879, 10000.699979000641, 5368.463153684678, 5379.946200537945, 5381.461853814665, 5390.21841832932, 5401.945980540223, 4059.2693315202955, 4436.3123715824095, 4758.809647614126, 4889.731064791399, 4951.801927922843, 3933.1347103637154, 3941.2511622791576, 4046.8988275293354, 4069.491313585802, 4107.938380924288, 1293.838270216223, 1301.0697351393799, 1305.536534530228, 1310.8885744711615, 1314.2049060318561, 787.5589669784939, 884.7168905950163, 891.9554022298859, 919.7838507950627, 971.7133445633555, 4612.962083531179, 5699.235870602754, 5888.0, 5917.792877249276, 6106.572539922252, 418.77804763475405, 428.32538751466564, 944.2210176604328, 1011.8735158105237, 1060.347886050089, 3897.162110146332, 3938.980305098456, 4035.3543433050572, 4061.8578349757618, 4110.403991421287, 10523.894761052445, 10946.56213751457, 10958.890411095947, 10972.067374273116, 10972.067374273116, 10827.242093053568, 10862.0, 10865.51105200268, 10873.293235939638, 10876.129909607213, 8126.228008339198, 8129.837403251902, 8149.511029338259, 8222.054463736627, 8244.8351032979, 5702.942970570241, 5808.448197421239, 5870.706464676664, 5885.764569417175, 5915.881682366415, 10046.899531004889, 10073.597056117673, 10119.392836429837, 10130.898691012995, 10205.591776328863, 9939.950300248453, 10158.898411015794, 10287.794244114926, 10323.81276153252, 10398.168146548409, 6623.0, 6932.930670693228, 7014.158301003912, 7138.607376594337, 7164.247753985756, 8477.279431248413, 8551.444156130081, 8557.657693692183, 8579.399442039246, 8580.313574914117, 7453.590052546945, 7491.063617047869, 7550.962245188959, 7620.276073772982, 7689.615519224129, 6306.590071645328, 7320.560766354036, 7407.296306850841, 7549.849003020019, 7560.924390756022, 7009.719611215494, 7029.332213439715, 7077.292270772881, 7105.360517553445, 7105.431565474853, 4844.0, 4888.315635810918, 4890.217565189552, 4906.803727850846, 4967.528084831935, 4585.151746926829, 4606.401167848158, 4690.648201384978, 4761.428628564595, 4762.190427627243], "value": 4570.435936020964, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.2487284332302, 301.2814437566404, 306.66420269804564, 307.88300445830583, 310.58381768430297, 5248.0553500369915, 5286.762095705692, 5422.295101636787, 5478.329519222121, 5529.9999999999945, 4902.80388784449, 5247.475252474751, 5294.867628309295, 5420.566354691625, 5455.972720136404, 3180.538821870827, 4156.5012198536215, 4174.603412675799, 4190.685698572619, 4192.706510544263, 3765.8305376258, 4019.5779443158485, 4150.854720084798, 4173.061061261223, 4184.623383895449, 3330.7002369786715, 3978.164585437047, 3979.9453144916474, 4002.2195671844, 4024.3762216856435, 3910.2179564087296, 3968.591150141716, 4009.7794621295816, 4026.4765580474495, 4062.801473565276, 3077.4460597092516, 3331.7001469867587, 3486.2678837443914, 3497.89506314811, 3517.9120521987156, 4226.154769046203, 4273.273543497613, 5027.245913113063, 5259.0796610593, 5276.7889284428575, 4334.176506463762, 4436.467623885154, 4458.754768487732, 4675.1299480207845, 4691.3432119503295, 4335.485418457287, 4491.955080449186, 5701.600887937846, 5731.942680573183, 5738.282714660668, 3037.58992536007, 3816.255830113129, 3842.7117966152373, 3854.325493038707, 3860.285847118292, 6024.879502409927, 6027.578069535134, 6058.818235452944, 6062.9996050652035, 6105.877882442326, 3090.5209692497697, 3331.8167500787204, 3804.334241507725, 3881.5342158941107, 3904.2475055086097, 3887.5723670396233, 3891.591382904811, 3917.196974620196, 3968.305546529346, 3977.482927219443, 4175.164967006611, 4437.0, 4609.423822022247, 4615.076984603025, 4628.0, 4359.760213188241, 4951.480094590016, 5745.368009518949, 5767.769289228384, 5813.563982701315, 1189.0084109117195, 1319.9802002969964, 1339.7923321885123, 1341.2824139085737, 1349.5479014530242, 665.7303791964263, 669.8124525132971, 746.4700062955254, 794.4796158516181, 808.3775492870457, 4127.4015267786, 4455.6435485161755, 4523.0, 4547.386102876136, 4585.839495617637, 4393.934090988638, 4416.930233487759, 4464.732116073046, 4891.902161956741, 4996.7001979881325, 3831.8695984684587, 3901.9609803902167, 4381.430414046154, 4577.084583083397, 4595.287730401793, 2241.3948233976735, 2594.675665541807, 2801.0, 3051.649060358043, 3097.7212050915527, 4994.827250146198, 5546.029444847136, 5621.8594535136945, 6072.271327440735, 6098.451139397387, 5741.7990370337675, 6041.697915104227, 6070.696465176724, 6080.695965201722, 6128.233970753656, 5977.940220597825, 6023.518118550418, 6053.487802561887, 6066.904839233588, 6079.878402431927, 5795.594308398372, 5824.796132135355, 5857.765689372548, 5873.442023007808, 5875.794347197828, 5653.547716182778, 5737.942620573741, 5778.653280803165, 5840.766369345179, 5851.414858514115, 5284.656497327662, 6119.653676191231, 6143.726821076051, 6156.876862462816, 6210.689465526615, 3477.669621385964, 3809.742784881038, 3941.3693808990424, 3962.881113566598, 4001.5598284188136, 4915.6067514598035, 5841.357450680507, 5861.238039054895, 5865.677387743544, 5869.442402971711, 4525.230710779109, 5014.899702005867, 5149.716765577779, 5294.126469132704, 5695.288088988877, 4878.09752198247, 5040.815408378955, 5079.263506791421, 5196.818111366084, 5369.0, 4585.58729714314, 5582.789895810007, 5623.606347555632, 5636.2100760124, 5640.915386269127, 4995.675281106716, 5044.697318160922, 5643.238162847963, 5680.8638272346525, 5694.943050569607, 5152.381714194321, 5549.611527193058, 5583.525400340854, 5635.943640563706, 5663.688497132697], "value": 4017.5429899277387, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.9454443644506, 695.9721611135554, 703.2896774257999, 716.7455553278589, 761.4974117082727, 15194.392224311014, 15829.445969391074, 15853.28660210289, 15888.364465421384, 15934.282957266922, 14256.643583910407, 14453.0605510642, 14457.92771036146, 14473.927630361834, 14516.854831451708, 659.241871847377, 824.4888169335021, 835.4444294544121, 851.7955690634266, 852.8507511185518, 852.47146769003, 859.1194026123243, 862.7498025572577, 863.2144748279068, 867.761365624452, 884.8982367027778, 900.5182227508284, 901.3510272603714, 901.4366021236727, 901.5086777706166, 744.3710064995071, 757.9545227286353, 848.9235968762811, 894.7628878347243, 894.8076163624787, 594.551113908996, 626.5269721360389, 673.7002034094829, 673.8416472129046, 674.1169068520205, 12140.21088629245, 14540.127592344494, 14557.272136393138, 14574.125552466887, 14607.853921460755, 14404.279786010762, 14415.207163605997, 14430.278486075655, 14525.128492290496, 14619.561413157622, 10915.727106822314, 10925.672229833117, 10930.890691093146, 10937.83593246102, 11365.261258018203, 3599.4420864766003, 3666.3767159582935, 3691.0218792020137, 3715.64701353371, 3814.6376094271277, 80097.0, 106287.40568891473, 108295.45852270689, 109229.0, 112299.43850280778, 10152.49237538135, 10804.243702940876, 10826.67519974402, 10839.078678312431, 11052.171087168495, 22492.437689057577, 22507.32478025662, 22507.662385064235, 22528.436789080402, 22638.094476221097, 7734.497257678346, 7798.33714134305, 7818.179091195457, 7936.444448888522, 7953.244441778022, 4375.365571992043, 4407.625351845129, 4408.382826404306, 4459.487158976694, 4540.659450541222, 3408.1309266136977, 3527.6825085742407, 3527.9118022049142, 3529.3470707918605, 3541.11472131967, 473.4555261449292, 602.5270162922085, 603.4840211619003, 619.2723549829022, 627.3788948940607, 564.1199728423672, 621.6425555305717, 656.5207398598953, 661.632793799446, 668.4952860590321, 8718.0, 8938.329625278131, 9317.767055823659, 9364.719058428258, 9374.85937710935, 563.5097465205216, 568.7213265499958, 611.7247238742584, 625.3964923848417, 672.9057931889539, 3821.4840996465678, 4481.305397663367, 4551.789594624958, 4619.452483418026, 4644.5123262056995, 110270.0, 121667.0, 126860.36569817092, 129872.35063824621, 130669.0, 110503.44748276207, 111291.0, 112637.0, 113220.43389783164, 114115.0, 89001.55499222592, 90441.0, 96147.0, 98498.50750746201, 99955.00044999456, 8553.914460855562, 8812.91187088121, 8880.245179159843, 8967.865482017645, 9047.0, 53197.46802531925, 53472.465275346745, 53708.19437708359, 54230.728846357095, 54418.286079961035, 70948.64525677338, 81822.59088704518, 85281.57359213164, 85376.0, 87314.69027964458, 11399.0, 11439.370834604177, 11453.942730286295, 11473.827892581785, 11773.823392648947, 12267.178548933616, 12369.381530923598, 12387.318697471726, 12445.115530566385, 12496.87503124957, 9055.36612437123, 9303.671766619747, 9763.902360976299, 11853.697428742002, 12169.574064907685, 10620.628278010232, 10729.46352682347, 10960.0, 11934.343611101473, 12397.566085186974, 11644.068474521848, 12034.63896083119, 12088.0, 12192.695182620151, 12315.692107697021, 9816.460094694861, 9894.0, 10015.59937602517, 10055.145312648507, 10071.143952764098, 8178.877316840133, 8905.421147625384, 9374.625014999323, 10295.485225738832, 10316.123129534073], "value": 7307.143874102363, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1621.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 117.0, 116.0, 118.0, 117.0, 118.0, 117.0, 115.0, 133.0], "value": 117.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 166.0, 159.0, 115.0, 159.0, 162.0, 112.0, 158.0, 109.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 213.0, 230.0, 201.0, 255.0, 239.0, 202.0, 200.0, 195.0, 217.0], "value": 214.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 110.0, 103.0, 173.0, 73.0, 61.0, 60.0, 60.0, 140.0, 56.0], "value": 90.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 84.0, 149.0, 100.0, 88.0, 87.0, 115.0, 70.0, 75.0, 110.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 91.0, 88.0, 91.0, 87.0, 92.0, 94.0, 135.0, 86.0], "value": 94.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 135.0, 96.0, 121.0, 102.0, 152.0, 124.0, 96.0, 95.0, 96.0], "value": 117.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 95.0, 90.0, 90.0, 91.0, 75.0, 147.0, 151.0, 92.0, 92.0], "value": 101.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 83.0, 90.0, 66.0, 59.0, 59.0, 59.0, 58.0, 56.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 83.0, 93.0, 109.0, 117.0, 114.0, 104.0, 70.0, 68.0, 72.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 90.0, 89.0, 90.0, 97.0, 117.0, 109.0, 85.0, 86.0], "value": 94.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 147.0, 149.0, 160.0, 155.0, 155.0, 163.0, 167.0, 175.0, 143.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 170.0, 177.0, 172.0, 173.0, 169.0, 175.0, 236.0, 173.0, 173.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 70.0, 70.0, 65.0, 67.0, 69.0, 70.0, 67.0], "value": 68.5, "unit": "score"}]}]} 12:11:55 INFO - Return code: 0 12:11:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:11:55 ERROR - # TBPL SUCCESS # 12:11:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:11:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:11:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:11:55 INFO - 2016-09-02 12:11:55.803 screenresolution[1669:10953] starting screenresolution argv=screenresolution get 12:11:55 INFO - 2016-09-02 12:11:55.805 screenresolution[1669:10953] Display 0: 1600x1200x32@60 12:11:55 INFO - 2016-09-02 12:11:55.811 screenresolution[1670:10956] starting screenresolution argv=screenresolution list 12:11:55 INFO - Available Modes on Display 0 12:11:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:11:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:11:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:11:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:11:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:11:56 INFO - Intel Iris: 12:11:56 INFO - Chipset Model: Intel Iris 12:11:56 INFO - Type: GPU 12:11:56 INFO - Bus: Built-In 12:11:56 INFO - VRAM (Dynamic, Max): 1536 MB 12:11:56 INFO - Vendor: Intel (0x8086) 12:11:56 INFO - Device ID: 0x0a2e 12:11:56 INFO - Revision ID: 0x0009 12:11:56 INFO - Displays: 12:11:56 INFO - Display: 12:11:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:11:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:11:56 INFO - Display Serial Number: 1600x1200 60 12:11:56 INFO - Main Display: Yes 12:11:56 INFO - Mirror: Off 12:11:56 INFO - Online: Yes 12:11:56 INFO - Rotation: Supported 12:11:56 INFO - Return code: 0 12:11:56 INFO - Running post-action listener: _resource_record_post_action 12:11:56 INFO - [mozharness: 2016-09-02 19:11:56.043671Z] Finished run-tests step (success) 12:11:56 INFO - Running post-run listener: _resource_record_post_run 12:11:56 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 32578560; Write bytes: 707041280; Read time: 320; Write time: 1883 12:11:56 INFO - TinderboxPrint: CPU usage
54.5% 12:11:56 INFO - TinderboxPrint: I/O read bytes / time
32,578,560 / 320 12:11:56 INFO - TinderboxPrint: I/O write bytes / time
707,041,280 / 1,883 12:11:56 INFO - TinderboxPrint: CPU idle
2,201.6 (45.5%) 12:11:56 INFO - TinderboxPrint: CPU system
981.7 (20.3%) 12:11:56 INFO - TinderboxPrint: CPU user
1,658.4 (34.3%) 12:11:56 INFO - TinderboxPrint: Swap in / out
434,876,416 / 0 12:11:56 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 407200256; Write bytes: 408233472; Read time: 31108; Write time: 747 12:11:56 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 29215744; Write bytes: 297492992; Read time: 291; Write time: 1131 12:11:56 INFO - Running post-run listener: _upload_blobber_files 12:11:56 INFO - Blob upload gear active. 12:11:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:11:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:11:56 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'] 12:11:56 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 12:11:56 INFO - (blobuploader) - INFO - Open directory for files ... 12:11:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:11:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:11:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:58 INFO - (blobuploader) - INFO - Done attempting. 12:11:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:11:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:11:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:59 INFO - (blobuploader) - INFO - Done attempting. 12:11:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:11:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:12:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:12:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:12:04 INFO - (blobuploader) - INFO - Done attempting. 12:12:04 INFO - (blobuploader) - INFO - Iteration through files over. 12:12:04 INFO - Return code: 0 12:12:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:12:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:12:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8e74d13333914054c1595320af495f01e9aad94dde22d42123530bcad158742d5c5e3c7311d9854233487c1404cc492cdb2b206f2a40be9ae5da1784070d5ef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3c76a6f4ab484046849fe12ad02019a7fd5a187c6744ac70c6fee5b922bdac2dbbf8123adb1506594a8ff0dc1858b665a2917865bec842c397b9378726ef0728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/392903aa96178714443f94237327477925dec4e594bbc48424f6a93d886bcb953a16000c1d43b263737495f53639943148bd01c2a0fdc65ddc6e58eed0be280a"} 12:12:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:12:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:12:04 INFO - Contents: 12:12:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8e74d13333914054c1595320af495f01e9aad94dde22d42123530bcad158742d5c5e3c7311d9854233487c1404cc492cdb2b206f2a40be9ae5da1784070d5ef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3c76a6f4ab484046849fe12ad02019a7fd5a187c6744ac70c6fee5b922bdac2dbbf8123adb1506594a8ff0dc1858b665a2917865bec842c397b9378726ef0728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/392903aa96178714443f94237327477925dec4e594bbc48424f6a93d886bcb953a16000c1d43b263737495f53639943148bd01c2a0fdc65ddc6e58eed0be280a"} 12:12:04 INFO - Running post-run listener: copy_logs_to_upload_dir 12:12:04 INFO - Copying logs to upload dir... 12:12:04 INFO - mkdir: /builds/slave/test/build/upload/logs 12:12:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.275899 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-02 12:12:04.565962) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 12:12:04.569807) ========= 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.1tsK8t9ZBj/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.oE1GysClBU/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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/8e74d13333914054c1595320af495f01e9aad94dde22d42123530bcad158742d5c5e3c7311d9854233487c1404cc492cdb2b206f2a40be9ae5da1784070d5ef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3c76a6f4ab484046849fe12ad02019a7fd5a187c6744ac70c6fee5b922bdac2dbbf8123adb1506594a8ff0dc1858b665a2917865bec842c397b9378726ef0728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/392903aa96178714443f94237327477925dec4e594bbc48424f6a93d886bcb953a16000c1d43b263737495f53639943148bd01c2a0fdc65ddc6e58eed0be280a"} build_url:https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/NdPPzuFwTjGUJ2-dHqOT9g/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/8e74d13333914054c1595320af495f01e9aad94dde22d42123530bcad158742d5c5e3c7311d9854233487c1404cc492cdb2b206f2a40be9ae5da1784070d5ef2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3c76a6f4ab484046849fe12ad02019a7fd5a187c6744ac70c6fee5b922bdac2dbbf8123adb1506594a8ff0dc1858b665a2917865bec842c397b9378726ef0728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/392903aa96178714443f94237327477925dec4e594bbc48424f6a93d886bcb953a16000c1d43b263737495f53639943148bd01c2a0fdc65ddc6e58eed0be280a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 12:12:04.603365) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 12:12:04.603716) ========= 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.1tsK8t9ZBj/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.oE1GysClBU/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.005085 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 12:12:04.652617) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 12:12:04.652956) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 12:12:04.653383) ========= ========= Total master_lag: 0.18 =========