builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0312 starttime: 1471304048.17 results: success (0) buildid: 20160815124529 builduid: 25acad5010584d2885577971cc32991e revision: dbb9da97e0e1c021314baf7de44f82fd4a74058d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 16:34:08.166099) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 16:34:08.166550) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 16:34:08.166823) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 16:34:08.192234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:34:08.192560) ========= 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.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-15 16:34:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 121M=0s 2016-08-15 16:34:08 (121 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104478 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:34:08.319627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:34:08.319935) ========= 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.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.025572 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:34:08.370445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 16:34:08.370820) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dbb9da97e0e1c021314baf7de44f82fd4a74058d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev dbb9da97e0e1c021314baf7de44f82fd4a74058d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-15 16:34:08,454 truncating revision to first 12 chars 2016-08-15 16:34:08,454 Setting DEBUG logging. 2016-08-15 16:34:08,454 attempt 1/10 2016-08-15 16:34:08,454 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dbb9da97e0e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 16:34:09,787 unpacking tar archive at: fx-team-dbb9da97e0e1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.614832 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 16:34:10.007587) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 16:34:10.007904) ========= script_repo_revision: dbb9da97e0e1c021314baf7de44f82fd4a74058d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 16:34:10.008276) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 16:34:10.008553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 16:34:10.027316) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-15 16:34:10.027607) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 16:34:10 INFO - MultiFileLogger online at 20160815 16:34:10 in /builds/slave/test 16:34:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:34:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:34:10 INFO - {'append_to_log': False, 16:34:10 INFO - 'base_work_dir': '/builds/slave/test', 16:34:10 INFO - 'blob_upload_branch': 'Fx-Team', 16:34:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:34:10 INFO - 'branch': 'Fx-Team', 16:34:10 INFO - 'buildbot_json_path': 'buildprops.json', 16:34:10 INFO - 'config_files': ('talos/mac_config.py',), 16:34:10 INFO - 'default_actions': ('clobber', 16:34:10 INFO - 'read-buildbot-config', 16:34:10 INFO - 'download-and-extract', 16:34:10 INFO - 'populate-webroot', 16:34:10 INFO - 'create-virtualenv', 16:34:10 INFO - 'install', 16:34:10 INFO - 'run-tests'), 16:34:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:34:10 INFO - 'download_minidump_stackwalk': True, 16:34:10 INFO - 'download_symbols': 'ondemand', 16:34:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:34:10 INFO - 'tooltool.py': '/tools/tooltool.py', 16:34:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:34:10 INFO - '/tools/misc-python/virtualenv.py')}, 16:34:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:34:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:34:10 INFO - 'installer_path': 'installer.exe', 16:34:10 INFO - 'log_level': 'info', 16:34:10 INFO - 'log_name': 'talos', 16:34:10 INFO - 'log_to_console': True, 16:34:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:34:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:34:10 INFO - 'opt_config_files': (), 16:34:10 INFO - 'pip_index': False, 16:34:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:34:10 INFO - 'cmd': ('bash', 16:34:10 INFO - '-c', 16:34:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:34:10 INFO - 'enabled': True, 16:34:10 INFO - 'halt_on_failure': False, 16:34:10 INFO - 'name': 'check_screen_resolution'},), 16:34:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:34:10 INFO - 'cmd': ('bash', 16:34:10 INFO - '-c', 16:34:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:34:10 INFO - 'enabled': True, 16:34:10 INFO - 'halt_on_failure': False, 16:34:10 INFO - 'name': 'check_screen_resolution'},), 16:34:10 INFO - 'run_cmd_checks_enabled': True, 16:34:10 INFO - 'sps_profile': False, 16:34:10 INFO - 'sps_profile_interval': 0, 16:34:10 INFO - 'suite': 'dromaeojs-e10s', 16:34:10 INFO - 'system_bits': '32', 16:34:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:34:10 INFO - 'title': 't-yosemite-r7-0312', 16:34:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:34:10 INFO - 'use_talos_json': True, 16:34:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:34:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:34:10 INFO - 'work_dir': 'build'} 16:34:10 INFO - [mozharness: 2016-08-15 23:34:10.222090Z] Running clobber step. 16:34:10 INFO - Running pre-action listener: _resource_record_pre_action 16:34:10 INFO - Running main action method: clobber 16:34:10 INFO - rmtree: /builds/slave/test/build 16:34:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:34:12 INFO - Running post-action listener: _resource_record_post_action 16:34:12 INFO - [mozharness: 2016-08-15 23:34:12.123529Z] Finished clobber step (success) 16:34:12 INFO - [mozharness: 2016-08-15 23:34:12.123672Z] Running read-buildbot-config step. 16:34:12 INFO - Running pre-action listener: _resource_record_pre_action 16:34:12 INFO - Running main action method: read_buildbot_config 16:34:12 INFO - Using buildbot properties: 16:34:12 INFO - { 16:34:12 INFO - "project": "", 16:34:12 INFO - "product": "firefox", 16:34:12 INFO - "script_repo_revision": "production", 16:34:12 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:34:12 INFO - "repository": "", 16:34:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:34:12 INFO - "buildid": "20160815124529", 16:34:12 INFO - "pgo_build": "False", 16:34:12 INFO - "basedir": "/builds/slave/test", 16:34:12 INFO - "buildnumber": 8, 16:34:12 INFO - "slavename": "t-yosemite-r7-0312", 16:34:12 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 16:34:12 INFO - "platform": "yosemite_r7", 16:34:12 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 16:34:12 INFO - "branch": "fx-team", 16:34:12 INFO - "repo_path": "integration/fx-team", 16:34:12 INFO - "revision": "dbb9da97e0e1c021314baf7de44f82fd4a74058d", 16:34:12 INFO - "stage_platform": "macosx64", 16:34:12 INFO - "builduid": "25acad5010584d2885577971cc32991e", 16:34:12 INFO - "slavebuilddir": "test" 16:34:12 INFO - } 16:34:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 16:34:12 INFO - Running post-action listener: _resource_record_post_action 16:34:12 INFO - [mozharness: 2016-08-15 23:34:12.127044Z] Finished read-buildbot-config step (success) 16:34:12 INFO - [mozharness: 2016-08-15 23:34:12.127183Z] Running download-and-extract step. 16:34:12 INFO - Running pre-action listener: _resource_record_pre_action 16:34:12 INFO - Running main action method: download_and_extract 16:34:12 INFO - mkdir: /builds/slave/test/build/tests 16:34:12 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')]} 16:34:12 INFO - trying https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 16:34:12 INFO - Downloading https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/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 16:34:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/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 16:34:13 INFO - Downloaded 1199 bytes. 16:34:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:34:13 INFO - Using the following test package requirements: 16:34:13 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:34:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 16:34:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 16:34:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'jsshell-mac.zip'], 16:34:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 16:34:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:34:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 16:34:13 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 16:34:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 16:34:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:34:13 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 16:34:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:13 INFO - trying https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:34:13 INFO - Downloading https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/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 16:34:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/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 16:34:14 INFO - Downloaded 16330448 bytes. 16:34:14 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 16:34:21 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 16:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:21 INFO - trying https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:34:21 INFO - Downloading https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/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 16:34:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/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 16:34:22 INFO - Downloaded 16330448 bytes. 16:34:22 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 16:34: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')]} 16:34:29 INFO - trying https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 16:34:29 INFO - Downloading https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/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 16:34:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/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 16:34:30 INFO - Downloaded 14413719 bytes. 16:34:30 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 16:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:30 INFO - trying https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:34:30 INFO - Downloading https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 16:34:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/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 16:34:33 INFO - Downloaded 111049912 bytes. 16:34:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:34:33 INFO - mkdir: /builds/slave/test/properties 16:34:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:34:33 INFO - Writing to file /builds/slave/test/properties/build_url 16:34:33 INFO - Contents: 16:34:33 INFO - build_url:https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:34:33 INFO - Running post-action listener: _resource_record_post_action 16:34:33 INFO - Running post-action listener: set_extra_try_arguments 16:34:33 INFO - [mozharness: 2016-08-15 23:34:33.850151Z] Finished download-and-extract step (success) 16:34:33 INFO - [mozharness: 2016-08-15 23:34:33.850273Z] Running populate-webroot step. 16:34:33 INFO - Running pre-action listener: _resource_record_pre_action 16:34:33 INFO - Running main action method: populate_webroot 16:34:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:34:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:34:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:34:33 INFO - '--tppagecycles', 16:34:33 INFO - '7'], 16:34:33 INFO - 'tests': ['tsvgm']}}, 16:34:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:34:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:34:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:34:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:34:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:34:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:34:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:33 INFO - 'talos_options': ['--disable-e10s'], 16:34:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:34:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:34:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:33 INFO - 'talos_options': ['--disable-e10s'], 16:34:33 INFO - 'tests': ['damp', 'tps']}, 16:34:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:33 INFO - 'tests': ['damp', 'tps']}, 16:34:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:34:33 INFO - 'tests': ['dromaeo_dom']}, 16:34:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:34:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:34:33 INFO - 'tests': ['basic_compositor_video']}, 16:34:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:34:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:34:33 INFO - 'tests': ['a11yr', 16:34:33 INFO - 'ts_paint', 16:34:33 INFO - 'tpaint', 16:34:33 INFO - 'sessionrestore', 16:34:33 INFO - 'sessionrestore_no_auto_restore', 16:34:33 INFO - 'tabpaint']}, 16:34:33 INFO - 'other-e10s': {'tests': ['a11yr', 16:34:33 INFO - 'ts_paint', 16:34:33 INFO - 'tpaint', 16:34:33 INFO - 'sessionrestore', 16:34:33 INFO - 'sessionrestore_no_auto_restore', 16:34:33 INFO - 'tabpaint']}, 16:34:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:34:33 INFO - 'ts_paint', 16:34:33 INFO - 'tpaint', 16:34:33 INFO - 'sessionrestore', 16:34:33 INFO - 'sessionrestore_no_auto_restore', 16:34:33 INFO - 'tabpaint']}, 16:34:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:34:33 INFO - 'ts_paint', 16:34:33 INFO - 'tpaint', 16:34:33 INFO - 'sessionrestore', 16:34:33 INFO - 'sessionrestore_no_auto_restore', 16:34:33 INFO - 'tabpaint']}, 16:34:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:34:33 INFO - 'tests': ['a11yr', 16:34:33 INFO - 'ts_paint', 16:34:33 INFO - 'tpaint', 16:34:33 INFO - 'sessionrestore', 16:34:33 INFO - 'sessionrestore_no_auto_restore', 16:34:33 INFO - 'tabpaint']}, 16:34:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:34:33 INFO - 'tests': ['a11yr', 16:34:33 INFO - 'ts_paint', 16:34:33 INFO - 'tpaint', 16:34:33 INFO - 'sessionrestore', 16:34:33 INFO - 'sessionrestore_no_auto_restore', 16:34:33 INFO - 'tabpaint']}, 16:34:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:34:33 INFO - 'tests': ['tsvgx', 16:34:33 INFO - 'tsvgr_opacity', 16:34:33 INFO - 'tart', 16:34:33 INFO - 'tscrollx', 16:34:33 INFO - 'cart']}, 16:34:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:34:33 INFO - 'tsvgr_opacity', 16:34:33 INFO - 'tart', 16:34:33 INFO - 'tscrollx', 16:34:33 INFO - 'cart']}, 16:34:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:33 INFO - 'talos_options': ['--disable-e10s'], 16:34:33 INFO - 'tests': ['tp5o']}, 16:34:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:33 INFO - 'tests': ['tp5o']}, 16:34:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:33 INFO - 'talos_options': ['--disable-e10s', 16:34:33 INFO - '--xperf_path', 16:34:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:34:33 INFO - 'tests': ['tp5n']}, 16:34:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:33 INFO - 'talos_options': ['--xperf_path', 16:34:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:34:33 INFO - 'tests': ['tp5n']}}, 16:34:33 INFO - 'talos.zip': {'path': '', 16:34:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:34:33 INFO - Running post-action listener: _resource_record_post_action 16:34:33 INFO - [mozharness: 2016-08-15 23:34:33.869367Z] Finished populate-webroot step (success) 16:34:33 INFO - [mozharness: 2016-08-15 23:34:33.869473Z] Running create-virtualenv step. 16:34:33 INFO - Running pre-action listener: _resource_record_pre_action 16:34:33 INFO - Running main action method: create_virtualenv 16:34:33 INFO - Creating virtualenv /builds/slave/test/build/venv 16:34:33 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 16:34:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:34:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:34:33 INFO - Using real prefix '/tools/python27' 16:34:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:34:34 INFO - Installing distribute.............................................................................................................................................................................................done. 16:34:37 INFO - Installing pip.................done. 16:34:37 INFO - Return code: 0 16:34:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:34:37 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')]} 16:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:37 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')]} 16:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:37 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 0x10d537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5cc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea2959a950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d49bd30>, '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 0x10d200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d493b20>, '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.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 16:34:37 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 16:34:37 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 16:34:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVvsuBDlJS/Render', 16:34:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:37 INFO - 'HOME': '/Users/cltbld', 16:34:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:37 INFO - 'LOGNAME': 'cltbld', 16:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:37 INFO - 'MOZ_NO_REMOTE': '1', 16:34:37 INFO - 'NO_EM_RESTART': '1', 16:34:37 INFO - 'PAGER': '/bin/cat', 16:34:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:37 INFO - 'PWD': '/builds/slave/test', 16:34:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:37 INFO - 'SHELL': '/bin/bash', 16:34:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QPpY8Pj1KG/Listeners', 16:34:37 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 16:34:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:37 INFO - 'USER': 'cltbld', 16:34:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:37 INFO - 'XPC_FLAGS': '0x0', 16:34:37 INFO - 'XPC_SERVICE_NAME': '0', 16:34:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:37 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 16:34:37 INFO - Cleaning up... 16:34:37 INFO - Return code: 0 16:34:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:34:37 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')]} 16:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:37 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')]} 16:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:37 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 0x10d537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5cc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea2959a950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d49bd30>, '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 0x10d200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d493b20>, '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.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 16:34:37 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 16:34:37 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 16:34:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVvsuBDlJS/Render', 16:34:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:37 INFO - 'HOME': '/Users/cltbld', 16:34:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:37 INFO - 'LOGNAME': 'cltbld', 16:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:37 INFO - 'MOZ_NO_REMOTE': '1', 16:34:37 INFO - 'NO_EM_RESTART': '1', 16:34:37 INFO - 'PAGER': '/bin/cat', 16:34:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:37 INFO - 'PWD': '/builds/slave/test', 16:34:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:37 INFO - 'SHELL': '/bin/bash', 16:34:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QPpY8Pj1KG/Listeners', 16:34:37 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 16:34:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:37 INFO - 'USER': 'cltbld', 16:34:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:37 INFO - 'XPC_FLAGS': '0x0', 16:34:37 INFO - 'XPC_SERVICE_NAME': '0', 16:34:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:38 INFO - Downloading/unpacking psutil>=3.1.1 16:34:38 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 16:34:38 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 16:34:38 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 16:34:38 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 16:34:38 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 16:34:38 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 16:34:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:34:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:41 INFO - Installing collected packages: psutil 16:34:41 INFO - Running setup.py install for psutil 16:34:41 INFO - building 'psutil._psutil_osx' extension 16:34:41 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 16:34:42 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 16:34:42 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 16:34:42 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 16:34:42 INFO - building 'psutil._psutil_posix' extension 16:34:42 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 16:34:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:34:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:34:42 INFO - ^ 16:34:42 INFO - 1 warning generated. 16:34:42 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 16:34:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:42 INFO - Successfully installed psutil 16:34:42 INFO - Cleaning up... 16:34:42 INFO - Return code: 0 16:34:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:34:42 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')]} 16:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:42 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')]} 16:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:42 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 0x10d537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5cc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea2959a950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d49bd30>, '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 0x10d200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d493b20>, '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.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 16:34:42 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 16:34:42 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 16:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVvsuBDlJS/Render', 16:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:42 INFO - 'HOME': '/Users/cltbld', 16:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:42 INFO - 'LOGNAME': 'cltbld', 16:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:42 INFO - 'MOZ_NO_REMOTE': '1', 16:34:42 INFO - 'NO_EM_RESTART': '1', 16:34:42 INFO - 'PAGER': '/bin/cat', 16:34:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:42 INFO - 'PWD': '/builds/slave/test', 16:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:42 INFO - 'SHELL': '/bin/bash', 16:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QPpY8Pj1KG/Listeners', 16:34:42 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 16:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:42 INFO - 'USER': 'cltbld', 16:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:42 INFO - 'XPC_FLAGS': '0x0', 16:34:42 INFO - 'XPC_SERVICE_NAME': '0', 16:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:34:45 INFO - Installing collected packages: mozsystemmonitor 16:34:45 INFO - Running setup.py install for mozsystemmonitor 16:34:45 INFO - Successfully installed mozsystemmonitor 16:34:45 INFO - Cleaning up... 16:34:45 INFO - Return code: 0 16:34:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5cc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea2959a950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d49bd30>, '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 0x10d200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d493b20>, '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.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 16:34:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:34:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVvsuBDlJS/Render', 16:34:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:45 INFO - 'HOME': '/Users/cltbld', 16:34:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:45 INFO - 'LOGNAME': 'cltbld', 16:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:45 INFO - 'MOZ_NO_REMOTE': '1', 16:34:45 INFO - 'NO_EM_RESTART': '1', 16:34:45 INFO - 'PAGER': '/bin/cat', 16:34:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:45 INFO - 'PWD': '/builds/slave/test', 16:34:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:45 INFO - 'SHELL': '/bin/bash', 16:34:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QPpY8Pj1KG/Listeners', 16:34:45 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 16:34:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:45 INFO - 'USER': 'cltbld', 16:34:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:45 INFO - 'XPC_FLAGS': '0x0', 16:34:45 INFO - 'XPC_SERVICE_NAME': '0', 16:34:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:45 INFO - Downloading/unpacking jsonschema==2.5.1 16:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:34:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:48 INFO - Downloading functools32-3.2.3-2.tar.gz 16:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:34:48 INFO - warning: no files found matching '*.txt' 16:34:48 INFO - no previously-included directories found matching 'build' 16:34:48 INFO - no previously-included directories found matching 'dist' 16:34:48 INFO - no previously-included directories found matching '.git*' 16:34:48 INFO - Installing collected packages: jsonschema, functools32 16:34:49 INFO - Running setup.py install for functools32 16:34:49 INFO - warning: no files found matching '*.txt' 16:34:49 INFO - no previously-included directories found matching 'build' 16:34:49 INFO - no previously-included directories found matching 'dist' 16:34:49 INFO - no previously-included directories found matching '.git*' 16:34:49 INFO - Successfully installed jsonschema functools32 16:34:49 INFO - Cleaning up... 16:34:49 INFO - Return code: 0 16:34:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:49 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 0x10d537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5cc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea2959a950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d49bd30>, '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 0x10d200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d493b20>, '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.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 16:34:49 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 16:34:49 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 16:34:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVvsuBDlJS/Render', 16:34:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:49 INFO - 'HOME': '/Users/cltbld', 16:34:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:49 INFO - 'LOGNAME': 'cltbld', 16:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:49 INFO - 'MOZ_NO_REMOTE': '1', 16:34:49 INFO - 'NO_EM_RESTART': '1', 16:34:49 INFO - 'PAGER': '/bin/cat', 16:34:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:49 INFO - 'PWD': '/builds/slave/test', 16:34:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:49 INFO - 'SHELL': '/bin/bash', 16:34:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QPpY8Pj1KG/Listeners', 16:34:49 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 16:34:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:49 INFO - 'USER': 'cltbld', 16:34:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:49 INFO - 'XPC_FLAGS': '0x0', 16:34:49 INFO - 'XPC_SERVICE_NAME': '0', 16:34:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:34:49 INFO - Cleaning up... 16:34:49 INFO - Return code: 0 16:34:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:49 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 0x10d537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5cc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea2959a950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d49bd30>, '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 0x10d200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d493b20>, '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.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 16:34:49 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 16:34:49 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 16:34:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVvsuBDlJS/Render', 16:34:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:49 INFO - 'HOME': '/Users/cltbld', 16:34:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:49 INFO - 'LOGNAME': 'cltbld', 16:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:49 INFO - 'MOZ_NO_REMOTE': '1', 16:34:49 INFO - 'NO_EM_RESTART': '1', 16:34:49 INFO - 'PAGER': '/bin/cat', 16:34:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:49 INFO - 'PWD': '/builds/slave/test', 16:34:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:49 INFO - 'SHELL': '/bin/bash', 16:34:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QPpY8Pj1KG/Listeners', 16:34:49 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 16:34:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:49 INFO - 'USER': 'cltbld', 16:34:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:49 INFO - 'XPC_FLAGS': '0x0', 16:34:49 INFO - 'XPC_SERVICE_NAME': '0', 16:34:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:49 INFO - Downloading/unpacking blobuploader==1.2.4 16:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:52 INFO - Downloading blobuploader-1.2.4.tar.gz 16:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:34:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:34:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:53 INFO - Downloading docopt-0.6.1.tar.gz 16:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:34:53 INFO - Installing collected packages: blobuploader, requests, docopt 16:34:53 INFO - Running setup.py install for blobuploader 16:34:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:34:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:34:53 INFO - Running setup.py install for requests 16:34:54 INFO - Running setup.py install for docopt 16:34:54 INFO - Successfully installed blobuploader requests docopt 16:34:54 INFO - Cleaning up... 16:34:54 INFO - Return code: 0 16:34:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:54 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 0x10d537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5cc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea2959a950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d49bd30>, '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 0x10d200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d493b20>, '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.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 16:34:54 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 16:34:54 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 16:34:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVvsuBDlJS/Render', 16:34:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:54 INFO - 'HOME': '/Users/cltbld', 16:34:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:54 INFO - 'LOGNAME': 'cltbld', 16:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:54 INFO - 'MOZ_NO_REMOTE': '1', 16:34:54 INFO - 'NO_EM_RESTART': '1', 16:34:54 INFO - 'PAGER': '/bin/cat', 16:34:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:54 INFO - 'PWD': '/builds/slave/test', 16:34:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:54 INFO - 'SHELL': '/bin/bash', 16:34:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QPpY8Pj1KG/Listeners', 16:34:54 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 16:34:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:54 INFO - 'USER': 'cltbld', 16:34:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:54 INFO - 'XPC_FLAGS': '0x0', 16:34:54 INFO - 'XPC_SERVICE_NAME': '0', 16:34:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-kmKCF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-UBr3yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-woK6Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:54 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-82LAR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-15Sdzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-eUAyPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-CyIgDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:34:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-RAN0Ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:34:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-bjIW8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:34:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-4V83pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:34:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-_z6HHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:34:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-1uK0O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:34:55 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Z2UiHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:34:56 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-oRbXTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:56 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-FhMSH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:34:56 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-FUuG5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:34:56 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-e2vpPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:34:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:34:56 INFO - Running setup.py install for manifestparser 16:34:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:34:56 INFO - Running setup.py install for mozcrash 16:34:56 INFO - Running setup.py install for mozdebug 16:34:56 INFO - Running setup.py install for mozdevice 16:34:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Running setup.py install for mozfile 16:34:57 INFO - Running setup.py install for mozhttpd 16:34:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Running setup.py install for mozinfo 16:34:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Running setup.py install for mozInstall 16:34:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Running setup.py install for mozleak 16:34:57 INFO - Running setup.py install for mozlog 16:34:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:34:57 INFO - Running setup.py install for moznetwork 16:34:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:34:58 INFO - Running setup.py install for mozprocess 16:34:58 INFO - Running setup.py install for mozprofile 16:34:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:34:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:34:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:34:58 INFO - Running setup.py install for mozrunner 16:34:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:34:58 INFO - Running setup.py install for mozscreenshot 16:34:58 INFO - Running setup.py install for moztest 16:34:58 INFO - Running setup.py install for mozversion 16:34:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:34:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:34:58 INFO - Cleaning up... 16:34:58 INFO - Return code: 0 16:34:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:58 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 0x10d537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5cc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea2959a950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d49bd30>, '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 0x10d200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d493b20>, '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.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 16:34:58 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 16:34:58 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 16:34:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVvsuBDlJS/Render', 16:34:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:58 INFO - 'HOME': '/Users/cltbld', 16:34:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:58 INFO - 'LOGNAME': 'cltbld', 16:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:58 INFO - 'MOZ_NO_REMOTE': '1', 16:34:58 INFO - 'NO_EM_RESTART': '1', 16:34:58 INFO - 'PAGER': '/bin/cat', 16:34:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:58 INFO - 'PWD': '/builds/slave/test', 16:34:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:58 INFO - 'SHELL': '/bin/bash', 16:34:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QPpY8Pj1KG/Listeners', 16:34:58 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 16:34:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:58 INFO - 'USER': 'cltbld', 16:34:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:58 INFO - 'XPC_FLAGS': '0x0', 16:34:58 INFO - 'XPC_SERVICE_NAME': '0', 16:34:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-L1G0QE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:59 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)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-b3ywor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:59 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)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-5ckr3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:59 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)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-T6APCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:59 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)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ccDvRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:59 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)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-j2wnAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:59 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)) 16:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-tSf9r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:35:00 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)) 16:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:35:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Ti1lNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:35:00 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)) 16:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:35:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Hgp6wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:35:00 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)) 16:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:35:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-UJGmZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:35:00 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)) 16:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:35:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-P1OB7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:35:00 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)) 16:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:35:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-BOqyQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:35:00 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)) 16:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:35:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-hZHCG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:35:00 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)) 16:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:35:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-BQzErV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:00 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)) 16:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-YHGfDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:00 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)) 16:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-LuPyEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:00 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)) 16:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-pv59Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:01 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)) 16:35:01 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)) 16:35:01 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)) 16:35:01 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)) 16:35:01 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)) 16:35:01 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)) 16:35:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:35:01 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 16:35:01 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 16:35:01 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 16:35:01 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 16:35:01 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 16:35:01 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 16:35:03 INFO - Downloading blessings-1.6.tar.gz 16:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:35:03 INFO - Installing collected packages: blessings 16:35:03 INFO - Running setup.py install for blessings 16:35:03 INFO - Successfully installed blessings 16:35:03 INFO - Cleaning up... 16:35:03 INFO - Return code: 0 16:35:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:35:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:04 INFO - Reading from file tmpfile_stdout 16:35:04 INFO - Current package versions: 16:35:04 INFO - blessings == 1.6 16:35:04 INFO - blobuploader == 1.2.4 16:35:04 INFO - docopt == 0.6.1 16:35:04 INFO - functools32 == 3.2.3-2 16:35:04 INFO - jsonschema == 2.5.1 16:35:04 INFO - manifestparser == 1.1 16:35:04 INFO - mozInstall == 1.12 16:35:04 INFO - mozcrash == 0.17 16:35:04 INFO - mozdebug == 0.1 16:35:04 INFO - mozdevice == 0.48 16:35:04 INFO - mozfile == 1.2 16:35:04 INFO - mozhttpd == 0.7 16:35:04 INFO - mozinfo == 0.9 16:35:04 INFO - mozleak == 0.1 16:35:04 INFO - mozlog == 3.3 16:35:04 INFO - moznetwork == 0.27 16:35:04 INFO - mozprocess == 0.23 16:35:04 INFO - mozprofile == 0.28 16:35:04 INFO - mozrunner == 6.12 16:35:04 INFO - mozscreenshot == 0.1 16:35:04 INFO - mozsystemmonitor == 0.3 16:35:04 INFO - moztest == 0.7 16:35:04 INFO - mozversion == 1.4 16:35:04 INFO - psutil == 3.1.1 16:35:04 INFO - requests == 1.2.3 16:35:04 INFO - wsgiref == 0.1.2 16:35:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:04 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')]} 16:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:04 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')]} 16:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:04 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 0x10d537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5cc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea2959a950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d49bd30>, '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 0x10d200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d493b20>, '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.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 16:35:04 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 16:35:04 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 16:35:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVvsuBDlJS/Render', 16:35:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:04 INFO - 'HOME': '/Users/cltbld', 16:35:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:04 INFO - 'LOGNAME': 'cltbld', 16:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:04 INFO - 'MOZ_NO_REMOTE': '1', 16:35:04 INFO - 'NO_EM_RESTART': '1', 16:35:04 INFO - 'PAGER': '/bin/cat', 16:35:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:04 INFO - 'PWD': '/builds/slave/test', 16:35:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:04 INFO - 'SHELL': '/bin/bash', 16:35:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QPpY8Pj1KG/Listeners', 16:35:04 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 16:35:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:04 INFO - 'USER': 'cltbld', 16:35:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:04 INFO - 'XPC_FLAGS': '0x0', 16:35:04 INFO - 'XPC_SERVICE_NAME': '0', 16:35:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 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)) 16:35:04 INFO - Cleaning up... 16:35:04 INFO - Return code: 0 16:35:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:35:04 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')]} 16:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:04 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')]} 16:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:04 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 0x10d537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5cc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea2959a950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d49bd30>, '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 0x10d200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d493b20>, '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.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 16:35:04 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 16:35:04 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 16:35:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVvsuBDlJS/Render', 16:35:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:04 INFO - 'HOME': '/Users/cltbld', 16:35:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:04 INFO - 'LOGNAME': 'cltbld', 16:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:04 INFO - 'MOZ_NO_REMOTE': '1', 16:35:04 INFO - 'NO_EM_RESTART': '1', 16:35:04 INFO - 'PAGER': '/bin/cat', 16:35:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:04 INFO - 'PWD': '/builds/slave/test', 16:35:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:04 INFO - 'SHELL': '/bin/bash', 16:35:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QPpY8Pj1KG/Listeners', 16:35:04 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 16:35:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:04 INFO - 'USER': 'cltbld', 16:35:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:04 INFO - 'XPC_FLAGS': '0x0', 16:35:04 INFO - 'XPC_SERVICE_NAME': '0', 16:35:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:35:05 INFO - Cleaning up... 16:35:05 INFO - Return code: 0 16:35:05 INFO - Running post-action listener: _resource_record_post_action 16:35:05 INFO - Running post-action listener: _start_resource_monitoring 16:35:05 INFO - Starting resource monitoring. 16:35:05 INFO - [mozharness: 2016-08-15 23:35:05.047577Z] Finished create-virtualenv step (success) 16:35:05 INFO - [mozharness: 2016-08-15 23:35:05.048564Z] Running install step. 16:35:05 INFO - Running pre-action listener: _resource_record_pre_action 16:35:05 INFO - Running main action method: install 16:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:05 INFO - Reading from file tmpfile_stdout 16:35:05 INFO - Detecting whether we're running mozinstall >=1.0... 16:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:35:05 INFO - Reading from file tmpfile_stdout 16:35:05 INFO - Output received: 16:35:05 INFO - Usage: mozinstall [options] installer 16:35:05 INFO - Options: 16:35:05 INFO - -h, --help show this help message and exit 16:35:05 INFO - -d DEST, --destination=DEST 16:35:05 INFO - Directory to install application into. [default: 16:35:05 INFO - "/builds/slave/test"] 16:35:05 INFO - --app=APP Application being installed. [default: firefox] 16:35:05 INFO - mkdir: /builds/slave/test/build/application 16:35:05 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'] 16:35:05 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 16:35:39 INFO - Reading from file tmpfile_stdout 16:35:39 INFO - Output received: 16:35:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:35:39 INFO - Running post-action listener: _resource_record_post_action 16:35:39 INFO - [mozharness: 2016-08-15 23:35:39.649624Z] Finished install step (success) 16:35:39 INFO - [mozharness: 2016-08-15 23:35:39.649756Z] Running run-tests step. 16:35:39 INFO - Running pre-action listener: _resource_record_pre_action 16:35:39 INFO - Running main action method: run_tests 16:35:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:35:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:35:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:35:39 INFO - 2016-08-15 16:35:39.664 screenresolution[1640:7363] starting screenresolution argv=screenresolution get 16:35:39 INFO - 2016-08-15 16:35:39.667 screenresolution[1640:7363] Display 0: 1600x1200x32@60 16:35:39 INFO - 2016-08-15 16:35:39.672 screenresolution[1641:7365] starting screenresolution argv=screenresolution list 16:35:39 INFO - Available Modes on Display 0 16:35:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:35:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:35:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:35:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:35:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:35:39 INFO - Intel Iris: 16:35:39 INFO - Chipset Model: Intel Iris 16:35:39 INFO - Type: GPU 16:35:39 INFO - Bus: Built-In 16:35:39 INFO - VRAM (Dynamic, Max): 1536 MB 16:35:39 INFO - Vendor: Intel (0x8086) 16:35:39 INFO - Device ID: 0x0a2e 16:35:39 INFO - Revision ID: 0x0009 16:35:39 INFO - Displays: 16:35:39 INFO - Display: 16:35:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:35:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:35:39 INFO - Display Serial Number: 1600x1200 60 16:35:39 INFO - Main Display: Yes 16:35:39 INFO - Mirror: Off 16:35:39 INFO - Online: Yes 16:35:39 INFO - Rotation: Supported 16:35:39 INFO - Return code: 0 16:35:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:35:39 INFO - Python 2.7.3 16:35:39 INFO - Return code: 0 16:35:39 INFO - grabbing minidump binary from tooltool 16:35: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')]} 16:35:39 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 0x10d49bd30>, '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 0x10d200db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d493b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:35:39 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 16:35:39 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 16:35:39 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 16:35:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:35:40 INFO - Return code: 0 16:35:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:35:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:35:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:35:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:35:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:35:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 16:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --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 16:35:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVvsuBDlJS/Render', 16:35:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:40 INFO - 'HOME': '/Users/cltbld', 16:35:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:40 INFO - 'LOGNAME': 'cltbld', 16:35:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:35:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:40 INFO - 'MOZ_NO_REMOTE': '1', 16:35:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:35:40 INFO - 'NO_EM_RESTART': '1', 16:35:40 INFO - 'PAGER': '/bin/cat', 16:35:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:40 INFO - 'PWD': '/builds/slave/test', 16:35:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:35:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:40 INFO - 'SHELL': '/bin/bash', 16:35:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QPpY8Pj1KG/Listeners', 16:35:40 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 16:35:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:40 INFO - 'USER': 'cltbld', 16:35:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:40 INFO - 'XPC_FLAGS': '0x0', 16:35:40 INFO - 'XPC_SERVICE_NAME': '0', 16:35:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 16:35:40 INFO - mozversion application_buildid: 20160815124529 16:35:40 INFO - mozversion application_changeset: dbb9da97e0e1c021314baf7de44f82fd4a74058d 16:35:40 INFO - mozversion application_display_name: Nightly 16:35:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:35:40 INFO - mozversion application_name: Firefox 16:35:40 INFO - mozversion application_remotingname: firefox 16:35:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:35:40 INFO - mozversion application_vendor: Mozilla 16:35:40 INFO - mozversion application_version: 51.0a1 16:35:40 INFO - mozversion platform_buildid: 20160815124529 16:35:40 INFO - mozversion platform_changeset: dbb9da97e0e1c021314baf7de44f82fd4a74058d 16:35:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:35:40 INFO - mozversion platform_version: 51.0a1 16:35:40 INFO - using testdate: 1471304140 16:35:40 INFO - actual date: 1471304140 16:35:40 INFO - starting webserver on 'localhost:49274' 16:35:40 INFO - SUITE-START | Running 2 tests 16:35:40 INFO - TEST-START | dromaeo_css 16:35:40 INFO - operating with platform_type : mac_ 16:35:40 INFO - Initialising browser for dromaeo_css test... 16:35:40 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpoL_szD/profile http://localhost:49274/getInfo.html) 16:35:43 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 16:35:43 INFO - PROCESS | 1651 | colorDepth:24 16:35:43 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 16:35:43 INFO - PROCESS | 1651 | __metrics 16:35:43 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 16:35:43 INFO - TEST-INFO | 1651: exit 0 16:35:43 INFO - Browser initialized. 16:35:43 INFO - Running cycle 1/1 for dromaeo_css test... 16:35:43 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpoL_szD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:35:56 INFO - PROCESS | 1654 | RSS: Main: 239693824 16:35:56 INFO - PROCESS | 1654 | 16:36:45 INFO - PROCESS | 1654 | 1471304205650 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] 16:38:57 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 16:38:59 INFO - PROCESS | 1654 | RSS: Main: 256573440 16:38:59 INFO - PROCESS | 1654 | 16:42:01 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 16:42:02 INFO - PROCESS | 1654 | RSS: Main: 266928128 16:42:02 INFO - PROCESS | 1654 | 16:45:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 16:45:04 INFO - PROCESS | 1654 | RSS: Main: 272596992 16:45:04 INFO - PROCESS | 1654 | 16:48:06 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 16:48:07 INFO - PROCESS | 1654 | RSS: Main: 272076800 16:48:07 INFO - PROCESS | 1654 | 16:51:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 16:51:10 INFO - PROCESS | 1654 | RSS: Main: 277258240 16:51:10 INFO - PROCESS | 1654 | 16:54:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 16:54:13 INFO - PROCESS | 1654 | RSS: Main: 279941120 16:54:13 INFO - PROCESS | 1654 | 16:54:13 INFO - PROCESS | 1654 | __start_tp_report 16:54:13 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 16:54:13 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 16:54:13 INFO - PROCESS | 1654 | |i|pagename|runs| 16:54:13 INFO - PROCESS | 1654 | |0;dojo.html;3364.6635336466347;3424.691777740003;3448.293099914518;3461.601915779686;3491.266833964867;5723.227364305828;5840.269966254218;5853.912191317128;5854.677992710399;5975.790847320344;4838.588719958799;5510.512161716334;5823.097419899912;5884.235049443577;5990.460858522732;4230.534641189467;4362.432883725127;4711.481737008935;4917.278952366679;5339.06566350889;5440.591955603326;5479.068558345091;5485.6434331768305;5497.697626630534;5511.311086114236;5255.106631872591;5281.973590132025;5360.731963401853;5368.731563421833;5377.838664840061;4381.693281470267;5368.62419630626;5370.785168593252;5384.1923711443205;5462.426445223274;4117.56765539617;5283.920741188886;5334.146536554172;5356.062689029404;5383.327084114486;4758.381410416624;5528.170774383834;5902.203202567642;5930.1401296812155;5932.911006334865;6237.656928868911;6272.40412160844;6299.464545513637;6319.8104056878365;6320.525960552977;6319;6336;6347.5556711029785;6351.396617321347;6368.840778980562;5375.81184658535;5966.731497082642;5971.193888824953;5976.641401515923;6006.189164462785;6377.808665740035;6388.5528013039575;6389.9361006389345;6404.839879002969;6413.518986076063;6172.722227499684;6241.594296370721;6242.1261023456755;6247.312795592481;6261.373862613702;5185.714785686748;6145.770845830852;6172.074188871705;6175.104609831549;6289.433950944437;6131.132004888217;6145.723442445101;6192.845178870564;6215.192025036717;6292.716827742671;6200;6214.564980451415;6223.719932603044;6251;6251.187345645128;4986.4514903360605;5068.847934561969;5103.311053007871;5137.101007323703;5139.743012849417;4534.138513682456;4543.5910768031035;4567.10941366437;4634.23535116702;4637.049404871993;5864.413558644102;5877.706114694248;5931;5938.673372964442;5960.1059841023325;6223.657698826518;6231.75072997075;6291.150694656254;6291.528135389773;6296.150019747367;5877.764889404376;5911.142884281755;5942.197803296586;5960.642361458326;5975.820725378246;5519.724013799294;5526.088195447706;5529.751161197756;5537.667739935617;5567.638103523258;6274.811755647338;6335.1447554579545;6443.001334793114;6453.870922581522;6486.156799616019;5921.61509501881;6175.104609831459;6289.465395441439;6290.308066112815;6321.49428045746;4954.529319714621;5285.788568457218;6420;6449.6130232186215;6486.805395838132;5800.912986305125;6149.016157414792;6204.317525072148;6225.346338634378;6292.11910332563;5861.208736820475;6228.22147231596;6287.088372186099;6300.1809764732125;6306.400891915261;4977.751112444291;5302.681839089667;6257.8748425030335;6261.592996455216;6280.434760871543;6115.301188035945;6144.938550614615;6239.532035097295;6260.373962603885;6266.937330626635;4562.338460923082;5059.898802024012;5647.745851436777;5654.660720356792;6115.149072927182;6171.814845554641;6236.18929539157;6258.217722784652;6279.71741271653;6310.968445157745;6029.75880964774;6078.54410919174;6083.300420451527;6196.194494715658;6215.751369945152 16:54:13 INFO - PROCESS | 1654 | |1;ext.html;449.79534311888085;477.11018949658876;481.6820898207182;545.6480570032329;545.6480570032331;37138.44292335617;39421.80289098558;39629.60370396295;39642.008949776195;39677.60322396779;40634.390484142765;40748.79625601868;41012.794936025355;41065;41114;9576.76058098548;9768.853467197998;9775.608975640966;9791.755206119868;9807.558659860324;8697.47815131091;9704.41773493589;9796.90203097967;9807.362521436084;9811.166050885684;9811.558479868387;9812.950935245313;9839.114479696826;9842.90157098427;9846;9745.31782775206;9767.120959113643;9770.951145244228;9809.362391444532;9817.214622830228;9626.326157169002;9721.562529686182;9728.17310528606;9733.707988760349;9745.269104817167;38391.8080409599;38650.80674596637;38689.22621547553;38874.8337549874;38891.61108388908;2609.699884513267;3198.18446296193;3251.788633738823;3439.673231043047;3441.1225137590004;28577;29901;30142;30315;31247.062588122164;2994.3412449261127;3034.2111051126644;3037.711417415342;3048.5122380419025;3161.7944833585743;444272;446073;449888;450026;450991;27864.442711145664;32389.352212955608;32568.02295931126;32599.51100733491;32694.509582356284;33611.495827562605;33679.83160084233;33861.830690846386;34141.65858341435;35382.29235415329;14063.789043164361;16518.587035324214;16635.41776037833;16684.998900066035;16701.415450459175;12686.746265074831;12751.681207969876;12756.61730148097;12859.16415432994;12886.871131288568;14857.108573485626;18282.725759113622;18302.725459118123;18317.17572709231;18370.08149592515;7746.845063098819;7893.329067029252;7917.802054948673;7932.206779322021;7957.164497727771;806.4717609965483;806.8063664720424;900.3877363392955;941.6374695742052;979.3291595257272;25469;29895.850520747692;30168;30205.69794302029;30603;903.6475774447971;924.2559739409705;999.480270259461;1011.6712068577742;1022.4121130350078;14562.053466524641;15102.773458398133;15288;15460.763138948858;15987.040777553384;519084;666293;667077;668078;668511;53425.46574534283;53719;53797.92404151895;54116.45883541114;54390.728046359516;1231.7167051578008;1267.3663168415792;1309.5220244610648;1313.6059182245288;1313.947442102305;28249.57625635658;29105.417891641624;29123.708762912098;29675.406491870475;29804.552931706476;49426.350388681116;50001;50021;50050.74974625104;50097.49902500928;596587;601090;603813;604371.9781401065;604451;25427;25484.617730733684;25654.743452565235;25769.355766105997;25785.484290314464;44009;44442.333365000195;44508.554914451735;45760.54239457563;45780;34751.826240868635;37091.6290837099;37653.81173094117;37691.81154094212;38512.22975540529;36726.63273367339;37129.071773205884;37227.813860930524;38212.808935955145;38257.04357391087;36168.45747313845;36630.26739465249;36989;37224.441633374976;37435.812820935724;28913.627025108464;30904.845475772476;33509.497357540145;33669.49495757517;34307.79922702693;24692.753072469044;24912.750872491768;24925.96717087238;25262.115825946003;25316.240512784647 16:54:13 INFO - PROCESS | 1654 | |2;jquery.html;368.4031868373236;376.8831662184721;380.0839975658663;380.9865757086151;398.11220977220796;19355.516112097204;20709.275175368864;21271.787282127174;21400.57198856022;21451.67822482662;18931.62136757264;19665.213391464324;19786.010699465005;21127.366179014654;21142.471438214052;5706.3437704663875;5922.822315330536;6004.369541198177;6082.96958515209;6139.693015349237;5775.422457754233;6064.211652485193;6092.543059270551;6105.267367915856;6107.297660769024;6139.293981192153;6147.4159954804445;6172.043333283348;6195.039768835838;6357.396047375492;6516.771912983023;6716.361945615183;6752.155980502437;6783.4912381571085;6813.386795188432;5743.798967036134;5760.6255593386295;5940.168376427304;5953.404659534055;5968.4031596840405;13014.674633134247;15985.600359990976;16883;24972.3756906077;25939.22182334533;2260.762619924917;2299.9655005174936;2300.5168914527967;2317;2337.836351455399;8998.280137588978;10175.440350780704;13352.806175672871;13827.930860345634;15394.384224631001;1793.6054068104995;1800.6668766278149;1805.494461550768;1856.5544269375252;1882.1624377152173;101111;111889;113727;118381.40809295984;119268.40365798115;8123.878141827878;9236.5843537041;11098.61154859576;11288.830667539993;11639.76720465586;11472.369019703996;11615.883841161649;14166.433342666383;14194.85805141956;14296.928515357356;7110;8475.618597163142;8526.701565445179;8636.265917397091;8661.256291182583;8429.199226073513;8437.198466145706;8681.782955426164;8844.204021638083;8887.466751994902;4398.868033958986;4505.61702255312;4517.593416592523;4547.681662283609;4593.885152871205;1872.6348362069539;1901.096978934995;1933.9709904351164;1966.695162249825;1992.272820420565;806.2743530822189;922.4142669404977;938.9295802814817;943.033390774448;978.188103873783;20726.792732072787;21513.247036353652;21549.46126346854;21674.891625542088;21744.34766956994;863.4430792139161;866.1165611076666;892.6920212526668;914.1818072824784;915.5834095486538;8339.708110216114;9451.385659932082;11055.889441105646;11560.30638161713;11563.88436115628;532171;537733;551649;572977;581915;127503;127747.08379374316;130036.04945925818;131946.34026829997;134022.32988834992;928.7167413938813;946.1342871272846;976.8534719791946;977.9755506112405;979.6424305128577;18189.45431637053;18655.90672046631;18694.34569790051;18985.765925214815;19136.768571102224;50346;54536.63658408572;54990.450095498534;56085.87828243494;56668.43331566631;74828.25171748431;78502.42995140179;78681.4263714711;79273.60363198147;79318;7739.3034626883855;8059.758207253792;8064.35485161174;8113.1886811320755;8227.13615070409;10912.508937097691;12721.93639031799;13228.074034817855;13325.400356983766;13331.066825322523;11059.889401105886;11083.279586826831;11120.388378639253;11335.603253886075;11422.885771142182;11098.944505277423;11193.832092518782;11240.325580465198;11432;11529.250598711056;11262.012232446157;11457.369844658624;11492.310461372344;11583.42082895835;11606;8077.394195435249;8135.75592732219;8141.430099893188;8296.419250652396;8333.041700204312;9267.86098208514;10561.63034293796;11011.953864382871;11112.611058612909;11445.885541144815 16:54:13 INFO - PROCESS | 1654 | |3;mootools.html;1391.8468968413476;1519.141684948004;1697.8641708663301;1830.469163942456;1838.4392760208132;7862.213778622135;8396.91603083969;8555.95722021389;8896.37725359225;8927.821443571132;8603.354748393864;8788.340874434427;8808.735737927856;8815.823683526325;8820.985586657536;2310.156792770639;2328.9767102329015;2338.2634470141934;2344.648302754592;2347.9178228762;1976.4070778766384;2385.451346190377;2398.20859116492;2404.0984630763464;2406.9037238510437;2381.535600557892;2382.5234953009467;2382.6306922426966;2396.25716028031;2399.7720216579396;1967.2917749610128;2007.6787713965696;2349.3891588187025;2373.394784330002;2386.725526564441;2355.105060077177;2359.622460406327;2361.1853910400882;2371.1582388252095;2372.7034120734907;8152.510849349058;8215.753527394128;8240.21717936795;8241.876371854427;8250.711225107092;5228.660137091115;5324.813631522917;5391.865203369947;5400.972995135038;5412.864678383033;3279.6884295991845;3470.0804286864;3475.8609655613745;3542.946855797165;3556.5020897074432;1030;1071.6249312740556;1075.639660713662;1080.724415274108;1082.442542090824;11476.254043487146;11546.711332216677;11655.358955257458;11676.883231167665;11685.415729213506;4623.144718227071;4631.791569379386;4823.1800593898415;4845.781939812717;4852.539008794159;8821.558922053871;9044.592993315317;9920.851187232198;9931;9935.503224838729;5327.520523152857;5337.8131765388025;5377.569794416516;5379.67721936685;5383.623146379794;4410.095930334273;4735.266033764772;4891;4932.679375840559;4942.827001054946;3874.1283211277237;3937.5078115235597;3989.740666856645;4015.959840401617;4042.8584999524874;1278.9001458745472;1294.5436384067923;1295.57893684551;1303.7457695749426;1310.3644732304824;810.6352141536214;921.5622579274791;921.949292788903;923.6028507741602;961.0725649747887;4739;5784.971075144597;5849.385814489502;6012.098185272244;6194.101855230966;421.71534214405153;427.4443223809036;445.14976395085876;451.1653441133876;453.11642297519967;3603.657652523006;3845.7115716321387;4022.8189731462153;4095.24238015968;4132.752034877917;8503.574821258911;10657.893421065844;10663.680089597325;10722.41026743521;10738.892611073945;10334.483275836179;10655.733606659896;10666.573337066431;10672.94663526693;10674.62638807638;8004.479708819024;8144.470609410369;8195.057568379712;8207.343412527103;8219.54792486407;5733.197352370588;5769.53843692512;5879.323877754113;5906.114082887601;5961.701914904151;9986.151177150025;10014.248931330034;10022.198224142197;10035;10061.899381006097;8150.551719655476;10137.18902487814;10252.846207307046;10291.279610427198;10295.07344339013;6891.793246202622;7228.783136505913;7393.408527317694;7466.402687785073;7561.7731468056045;8413.621387037476;8502.574871256289;8504;8511.191436813493;8533.35999800005;7401.000864883172;7461.664225109775;7519.548827070174;7543.886841697269;7655;7333.1200255969625;7373;7395.667194976347;7512.5492470451945;7554.773356799305;6814.965925170342;6946.513744038071;6977.616231107135;6985.1967023790885;6993.720251190099;4943.530364615356;4950.356453661001;5030.0694371541385;5090.007448547498;5100.413452453015;5032.748362581783;5041.6722913010535;5172.275881376535;5182.663126896739;5242.18746094356 16:54:13 INFO - PROCESS | 1654 | |4;prototype.html;269.91092939330036;288.356963970346;300.51616896796156;308.0082135523614;310.10998434492996;4371.715838470497;4794.904101917964;5427.43011983742;5669.036263835148;5687.175359572864;4221.303484924992;4790.329353890458;4962.826301079463;5513.58648101392;5593.720313984295;3844.9810800137984;3900.5904380040115;4212.578742125778;4240.745555266679;4257.914841703164;3761.6050314716836;3821.5414150301863;3875.767453952772;3941.3693808990565;4267.295896177127;4174.248635245654;4192.224438478891;4195.475565554306;4213.47331583552;4227.915441691164;3472.9131771705784;3526.347625689256;4123.463949686521;4224.45082139323;4232.978835105836;2879.9280017999718;3323.3851737428413;3660.5058317127114;3664.918848939569;3678.319510890494;4734.384530011076;5068.442471328188;5159.484051594848;5358.46415358461;5384.596155288369;4025.9798701006603;4046.9392959105635;4831.637627177941;4840.362002708533;4853.660243782937;5742.0238559445;5852.76588936442;5862.296524417055;5876.794312199053;5911.881762364772;3608.242269123461;3621.818909054563;3865.1496670732395;3926;4051.6150965658217;5633.521150702195;6074.726637301332;6115.908261376083;6162.352952939922;6220.440160385542;3348.4809854472596;3936.6653834424396;3994.6404823566018;3996.4005399189773;4008.8797336079965;3699.5560532736245;3957.2876882160913;4006.358982562776;4022.8735953932946;4033.3143365627916;3933.3903244997073;4701.670883038155;4705.505921878222;4712.458067322234;4744.905101897943;5136.075506408883;5863.296404431496;5916.2013128228;5920.348761636216;5932.2584676915385;1179.6637958182048;1244.589285535771;1299.5639818001162;1359.2456186816214;1369.1990185741254;828.9844939948636;889.973300800977;907.1880666803174;924.3714274293545;931.1479995803763;4779.784909679072;5153.304303918998;5207.531322181022;5328.481382805881;5374.54316383104;4831.95168048322;5699.347189315052;5948.1858033299395;5958.195643588147;5961.880762384728;5017.724025178577;5279.366476022825;5346.385165705916;5346.572274218053;5374.892502150014;2405.6872606561037;2493.314338556875;2503.5869081601695;2619.620155077503;2690.3005218643293;4421.513633500313;4848.757562121879;4885.560299573055;5169.663971841818;5174.861530463292;4662.883427914329;4863.489333619989;5113.948860511422;5128.999845030184;5154.458781827929;4308.41836352101;5090.669106508065;5138.845834624967;5151.471242199031;5152;4308.763018034038;4332.69671123031;4970.4212966663945;5046.949530504795;5096.356105384668;4653.697509661861;4678.461976872703;4865.391826021747;4979.203327467588;4998.925016124834;4597.908041839211;4822.95177048239;4885.511448855086;5190.351206099238;5205.6356055075785;3131.890383836646;3150.4959206526846;3312.7018568328967;3464.8960531184107;3471.3230919970365;4522.954770452254;4555.658325625657;4702.2241330181505;5040.243963405518;5055.418626857959;4830.589399901048;4835.887745818552;4842.523030475739;4844.294115001956;4858.611311095175;4457.888552786077;4540.818367265272;4748.430188377417;4793.352897358812;4827.8551643450755;4216.133029539942;4276.781117381532;4451.599356057841;4567.191177425925;4817.542333478314;4327.701689493202;4362;4371.562843715603;4691.741954192552;4806;4003.1785537580913;4014.578469260802;4774.928376074292;4802.495737947465;4810.518948105301 16:54:13 INFO - PROCESS | 1654 | |5;yui.html;699.8600279944012;700.4431476975803;744.6611791634804;750.1635676221014;804.4208170117521;15141.394344226232;15916.602084947883;16004.839951600481;16012.35950561979;16035.679286414264;14497.130172189676;14604.561863144096;14619;14638.926805365985;14655;664.7772996046306;820.7865954851736;823.5964377455034;852.1478521478522;861.1861790607878;833.2708879730236;850.2560259772699;850.5577099908044;851.6891334662835;855.9229669329759;904.3895370624834;905.2531661379388;906.8821053263066;909.0999910088997;909.4452384045727;883.0639522106587;896.3725392225435;899.7525680437932;900.3922352412161;900.4327273817486;666.8532922756985;668.2849351194224;668.84616538196;673.8820706376365;673.9764108256237;12529.686757831036;14874.925625371912;15065.548033559011;15082.170480623561;15085.47200847965;14537.854621453756;14660.120392776467;14697.70604587913;14727;14861.628459288497;11980.400979950968;12167.269963802111;12374.81437778434;12416.75166496665;12607.936960315232;3856.8842934712;3864.3816989281863;4052.959470405288;4085.7140000199997;4091.713580049398;109057;110569.89430105676;110785.44607276993;110958;111090;10815;11285.830712539318;11319.377434241196;11339.092872570174;11790.882091178979;23095.307140785466;23362;23365.88317058404;23383.947722352535;23413.76586234116;8197.877031844528;8277.130901255401;8296.917030829734;8304.128066553047;8410.663573456994;4511.870456970267;4558.270676691714;4563.840265590688;4579.564941330635;4731.219348807477;3597.3165098631175;3692.833822477995;3703.4629978653484;3720.255948810249;3723.590405055442;584.9093390524475;595.6039233909488;703.8627467643863;718.4503854551273;726.9345758881726;526.8524813052352;527.5753018819887;597.3041406761162;677.678102901118;681.6046692918096;9642.71071867845;9724.659636912675;9803.950980245196;9833.280025587757;9875.259355548218;521.8564894653924;569.2173261765073;609.8321713917798;638.5466318913531;690.8255964859658;4251.277282861921;4526.275795872644;4746.691465054761;4800.855974320776;4805.687630304019;148828.76756848657;154845.22577387042;158259;158589;162603.7479250432;130405.34797325953;131699;134058.32970835082;135610;135703;83682;111113;113222;113790.43104784423;114273.4286328563;8901.73294801157;8965.462072275684;8968.910310896808;9174.862377064215;9180.357374983687;43050.569494304655;46056;57479.712601436724;60189.69905150446;60250.39749602448;47526.49470105924;62336;62761;82405.17594823975;86548.5672571633;10664.84002739944;11849.940750296193;12038.699032524257;12097.81853272184;12433.751324973631;13170;13433.782157852369;13546.390412431661;13755.037147399586;14081.155130692192;12653.74692506163;12810.935945320214;12995.220286782824;13195.80206296887;13212.339383031001;12595.68510787201;12773.936130319289;13130.212187268795;13141.73716525645;13179.802302965654;12345.691357716129;12371.381430928597;12385.93807030959;12397;12620.684482888002;10127;10351.43067131315;10401.635942741968;10408.843867341844;10749.140068794633;8175.1007389188335;10595.09941654968;10613.575456981634;10763.946180269362;10775.6228532001 16:54:13 INFO - PROCESS | 1654 | __end_tp_report 16:54:13 INFO - PROCESS | 1654 | __start_cc_report 16:54:13 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,411 16:54:13 INFO - PROCESS | 1654 | __end_cc_report 16:54:13 INFO - PROCESS | 1654 | __startTimestamp1471305253609__endTimestamp 16:54:13 INFO - PROCESS | 1654 | 16:54:13 INFO - PROCESS | 1654 | ------- Summary: start ------- 16:54:13 INFO - PROCESS | 1654 | Number of tests: 6 16:54:13 INFO - PROCESS | 1654 | 16:54:13 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5752.43 Median:5975.79 stddev:686.91 (11.5%) stddev-sans-first:662.99 16:54:13 INFO - PROCESS | 1654 | Values: 3364.7 3424.7 3448.3 3461.6 3491.3 5723.2 5840.3 5853.9 5854.7 5975.8 4838.6 5510.5 5823.1 5884.2 5990.5 4230.5 4362.4 4711.5 4917.3 5339.1 5440.6 5479.1 5485.6 5497.7 5511.3 5255.1 5282.0 5360.7 5368.7 5377.8 4381.7 5368.6 5370.8 5384.2 5462.4 4117.6 5283.9 5334.1 5356.1 5383.3 4758.4 5528.2 5902.2 5930.1 5932.9 6237.7 6272.4 6299.5 6319.8 6320.5 6319.0 6336.0 6347.6 6351.4 6368.8 5375.8 5966.7 5971.2 5976.6 6006.2 6377.8 6388.6 6389.9 6404.8 6413.5 6172.7 6241.6 6242.1 6247.3 6261.4 5185.7 6145.8 6172.1 6175.1 6289.4 6131.1 6145.7 6192.8 6215.2 6292.7 6200.0 6214.6 6223.7 6251.0 6251.2 4986.5 5068.8 5103.3 5137.1 5139.7 4534.1 4543.6 4567.1 4634.2 4637.0 5864.4 5877.7 5931.0 5938.7 5960.1 6223.7 6231.8 6291.2 6291.5 6296.2 5877.8 5911.1 5942.2 5960.6 5975.8 5519.7 5526.1 5529.8 5537.7 5567.6 6274.8 6335.1 6443.0 6453.9 6486.2 5921.6 6175.1 6289.5 6290.3 6321.5 4954.5 5285.8 6420.0 6449.6 6486.8 5800.9 6149.0 6204.3 6225.3 6292.1 5861.2 6228.2 6287.1 6300.2 6306.4 4977.8 5302.7 6257.9 6261.6 6280.4 6115.3 6144.9 6239.5 6260.4 6266.9 4562.3 5059.9 5647.7 5654.7 6115.1 6171.8 6236.2 6258.2 6279.7 6311.0 6029.8 6078.5 6083.3 6196.2 6215.8 16:54:13 INFO - PROCESS | 1654 | 16:54:13 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:67568.76 Median:38234.93 stddev:152657.49 (399.3%) stddev-sans-first:153002.55 16:54:13 INFO - PROCESS | 1654 | Values: 449.8 477.1 481.7 545.6 545.6 37138.4 39421.8 39629.6 39642.0 39677.6 40634.4 40748.8 41012.8 41065.0 41114.0 9576.8 9768.9 9775.6 9791.8 9807.6 8697.5 9704.4 9796.9 9807.4 9811.2 9811.6 9813.0 9839.1 9842.9 9846.0 9745.3 9767.1 9771.0 9809.4 9817.2 9626.3 9721.6 9728.2 9733.7 9745.3 38391.8 38650.8 38689.2 38874.8 38891.6 2609.7 3198.2 3251.8 3439.7 3441.1 28577.0 29901.0 30142.0 30315.0 31247.1 2994.3 3034.2 3037.7 3048.5 3161.8 444272.0 446073.0 449888.0 450026.0 450991.0 27864.4 32389.4 32568.0 32599.5 32694.5 33611.5 33679.8 33861.8 34141.7 35382.3 14063.8 16518.6 16635.4 16685.0 16701.4 12686.7 12751.7 12756.6 12859.2 12886.9 14857.1 18282.7 18302.7 18317.2 18370.1 7746.8 7893.3 7917.8 7932.2 7957.2 806.5 806.8 900.4 941.6 979.3 25469.0 29895.9 30168.0 30205.7 30603.0 903.6 924.3 999.5 1011.7 1022.4 14562.1 15102.8 15288.0 15460.8 15987.0 519084.0 666293.0 667077.0 668078.0 668511.0 53425.5 53719.0 53797.9 54116.5 54390.7 1231.7 1267.4 1309.5 1313.6 1313.9 28249.6 29105.4 29123.7 29675.4 29804.6 49426.4 50001.0 50021.0 50050.7 50097.5 596587.0 601090.0 603813.0 604372.0 604451.0 25427.0 25484.6 25654.7 25769.4 25785.5 44009.0 44442.3 44508.6 45760.5 45780.0 34751.8 37091.6 37653.8 37691.8 38512.2 36726.6 37129.1 37227.8 38212.8 38257.0 36168.5 36630.3 36989.0 37224.4 37435.8 28913.6 30904.8 33509.5 33669.5 34307.8 24692.8 24912.8 24926.0 25262.1 25316.2 16:54:13 INFO - PROCESS | 1654 | 16:54:13 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:33688.80 Median:378.48 stddev:93125.18 (24604.8%) stddev-sans-first:93352.82 16:54:13 INFO - PROCESS | 1654 | Values: 368.4 376.9 380.1 381.0 398.1 19355.5 20709.3 21271.8 21400.6 21451.7 18931.6 19665.2 19786.0 21127.4 21142.5 5706.3 5922.8 6004.4 6083.0 6139.7 5775.4 6064.2 6092.5 6105.3 6107.3 6139.3 6147.4 6172.0 6195.0 6357.4 6516.8 6716.4 6752.2 6783.5 6813.4 5743.8 5760.6 5940.2 5953.4 5968.4 13014.7 15985.6 16883.0 24972.4 25939.2 2260.8 2300.0 2300.5 2317.0 2337.8 8998.3 10175.4 13352.8 13827.9 15394.4 1793.6 1800.7 1805.5 1856.6 1882.2 101111.0 111889.0 113727.0 118381.4 119268.4 8123.9 9236.6 11098.6 11288.8 11639.8 11472.4 11615.9 14166.4 14194.9 14296.9 7110.0 8475.6 8526.7 8636.3 8661.3 8429.2 8437.2 8681.8 8844.2 8887.5 4398.9 4505.6 4517.6 4547.7 4593.9 1872.6 1901.1 1934.0 1966.7 1992.3 806.3 922.4 938.9 943.0 978.2 20726.8 21513.2 21549.5 21674.9 21744.3 863.4 866.1 892.7 914.2 915.6 8339.7 9451.4 11055.9 11560.3 11563.9 532171.0 537733.0 551649.0 572977.0 581915.0 127503.0 127747.1 130036.0 131946.3 134022.3 928.7 946.1 976.9 978.0 979.6 18189.5 18655.9 18694.3 18985.8 19136.8 50346.0 54536.6 54990.5 56085.9 56668.4 74828.3 78502.4 78681.4 79273.6 79318.0 7739.3 8059.8 8064.4 8113.2 8227.1 10912.5 12721.9 13228.1 13325.4 13331.1 11059.9 11083.3 11120.4 11335.6 11422.9 11098.9 11193.8 11240.3 11432.0 11529.3 11262.0 11457.4 11492.3 11583.4 11606.0 8077.4 8135.8 8141.4 8296.4 8333.0 9267.9 10561.6 11012.0 11112.6 11445.9 16:54:13 INFO - PROCESS | 1654 | 16:54:13 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5654.09 Median:4911.84 stddev:3167.58 (64.5%) stddev-sans-first:3160.27 16:54:13 INFO - PROCESS | 1654 | Values: 1391.8 1519.1 1697.9 1830.5 1838.4 7862.2 8396.9 8556.0 8896.4 8927.8 8603.4 8788.3 8808.7 8815.8 8821.0 2310.2 2329.0 2338.3 2344.6 2347.9 1976.4 2385.5 2398.2 2404.1 2406.9 2381.5 2382.5 2382.6 2396.3 2399.8 1967.3 2007.7 2349.4 2373.4 2386.7 2355.1 2359.6 2361.2 2371.2 2372.7 8152.5 8215.8 8240.2 8241.9 8250.7 5228.7 5324.8 5391.9 5401.0 5412.9 3279.7 3470.1 3475.9 3542.9 3556.5 1030.0 1071.6 1075.6 1080.7 1082.4 11476.3 11546.7 11655.4 11676.9 11685.4 4623.1 4631.8 4823.2 4845.8 4852.5 8821.6 9044.6 9920.9 9931.0 9935.5 5327.5 5337.8 5377.6 5379.7 5383.6 4410.1 4735.3 4891.0 4932.7 4942.8 3874.1 3937.5 3989.7 4016.0 4042.9 1278.9 1294.5 1295.6 1303.7 1310.4 810.6 921.6 921.9 923.6 961.1 4739.0 5785.0 5849.4 6012.1 6194.1 421.7 427.4 445.1 451.2 453.1 3603.7 3845.7 4022.8 4095.2 4132.8 8503.6 10657.9 10663.7 10722.4 10738.9 10334.5 10655.7 10666.6 10672.9 10674.6 8004.5 8144.5 8195.1 8207.3 8219.5 5733.2 5769.5 5879.3 5906.1 5961.7 9986.2 10014.2 10022.2 10035.0 10061.9 8150.6 10137.2 10252.8 10291.3 10295.1 6891.8 7228.8 7393.4 7466.4 7561.8 8413.6 8502.6 8504.0 8511.2 8533.4 7401.0 7461.7 7519.5 7543.9 7655.0 7333.1 7373.0 7395.7 7512.5 7554.8 6815.0 6946.5 6977.6 6985.2 6993.7 4943.5 4950.4 5030.1 5090.0 5100.4 5032.7 5041.7 5172.3 5182.7 5242.2 16:54:13 INFO - PROCESS | 1654 | 16:54:13 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4301.44 Median:4723.42 stddev:1305.27 (27.6%) stddev-sans-first:1273.38 16:54:13 INFO - PROCESS | 1654 | Values: 269.9 288.4 300.5 308.0 310.1 4371.7 4794.9 5427.4 5669.0 5687.2 4221.3 4790.3 4962.8 5513.6 5593.7 3845.0 3900.6 4212.6 4240.7 4257.9 3761.6 3821.5 3875.8 3941.4 4267.3 4174.2 4192.2 4195.5 4213.5 4227.9 3472.9 3526.3 4123.5 4224.5 4233.0 2879.9 3323.4 3660.5 3664.9 3678.3 4734.4 5068.4 5159.5 5358.5 5384.6 4026.0 4046.9 4831.6 4840.4 4853.7 5742.0 5852.8 5862.3 5876.8 5911.9 3608.2 3621.8 3865.1 3926.0 4051.6 5633.5 6074.7 6115.9 6162.4 6220.4 3348.5 3936.7 3994.6 3996.4 4008.9 3699.6 3957.3 4006.4 4022.9 4033.3 3933.4 4701.7 4705.5 4712.5 4744.9 5136.1 5863.3 5916.2 5920.3 5932.3 1179.7 1244.6 1299.6 1359.2 1369.2 829.0 890.0 907.2 924.4 931.1 4779.8 5153.3 5207.5 5328.5 5374.5 4832.0 5699.3 5948.2 5958.2 5961.9 5017.7 5279.4 5346.4 5346.6 5374.9 2405.7 2493.3 2503.6 2619.6 2690.3 4421.5 4848.8 4885.6 5169.7 5174.9 4662.9 4863.5 5113.9 5129.0 5154.5 4308.4 5090.7 5138.8 5151.5 5152.0 4308.8 4332.7 4970.4 5046.9 5096.4 4653.7 4678.5 4865.4 4979.2 4998.9 4597.9 4823.0 4885.5 5190.4 5205.6 3131.9 3150.5 3312.7 3464.9 3471.3 4523.0 4555.7 4702.2 5040.2 5055.4 4830.6 4835.9 4842.5 4844.3 4858.6 4457.9 4540.8 4748.4 4793.4 4827.9 4216.1 4276.8 4451.6 4567.2 4817.5 4327.7 4362.0 4371.6 4691.7 4806.0 4003.2 4014.6 4774.9 4802.5 4810.5 16:54:13 INFO - PROCESS | 1654 | 16:54:13 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:24201.55 Median:3711.86 stddev:39544.64 (1065.4%) stddev-sans-first:39616.20 16:54:13 INFO - PROCESS | 1654 | Values: 699.9 700.4 744.7 750.2 804.4 15141.4 15916.6 16004.8 16012.4 16035.7 14497.1 14604.6 14619.0 14638.9 14655.0 664.8 820.8 823.6 852.1 861.2 833.3 850.3 850.6 851.7 855.9 904.4 905.3 906.9 909.1 909.4 883.1 896.4 899.8 900.4 900.4 666.9 668.3 668.8 673.9 674.0 12529.7 14874.9 15065.5 15082.2 15085.5 14537.9 14660.1 14697.7 14727.0 14861.6 11980.4 12167.3 12374.8 12416.8 12607.9 3856.9 3864.4 4053.0 4085.7 4091.7 109057.0 110569.9 110785.4 110958.0 111090.0 10815.0 11285.8 11319.4 11339.1 11790.9 23095.3 23362.0 23365.9 23383.9 23413.8 8197.9 8277.1 8296.9 8304.1 8410.7 4511.9 4558.3 4563.8 4579.6 4731.2 3597.3 3692.8 3703.5 3720.3 3723.6 584.9 595.6 703.9 718.5 726.9 526.9 527.6 597.3 677.7 681.6 9642.7 9724.7 9804.0 9833.3 9875.3 521.9 569.2 609.8 638.5 690.8 4251.3 4526.3 4746.7 4800.9 4805.7 148828.8 154845.2 158259.0 158589.0 162603.7 130405.3 131699.0 134058.3 135610.0 135703.0 83682.0 111113.0 113222.0 113790.4 114273.4 8901.7 8965.5 8968.9 9174.9 9180.4 43050.6 46056.0 57479.7 60189.7 60250.4 47526.5 62336.0 62761.0 82405.2 86548.6 10664.8 11849.9 12038.7 12097.8 12433.8 13170.0 13433.8 13546.4 13755.0 14081.2 12653.7 12810.9 12995.2 13195.8 13212.3 12595.7 12773.9 13130.2 13141.7 13179.8 12345.7 12371.4 12385.9 12397.0 12620.7 10127.0 10351.4 10401.6 10408.8 10749.1 8175.1 10595.1 10613.6 10763.9 10775.6 16:54:13 INFO - PROCESS | 1654 | -------- Summary: end -------- 16:54:13 INFO - PROCESS | 1654 | 16:54:14 INFO - TEST-INFO | 1654: exit 0 16:54:14 INFO - TEST-OK | dromaeo_css | took 1114027ms 16:54:14 INFO - TEST-START | kraken 16:54:14 INFO - operating with platform_type : mac_ 16:54:14 INFO - Initialising browser for kraken test... 16:54:14 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp5WNnfI/profile http://localhost:49274/getInfo.html) 16:54:16 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 16:54:16 INFO - PROCESS | 1665 | colorDepth:24 16:54:16 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 16:54:16 INFO - PROCESS | 1665 | __metrics 16:54:17 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 16:54:17 INFO - TEST-INFO | 1665: exit 0 16:54:17 INFO - Browser initialized. 16:54:17 INFO - Running cycle 1/1 for kraken test... 16:54:17 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp5WNnfI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:54:29 INFO - PROCESS | 1667 | RSS: Main: 239648768 16:54:29 INFO - PROCESS | 1667 | 16:54:32 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 16:54:33 INFO - PROCESS | 1667 | RSS: Main: 252624896 16:54:33 INFO - PROCESS | 1667 | 16:54:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 16:54:36 INFO - PROCESS | 1667 | RSS: Main: 261373952 16:54:36 INFO - PROCESS | 1667 | 16:54:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 16:54:41 INFO - PROCESS | 1667 | RSS: Main: 264146944 16:54:41 INFO - PROCESS | 1667 | 16:54:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 16:54:43 INFO - PROCESS | 1667 | RSS: Main: 265621504 16:54:43 INFO - PROCESS | 1667 | 16:54:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:54:46 INFO - PROCESS | 1667 | RSS: Main: 267313152 16:54:46 INFO - PROCESS | 1667 | 16:54:49 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 16:54:50 INFO - PROCESS | 1667 | RSS: Main: 267386880 16:54:50 INFO - PROCESS | 1667 | 16:54:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 16:54:53 INFO - PROCESS | 1667 | RSS: Main: 267603968 16:54:53 INFO - PROCESS | 1667 | 16:54:56 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 16:54:57 INFO - PROCESS | 1667 | RSS: Main: 267735040 16:54:57 INFO - PROCESS | 1667 | 16:54:58 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:54:59 INFO - PROCESS | 1667 | RSS: Main: 267481088 16:54:59 INFO - PROCESS | 1667 | 16:55:01 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:55:02 INFO - PROCESS | 1667 | RSS: Main: 267583488 16:55:02 INFO - PROCESS | 1667 | 16:55:04 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:55:05 INFO - PROCESS | 1667 | RSS: Main: 267882496 16:55:05 INFO - PROCESS | 1667 | 16:55:07 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:55:08 INFO - PROCESS | 1667 | RSS: Main: 268050432 16:55:08 INFO - PROCESS | 1667 | 16:55:11 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:55:12 INFO - PROCESS | 1667 | RSS: Main: 268087296 16:55:12 INFO - PROCESS | 1667 | 16:55:13 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 16:55:14 INFO - PROCESS | 1667 | RSS: Main: 268943360 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | __start_tp_report 16:55:14 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 16:55:14 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 16:55:14 INFO - PROCESS | 1667 | |i|pagename|runs| 16:55:14 INFO - PROCESS | 1667 | |0;ai-astar;109;118;111;121;117;118;115;155;171;149 16:55:14 INFO - PROCESS | 1667 | |1;audio-beat-detection;142;113;130;158;115;134;135;142;159;113 16:55:14 INFO - PROCESS | 1667 | |2;audio-dft;215;190;244;278;274;198;197;200;225;197 16:55:14 INFO - PROCESS | 1667 | |3;audio-fft;70;102;68;155;53;84;81;82;159;58 16:55:14 INFO - PROCESS | 1667 | |4;audio-oscillator;81;95;163;84;70;89;114;72;73;115 16:55:14 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;90;76;134;85;99;84;89;85;88;86 16:55:14 INFO - PROCESS | 1667 | |6;imaging-darkroom;96;95;95;98;96;95;95;97;95;95 16:55:14 INFO - PROCESS | 1667 | |7;imaging-desaturate;114;145;78;149;141;92;112;90;91;91 16:55:14 INFO - PROCESS | 1667 | |8;json-parse-financial;53;58;58;59;53;54;66;54;55;59 16:55:14 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;65;102;70;87;62;83;70;58;81;101 16:55:14 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;90;90;98;81;87;86;88;83;86;88 16:55:14 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;138;143;133;124;159;159;148;131;178;155 16:55:14 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;175;174;179;175;174;173;175;174;160;194 16:55:14 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;69;71;67;69;64;90;87;87;89;91 16:55:14 INFO - PROCESS | 1667 | __end_tp_report 16:55:14 INFO - PROCESS | 1667 | __start_cc_report 16:55:14 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1042 16:55:14 INFO - PROCESS | 1667 | __end_cc_report 16:55:14 INFO - PROCESS | 1667 | __startTimestamp1471305314195__endTimestamp 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | ------- Summary: start ------- 16:55:14 INFO - PROCESS | 1667 | Number of tests: 14 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:128.40 Median:119.50 stddev:21.62 (18.1%) stddev-sans-first:21.76 16:55:14 INFO - PROCESS | 1667 | Values: 109.0 118.0 111.0 121.0 117.0 118.0 115.0 155.0 171.0 149.0 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:138.50 stddev:16.96 (12.2%) stddev-sans-first:17.75 16:55:14 INFO - PROCESS | 1667 | Values: 142.0 113.0 130.0 158.0 115.0 134.0 135.0 142.0 159.0 113.0 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:221.80 Median:220.00 stddev:32.86 (14.9%) stddev-sans-first:34.76 16:55:14 INFO - PROCESS | 1667 | Values: 215.0 190.0 244.0 278.0 274.0 198.0 197.0 200.0 225.0 197.0 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:91.20 Median:69.00 stddev:37.38 (54.2%) stddev-sans-first:38.85 16:55:14 INFO - PROCESS | 1667 | Values: 70.0 102.0 68.0 155.0 53.0 84.0 81.0 82.0 159.0 58.0 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:77.00 stddev:28.62 (37.2%) stddev-sans-first:29.87 16:55:14 INFO - PROCESS | 1667 | Values: 81.0 95.0 163.0 84.0 70.0 89.0 114.0 72.0 73.0 115.0 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:91.60 Median:87.00 stddev:15.97 (18.4%) stddev-sans-first:16.92 16:55:14 INFO - PROCESS | 1667 | Values: 90.0 76.0 134.0 85.0 99.0 84.0 89.0 85.0 88.0 86.0 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:95.50 stddev:1.06 (1.1%) stddev-sans-first:1.12 16:55:14 INFO - PROCESS | 1667 | Values: 96.0 95.0 95.0 98.0 96.0 95.0 95.0 97.0 95.0 95.0 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:110.30 Median:84.00 stddev:26.24 (31.2%) stddev-sans-first:27.80 16:55:14 INFO - PROCESS | 1667 | Values: 114.0 145.0 78.0 149.0 141.0 92.0 112.0 90.0 91.0 91.0 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:58.00 stddev:4.01 (6.9%) stddev-sans-first:4.00 16:55:14 INFO - PROCESS | 1667 | Values: 53.0 58.0 58.0 59.0 53.0 54.0 66.0 54.0 55.0 59.0 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:77.90 Median:70.00 stddev:15.54 (22.2%) stddev-sans-first:15.76 16:55:14 INFO - PROCESS | 1667 | Values: 65.0 102.0 70.0 87.0 62.0 83.0 70.0 58.0 81.0 101.0 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:88.00 stddev:4.60 (5.2%) stddev-sans-first:4.80 16:55:14 INFO - PROCESS | 1667 | Values: 90.0 90.0 98.0 81.0 87.0 86.0 88.0 83.0 86.0 88.0 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:151.50 stddev:16.30 (10.8%) stddev-sans-first:16.98 16:55:14 INFO - PROCESS | 1667 | Values: 138.0 143.0 133.0 124.0 159.0 159.0 148.0 131.0 178.0 155.0 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:175.00 stddev:8.22 (4.7%) stddev-sans-first:8.72 16:55:14 INFO - PROCESS | 1667 | Values: 175.0 174.0 179.0 175.0 174.0 173.0 175.0 174.0 160.0 194.0 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.40 Median:87.00 stddev:11.17 (12.8%) stddev-sans-first:11.31 16:55:14 INFO - PROCESS | 1667 | Values: 69.0 71.0 67.0 69.0 64.0 90.0 87.0 87.0 89.0 91.0 16:55:14 INFO - PROCESS | 1667 | -------- Summary: end -------- 16:55:14 INFO - PROCESS | 1667 | 16:55:14 INFO - TEST-INFO | 1667: exit 0 16:55:15 INFO - TEST-OK | kraken | took 60752ms 16:55:15 INFO - SUITE-END | took 1174s 16:55:15 INFO - Completed test suite (00:19:35) 16:55:15 INFO - javascript benchmark 16:55:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7184.109427029955, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3364.6635336466347, 3424.691777740003, 3448.293099914518, 3461.601915779686, 3491.266833964867, 5723.227364305828, 5840.269966254218, 5853.912191317128, 5854.677992710399, 5975.790847320344, 4838.588719958799, 5510.512161716334, 5823.097419899912, 5884.235049443577, 5990.460858522732, 4230.534641189467, 4362.432883725127, 4711.481737008935, 4917.278952366679, 5339.06566350889, 5440.591955603326, 5479.068558345091, 5485.6434331768305, 5497.697626630534, 5511.311086114236, 5255.106631872591, 5281.973590132025, 5360.731963401853, 5368.731563421833, 5377.838664840061, 4381.693281470267, 5368.62419630626, 5370.785168593252, 5384.1923711443205, 5462.426445223274, 4117.56765539617, 5283.920741188886, 5334.146536554172, 5356.062689029404, 5383.327084114486, 4758.381410416624, 5528.170774383834, 5902.203202567642, 5930.1401296812155, 5932.911006334865, 6237.656928868911, 6272.40412160844, 6299.464545513637, 6319.8104056878365, 6320.525960552977, 6319.0, 6336.0, 6347.5556711029785, 6351.396617321347, 6368.840778980562, 5375.81184658535, 5966.731497082642, 5971.193888824953, 5976.641401515923, 6006.189164462785, 6377.808665740035, 6388.5528013039575, 6389.9361006389345, 6404.839879002969, 6413.518986076063, 6172.722227499684, 6241.594296370721, 6242.1261023456755, 6247.312795592481, 6261.373862613702, 5185.714785686748, 6145.770845830852, 6172.074188871705, 6175.104609831549, 6289.433950944437, 6131.132004888217, 6145.723442445101, 6192.845178870564, 6215.192025036717, 6292.716827742671, 6200.0, 6214.564980451415, 6223.719932603044, 6251.0, 6251.187345645128, 4986.4514903360605, 5068.847934561969, 5103.311053007871, 5137.101007323703, 5139.743012849417, 4534.138513682456, 4543.5910768031035, 4567.10941366437, 4634.23535116702, 4637.049404871993, 5864.413558644102, 5877.706114694248, 5931.0, 5938.673372964442, 5960.1059841023325, 6223.657698826518, 6231.75072997075, 6291.150694656254, 6291.528135389773, 6296.150019747367, 5877.764889404376, 5911.142884281755, 5942.197803296586, 5960.642361458326, 5975.820725378246, 5519.724013799294, 5526.088195447706, 5529.751161197756, 5537.667739935617, 5567.638103523258, 6274.811755647338, 6335.1447554579545, 6443.001334793114, 6453.870922581522, 6486.156799616019, 5921.61509501881, 6175.104609831459, 6289.465395441439, 6290.308066112815, 6321.49428045746, 4954.529319714621, 5285.788568457218, 6420.0, 6449.6130232186215, 6486.805395838132, 5800.912986305125, 6149.016157414792, 6204.317525072148, 6225.346338634378, 6292.11910332563, 5861.208736820475, 6228.22147231596, 6287.088372186099, 6300.1809764732125, 6306.400891915261, 4977.751112444291, 5302.681839089667, 6257.8748425030335, 6261.592996455216, 6280.434760871543, 6115.301188035945, 6144.938550614615, 6239.532035097295, 6260.373962603885, 6266.937330626635, 4562.338460923082, 5059.898802024012, 5647.745851436777, 5654.660720356792, 6115.149072927182, 6171.814845554641, 6236.18929539157, 6258.217722784652, 6279.71741271653, 6310.968445157745, 6029.75880964774, 6078.54410919174, 6083.300420451527, 6196.194494715658, 6215.751369945152], "value": 5711.745861368237, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.79534311888085, 477.11018949658876, 481.6820898207182, 545.6480570032329, 545.6480570032331, 37138.44292335617, 39421.80289098558, 39629.60370396295, 39642.008949776195, 39677.60322396779, 40634.390484142765, 40748.79625601868, 41012.794936025355, 41065.0, 41114.0, 9576.76058098548, 9768.853467197998, 9775.608975640966, 9791.755206119868, 9807.558659860324, 8697.47815131091, 9704.41773493589, 9796.90203097967, 9807.362521436084, 9811.166050885684, 9811.558479868387, 9812.950935245313, 9839.114479696826, 9842.90157098427, 9846.0, 9745.31782775206, 9767.120959113643, 9770.951145244228, 9809.362391444532, 9817.214622830228, 9626.326157169002, 9721.562529686182, 9728.17310528606, 9733.707988760349, 9745.269104817167, 38391.8080409599, 38650.80674596637, 38689.22621547553, 38874.8337549874, 38891.61108388908, 2609.699884513267, 3198.18446296193, 3251.788633738823, 3439.673231043047, 3441.1225137590004, 28577.0, 29901.0, 30142.0, 30315.0, 31247.062588122164, 2994.3412449261127, 3034.2111051126644, 3037.711417415342, 3048.5122380419025, 3161.7944833585743, 444272.0, 446073.0, 449888.0, 450026.0, 450991.0, 27864.442711145664, 32389.352212955608, 32568.02295931126, 32599.51100733491, 32694.509582356284, 33611.495827562605, 33679.83160084233, 33861.830690846386, 34141.65858341435, 35382.29235415329, 14063.789043164361, 16518.587035324214, 16635.41776037833, 16684.998900066035, 16701.415450459175, 12686.746265074831, 12751.681207969876, 12756.61730148097, 12859.16415432994, 12886.871131288568, 14857.108573485626, 18282.725759113622, 18302.725459118123, 18317.17572709231, 18370.08149592515, 7746.845063098819, 7893.329067029252, 7917.802054948673, 7932.206779322021, 7957.164497727771, 806.4717609965483, 806.8063664720424, 900.3877363392955, 941.6374695742052, 979.3291595257272, 25469.0, 29895.850520747692, 30168.0, 30205.69794302029, 30603.0, 903.6475774447971, 924.2559739409705, 999.480270259461, 1011.6712068577742, 1022.4121130350078, 14562.053466524641, 15102.773458398133, 15288.0, 15460.763138948858, 15987.040777553384, 519084.0, 666293.0, 667077.0, 668078.0, 668511.0, 53425.46574534283, 53719.0, 53797.92404151895, 54116.45883541114, 54390.728046359516, 1231.7167051578008, 1267.3663168415792, 1309.5220244610648, 1313.6059182245288, 1313.947442102305, 28249.57625635658, 29105.417891641624, 29123.708762912098, 29675.406491870475, 29804.552931706476, 49426.350388681116, 50001.0, 50021.0, 50050.74974625104, 50097.49902500928, 596587.0, 601090.0, 603813.0, 604371.9781401065, 604451.0, 25427.0, 25484.617730733684, 25654.743452565235, 25769.355766105997, 25785.484290314464, 44009.0, 44442.333365000195, 44508.554914451735, 45760.54239457563, 45780.0, 34751.826240868635, 37091.6290837099, 37653.81173094117, 37691.81154094212, 38512.22975540529, 36726.63273367339, 37129.071773205884, 37227.813860930524, 38212.808935955145, 38257.04357391087, 36168.45747313845, 36630.26739465249, 36989.0, 37224.441633374976, 37435.812820935724, 28913.627025108464, 30904.845475772476, 33509.497357540145, 33669.49495757517, 34307.79922702693, 24692.753072469044, 24912.750872491768, 24925.96717087238, 25262.115825946003, 25316.240512784647], "value": 18830.418382191612, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.4031868373236, 376.8831662184721, 380.0839975658663, 380.9865757086151, 398.11220977220796, 19355.516112097204, 20709.275175368864, 21271.787282127174, 21400.57198856022, 21451.67822482662, 18931.62136757264, 19665.213391464324, 19786.010699465005, 21127.366179014654, 21142.471438214052, 5706.3437704663875, 5922.822315330536, 6004.369541198177, 6082.96958515209, 6139.693015349237, 5775.422457754233, 6064.211652485193, 6092.543059270551, 6105.267367915856, 6107.297660769024, 6139.293981192153, 6147.4159954804445, 6172.043333283348, 6195.039768835838, 6357.396047375492, 6516.771912983023, 6716.361945615183, 6752.155980502437, 6783.4912381571085, 6813.386795188432, 5743.798967036134, 5760.6255593386295, 5940.168376427304, 5953.404659534055, 5968.4031596840405, 13014.674633134247, 15985.600359990976, 16883.0, 24972.3756906077, 25939.22182334533, 2260.762619924917, 2299.9655005174936, 2300.5168914527967, 2317.0, 2337.836351455399, 8998.280137588978, 10175.440350780704, 13352.806175672871, 13827.930860345634, 15394.384224631001, 1793.6054068104995, 1800.6668766278149, 1805.494461550768, 1856.5544269375252, 1882.1624377152173, 101111.0, 111889.0, 113727.0, 118381.40809295984, 119268.40365798115, 8123.878141827878, 9236.5843537041, 11098.61154859576, 11288.830667539993, 11639.76720465586, 11472.369019703996, 11615.883841161649, 14166.433342666383, 14194.85805141956, 14296.928515357356, 7110.0, 8475.618597163142, 8526.701565445179, 8636.265917397091, 8661.256291182583, 8429.199226073513, 8437.198466145706, 8681.782955426164, 8844.204021638083, 8887.466751994902, 4398.868033958986, 4505.61702255312, 4517.593416592523, 4547.681662283609, 4593.885152871205, 1872.6348362069539, 1901.096978934995, 1933.9709904351164, 1966.695162249825, 1992.272820420565, 806.2743530822189, 922.4142669404977, 938.9295802814817, 943.033390774448, 978.188103873783, 20726.792732072787, 21513.247036353652, 21549.46126346854, 21674.891625542088, 21744.34766956994, 863.4430792139161, 866.1165611076666, 892.6920212526668, 914.1818072824784, 915.5834095486538, 8339.708110216114, 9451.385659932082, 11055.889441105646, 11560.30638161713, 11563.88436115628, 532171.0, 537733.0, 551649.0, 572977.0, 581915.0, 127503.0, 127747.08379374316, 130036.04945925818, 131946.34026829997, 134022.32988834992, 928.7167413938813, 946.1342871272846, 976.8534719791946, 977.9755506112405, 979.6424305128577, 18189.45431637053, 18655.90672046631, 18694.34569790051, 18985.765925214815, 19136.768571102224, 50346.0, 54536.63658408572, 54990.450095498534, 56085.87828243494, 56668.43331566631, 74828.25171748431, 78502.42995140179, 78681.4263714711, 79273.60363198147, 79318.0, 7739.3034626883855, 8059.758207253792, 8064.35485161174, 8113.1886811320755, 8227.13615070409, 10912.508937097691, 12721.93639031799, 13228.074034817855, 13325.400356983766, 13331.066825322523, 11059.889401105886, 11083.279586826831, 11120.388378639253, 11335.603253886075, 11422.885771142182, 11098.944505277423, 11193.832092518782, 11240.325580465198, 11432.0, 11529.250598711056, 11262.012232446157, 11457.369844658624, 11492.310461372344, 11583.42082895835, 11606.0, 8077.394195435249, 8135.75592732219, 8141.430099893188, 8296.419250652396, 8333.041700204312, 9267.86098208514, 10561.63034293796, 11011.953864382871, 11112.611058612909, 11445.885541144815], "value": 9532.843779799303, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.8468968413476, 1519.141684948004, 1697.8641708663301, 1830.469163942456, 1838.4392760208132, 7862.213778622135, 8396.91603083969, 8555.95722021389, 8896.37725359225, 8927.821443571132, 8603.354748393864, 8788.340874434427, 8808.735737927856, 8815.823683526325, 8820.985586657536, 2310.156792770639, 2328.9767102329015, 2338.2634470141934, 2344.648302754592, 2347.9178228762, 1976.4070778766384, 2385.451346190377, 2398.20859116492, 2404.0984630763464, 2406.9037238510437, 2381.535600557892, 2382.5234953009467, 2382.6306922426966, 2396.25716028031, 2399.7720216579396, 1967.2917749610128, 2007.6787713965696, 2349.3891588187025, 2373.394784330002, 2386.725526564441, 2355.105060077177, 2359.622460406327, 2361.1853910400882, 2371.1582388252095, 2372.7034120734907, 8152.510849349058, 8215.753527394128, 8240.21717936795, 8241.876371854427, 8250.711225107092, 5228.660137091115, 5324.813631522917, 5391.865203369947, 5400.972995135038, 5412.864678383033, 3279.6884295991845, 3470.0804286864, 3475.8609655613745, 3542.946855797165, 3556.5020897074432, 1030.0, 1071.6249312740556, 1075.639660713662, 1080.724415274108, 1082.442542090824, 11476.254043487146, 11546.711332216677, 11655.358955257458, 11676.883231167665, 11685.415729213506, 4623.144718227071, 4631.791569379386, 4823.1800593898415, 4845.781939812717, 4852.539008794159, 8821.558922053871, 9044.592993315317, 9920.851187232198, 9931.0, 9935.503224838729, 5327.520523152857, 5337.8131765388025, 5377.569794416516, 5379.67721936685, 5383.623146379794, 4410.095930334273, 4735.266033764772, 4891.0, 4932.679375840559, 4942.827001054946, 3874.1283211277237, 3937.5078115235597, 3989.740666856645, 4015.959840401617, 4042.8584999524874, 1278.9001458745472, 1294.5436384067923, 1295.57893684551, 1303.7457695749426, 1310.3644732304824, 810.6352141536214, 921.5622579274791, 921.949292788903, 923.6028507741602, 961.0725649747887, 4739.0, 5784.971075144597, 5849.385814489502, 6012.098185272244, 6194.101855230966, 421.71534214405153, 427.4443223809036, 445.14976395085876, 451.1653441133876, 453.11642297519967, 3603.657652523006, 3845.7115716321387, 4022.8189731462153, 4095.24238015968, 4132.752034877917, 8503.574821258911, 10657.893421065844, 10663.680089597325, 10722.41026743521, 10738.892611073945, 10334.483275836179, 10655.733606659896, 10666.573337066431, 10672.94663526693, 10674.62638807638, 8004.479708819024, 8144.470609410369, 8195.057568379712, 8207.343412527103, 8219.54792486407, 5733.197352370588, 5769.53843692512, 5879.323877754113, 5906.114082887601, 5961.701914904151, 9986.151177150025, 10014.248931330034, 10022.198224142197, 10035.0, 10061.899381006097, 8150.551719655476, 10137.18902487814, 10252.846207307046, 10291.279610427198, 10295.07344339013, 6891.793246202622, 7228.783136505913, 7393.408527317694, 7466.402687785073, 7561.7731468056045, 8413.621387037476, 8502.574871256289, 8504.0, 8511.191436813493, 8533.35999800005, 7401.000864883172, 7461.664225109775, 7519.548827070174, 7543.886841697269, 7655.0, 7333.1200255969625, 7373.0, 7395.667194976347, 7512.5492470451945, 7554.773356799305, 6814.965925170342, 6946.513744038071, 6977.616231107135, 6985.1967023790885, 6993.720251190099, 4943.530364615356, 4950.356453661001, 5030.0694371541385, 5090.007448547498, 5100.413452453015, 5032.748362581783, 5041.6722913010535, 5172.275881376535, 5182.663126896739, 5242.18746094356], "value": 4476.270577060331, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [269.91092939330036, 288.356963970346, 300.51616896796156, 308.0082135523614, 310.10998434492996, 4371.715838470497, 4794.904101917964, 5427.43011983742, 5669.036263835148, 5687.175359572864, 4221.303484924992, 4790.329353890458, 4962.826301079463, 5513.58648101392, 5593.720313984295, 3844.9810800137984, 3900.5904380040115, 4212.578742125778, 4240.745555266679, 4257.914841703164, 3761.6050314716836, 3821.5414150301863, 3875.767453952772, 3941.3693808990565, 4267.295896177127, 4174.248635245654, 4192.224438478891, 4195.475565554306, 4213.47331583552, 4227.915441691164, 3472.9131771705784, 3526.347625689256, 4123.463949686521, 4224.45082139323, 4232.978835105836, 2879.9280017999718, 3323.3851737428413, 3660.5058317127114, 3664.918848939569, 3678.319510890494, 4734.384530011076, 5068.442471328188, 5159.484051594848, 5358.46415358461, 5384.596155288369, 4025.9798701006603, 4046.9392959105635, 4831.637627177941, 4840.362002708533, 4853.660243782937, 5742.0238559445, 5852.76588936442, 5862.296524417055, 5876.794312199053, 5911.881762364772, 3608.242269123461, 3621.818909054563, 3865.1496670732395, 3926.0, 4051.6150965658217, 5633.521150702195, 6074.726637301332, 6115.908261376083, 6162.352952939922, 6220.440160385542, 3348.4809854472596, 3936.6653834424396, 3994.6404823566018, 3996.4005399189773, 4008.8797336079965, 3699.5560532736245, 3957.2876882160913, 4006.358982562776, 4022.8735953932946, 4033.3143365627916, 3933.3903244997073, 4701.670883038155, 4705.505921878222, 4712.458067322234, 4744.905101897943, 5136.075506408883, 5863.296404431496, 5916.2013128228, 5920.348761636216, 5932.2584676915385, 1179.6637958182048, 1244.589285535771, 1299.5639818001162, 1359.2456186816214, 1369.1990185741254, 828.9844939948636, 889.973300800977, 907.1880666803174, 924.3714274293545, 931.1479995803763, 4779.784909679072, 5153.304303918998, 5207.531322181022, 5328.481382805881, 5374.54316383104, 4831.95168048322, 5699.347189315052, 5948.1858033299395, 5958.195643588147, 5961.880762384728, 5017.724025178577, 5279.366476022825, 5346.385165705916, 5346.572274218053, 5374.892502150014, 2405.6872606561037, 2493.314338556875, 2503.5869081601695, 2619.620155077503, 2690.3005218643293, 4421.513633500313, 4848.757562121879, 4885.560299573055, 5169.663971841818, 5174.861530463292, 4662.883427914329, 4863.489333619989, 5113.948860511422, 5128.999845030184, 5154.458781827929, 4308.41836352101, 5090.669106508065, 5138.845834624967, 5151.471242199031, 5152.0, 4308.763018034038, 4332.69671123031, 4970.4212966663945, 5046.949530504795, 5096.356105384668, 4653.697509661861, 4678.461976872703, 4865.391826021747, 4979.203327467588, 4998.925016124834, 4597.908041839211, 4822.95177048239, 4885.511448855086, 5190.351206099238, 5205.6356055075785, 3131.890383836646, 3150.4959206526846, 3312.7018568328967, 3464.8960531184107, 3471.3230919970365, 4522.954770452254, 4555.658325625657, 4702.2241330181505, 5040.243963405518, 5055.418626857959, 4830.589399901048, 4835.887745818552, 4842.523030475739, 4844.294115001956, 4858.611311095175, 4457.888552786077, 4540.818367265272, 4748.430188377417, 4793.352897358812, 4827.8551643450755, 4216.133029539942, 4276.781117381532, 4451.599356057841, 4567.191177425925, 4817.542333478314, 4327.701689493202, 4362.0, 4371.562843715603, 4691.741954192552, 4806.0, 4003.1785537580913, 4014.578469260802, 4774.928376074292, 4802.495737947465, 4810.518948105301], "value": 3892.895516343785, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.8600279944012, 700.4431476975803, 744.6611791634804, 750.1635676221014, 804.4208170117521, 15141.394344226232, 15916.602084947883, 16004.839951600481, 16012.35950561979, 16035.679286414264, 14497.130172189676, 14604.561863144096, 14619.0, 14638.926805365985, 14655.0, 664.7772996046306, 820.7865954851736, 823.5964377455034, 852.1478521478522, 861.1861790607878, 833.2708879730236, 850.2560259772699, 850.5577099908044, 851.6891334662835, 855.9229669329759, 904.3895370624834, 905.2531661379388, 906.8821053263066, 909.0999910088997, 909.4452384045727, 883.0639522106587, 896.3725392225435, 899.7525680437932, 900.3922352412161, 900.4327273817486, 666.8532922756985, 668.2849351194224, 668.84616538196, 673.8820706376365, 673.9764108256237, 12529.686757831036, 14874.925625371912, 15065.548033559011, 15082.170480623561, 15085.47200847965, 14537.854621453756, 14660.120392776467, 14697.70604587913, 14727.0, 14861.628459288497, 11980.400979950968, 12167.269963802111, 12374.81437778434, 12416.75166496665, 12607.936960315232, 3856.8842934712, 3864.3816989281863, 4052.959470405288, 4085.7140000199997, 4091.713580049398, 109057.0, 110569.89430105676, 110785.44607276993, 110958.0, 111090.0, 10815.0, 11285.830712539318, 11319.377434241196, 11339.092872570174, 11790.882091178979, 23095.307140785466, 23362.0, 23365.88317058404, 23383.947722352535, 23413.76586234116, 8197.877031844528, 8277.130901255401, 8296.917030829734, 8304.128066553047, 8410.663573456994, 4511.870456970267, 4558.270676691714, 4563.840265590688, 4579.564941330635, 4731.219348807477, 3597.3165098631175, 3692.833822477995, 3703.4629978653484, 3720.255948810249, 3723.590405055442, 584.9093390524475, 595.6039233909488, 703.8627467643863, 718.4503854551273, 726.9345758881726, 526.8524813052352, 527.5753018819887, 597.3041406761162, 677.678102901118, 681.6046692918096, 9642.71071867845, 9724.659636912675, 9803.950980245196, 9833.280025587757, 9875.259355548218, 521.8564894653924, 569.2173261765073, 609.8321713917798, 638.5466318913531, 690.8255964859658, 4251.277282861921, 4526.275795872644, 4746.691465054761, 4800.855974320776, 4805.687630304019, 148828.76756848657, 154845.22577387042, 158259.0, 158589.0, 162603.7479250432, 130405.34797325953, 131699.0, 134058.32970835082, 135610.0, 135703.0, 83682.0, 111113.0, 113222.0, 113790.43104784423, 114273.4286328563, 8901.73294801157, 8965.462072275684, 8968.910310896808, 9174.862377064215, 9180.357374983687, 43050.569494304655, 46056.0, 57479.712601436724, 60189.69905150446, 60250.39749602448, 47526.49470105924, 62336.0, 62761.0, 82405.17594823975, 86548.5672571633, 10664.84002739944, 11849.940750296193, 12038.699032524257, 12097.81853272184, 12433.751324973631, 13170.0, 13433.782157852369, 13546.390412431661, 13755.037147399586, 14081.155130692192, 12653.74692506163, 12810.935945320214, 12995.220286782824, 13195.80206296887, 13212.339383031001, 12595.68510787201, 12773.936130319289, 13130.212187268795, 13141.73716525645, 13179.802302965654, 12345.691357716129, 12371.381430928597, 12385.93807030959, 12397.0, 12620.684482888002, 10127.0, 10351.43067131315, 10401.635942741968, 10408.843867341844, 10749.140068794633, 8175.1007389188335, 10595.09941654968, 10613.575456981634, 10763.946180269362, 10775.6228532001], "value": 7693.966207717444, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 118.0, 111.0, 121.0, 117.0, 118.0, 115.0, 155.0, 171.0, 149.0], "value": 128.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 113.0, 130.0, 158.0, 115.0, 134.0, 135.0, 142.0, 159.0, 113.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [215.0, 190.0, 244.0, 278.0, 274.0, 198.0, 197.0, 200.0, 225.0, 197.0], "value": 221.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 102.0, 68.0, 155.0, 53.0, 84.0, 81.0, 82.0, 159.0, 58.0], "value": 91.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 95.0, 163.0, 84.0, 70.0, 89.0, 114.0, 72.0, 73.0, 115.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 76.0, 134.0, 85.0, 99.0, 84.0, 89.0, 85.0, 88.0, 86.0], "value": 91.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 98.0, 96.0, 95.0, 95.0, 97.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 145.0, 78.0, 149.0, 141.0, 92.0, 112.0, 90.0, 91.0, 91.0], "value": 110.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 58.0, 59.0, 53.0, 54.0, 66.0, 54.0, 55.0, 59.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 102.0, 70.0, 87.0, 62.0, 83.0, 70.0, 58.0, 81.0, 101.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 98.0, 81.0, 87.0, 86.0, 88.0, 83.0, 86.0, 88.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 143.0, 133.0, 124.0, 159.0, 159.0, 148.0, 131.0, 178.0, 155.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 179.0, 175.0, 174.0, 173.0, 175.0, 174.0, 160.0, 194.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 67.0, 69.0, 64.0, 90.0, 87.0, 87.0, 89.0, 91.0], "value": 78.4, "unit": "score"}]}]} 16:55:15 INFO - Return code: 0 16:55:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:55:15 ERROR - # TBPL SUCCESS # 16:55:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:55:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:55:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:55:15 INFO - 2016-08-15 16:55:15.497 screenresolution[1672:10398] starting screenresolution argv=screenresolution get 16:55:15 INFO - 2016-08-15 16:55:15.500 screenresolution[1672:10398] Display 0: 1600x1200x32@60 16:55:15 INFO - 2016-08-15 16:55:15.505 screenresolution[1673:10401] starting screenresolution argv=screenresolution list 16:55:15 INFO - Available Modes on Display 0 16:55:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:55:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:55:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:55:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:55:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:55:15 INFO - Intel Iris: 16:55:15 INFO - Chipset Model: Intel Iris 16:55:15 INFO - Type: GPU 16:55:15 INFO - Bus: Built-In 16:55:15 INFO - VRAM (Dynamic, Max): 1536 MB 16:55:15 INFO - Vendor: Intel (0x8086) 16:55:15 INFO - Device ID: 0x0a2e 16:55:15 INFO - Revision ID: 0x0009 16:55:15 INFO - Displays: 16:55:15 INFO - Display: 16:55:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:55:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:55:15 INFO - Display Serial Number: 1600x1200 60 16:55:15 INFO - Main Display: Yes 16:55:15 INFO - Mirror: Off 16:55:15 INFO - Online: Yes 16:55:15 INFO - Rotation: Supported 16:55:15 INFO - Return code: 0 16:55:15 INFO - Running post-action listener: _resource_record_post_action 16:55:15 INFO - [mozharness: 2016-08-15 23:55:15.739548Z] Finished run-tests step (success) 16:55:15 INFO - Running post-run listener: _resource_record_post_run 16:55:15 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 36765696; Write bytes: 706009088; Read time: 237; Write time: 2030 16:55:15 INFO - TinderboxPrint: CPU usage
54.4% 16:55:15 INFO - TinderboxPrint: I/O read bytes / time
36,765,696 / 237 16:55:15 INFO - TinderboxPrint: I/O write bytes / time
706,009,088 / 2,030 16:55:15 INFO - TinderboxPrint: CPU idle
2,205.5 (45.6%) 16:55:15 INFO - TinderboxPrint: CPU system
974.5 (20.1%) 16:55:15 INFO - TinderboxPrint: CPU user
1,661.8 (34.3%) 16:55:15 INFO - TinderboxPrint: Swap in / out
441,643,008 / 0 16:55:15 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 394179072; Write bytes: 388503552; Read time: 29211; Write time: 824 16:55:15 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 34959360; Write bytes: 297521152; Read time: 220; Write time: 1153 16:55:16 INFO - Running post-run listener: _upload_blobber_files 16:55:16 INFO - Blob upload gear active. 16:55:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:55:16 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 16:55:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:55:16 INFO - (blobuploader) - INFO - Open directory for files ... 16:55:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:55:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:55:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:17 INFO - (blobuploader) - INFO - Done attempting. 16:55:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:55:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:55:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:18 INFO - (blobuploader) - INFO - Done attempting. 16:55:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:55:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:55:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:21 INFO - (blobuploader) - INFO - Done attempting. 16:55:21 INFO - (blobuploader) - INFO - Iteration through files over. 16:55:21 INFO - Return code: 0 16:55:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:55:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:55:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3488e70d8d95b1e860e845725e03b98a9cd573cffc73ca40ab49937c776d3c5a0b722466a9eae2b767fb5440db3726185455546cfd5d5f6ce38b2e7d2c2ec5fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f84c05b1f7688dbffc90a043f7c4934097c23cb521b2befd27c8c0c33144ef4c60070bd8d28649c920b11f055ceb8a100d1585a6598628ad270ca8acc00bda4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09587e55af0539a35ae51b70131a65f5c4325119f6df6e446815e5ac8e9d74c77ad947d8b831da49c47c303c2ea25dc9fca54cf619578771801b213c1ba26c36"} 16:55:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:55:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:55:21 INFO - Contents: 16:55:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3488e70d8d95b1e860e845725e03b98a9cd573cffc73ca40ab49937c776d3c5a0b722466a9eae2b767fb5440db3726185455546cfd5d5f6ce38b2e7d2c2ec5fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f84c05b1f7688dbffc90a043f7c4934097c23cb521b2befd27c8c0c33144ef4c60070bd8d28649c920b11f055ceb8a100d1585a6598628ad270ca8acc00bda4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09587e55af0539a35ae51b70131a65f5c4325119f6df6e446815e5ac8e9d74c77ad947d8b831da49c47c303c2ea25dc9fca54cf619578771801b213c1ba26c36"} 16:55:21 INFO - Running post-run listener: copy_logs_to_upload_dir 16:55:21 INFO - Copying logs to upload dir... 16:55:21 INFO - mkdir: /builds/slave/test/build/upload/logs 16:55:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.135977 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-15 16:55:21.199661) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 16:55:21.202945) ========= 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.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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/Fx-Team/sha512/3488e70d8d95b1e860e845725e03b98a9cd573cffc73ca40ab49937c776d3c5a0b722466a9eae2b767fb5440db3726185455546cfd5d5f6ce38b2e7d2c2ec5fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f84c05b1f7688dbffc90a043f7c4934097c23cb521b2befd27c8c0c33144ef4c60070bd8d28649c920b11f055ceb8a100d1585a6598628ad270ca8acc00bda4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09587e55af0539a35ae51b70131a65f5c4325119f6df6e446815e5ac8e9d74c77ad947d8b831da49c47c303c2ea25dc9fca54cf619578771801b213c1ba26c36"} build_url:https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/B3WGrhNcSWGnfsERT9KFAw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3488e70d8d95b1e860e845725e03b98a9cd573cffc73ca40ab49937c776d3c5a0b722466a9eae2b767fb5440db3726185455546cfd5d5f6ce38b2e7d2c2ec5fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f84c05b1f7688dbffc90a043f7c4934097c23cb521b2befd27c8c0c33144ef4c60070bd8d28649c920b11f055ceb8a100d1585a6598628ad270ca8acc00bda4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09587e55af0539a35ae51b70131a65f5c4325119f6df6e446815e5ac8e9d74c77ad947d8b831da49c47c303c2ea25dc9fca54cf619578771801b213c1ba26c36"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 16:55:21.235621) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:55:21.235954) ========= 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.VVvsuBDlJS/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.QPpY8Pj1KG/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.005246 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:55:21.284427) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 16:55:21.284746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 16:55:21.285086) ========= ========= Total master_lag: 0.17 =========