builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0262 starttime: 1471062141.62 results: success (0) buildid: 20160812164016 builduid: 2bd2613e071e472e969ba0e9380da997 revision: 1ba6215e84c3b34b928898331c3d444b3dd96ee3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 21:22:21.622167) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 21:22:21.622608) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 21:22:21.622887) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 21:22:21.645905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:22:21.646238) ========= 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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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-12 21:22:21-- 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% 20.8M=0.001s 2016-08-12 21:22:21 (20.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194580 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:22:21.922696) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:22:21.923006) ========= 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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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.020510 ========= master_lag: 0.21 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:22:22.149563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-12 21:22:22.149880) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1ba6215e84c3b34b928898331c3d444b3dd96ee3 --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 1ba6215e84c3b34b928898331c3d444b3dd96ee3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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-12 21:22:22,233 truncating revision to first 12 chars 2016-08-12 21:22:22,233 Setting DEBUG logging. 2016-08-12 21:22:22,233 attempt 1/10 2016-08-12 21:22:22,233 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1ba6215e84c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 21:22:23,544 unpacking tar archive at: fx-team-1ba6215e84c3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.599523 ========= master_lag: 0.96 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-12 21:22:24.712609) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 21:22:24.712928) ========= script_repo_revision: 1ba6215e84c3b34b928898331c3d444b3dd96ee3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 21:22:24.713307) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-08-12 21:22:24.713585) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-08-12 21:22:25.837367) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-12 21:22:25.837837) ========= /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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 21:22:26 INFO - MultiFileLogger online at 20160812 21:22:26 in /builds/slave/test 21:22:26 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 21:22:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:22:26 INFO - {'append_to_log': False, 21:22:26 INFO - 'base_work_dir': '/builds/slave/test', 21:22:26 INFO - 'blob_upload_branch': 'Fx-Team', 21:22:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:22:26 INFO - 'branch': 'Fx-Team', 21:22:26 INFO - 'buildbot_json_path': 'buildprops.json', 21:22:26 INFO - 'config_files': ('talos/mac_config.py',), 21:22:26 INFO - 'default_actions': ('clobber', 21:22:26 INFO - 'read-buildbot-config', 21:22:26 INFO - 'download-and-extract', 21:22:26 INFO - 'populate-webroot', 21:22:26 INFO - 'create-virtualenv', 21:22:26 INFO - 'install', 21:22:26 INFO - 'run-tests'), 21:22:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:22:26 INFO - 'download_minidump_stackwalk': True, 21:22:26 INFO - 'download_symbols': 'ondemand', 21:22:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:22:26 INFO - 'tooltool.py': '/tools/tooltool.py', 21:22:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:22:26 INFO - '/tools/misc-python/virtualenv.py')}, 21:22:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:22:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:22:26 INFO - 'installer_path': 'installer.exe', 21:22:26 INFO - 'log_level': 'info', 21:22:26 INFO - 'log_name': 'talos', 21:22:26 INFO - 'log_to_console': True, 21:22:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:22:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:22:26 INFO - 'opt_config_files': (), 21:22:26 INFO - 'pip_index': False, 21:22:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:22:26 INFO - 'cmd': ('bash', 21:22:26 INFO - '-c', 21:22:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:22:26 INFO - 'enabled': True, 21:22:26 INFO - 'halt_on_failure': False, 21:22:26 INFO - 'name': 'check_screen_resolution'},), 21:22:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:22:26 INFO - 'cmd': ('bash', 21:22:26 INFO - '-c', 21:22:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:22:26 INFO - 'enabled': True, 21:22:26 INFO - 'halt_on_failure': False, 21:22:26 INFO - 'name': 'check_screen_resolution'},), 21:22:26 INFO - 'run_cmd_checks_enabled': True, 21:22:26 INFO - 'sps_profile': False, 21:22:26 INFO - 'sps_profile_interval': 0, 21:22:26 INFO - 'suite': 'dromaeojs-e10s', 21:22:26 INFO - 'system_bits': '32', 21:22:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:22:26 INFO - 'title': 't-yosemite-r7-0262', 21:22:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:22:26 INFO - 'use_talos_json': True, 21:22:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:22:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:22:26 INFO - 'work_dir': 'build'} 21:22:26 INFO - [mozharness: 2016-08-13 04:22:26.028428Z] Running clobber step. 21:22:26 INFO - Running pre-action listener: _resource_record_pre_action 21:22:26 INFO - Running main action method: clobber 21:22:26 INFO - rmtree: /builds/slave/test/build 21:22:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:22:26 INFO - Running post-action listener: _resource_record_post_action 21:22:26 INFO - [mozharness: 2016-08-13 04:22:26.519962Z] Finished clobber step (success) 21:22:26 INFO - [mozharness: 2016-08-13 04:22:26.520248Z] Running read-buildbot-config step. 21:22:26 INFO - Running pre-action listener: _resource_record_pre_action 21:22:26 INFO - Running main action method: read_buildbot_config 21:22:26 INFO - Using buildbot properties: 21:22:26 INFO - { 21:22:26 INFO - "project": "", 21:22:26 INFO - "product": "firefox", 21:22:26 INFO - "script_repo_revision": "production", 21:22:26 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 21:22:26 INFO - "repository": "", 21:22:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 21:22:26 INFO - "buildid": "20160812164016", 21:22:26 INFO - "pgo_build": "False", 21:22:26 INFO - "basedir": "/builds/slave/test", 21:22:26 INFO - "buildnumber": 81, 21:22:26 INFO - "slavename": "t-yosemite-r7-0262", 21:22:26 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 21:22:26 INFO - "platform": "yosemite_r7", 21:22:26 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 21:22:26 INFO - "branch": "fx-team", 21:22:26 INFO - "repo_path": "integration/fx-team", 21:22:26 INFO - "revision": "1ba6215e84c3b34b928898331c3d444b3dd96ee3", 21:22:26 INFO - "stage_platform": "macosx64", 21:22:26 INFO - "builduid": "2bd2613e071e472e969ba0e9380da997", 21:22:26 INFO - "slavebuilddir": "test" 21:22:26 INFO - } 21:22:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 21:22:26 INFO - Running post-action listener: _resource_record_post_action 21:22:26 INFO - [mozharness: 2016-08-13 04:22:26.525688Z] Finished read-buildbot-config step (success) 21:22:26 INFO - [mozharness: 2016-08-13 04:22:26.525849Z] Running download-and-extract step. 21:22:26 INFO - Running pre-action listener: _resource_record_pre_action 21:22:26 INFO - Running main action method: download_and_extract 21:22:26 INFO - mkdir: /builds/slave/test/build/tests 21:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:26 INFO - trying https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 21:22:26 INFO - Downloading https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/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 21:22:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/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 21:22:27 INFO - Downloaded 1199 bytes. 21:22:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 21:22:27 INFO - Using the following test package requirements: 21:22:27 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:22:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:22:27 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 21:22:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:22:27 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 21:22:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:22:27 INFO - u'jsshell-mac.zip'], 21:22:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:22:27 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 21:22:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:22:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:22:27 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 21:22:27 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:22:27 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 21:22:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:22:27 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 21:22:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:22:27 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 21:22:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:22:27 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')]} 21:22:27 INFO - trying https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:22:27 INFO - Downloading https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/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 21:22:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/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 21:22:28 INFO - Downloaded 16330576 bytes. 21:22:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 21:22:35 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 21:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:35 INFO - trying https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:22:35 INFO - Downloading https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/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 21:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/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 21:22:36 INFO - Downloaded 16330576 bytes. 21:22:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 21:22: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')]} 21:22:42 INFO - trying https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 21:22:42 INFO - Downloading https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/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 21:22:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/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 21:22:43 INFO - Downloaded 14413719 bytes. 21:22:43 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 21:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:44 INFO - trying https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:22:44 INFO - Downloading https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 21:22:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/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 21:22:47 INFO - Downloaded 111040549 bytes. 21:22:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:22:47 INFO - mkdir: /builds/slave/test/properties 21:22:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:22:47 INFO - Writing to file /builds/slave/test/properties/build_url 21:22:47 INFO - Contents: 21:22:47 INFO - build_url:https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:22:48 INFO - Running post-action listener: _resource_record_post_action 21:22:48 INFO - Running post-action listener: set_extra_try_arguments 21:22:48 INFO - [mozharness: 2016-08-13 04:22:48.851455Z] Finished download-and-extract step (success) 21:22:48 INFO - [mozharness: 2016-08-13 04:22:48.851555Z] Running populate-webroot step. 21:22:48 INFO - Running pre-action listener: _resource_record_pre_action 21:22:48 INFO - Running main action method: populate_webroot 21:22:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:22:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:22:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:22:48 INFO - '--tppagecycles', 21:22:48 INFO - '7'], 21:22:48 INFO - 'tests': ['tsvgm']}}, 21:22:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:22:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:22:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:22:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:22:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:22:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:22:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:48 INFO - 'talos_options': ['--disable-e10s'], 21:22:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:22:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:22:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:48 INFO - 'talos_options': ['--disable-e10s'], 21:22:48 INFO - 'tests': ['damp', 'tps']}, 21:22:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:48 INFO - 'tests': ['damp', 'tps']}, 21:22:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:22:48 INFO - 'tests': ['dromaeo_dom']}, 21:22:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:22:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:22:48 INFO - 'tests': ['basic_compositor_video']}, 21:22:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:22:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:22:48 INFO - 'tests': ['a11yr', 21:22:48 INFO - 'ts_paint', 21:22:48 INFO - 'tpaint', 21:22:48 INFO - 'sessionrestore', 21:22:48 INFO - 'sessionrestore_no_auto_restore', 21:22:48 INFO - 'tabpaint']}, 21:22:48 INFO - 'other-e10s': {'tests': ['a11yr', 21:22:48 INFO - 'ts_paint', 21:22:48 INFO - 'tpaint', 21:22:48 INFO - 'sessionrestore', 21:22:48 INFO - 'sessionrestore_no_auto_restore', 21:22:48 INFO - 'tabpaint']}, 21:22:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:22:48 INFO - 'ts_paint', 21:22:48 INFO - 'tpaint', 21:22:48 INFO - 'sessionrestore', 21:22:48 INFO - 'sessionrestore_no_auto_restore', 21:22:48 INFO - 'tabpaint']}, 21:22:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:22:48 INFO - 'ts_paint', 21:22:48 INFO - 'tpaint', 21:22:48 INFO - 'sessionrestore', 21:22:48 INFO - 'sessionrestore_no_auto_restore', 21:22:48 INFO - 'tabpaint']}, 21:22:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:22:48 INFO - 'tests': ['a11yr', 21:22:48 INFO - 'ts_paint', 21:22:48 INFO - 'tpaint', 21:22:48 INFO - 'sessionrestore', 21:22:48 INFO - 'sessionrestore_no_auto_restore', 21:22:48 INFO - 'tabpaint']}, 21:22:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:22:48 INFO - 'tests': ['a11yr', 21:22:48 INFO - 'ts_paint', 21:22:48 INFO - 'tpaint', 21:22:48 INFO - 'sessionrestore', 21:22:48 INFO - 'sessionrestore_no_auto_restore', 21:22:48 INFO - 'tabpaint']}, 21:22:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:22:48 INFO - 'tests': ['tsvgx', 21:22:48 INFO - 'tsvgr_opacity', 21:22:48 INFO - 'tart', 21:22:48 INFO - 'tscrollx', 21:22:48 INFO - 'cart']}, 21:22:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:22:48 INFO - 'tsvgr_opacity', 21:22:48 INFO - 'tart', 21:22:48 INFO - 'tscrollx', 21:22:48 INFO - 'cart']}, 21:22:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:48 INFO - 'talos_options': ['--disable-e10s'], 21:22:48 INFO - 'tests': ['tp5o']}, 21:22:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:48 INFO - 'tests': ['tp5o']}, 21:22:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:48 INFO - 'talos_options': ['--disable-e10s', 21:22:48 INFO - '--xperf_path', 21:22:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:22:48 INFO - 'tests': ['tp5n']}, 21:22:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:48 INFO - 'talos_options': ['--xperf_path', 21:22:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:22:48 INFO - 'tests': ['tp5n']}}, 21:22:48 INFO - 'talos.zip': {'path': '', 21:22:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:22:48 INFO - Running post-action listener: _resource_record_post_action 21:22:48 INFO - [mozharness: 2016-08-13 04:22:48.870242Z] Finished populate-webroot step (success) 21:22:48 INFO - [mozharness: 2016-08-13 04:22:48.870378Z] Running create-virtualenv step. 21:22:48 INFO - Running pre-action listener: _resource_record_pre_action 21:22:48 INFO - Running main action method: create_virtualenv 21:22:48 INFO - Creating virtualenv /builds/slave/test/build/venv 21:22:48 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 21:22:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:22:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:22:48 INFO - Using real prefix '/tools/python27' 21:22:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:22:49 INFO - Installing distribute.............................................................................................................................................................................................done. 21:22:52 INFO - Installing pip.................done. 21:22:52 INFO - Return code: 0 21:22:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:52 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 0x10d97ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c95f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8e2d30>, '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 0x10d647db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8dab20>, '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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 21:22:52 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 21:22:52 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 21:22:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AGK0Eb9Uzk/Render', 21:22:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:52 INFO - 'HOME': '/Users/cltbld', 21:22:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:52 INFO - 'LOGNAME': 'cltbld', 21:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:52 INFO - 'MOZ_NO_REMOTE': '1', 21:22:52 INFO - 'NO_EM_RESTART': '1', 21:22:52 INFO - 'PAGER': '/bin/cat', 21:22:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:52 INFO - 'PWD': '/builds/slave/test', 21:22:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:52 INFO - 'SHELL': '/bin/bash', 21:22:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OIVOhuPFSQ/Listeners', 21:22:52 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 21:22:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:52 INFO - 'USER': 'cltbld', 21:22:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:52 INFO - 'XPC_FLAGS': '0x0', 21:22:52 INFO - 'XPC_SERVICE_NAME': '0', 21:22:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:52 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 21:22:52 INFO - Cleaning up... 21:22:53 INFO - Return code: 0 21:22:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:53 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 0x10d97ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c95f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8e2d30>, '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 0x10d647db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8dab20>, '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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 21:22:53 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 21:22:53 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 21:22:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AGK0Eb9Uzk/Render', 21:22:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:53 INFO - 'HOME': '/Users/cltbld', 21:22:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:53 INFO - 'LOGNAME': 'cltbld', 21:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:53 INFO - 'MOZ_NO_REMOTE': '1', 21:22:53 INFO - 'NO_EM_RESTART': '1', 21:22:53 INFO - 'PAGER': '/bin/cat', 21:22:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:53 INFO - 'PWD': '/builds/slave/test', 21:22:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:53 INFO - 'SHELL': '/bin/bash', 21:22:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OIVOhuPFSQ/Listeners', 21:22:53 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 21:22:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:53 INFO - 'USER': 'cltbld', 21:22:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:53 INFO - 'XPC_FLAGS': '0x0', 21:22:53 INFO - 'XPC_SERVICE_NAME': '0', 21:22:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:53 INFO - Downloading/unpacking psutil>=3.1.1 21:22:53 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 21:22:53 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 21:22:53 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 21:22:53 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 21:22:53 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 21:22:53 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 21:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:22:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:22:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:22:56 INFO - Installing collected packages: psutil 21:22:56 INFO - Running setup.py install for psutil 21:22:56 INFO - building 'psutil._psutil_osx' extension 21:22:56 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 21:22:57 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 21:22:57 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 21:22:57 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 21:22:57 INFO - building 'psutil._psutil_posix' extension 21:22:57 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 21:22:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:22:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:22:57 INFO - ^ 21:22:57 INFO - 1 warning generated. 21:22:57 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 21:22:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:22:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:22:57 INFO - Successfully installed psutil 21:22:57 INFO - Cleaning up... 21:22:57 INFO - Return code: 0 21:22:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:57 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 0x10d97ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c95f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8e2d30>, '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 0x10d647db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8dab20>, '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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 21:22:57 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 21:22:57 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 21:22:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AGK0Eb9Uzk/Render', 21:22:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:57 INFO - 'HOME': '/Users/cltbld', 21:22:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:57 INFO - 'LOGNAME': 'cltbld', 21:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:57 INFO - 'MOZ_NO_REMOTE': '1', 21:22:57 INFO - 'NO_EM_RESTART': '1', 21:22:57 INFO - 'PAGER': '/bin/cat', 21:22:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:57 INFO - 'PWD': '/builds/slave/test', 21:22:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:57 INFO - 'SHELL': '/bin/bash', 21:22:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OIVOhuPFSQ/Listeners', 21:22:57 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 21:22:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:57 INFO - 'USER': 'cltbld', 21:22:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:57 INFO - 'XPC_FLAGS': '0x0', 21:22:57 INFO - 'XPC_SERVICE_NAME': '0', 21:22:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:22:57 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 21:22:57 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 21:22:57 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 21:22:57 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 21:22:57 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 21:22:57 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 21:23:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:23:00 INFO - Installing collected packages: mozsystemmonitor 21:23:00 INFO - Running setup.py install for mozsystemmonitor 21:23:00 INFO - Successfully installed mozsystemmonitor 21:23:00 INFO - Cleaning up... 21:23:00 INFO - Return code: 0 21:23:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:00 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 0x10d97ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c95f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8e2d30>, '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 0x10d647db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8dab20>, '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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 21:23:00 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 21:23:00 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 21:23:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AGK0Eb9Uzk/Render', 21:23:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:00 INFO - 'HOME': '/Users/cltbld', 21:23:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:00 INFO - 'LOGNAME': 'cltbld', 21:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:00 INFO - 'MOZ_NO_REMOTE': '1', 21:23:00 INFO - 'NO_EM_RESTART': '1', 21:23:00 INFO - 'PAGER': '/bin/cat', 21:23:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:00 INFO - 'PWD': '/builds/slave/test', 21:23:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:00 INFO - 'SHELL': '/bin/bash', 21:23:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OIVOhuPFSQ/Listeners', 21:23:00 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 21:23:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:00 INFO - 'USER': 'cltbld', 21:23:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:00 INFO - 'XPC_FLAGS': '0x0', 21:23:00 INFO - 'XPC_SERVICE_NAME': '0', 21:23:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:00 INFO - Downloading/unpacking jsonschema==2.5.1 21:23:00 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 21:23:00 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 21:23:00 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 21:23:00 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 21:23:00 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 21:23:00 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 21:23:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:23:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:23:03 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 21:23:03 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 21:23:03 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 21:23:03 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 21:23:03 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 21:23:03 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 21:23:03 INFO - Downloading functools32-3.2.3-2.tar.gz 21:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:23:03 INFO - warning: no files found matching '*.txt' 21:23:03 INFO - no previously-included directories found matching 'build' 21:23:03 INFO - no previously-included directories found matching 'dist' 21:23:03 INFO - no previously-included directories found matching '.git*' 21:23:03 INFO - Installing collected packages: jsonschema, functools32 21:23:03 INFO - Running setup.py install for functools32 21:23:04 INFO - warning: no files found matching '*.txt' 21:23:04 INFO - no previously-included directories found matching 'build' 21:23:04 INFO - no previously-included directories found matching 'dist' 21:23:04 INFO - no previously-included directories found matching '.git*' 21:23:04 INFO - Successfully installed jsonschema functools32 21:23:04 INFO - Cleaning up... 21:23:04 INFO - Return code: 0 21:23:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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', '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 0x10d97ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c95f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8e2d30>, '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 0x10d647db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8dab20>, '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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 21:23: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:23: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 functools32==3.2.3-2 21:23:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AGK0Eb9Uzk/Render', 21:23:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:04 INFO - 'HOME': '/Users/cltbld', 21:23:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:04 INFO - 'LOGNAME': 'cltbld', 21:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:04 INFO - 'MOZ_NO_REMOTE': '1', 21:23:04 INFO - 'NO_EM_RESTART': '1', 21:23:04 INFO - 'PAGER': '/bin/cat', 21:23:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:04 INFO - 'PWD': '/builds/slave/test', 21:23:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:04 INFO - 'SHELL': '/bin/bash', 21:23:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OIVOhuPFSQ/Listeners', 21:23:04 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 21:23:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:04 INFO - 'USER': 'cltbld', 21:23:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:04 INFO - 'XPC_FLAGS': '0x0', 21:23:04 INFO - 'XPC_SERVICE_NAME': '0', 21:23:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:23:04 INFO - Cleaning up... 21:23:04 INFO - Return code: 0 21:23:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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', '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 0x10d97ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c95f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8e2d30>, '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 0x10d647db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8dab20>, '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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 21:23: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:23: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 blobuploader==1.2.4 21:23:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AGK0Eb9Uzk/Render', 21:23:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:04 INFO - 'HOME': '/Users/cltbld', 21:23:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:04 INFO - 'LOGNAME': 'cltbld', 21:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:04 INFO - 'MOZ_NO_REMOTE': '1', 21:23:04 INFO - 'NO_EM_RESTART': '1', 21:23:04 INFO - 'PAGER': '/bin/cat', 21:23:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:04 INFO - 'PWD': '/builds/slave/test', 21:23:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:04 INFO - 'SHELL': '/bin/bash', 21:23:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OIVOhuPFSQ/Listeners', 21:23:04 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 21:23:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:04 INFO - 'USER': 'cltbld', 21:23:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:04 INFO - 'XPC_FLAGS': '0x0', 21:23:04 INFO - 'XPC_SERVICE_NAME': '0', 21:23:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:04 INFO - Downloading/unpacking blobuploader==1.2.4 21:23:04 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 21:23:04 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 21:23:04 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 21:23:04 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 21:23:04 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 21:23:04 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 21:23:07 INFO - Downloading blobuploader-1.2.4.tar.gz 21:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:23:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:23:07 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 21:23:07 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 21:23:07 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 21:23:07 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 21:23:07 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 21:23:07 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 21:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:23:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:23:07 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 21:23:07 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 21:23:07 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 21:23:07 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 21:23:07 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 21:23:07 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 21:23:08 INFO - Downloading docopt-0.6.1.tar.gz 21:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:23:08 INFO - Installing collected packages: blobuploader, requests, docopt 21:23:08 INFO - Running setup.py install for blobuploader 21:23:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:23:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:23:08 INFO - Running setup.py install for requests 21:23:09 INFO - Running setup.py install for docopt 21:23:09 INFO - Successfully installed blobuploader requests docopt 21:23:09 INFO - Cleaning up... 21:23:09 INFO - Return code: 0 21:23:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:09 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 0x10d97ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c95f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8e2d30>, '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 0x10d647db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8dab20>, '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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 21:23:09 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 21:23:09 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 21:23:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AGK0Eb9Uzk/Render', 21:23:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:09 INFO - 'HOME': '/Users/cltbld', 21:23:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:09 INFO - 'LOGNAME': 'cltbld', 21:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:09 INFO - 'MOZ_NO_REMOTE': '1', 21:23:09 INFO - 'NO_EM_RESTART': '1', 21:23:09 INFO - 'PAGER': '/bin/cat', 21:23:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:09 INFO - 'PWD': '/builds/slave/test', 21:23:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:09 INFO - 'SHELL': '/bin/bash', 21:23:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OIVOhuPFSQ/Listeners', 21:23:09 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 21:23:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:09 INFO - 'USER': 'cltbld', 21:23:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:09 INFO - 'XPC_FLAGS': '0x0', 21:23:09 INFO - 'XPC_SERVICE_NAME': '0', 21:23:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:09 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-hLilR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:09 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-AY4ycd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:09 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-0xg4FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:09 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-mo_kvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:09 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-vlOAyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:10 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-coI8Ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:10 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-JOTx2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:10 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-RoWyXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:10 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-fudcQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:10 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-UUPHZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:10 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-NRN_NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:10 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-mWw9gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:10 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-x6UYcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:10 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-UCUYKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:10 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-yEu8D3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:11 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-3Il4zI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:11 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-j5l0DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:23:11 INFO - Running setup.py install for manifestparser 21:23:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:23:11 INFO - Running setup.py install for mozcrash 21:23:11 INFO - Running setup.py install for mozdebug 21:23:11 INFO - Running setup.py install for mozdevice 21:23:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:23:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:23:11 INFO - Running setup.py install for mozfile 21:23:12 INFO - Running setup.py install for mozhttpd 21:23:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:23:12 INFO - Running setup.py install for mozinfo 21:23:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:23:12 INFO - Running setup.py install for mozInstall 21:23:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:23:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:23:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:23:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:23:12 INFO - Running setup.py install for mozleak 21:23:12 INFO - Running setup.py install for mozlog 21:23:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:23:12 INFO - Running setup.py install for moznetwork 21:23:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:23:12 INFO - Running setup.py install for mozprocess 21:23:13 INFO - Running setup.py install for mozprofile 21:23:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:23:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:23:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:23:13 INFO - Running setup.py install for mozrunner 21:23:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:23:13 INFO - Running setup.py install for mozscreenshot 21:23:13 INFO - Running setup.py install for moztest 21:23:13 INFO - Running setup.py install for mozversion 21:23:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:23:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:23:13 INFO - Cleaning up... 21:23:13 INFO - Return code: 0 21:23:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:13 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 0x10d97ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c95f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8e2d30>, '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 0x10d647db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8dab20>, '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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 21:23:13 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 21:23:13 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 21:23:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AGK0Eb9Uzk/Render', 21:23:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:13 INFO - 'HOME': '/Users/cltbld', 21:23:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:13 INFO - 'LOGNAME': 'cltbld', 21:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:13 INFO - 'MOZ_NO_REMOTE': '1', 21:23:13 INFO - 'NO_EM_RESTART': '1', 21:23:13 INFO - 'PAGER': '/bin/cat', 21:23:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:13 INFO - 'PWD': '/builds/slave/test', 21:23:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:13 INFO - 'SHELL': '/bin/bash', 21:23:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OIVOhuPFSQ/Listeners', 21:23:13 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 21:23:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:13 INFO - 'USER': 'cltbld', 21:23:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:13 INFO - 'XPC_FLAGS': '0x0', 21:23:13 INFO - 'XPC_SERVICE_NAME': '0', 21:23:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:14 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-3MnhZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:14 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)) 21:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:14 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-kAPbbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:14 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)) 21:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:14 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-41lx8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:14 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)) 21:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:14 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-Q3Ggfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:14 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)) 21:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:14 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-xKqGOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:14 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)) 21:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:14 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-nv88KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:14 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)) 21:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:14 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-tU0DKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:14 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)) 21:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:14 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-iHtiXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:14 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)) 21:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:14 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-IuEduY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:15 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)) 21:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:15 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-9JCseT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:15 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)) 21:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:15 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-Yk0luy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:15 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)) 21:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:15 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-VN1PsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:15 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)) 21:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:15 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-rwhF_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:15 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)) 21:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:15 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-VvUMed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:15 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)) 21:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:15 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-t9y1r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:15 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)) 21:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:15 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-phGy_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:15 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)) 21:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:15 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-qMyU9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:15 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)) 21:23:15 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)) 21:23:15 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)) 21:23:15 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)) 21:23:15 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)) 21:23:15 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)) 21:23:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:23:15 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 21:23:15 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 21:23:15 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 21:23:15 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 21:23:15 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 21:23:15 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 21:23:18 INFO - Downloading blessings-1.6.tar.gz 21:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:23:18 INFO - Installing collected packages: blessings 21:23:18 INFO - Running setup.py install for blessings 21:23:18 INFO - Successfully installed blessings 21:23:18 INFO - Cleaning up... 21:23:18 INFO - Return code: 0 21:23:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:23:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:18 INFO - Reading from file tmpfile_stdout 21:23:18 INFO - Current package versions: 21:23:18 INFO - blessings == 1.6 21:23:18 INFO - blobuploader == 1.2.4 21:23:18 INFO - docopt == 0.6.1 21:23:18 INFO - functools32 == 3.2.3-2 21:23:18 INFO - jsonschema == 2.5.1 21:23:18 INFO - manifestparser == 1.1 21:23:18 INFO - mozInstall == 1.12 21:23:18 INFO - mozcrash == 0.17 21:23:18 INFO - mozdebug == 0.1 21:23:18 INFO - mozdevice == 0.48 21:23:18 INFO - mozfile == 1.2 21:23:18 INFO - mozhttpd == 0.7 21:23:18 INFO - mozinfo == 0.9 21:23:18 INFO - mozleak == 0.1 21:23:18 INFO - mozlog == 3.3 21:23:18 INFO - moznetwork == 0.27 21:23:18 INFO - mozprocess == 0.23 21:23:18 INFO - mozprofile == 0.28 21:23:18 INFO - mozrunner == 6.12 21:23:18 INFO - mozscreenshot == 0.1 21:23:18 INFO - mozsystemmonitor == 0.3 21:23:18 INFO - moztest == 0.7 21:23:18 INFO - mozversion == 1.4 21:23:18 INFO - psutil == 3.1.1 21:23:18 INFO - requests == 1.2.3 21:23:18 INFO - wsgiref == 0.1.2 21:23:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:19 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 0x10d97ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c95f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8e2d30>, '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 0x10d647db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8dab20>, '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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 21:23:19 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 21:23:19 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 21:23:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AGK0Eb9Uzk/Render', 21:23:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:19 INFO - 'HOME': '/Users/cltbld', 21:23:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:19 INFO - 'LOGNAME': 'cltbld', 21:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:19 INFO - 'MOZ_NO_REMOTE': '1', 21:23:19 INFO - 'NO_EM_RESTART': '1', 21:23:19 INFO - 'PAGER': '/bin/cat', 21:23:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:19 INFO - 'PWD': '/builds/slave/test', 21:23:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:19 INFO - 'SHELL': '/bin/bash', 21:23:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OIVOhuPFSQ/Listeners', 21:23:19 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 21:23:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:19 INFO - 'USER': 'cltbld', 21:23:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:19 INFO - 'XPC_FLAGS': '0x0', 21:23:19 INFO - 'XPC_SERVICE_NAME': '0', 21:23:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:19 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)) 21:23:19 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)) 21:23:19 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)) 21:23:19 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)) 21:23:19 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)) 21:23:19 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)) 21:23:19 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)) 21:23:19 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)) 21:23:19 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)) 21:23:19 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)) 21:23:19 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)) 21:23:19 INFO - Cleaning up... 21:23:19 INFO - Return code: 0 21:23:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d97ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a9c95f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8e2d30>, '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 0x10d647db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8dab20>, '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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 21:23:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:23:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AGK0Eb9Uzk/Render', 21:23:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:19 INFO - 'HOME': '/Users/cltbld', 21:23:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:19 INFO - 'LOGNAME': 'cltbld', 21:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:19 INFO - 'MOZ_NO_REMOTE': '1', 21:23:19 INFO - 'NO_EM_RESTART': '1', 21:23:19 INFO - 'PAGER': '/bin/cat', 21:23:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:19 INFO - 'PWD': '/builds/slave/test', 21:23:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:19 INFO - 'SHELL': '/bin/bash', 21:23:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OIVOhuPFSQ/Listeners', 21:23:19 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 21:23:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:19 INFO - 'USER': 'cltbld', 21:23:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:19 INFO - 'XPC_FLAGS': '0x0', 21:23:19 INFO - 'XPC_SERVICE_NAME': '0', 21:23:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:23:19 INFO - Cleaning up... 21:23:19 INFO - Return code: 0 21:23:19 INFO - Running post-action listener: _resource_record_post_action 21:23:19 INFO - Running post-action listener: _start_resource_monitoring 21:23:19 INFO - Starting resource monitoring. 21:23:19 INFO - [mozharness: 2016-08-13 04:23:19.558251Z] Finished create-virtualenv step (success) 21:23:19 INFO - [mozharness: 2016-08-13 04:23:19.559216Z] Running install step. 21:23:19 INFO - Running pre-action listener: _resource_record_pre_action 21:23:19 INFO - Running main action method: install 21:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:19 INFO - Reading from file tmpfile_stdout 21:23:19 INFO - Detecting whether we're running mozinstall >=1.0... 21:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:23:19 INFO - Reading from file tmpfile_stdout 21:23:19 INFO - Output received: 21:23:19 INFO - Usage: mozinstall [options] installer 21:23:19 INFO - Options: 21:23:19 INFO - -h, --help show this help message and exit 21:23:19 INFO - -d DEST, --destination=DEST 21:23:19 INFO - Directory to install application into. [default: 21:23:19 INFO - "/builds/slave/test"] 21:23:19 INFO - --app=APP Application being installed. [default: firefox] 21:23:19 INFO - mkdir: /builds/slave/test/build/application 21:23:19 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'] 21:23:19 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 21:23:54 INFO - Reading from file tmpfile_stdout 21:23:54 INFO - Output received: 21:23:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:23:54 INFO - Running post-action listener: _resource_record_post_action 21:23:54 INFO - [mozharness: 2016-08-13 04:23:54.628154Z] Finished install step (success) 21:23:54 INFO - [mozharness: 2016-08-13 04:23:54.628267Z] Running run-tests step. 21:23:54 INFO - Running pre-action listener: _resource_record_pre_action 21:23:54 INFO - Running main action method: run_tests 21:23:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:23:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:23:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:23:54 INFO - 2016-08-12 21:23:54.642 screenresolution[6451:107561] starting screenresolution argv=screenresolution get 21:23:54 INFO - 2016-08-12 21:23:54.644 screenresolution[6451:107561] Display 0: 1600x1200x32@60 21:23:54 INFO - 2016-08-12 21:23:54.650 screenresolution[6452:107563] starting screenresolution argv=screenresolution list 21:23:54 INFO - Available Modes on Display 0 21:23:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:23:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:23:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:23:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:23:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:23:54 INFO - Intel Iris: 21:23:54 INFO - Chipset Model: Intel Iris 21:23:54 INFO - Type: GPU 21:23:54 INFO - Bus: Built-In 21:23:54 INFO - VRAM (Dynamic, Max): 1536 MB 21:23:54 INFO - Vendor: Intel (0x8086) 21:23:54 INFO - Device ID: 0x0a2e 21:23:54 INFO - Revision ID: 0x0009 21:23:54 INFO - Displays: 21:23:54 INFO - Display: 21:23:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:23:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:23:54 INFO - Display Serial Number: 1600x1200 60 21:23:54 INFO - Main Display: Yes 21:23:54 INFO - Mirror: Off 21:23:54 INFO - Online: Yes 21:23:54 INFO - Rotation: Supported 21:23:54 INFO - Return code: 0 21:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:23:54 INFO - Python 2.7.3 21:23:54 INFO - Return code: 0 21:23:54 INFO - grabbing minidump binary from tooltool 21:23: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')]} 21:23:54 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 0x10d8e2d30>, '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 0x10d647db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8dab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:23:54 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 21:23:54 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 21:23:54 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 21:23:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:23:54 INFO - Return code: 0 21:23:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:23:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:23:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:23:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:23:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:23:54 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/OdPFSTTsSjqY4144X9dEdQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0262', '--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 21:23:54 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/OdPFSTTsSjqY4144X9dEdQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0262 --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 21:23:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AGK0Eb9Uzk/Render', 21:23:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:54 INFO - 'HOME': '/Users/cltbld', 21:23:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:54 INFO - 'LOGNAME': 'cltbld', 21:23:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:23:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:54 INFO - 'MOZ_NO_REMOTE': '1', 21:23:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:23:54 INFO - 'NO_EM_RESTART': '1', 21:23:54 INFO - 'PAGER': '/bin/cat', 21:23:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:54 INFO - 'PWD': '/builds/slave/test', 21:23:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:23:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:54 INFO - 'SHELL': '/bin/bash', 21:23:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OIVOhuPFSQ/Listeners', 21:23:54 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 21:23:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:54 INFO - 'USER': 'cltbld', 21:23:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:54 INFO - 'XPC_FLAGS': '0x0', 21:23:54 INFO - 'XPC_SERVICE_NAME': '0', 21:23:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:54 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/OdPFSTTsSjqY4144X9dEdQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0262', '--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 21:23:55 INFO - mozversion application_buildid: 20160812164016 21:23:55 INFO - mozversion application_changeset: 1ba6215e84c3b34b928898331c3d444b3dd96ee3 21:23:55 INFO - mozversion application_display_name: Nightly 21:23:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:23:55 INFO - mozversion application_name: Firefox 21:23:55 INFO - mozversion application_remotingname: firefox 21:23:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:23:55 INFO - mozversion application_vendor: Mozilla 21:23:55 INFO - mozversion application_version: 51.0a1 21:23:55 INFO - mozversion platform_buildid: 20160812164016 21:23:55 INFO - mozversion platform_changeset: 1ba6215e84c3b34b928898331c3d444b3dd96ee3 21:23:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:23:55 INFO - mozversion platform_version: 51.0a1 21:23:55 INFO - using testdate: 1471062235 21:23:55 INFO - actual date: 1471062235 21:23:55 INFO - starting webserver on 'localhost:57412' 21:23:55 INFO - SUITE-START | Running 2 tests 21:23:55 INFO - TEST-START | dromaeo_css 21:23:55 INFO - operating with platform_type : mac_ 21:23:55 INFO - Initialising browser for dromaeo_css test... 21:23:55 INFO - TEST-INFO | started process 6462 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpkYcacN/profile http://localhost:57412/getInfo.html) 21:23:57 INFO - PROCESS | 6462 | __metrics Screen width/height:1600/1200 21:23:57 INFO - PROCESS | 6462 | colorDepth:24 21:23:57 INFO - PROCESS | 6462 | Browser inner width/height: 1024/689 21:23:57 INFO - PROCESS | 6462 | __metrics 21:23:58 ERROR - PROCESS | 6462 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 21:23:58 INFO - TEST-INFO | 6462: exit 0 21:23:58 INFO - Browser initialized. 21:23:58 INFO - Running cycle 1/1 for dromaeo_css test... 21:23:58 INFO - TEST-INFO | started process 6466 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpkYcacN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:24:10 INFO - PROCESS | 6466 | RSS: Main: 239259648 21:24:10 INFO - PROCESS | 6466 | 21:25:00 INFO - PROCESS | 6466 | 1471062300468 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] 21:27:12 INFO - PROCESS | 6466 | Cycle 1(1): loaded http://localhost:57412/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57412/tests/dromaeo/cssquery-ext.html) 21:27:13 INFO - PROCESS | 6466 | RSS: Main: 254218240 21:27:13 INFO - PROCESS | 6466 | 21:30:16 INFO - PROCESS | 6466 | Cycle 1(1): loaded http://localhost:57412/tests/dromaeo/cssquery-ext.html (next: http://localhost:57412/tests/dromaeo/cssquery-jquery.html) 21:30:16 INFO - PROCESS | 6466 | RSS: Main: 266485760 21:30:16 INFO - PROCESS | 6466 | 21:33:18 INFO - PROCESS | 6466 | Cycle 1(1): loaded http://localhost:57412/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57412/tests/dromaeo/cssquery-mootools.html) 21:33:19 INFO - PROCESS | 6466 | RSS: Main: 271204352 21:33:19 INFO - PROCESS | 6466 | 21:36:21 INFO - PROCESS | 6466 | Cycle 1(1): loaded http://localhost:57412/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57412/tests/dromaeo/cssquery-prototype.html) 21:36:21 INFO - PROCESS | 6466 | RSS: Main: 271142912 21:36:21 INFO - PROCESS | 6466 | 21:39:24 INFO - PROCESS | 6466 | Cycle 1(1): loaded http://localhost:57412/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57412/tests/dromaeo/cssquery-yui.html) 21:39:25 INFO - PROCESS | 6466 | RSS: Main: 275972096 21:39:25 INFO - PROCESS | 6466 | 21:42:28 INFO - PROCESS | 6466 | Cycle 1(1): loaded http://localhost:57412/tests/dromaeo/cssquery-yui.html (next: http://localhost:57412/tests/dromaeo/cssquery-dojo.html) 21:42:28 INFO - PROCESS | 6466 | RSS: Main: 278708224 21:42:28 INFO - PROCESS | 6466 | 21:42:28 INFO - PROCESS | 6466 | __start_tp_report 21:42:28 INFO - PROCESS | 6466 | _x_x_mozilla_page_load 21:42:28 INFO - PROCESS | 6466 | _x_x_mozilla_page_load_details 21:42:28 INFO - PROCESS | 6466 | |i|pagename|runs| 21:42:28 INFO - PROCESS | 6466 | |0;dojo.html;2870.3685189258363;3342.882999095032;3358.244395011124;3366.764326497146;3414.8634054637823;5683.062294721366;5704.600677952545;5719.256496655435;5772.769089236431;5843.328017278014;5629.831105066844;5666.631668941526;5673.574481913853;5742.6841523716175;5879.911801322984;5059.089363914503;5160;5166.302549155872;5237.135872581039;5265.8946821063555;4660.906781864378;5240.187770895517;5316.627836051478;5337.813176538822;5392.379876314215;4262.488501379854;5202.219667049935;5246.895062098756;5255.132903071008;5318;5262.789488420459;5270.1040823060175;5288.444713305124;5295.364556253275;5317.12267475866;5218.478152184751;5220.373555173365;5256.237845512417;5262.421133675292;5282.735863206863;5447.264619276426;5699.487046165865;5779.566532510079;5805.245318108618;5829.329627092896;6151.477124444427;6189.257289125334;6241;6246.0630905364105;6258.499320054385;6231.9688401557705;6245.156903818017;6246.87506249877;6269.090981807658;6273.905891411587;5772.451617096369;5804.854878628068;5870.119482077723;5881.970590147107;5942.97028514859;6264.561480696399;6265;6277.937220627735;6282.968585157045;6290.339514350927;6106.877862442815;6122.785702500391;6204.13142160098;6222.097795819672;6237.376262373817;6149.877002459926;6159.5072394208355;6181.474574661204;6208.099825525273;6246.094316324107;6237.500999919996;6252.718627661766;6275.748970041147;6289.056641503811;6297.559170858088;6219;6220.782272620527;6259.280182778948;6263.843403914939;6267.2165979252595;4936.185529387611;4950.331705219749;4971.178692108939;4980.078685443204;5010.248462730547;4448.799804008828;4491.955080449219;4497.887552811206;4506.459224892968;4530.524294949048;5678.290213723285;5730.7421166047625;5739.426057394227;5754.568407369464;5759.740811663485;5015.849524514198;5218.478152184751;6138.1738283688655;6177.289611694623;6182.505399568024;5762.942370576325;5766.221560089418;5780.421957804186;5797.130430435384;5815.3021637402935;4657.371254880615;5464.562834973192;5482.424345443751;5489.204065410493;5522.22688823565;6182.1345011698395;6255.186825712628;6282.654454005074;6315.27374351937;6317.778877739257;6246.531510136667;6249.718762655601;6252.937470625236;6266.624002559861;6269.62382257066;6323.620582765049;6338.429541341301;6343.238811342669;6353.078803573549;6368.904466432915;6084.482818960438;6127.830981140938;6174.135621012972;6211;6231.189945307081;6075.392460753889;6215.533834962486;6234.438900498977;6234.906476402767;6235.939890218764;5205.947940520547;6063.484603808549;6070.150178974859;6129.1112788644505;6194.0708893664505;4440.955590444183;6055.969720151371;6147.262328520606;6154.107654390178;6200.534959877937;5108.974455127701;5982.0727787193055;6056.06131049688;6074.787382441594;6084.178635884099;6142.293636231891;6143.969280153749;6197.690115494297;6216.875662486816;6221.595596286227;5951.018082016419;6014.36849130835;6051.4553690168095;6095.786647467317;6114.877702445837 21:42:28 INFO - PROCESS | 6466 | |1;ext.html;462.962962962963;476.8521758254941;506.5036264460828;545.4055079962844;551.9254900588419;36522;39243.99999999996;39313;39316.606833931655;39321.60678393219;40102.19795604086;40403.38386464538;40686.98282542938;40824.97937551563;40851.18297634045;9513.667021654244;9665.226781857435;9693.176080033205;9717.56270967808;9753.073458021512;9596;9710.854337184948;9720.416774993488;9721.659741909034;9754.268429867752;9664.80670386592;9714.222862171046;9734.51327433629;9741.512924353789;9790.706278811647;9685.079917407835;9711.854322185138;9723.65967191152;9736.464494452803;9759.609615615367;9568.33021688482;9621;9636.469994150319;9643.228541716646;9695.854562181574;38331.04172395685;38441.654542090895;38530.807345963374;38636.613633863584;38746.225075498616;2636.248669129308;3267.1995361136674;3301.7688761786685;3497.720182385403;3525.5416795816636;28650.426991460055;30034.69965300341;30036.948706795374;30137.698623013708;30903.38193236145;3107.5027995520836;3125.2030732163153;3136.38840426117;3212.7590430717555;3226.91932701682;432758;449034;450626;451667;455471;29067.273318167216;31779.205519861727;32424.35151296961;32530.674693253237;32574.348513029607;33414.665853341154;33466.99599012033;34148;35062.82468587641;35526.64473355285;16541.751873721903;16724.24740886663;16739.916300418663;16748.832511674726;16812.915935420246;12732.936335318263;12798.232106073665;12813;12832.80750788739;12869.970402367975;18096.638067238582;18467.261309547466;18507.889526628445;18508.44474665762;18516.722249166272;7370.926290737131;7405.333519983227;7476.476646634684;7480.139783924918;7524.2851929066655;715.1560363048613;907.9591418386188;910.4127837544746;962.8266911955915;997.4962643864802;30090.097297081124;30189.245268868453;30818;31547.84226078901;32179.35641287161;942.7407462947745;1013.2198207380276;1021.7292417509366;1044.6187141693226;1059.8659434405267;12719.87280127187;14535.127892326494;15195.468158614396;15486.922565387102;15518.9224053879;689777;698417;698531;700387;700393;51512.48487515152;52463.73768131135;53542.46457535375;53791.731041344545;54344.728276358364;1305.6017914535967;1346.0913883128849;1361.251311778518;1379.675776192594;1381.599336192493;28599.28501787472;28696.282592935342;28777.712222877504;29576;29764.70235297706;47863.5213647873;48388;48521.51478485311;48700.269495958295;49028.50971490239;592181;593942;594695;595416;595994;25321.493570128863;25452.745472545037;25679.614805777554;25685.3578660535;25847.741522584533;40963.59036409717;41290.55483058199;44171.77914110409;45176;45685.086298273185;30143.246418839706;30347.78608855621;35805;37206.25587488289;37844.50637817509;35717.46423803593;36880.81559592185;37040.81479592585;38038.85883423502;38272.808635956644;36748.81625591855;36784.44823327599;37921.81039094787;38521.422178667905;38710.41934371043;29346.853265733534;31884.7246110153;35022.64977350194;35140;35338;24931.62602560927;25338.873305633355;25364.873175634002;25666.871665641553;25682.357941051625 21:42:28 INFO - PROCESS | 6466 | |2;jquery.html;338.409475465313;359.3764818040699;367.1445531910649;372.07539264926635;390.71282607283644;19865.50336241593;20881.791182088175;21057.684134737992;21710.023048962776;22102.88948555255;20510.589788204226;20925.47686307843;21040.789592104073;21396.89301553494;21424.25015124471;5245.554127899133;5864.061750119981;5993.351828247223;6076.301225359096;6081.695915204245;5960.850978725523;6020.367861374559;6026.487748541357;6045.939540604581;6072.301685306202;5762;5851.853703657422;5859.824205273827;5886.970565147169;5938.52491800657;5799.246098007232;5903.527717782567;5903.881922361572;5908.409159084079;5935.851603709899;4979.601631869442;5166.844994650129;5175.430702622709;5182.32629758129;5193.272941788153;25748.97004119833;25917.74082259172;26062.609060864103;26359.604605930926;26713.198604041714;2187.9234226802146;2242.551489702066;2296.5751336002727;2387.725411577656;2756.9035083772173;15438.29829779784;15549;15780.605484862856;16049.438269660623;16463.670726585402;1622.772811806348;1863.515485973643;1896.3078476356168;1905.2759951218586;1921.1258877210976;114047;119000;119825.40087299507;119837.40081299625;120458;10410.531526081344;10538.631147909786;10628.574857005633;10924.449553895016;11155.27490713101;13603.795943060863;13693.794593081111;13720.313984300745;13728.65678358049;13729.588112356645;8289.4197406181;8433.608454605044;8492.787680308042;8564.143585641386;8701.17338852808;8521.488710677379;8536.402451828437;8566.700165494178;8796.648134074565;8840.823183536293;6511.73953041873;6599.274079851212;6637.535372523877;6645.501587380966;6681.164854393201;1793.3812834572052;1830.8626852986079;1835.1374853818684;1852.2405813616622;1867.1224524473748;889.5952341684518;892.9330300227379;903.3676426501476;913.55235934393;932.7901222225081;18980.715289270673;21779.328129216887;22498.437539061328;22534.704344479036;22689.886550567142;839.5214727605206;938.6433155400904;943.4009404028492;951.2390087929629;1006.8489726541078;11454.312741235553;11737;11945.940270298594;11967.102467314986;12068.637940861789;591877;592138;598103;598198;607160;83113.92215194668;93509;115665;120626;123162.38418807849;949.2453499467939;980.299086153418;1011.9949400253099;1014.5383850348074;1021.5709402051157;17149.74275385895;19238.326658566883;19506.512337191118;19571.51071223174;19777.70333445028;38397;45737;51727.67225474787;55358;57036.42963570477;82461.17538824775;82543;83101.16898830935;84621;85205.57397212974;7118.430525557839;7985.680572777024;8071.51570905724;8132.796680083045;8219.30135938428;10241.436720980417;12860.678483037998;13022.934885325512;13106.475740970636;13399.665008374868;11235.943820280847;11282.830757538479;11614.6515604532;11635.47640356203;11679.941600291944;9963.750906227402;10540.104091152338;11139.832902506307;11231.382273974683;11448.3703396314;11022.283551569442;11416.429178540873;11508.136889733136;11682.591109311134;11851.703707407383;7930.167332430012;8075.83848323042;8154.143814899588;8179.959100204461;8230.588470576327;9412.67055653049;11347.943260283646;11493;11522.42387880586;11543.884561154617 21:42:28 INFO - PROCESS | 6466 | |3;mootools.html;1355.3629793996822;1507.811523559555;1689.400262906668;1820.7997120316754;1863.9813601863987;7748;8332.875006874894;8550.786230344229;8886.977997530286;8898.955505222473;8467.491950482976;8705.173008564192;8745.562721863913;8750.737477875658;8794.16455436734;2309.976900230997;2336.0889253191267;2363.385519764865;2364.1016413762745;2377.239283429303;2315.8842057897123;2344.648302754592;2355.4582446037334;2369.4668699542635;2370.8103351731907;2332.346942856003;2337.135259953811;2350.459394339303;2354.0583766493455;2354.776296251862;2320.3271051395077;2332.8483648562874;2342.8594284342907;2343.4727186383097;2345.3081341004445;2316.513532158249;2322.744498105207;2327.104064934995;2328.7438381777993;2338.228384633084;7798.454108212427;8801.559922003938;8857.468551886908;8869.512176830272;8881.555922203928;4304.440422745054;5192.428832828386;5275.129603615399;5285.233641122054;5293.39126000511;3513.9824300878586;3592.3533763922483;3621.076625460517;3675.0261180786847;3696.149885526317;1057.302180560834;1099.8405231241504;1101.8567586213821;1110.8333749937494;1125.8029844777132;11119;11154.107671386351;11365.659030229106;11383.829242561369;11397.202195846212;4535.9773201133785;4633.837815676435;4771.093492236464;4792.257200133985;4808.61531077513;9759.170470509944;9805.80388392228;9810.264230182765;9836.262280329003;9838.212942964547;5230.476952304815;5282.207668849704;5308.177232528964;5308.203769434615;5319.175527793198;4400;4708.364370809897;4856.053069651384;4874.122657921608;4882.292067650242;3298.3073554553334;3844.3272427325105;3933.92132157361;3993.0815912340327;4025.2352053109817;1270.244204698203;1270.314030423561;1270.606112105232;1285.2095960984113;1297.202220634303;837.0917554453365;847.9109693482219;894.5035505294494;900.1763386501409;943.3113826906397;5589.692566908859;5651.547876169897;5771;5968.612040217372;5999.370066143079;947.6872632031414;949.2832911152174;968.9951550242345;979.740368802268;1008.742770593494;3284.261041265696;3736.7944763038295;3975.980120099381;3977.3238549446664;4042.8382864685673;10362.430066346424;10626.149908007495;10727.40999245049;10739.892601073889;10762.246642734934;10600.416977066336;10601;10715.732106697238;10744.301620394806;10750.301230419998;7464.925350746423;7716.5370077795515;8097.959510202293;8130.227628375414;8214.014318281845;5891.263592050994;5933.9109913352195;5939.554533410098;5997.910031349446;6146.354632763496;9839.5080245986;9872.45701486425;9907.51387291912;10039.447830369108;10080.798384032132;9832.360896541702;9992.500374981368;10048.542961270721;10085.243606729671;10280.845787313046;6875.621840798804;7425.851482970203;7523;7840.647170877438;8148.796280093045;8239.176082391712;8372.41393102477;8373.916260837314;8389.161083891562;8406.537640429835;7425.220351862977;7426.628668566442;7522.887156692764;7523.3229009389415;7547.886781698388;7220.0613920190035;7337.376323012603;7344.265573442613;7379.520331178456;7415.629218539159;6032.215811944419;6893.379595836399;6939.757108501179;6951.304869513008;7015.228324884157;4105.404716316058;4741.454732705783;4834.129856625841;4835.927461088157;4927.507249275187;4943.382077240345;5101.234814777813;5109.412417572027;5127.66670166438;5193.37679478465 21:42:28 INFO - PROCESS | 6466 | |4;prototype.html;302.96364436267646;308.48175065889313;309.8032749204255;317.13106089315266;317.9395914776194;5769.538436925046;5820.359760426355;5836.737346819393;5859.912101318473;5877.412258774126;5658.199191400263;5665.855450225134;5674.815196149481;5699.373068962411;5727.541796656268;3923.274194274054;4006.0786019215598;4084.1219137885423;4182.728122672017;4353.216421044211;4272.978635106821;4301.849435269766;4308.913821723564;4320.481542214923;4354.084202950708;3556.78659280444;3956.109875278054;4277.871663850074;4300.462442194726;4311.417958575584;3985.804258722401;4110.403991421242;4300.268954277749;4355.671520186342;4378.9562104378865;3019.4564978303897;3282.556854824592;3296.8186749728757;3393.506856982944;3733.533308336458;4598.631704672097;5580.386157522669;5583.888322233533;5603;5623.212750214973;4321.719088259285;4839.419269687624;4983.401991761012;5015.166430966492;5085.338905942241;5981.401859814027;5982.970085149546;6006.8498287542725;6034.909476357858;6048.39516048396;3811.275857587077;3993.101552150743;4137.565555616647;4150.398192262135;4173.561776013506;4985.476524964863;5471.932973070253;5716.685582292972;6351.333110023427;6393.648349340784;4050.974512743628;4055.4727885374714;4071.877843664695;4093.6111069448357;4110.280700877334;4141.192467468875;4155.2728272552185;4155.940235239995;4158.875233742992;4193.580641935782;4515.216489486635;4844.159219496569;4924.272698209687;4930.630202734809;4947.6289278304275;5327.786888524493;5551.584345991827;5976.234971967632;6042.879142417127;6048.334683184846;1385.8475567687547;1410.9506167284096;1416.553785557546;1416.5750274917484;1421.474054599784;801.8493461882217;845.8477474054729;860.6858496648678;865.5585651317873;897.8238507555124;5159.716215608178;5270.657407268515;5449.972750136224;5508.779648814083;5586.441355864462;5626.690532020696;5906.911396329058;6101.908471372844;6119.816405507842;6141.324454310023;5312.937412517512;5483.122700367922;5509.851158048365;5509.933774834437;5561.6663000220115;2709.403931135147;2720.687120981073;2842.3178437175343;3176.6029246344206;3228.9838550807094;4894.755262236874;5345.224942383333;6177.81466556004;6271.3728627136925;6286.717097730613;5220.014885784067;6137.478314343241;6222.666500062476;6256.374362563707;6284.209000434854;5860.765569377262;5949.757382226697;5988.790392336422;6260.154879091356;6290.496760259169;4930.619426560569;5793.9860524408905;6036.577439579188;6085.300190478151;6127.877442451037;5431;5539.8892022158525;5969.492593129633;6008.489278411384;6052.818415447544;5839.240898683144;6214.5960512566535;6301.527385446018;6312.928161335821;6313.747450101944;3521.7710848794745;3961.3265744824025;3967.6429121379215;3979.8607048753156;3999.580044095328;5418.9924591851905;5443.618946673695;6035.913535563641;6115;6118.357572454828;5206.9586082782835;5224.111900976767;5825.330087040044;5921.644701317935;5944.6730429826775;5459.7270136492225;5838.795642152504;5848.970755146197;5859.882802344015;5879.676617786063;4638.489766125656;5314.441983591822;5566.638168519034;5754.518516297747;5779.624324418899;4472.865814025585;5977.432143946318;5989.580729348903;6023.157537188919;6023.45788879003;5640.661560306395;5844.4155584442915;5883.941160588511;5905.557083218861;5930.584859059824 21:42:28 INFO - PROCESS | 6466 | |5;yui.html;605.5942518512593;657.4970147836906;667.3560014585923;669.8727241824056;727.4471401734681;15175.013624114425;15467.69064618707;15490.91563590549;15502.534923952286;15516;14209.502667406618;14236.359363828627;14325.78511322331;14327;14355.64110897228;671.2582596231167;821.9095899451056;829.3821103278051;836.7657056024323;860.1441565642194;841.2302742990187;846.6909578004015;854.8418542569644;857.6998050682274;858.6479543387212;875.8598624220126;897.7486303834937;902.1970446302796;902.3999040638;902.9638814447447;862.8878245828065;888.6711916590871;890.8173824366022;894.190757364586;897.9326550508738;658.2035736758528;659.304433822322;664.2626684380334;666.2072134160334;671.0839703804321;14366.784498232535;14457;14620.926895365561;14621.268936553237;14667.046641968345;13415.798763018562;14287.357068931922;14378.352974116086;14457.78313325301;14500.202488863108;11246.775064498746;11899.226550274205;11989.681135075134;12150.088743344197;12459;3888.6305800948867;3924.2543916655745;3936.9212615747524;4061.7969101544804;4071.348584226539;91329.54335228281;114890.42554787257;116907;119253;120251;11043.282186657842;11113;11145.665630031112;11153.832692509619;11351.091912646969;22144;22566;22570.661440078413;22570.887145564167;22715.864206789596;8173.795655108551;8215.465994710325;8359.414840961195;8484.745457636282;8504.65981360751;4493.146302202571;4581.496035436099;4681.32120842476;4791.401074865642;4800.73595952219;3247.886323978649;3300.752443566742;3341.298327351235;3349;3362.9663703363144;624.8406656302614;631.4916492223804;637.5664548107239;656.4617014048434;663.3996233408676;604.2054698072021;611.7308384310888;650.2099948562519;660.5640277416882;688.3495097133261;8923.553822308859;9490.952545237229;9496;9552.092551207625;9717.46553939526;620.4480683977125;631.4948041566728;641.6535071061575;673.1719984419192;686.5468790598181;3973.5827738087664;4521.864344069683;4596.287575425815;4604.677672562955;4608.700434471749;128474.71525284814;154673.22663386835;159501.25236850197;160093;161362;126451;128901;131307;134833;136417;82173.58913205395;99841;104339;104605;107120.46439767751;8723.607437665447;8876.644934202817;8883.511406872683;8902.530318909965;8977.865332020156;63224.367756321844;64289.35710643021;65394.34605653882;67169.66415167892;67308;90315;96444.0355596463;98858.50570747387;99686.5015674917;101738;10026.69919902404;11099.778004440028;11832.822507662564;12134.150609457252;12306.323152226714;14469;15021.173835439156;15084.547463576111;15119.470818521298;15136.091834489966;12141.635750927486;13127.237259687863;13620.318984050957;13861.09902856311;14141.222232777296;13645.863541364459;13692.3838427273;14223.431062757374;14435.711285774016;14575.708485830437;13293.867061329649;13618.591442256748;13852.16886986784;14055.134274167716;14150.292485375896;11117.44412779374;11304.208705390543;11549.480273387886;11903.226290291102;11995;10139.64511242103;10753.516091776046;10979.725506862073;11628.88371116278;11828.881711182778 21:42:28 INFO - PROCESS | 6466 | __end_tp_report 21:42:28 INFO - PROCESS | 6466 | __start_cc_report 21:42:28 INFO - PROCESS | 6466 | _x_x_mozilla_cycle_collect,422 21:42:28 INFO - PROCESS | 6466 | __end_cc_report 21:42:28 INFO - PROCESS | 6466 | __startTimestamp1471063348815__endTimestamp 21:42:28 INFO - PROCESS | 6466 | 21:42:28 INFO - PROCESS | 6466 | ------- Summary: start ------- 21:42:28 INFO - PROCESS | 6466 | Number of tests: 6 21:42:28 INFO - PROCESS | 6466 | 21:42:28 INFO - PROCESS | 6466 | [#0] dojo.html Cycles:165 Average:5727.38 Median:6014.37 stddev:671.27 (11.2%) stddev-sans-first:634.81 21:42:28 INFO - PROCESS | 6466 | Values: 2870.4 3342.9 3358.2 3366.8 3414.9 5683.1 5704.6 5719.3 5772.8 5843.3 5629.8 5666.6 5673.6 5742.7 5879.9 5059.1 5160.0 5166.3 5237.1 5265.9 4660.9 5240.2 5316.6 5337.8 5392.4 4262.5 5202.2 5246.9 5255.1 5318.0 5262.8 5270.1 5288.4 5295.4 5317.1 5218.5 5220.4 5256.2 5262.4 5282.7 5447.3 5699.5 5779.6 5805.2 5829.3 6151.5 6189.3 6241.0 6246.1 6258.5 6232.0 6245.2 6246.9 6269.1 6273.9 5772.5 5804.9 5870.1 5882.0 5943.0 6264.6 6265.0 6277.9 6283.0 6290.3 6106.9 6122.8 6204.1 6222.1 6237.4 6149.9 6159.5 6181.5 6208.1 6246.1 6237.5 6252.7 6275.7 6289.1 6297.6 6219.0 6220.8 6259.3 6263.8 6267.2 4936.2 4950.3 4971.2 4980.1 5010.2 4448.8 4492.0 4497.9 4506.5 4530.5 5678.3 5730.7 5739.4 5754.6 5759.7 5015.8 5218.5 6138.2 6177.3 6182.5 5762.9 5766.2 5780.4 5797.1 5815.3 4657.4 5464.6 5482.4 5489.2 5522.2 6182.1 6255.2 6282.7 6315.3 6317.8 6246.5 6249.7 6252.9 6266.6 6269.6 6323.6 6338.4 6343.2 6353.1 6368.9 6084.5 6127.8 6174.1 6211.0 6231.2 6075.4 6215.5 6234.4 6234.9 6235.9 5205.9 6063.5 6070.2 6129.1 6194.1 4441.0 6056.0 6147.3 6154.1 6200.5 5109.0 5982.1 6056.1 6074.8 6084.2 6142.3 6144.0 6197.7 6216.9 6221.6 5951.0 6014.4 6051.5 6095.8 6114.9 21:42:28 INFO - PROCESS | 6466 | 21:42:28 INFO - PROCESS | 6466 | [#1] ext.html Cycles:180 Average:68918.44 Median:37980.33 stddev:158037.66 (416.1%) stddev-sans-first:158397.42 21:42:28 INFO - PROCESS | 6466 | Values: 463.0 476.9 506.5 545.4 551.9 36522.0 39244.0 39313.0 39316.6 39321.6 40102.2 40403.4 40687.0 40825.0 40851.2 9513.7 9665.2 9693.2 9717.6 9753.1 9596.0 9710.9 9720.4 9721.7 9754.3 9664.8 9714.2 9734.5 9741.5 9790.7 9685.1 9711.9 9723.7 9736.5 9759.6 9568.3 9621.0 9636.5 9643.2 9695.9 38331.0 38441.7 38530.8 38636.6 38746.2 2636.2 3267.2 3301.8 3497.7 3525.5 28650.4 30034.7 30036.9 30137.7 30903.4 3107.5 3125.2 3136.4 3212.8 3226.9 432758.0 449034.0 450626.0 451667.0 455471.0 29067.3 31779.2 32424.4 32530.7 32574.3 33414.7 33467.0 34148.0 35062.8 35526.6 16541.8 16724.2 16739.9 16748.8 16812.9 12732.9 12798.2 12813.0 12832.8 12870.0 18096.6 18467.3 18507.9 18508.4 18516.7 7370.9 7405.3 7476.5 7480.1 7524.3 715.2 908.0 910.4 962.8 997.5 30090.1 30189.2 30818.0 31547.8 32179.4 942.7 1013.2 1021.7 1044.6 1059.9 12719.9 14535.1 15195.5 15486.9 15518.9 689777.0 698417.0 698531.0 700387.0 700393.0 51512.5 52463.7 53542.5 53791.7 54344.7 1305.6 1346.1 1361.3 1379.7 1381.6 28599.3 28696.3 28777.7 29576.0 29764.7 47863.5 48388.0 48521.5 48700.3 49028.5 592181.0 593942.0 594695.0 595416.0 595994.0 25321.5 25452.7 25679.6 25685.4 25847.7 40963.6 41290.6 44171.8 45176.0 45685.1 30143.2 30347.8 35805.0 37206.3 37844.5 35717.5 36880.8 37040.8 38038.9 38272.8 36748.8 36784.4 37921.8 38521.4 38710.4 29346.9 31884.7 35022.6 35140.0 35338.0 24931.6 25338.9 25364.9 25666.9 25682.4 21:42:28 INFO - PROCESS | 6466 | 21:42:28 INFO - PROCESS | 6466 | [#2] jquery.html Cycles:180 Average:34806.52 Median:25990.17 stddev:99301.67 (382.1%) stddev-sans-first:99546.51 21:42:28 INFO - PROCESS | 6466 | Values: 338.4 359.4 367.1 372.1 390.7 19865.5 20881.8 21057.7 21710.0 22102.9 20510.6 20925.5 21040.8 21396.9 21424.3 5245.6 5864.1 5993.4 6076.3 6081.7 5960.9 6020.4 6026.5 6045.9 6072.3 5762.0 5851.9 5859.8 5887.0 5938.5 5799.2 5903.5 5903.9 5908.4 5935.9 4979.6 5166.8 5175.4 5182.3 5193.3 25749.0 25917.7 26062.6 26359.6 26713.2 2187.9 2242.6 2296.6 2387.7 2756.9 15438.3 15549.0 15780.6 16049.4 16463.7 1622.8 1863.5 1896.3 1905.3 1921.1 114047.0 119000.0 119825.4 119837.4 120458.0 10410.5 10538.6 10628.6 10924.4 11155.3 13603.8 13693.8 13720.3 13728.7 13729.6 8289.4 8433.6 8492.8 8564.1 8701.2 8521.5 8536.4 8566.7 8796.6 8840.8 6511.7 6599.3 6637.5 6645.5 6681.2 1793.4 1830.9 1835.1 1852.2 1867.1 889.6 892.9 903.4 913.6 932.8 18980.7 21779.3 22498.4 22534.7 22689.9 839.5 938.6 943.4 951.2 1006.8 11454.3 11737.0 11945.9 11967.1 12068.6 591877.0 592138.0 598103.0 598198.0 607160.0 83113.9 93509.0 115665.0 120626.0 123162.4 949.2 980.3 1012.0 1014.5 1021.6 17149.7 19238.3 19506.5 19571.5 19777.7 38397.0 45737.0 51727.7 55358.0 57036.4 82461.2 82543.0 83101.2 84621.0 85205.6 7118.4 7985.7 8071.5 8132.8 8219.3 10241.4 12860.7 13022.9 13106.5 13399.7 11235.9 11282.8 11614.7 11635.5 11679.9 9963.8 10540.1 11139.8 11231.4 11448.4 11022.3 11416.4 11508.1 11682.6 11851.7 7930.2 8075.8 8154.1 8180.0 8230.6 9412.7 11347.9 11493.0 11522.4 11543.9 21:42:28 INFO - PROCESS | 6466 | 21:42:28 INFO - PROCESS | 6466 | [#3] mootools.html Cycles:180 Average:5663.33 Median:4904.90 stddev:3162.01 (64.5%) stddev-sans-first:3154.30 21:42:28 INFO - PROCESS | 6466 | Values: 1355.4 1507.8 1689.4 1820.8 1864.0 7748.0 8332.9 8550.8 8887.0 8899.0 8467.5 8705.2 8745.6 8750.7 8794.2 2310.0 2336.1 2363.4 2364.1 2377.2 2315.9 2344.6 2355.5 2369.5 2370.8 2332.3 2337.1 2350.5 2354.1 2354.8 2320.3 2332.8 2342.9 2343.5 2345.3 2316.5 2322.7 2327.1 2328.7 2338.2 7798.5 8801.6 8857.5 8869.5 8881.6 4304.4 5192.4 5275.1 5285.2 5293.4 3514.0 3592.4 3621.1 3675.0 3696.1 1057.3 1099.8 1101.9 1110.8 1125.8 11119.0 11154.1 11365.7 11383.8 11397.2 4536.0 4633.8 4771.1 4792.3 4808.6 9759.2 9805.8 9810.3 9836.3 9838.2 5230.5 5282.2 5308.2 5308.2 5319.2 4400.0 4708.4 4856.1 4874.1 4882.3 3298.3 3844.3 3933.9 3993.1 4025.2 1270.2 1270.3 1270.6 1285.2 1297.2 837.1 847.9 894.5 900.2 943.3 5589.7 5651.5 5771.0 5968.6 5999.4 947.7 949.3 969.0 979.7 1008.7 3284.3 3736.8 3976.0 3977.3 4042.8 10362.4 10626.1 10727.4 10739.9 10762.2 10600.4 10601.0 10715.7 10744.3 10750.3 7464.9 7716.5 8098.0 8130.2 8214.0 5891.3 5933.9 5939.6 5997.9 6146.4 9839.5 9872.5 9907.5 10039.4 10080.8 9832.4 9992.5 10048.5 10085.2 10280.8 6875.6 7425.9 7523.0 7840.6 8148.8 8239.2 8372.4 8373.9 8389.2 8406.5 7425.2 7426.6 7522.9 7523.3 7547.9 7220.1 7337.4 7344.3 7379.5 7415.6 6032.2 6893.4 6939.8 6951.3 7015.2 4105.4 4741.5 4834.1 4835.9 4927.5 4943.4 5101.2 5109.4 5127.7 5193.4 21:42:28 INFO - PROCESS | 6466 | 21:42:28 INFO - PROCESS | 6466 | [#4] prototype.html Cycles:180 Average:4795.86 Median:5477.53 stddev:1496.08 (27.3%) stddev-sans-first:1461.77 21:42:28 INFO - PROCESS | 6466 | Values: 303.0 308.5 309.8 317.1 317.9 5769.5 5820.4 5836.7 5859.9 5877.4 5658.2 5665.9 5674.8 5699.4 5727.5 3923.3 4006.1 4084.1 4182.7 4353.2 4273.0 4301.8 4308.9 4320.5 4354.1 3556.8 3956.1 4277.9 4300.5 4311.4 3985.8 4110.4 4300.3 4355.7 4379.0 3019.5 3282.6 3296.8 3393.5 3733.5 4598.6 5580.4 5583.9 5603.0 5623.2 4321.7 4839.4 4983.4 5015.2 5085.3 5981.4 5983.0 6006.8 6034.9 6048.4 3811.3 3993.1 4137.6 4150.4 4173.6 4985.5 5471.9 5716.7 6351.3 6393.6 4051.0 4055.5 4071.9 4093.6 4110.3 4141.2 4155.3 4155.9 4158.9 4193.6 4515.2 4844.2 4924.3 4930.6 4947.6 5327.8 5551.6 5976.2 6042.9 6048.3 1385.8 1411.0 1416.6 1416.6 1421.5 801.8 845.8 860.7 865.6 897.8 5159.7 5270.7 5450.0 5508.8 5586.4 5626.7 5906.9 6101.9 6119.8 6141.3 5312.9 5483.1 5509.9 5509.9 5561.7 2709.4 2720.7 2842.3 3176.6 3229.0 4894.8 5345.2 6177.8 6271.4 6286.7 5220.0 6137.5 6222.7 6256.4 6284.2 5860.8 5949.8 5988.8 6260.2 6290.5 4930.6 5794.0 6036.6 6085.3 6127.9 5431.0 5539.9 5969.5 6008.5 6052.8 5839.2 6214.6 6301.5 6312.9 6313.7 3521.8 3961.3 3967.6 3979.9 3999.6 5419.0 5443.6 6035.9 6115.0 6118.4 5207.0 5224.1 5825.3 5921.6 5944.7 5459.7 5838.8 5849.0 5859.9 5879.7 4638.5 5314.4 5566.6 5754.5 5779.6 4472.9 5977.4 5989.6 6023.2 6023.5 5640.7 5844.4 5883.9 5905.6 5930.6 21:42:28 INFO - PROCESS | 6466 | 21:42:28 INFO - PROCESS | 6466 | [#5] yui.html Cycles:180 Average:25102.54 Median:3345.15 stddev:40198.76 (1201.7%) stddev-sans-first:40269.45 21:42:28 INFO - PROCESS | 6466 | Values: 605.6 657.5 667.4 669.9 727.4 15175.0 15467.7 15490.9 15502.5 15516.0 14209.5 14236.4 14325.8 14327.0 14355.6 671.3 821.9 829.4 836.8 860.1 841.2 846.7 854.8 857.7 858.6 875.9 897.7 902.2 902.4 903.0 862.9 888.7 890.8 894.2 897.9 658.2 659.3 664.3 666.2 671.1 14366.8 14457.0 14620.9 14621.3 14667.0 13415.8 14287.4 14378.4 14457.8 14500.2 11246.8 11899.2 11989.7 12150.1 12459.0 3888.6 3924.3 3936.9 4061.8 4071.3 91329.5 114890.4 116907.0 119253.0 120251.0 11043.3 11113.0 11145.7 11153.8 11351.1 22144.0 22566.0 22570.7 22570.9 22715.9 8173.8 8215.5 8359.4 8484.7 8504.7 4493.1 4581.5 4681.3 4791.4 4800.7 3247.9 3300.8 3341.3 3349.0 3363.0 624.8 631.5 637.6 656.5 663.4 604.2 611.7 650.2 660.6 688.3 8923.6 9491.0 9496.0 9552.1 9717.5 620.4 631.5 641.7 673.2 686.5 3973.6 4521.9 4596.3 4604.7 4608.7 128474.7 154673.2 159501.3 160093.0 161362.0 126451.0 128901.0 131307.0 134833.0 136417.0 82173.6 99841.0 104339.0 104605.0 107120.5 8723.6 8876.6 8883.5 8902.5 8977.9 63224.4 64289.4 65394.3 67169.7 67308.0 90315.0 96444.0 98858.5 99686.5 101738.0 10026.7 11099.8 11832.8 12134.2 12306.3 14469.0 15021.2 15084.5 15119.5 15136.1 12141.6 13127.2 13620.3 13861.1 14141.2 13645.9 13692.4 14223.4 14435.7 14575.7 13293.9 13618.6 13852.2 14055.1 14150.3 11117.4 11304.2 11549.5 11903.2 11995.0 10139.6 10753.5 10979.7 11628.9 11828.9 21:42:28 INFO - PROCESS | 6466 | -------- Summary: end -------- 21:42:28 INFO - PROCESS | 6466 | 21:42:29 INFO - TEST-INFO | 6466: exit 0 21:42:29 INFO - TEST-OK | dromaeo_css | took 1114275ms 21:42:29 INFO - TEST-START | kraken 21:42:29 INFO - operating with platform_type : mac_ 21:42:29 INFO - Initialising browser for kraken test... 21:42:29 INFO - TEST-INFO | started process 6471 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpxkLJzI/profile http://localhost:57412/getInfo.html) 21:42:32 INFO - PROCESS | 6471 | __metrics Screen width/height:1600/1200 21:42:32 INFO - PROCESS | 6471 | colorDepth:24 21:42:32 INFO - PROCESS | 6471 | Browser inner width/height: 1024/689 21:42:32 INFO - PROCESS | 6471 | __metrics 21:42:32 ERROR - PROCESS | 6471 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 21:42:33 INFO - TEST-INFO | 6471: exit 0 21:42:33 INFO - Browser initialized. 21:42:33 INFO - Running cycle 1/1 for kraken test... 21:42:33 INFO - TEST-INFO | started process 6473 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpxkLJzI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:45 INFO - PROCESS | 6473 | RSS: Main: 239624192 21:42:45 INFO - PROCESS | 6473 | 21:42:48 INFO - PROCESS | 6473 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57412/tests/kraken/driver.html?testName=audio-beat-detection) 21:42:49 INFO - PROCESS | 6473 | RSS: Main: 252727296 21:42:49 INFO - PROCESS | 6473 | 21:42:51 INFO - PROCESS | 6473 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57412/tests/kraken/driver.html?testName=audio-dft) 21:42:52 INFO - PROCESS | 6473 | RSS: Main: 261361664 21:42:52 INFO - PROCESS | 6473 | 21:42:55 INFO - PROCESS | 6473 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57412/tests/kraken/driver.html?testName=audio-fft) 21:42:56 INFO - PROCESS | 6473 | RSS: Main: 264458240 21:42:56 INFO - PROCESS | 6473 | 21:42:58 INFO - PROCESS | 6473 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57412/tests/kraken/driver.html?testName=audio-oscillator) 21:42:59 INFO - PROCESS | 6473 | RSS: Main: 266821632 21:42:59 INFO - PROCESS | 6473 | 21:43:01 INFO - PROCESS | 6473 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57412/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:43:02 INFO - PROCESS | 6473 | RSS: Main: 267993088 21:43:02 INFO - PROCESS | 6473 | 21:43:05 INFO - PROCESS | 6473 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57412/tests/kraken/driver.html?testName=imaging-darkroom) 21:43:05 INFO - PROCESS | 6473 | RSS: Main: 267481088 21:43:05 INFO - PROCESS | 6473 | 21:43:08 INFO - PROCESS | 6473 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57412/tests/kraken/driver.html?testName=imaging-desaturate) 21:43:09 INFO - PROCESS | 6473 | RSS: Main: 267890688 21:43:09 INFO - PROCESS | 6473 | 21:43:12 INFO - PROCESS | 6473 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57412/tests/kraken/driver.html?testName=json-parse-financial) 21:43:13 INFO - PROCESS | 6473 | RSS: Main: 268050432 21:43:13 INFO - PROCESS | 6473 | 21:43:14 INFO - PROCESS | 6473 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57412/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:43:15 INFO - PROCESS | 6473 | RSS: Main: 267653120 21:43:15 INFO - PROCESS | 6473 | 21:43:17 INFO - PROCESS | 6473 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:43:17 INFO - PROCESS | 6473 | RSS: Main: 267804672 21:43:17 INFO - PROCESS | 6473 | 21:43:20 INFO - PROCESS | 6473 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:43:20 INFO - PROCESS | 6473 | RSS: Main: 268124160 21:43:20 INFO - PROCESS | 6473 | 21:43:23 INFO - PROCESS | 6473 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:43:24 INFO - PROCESS | 6473 | RSS: Main: 268181504 21:43:24 INFO - PROCESS | 6473 | 21:43:27 INFO - PROCESS | 6473 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:43:27 INFO - PROCESS | 6473 | RSS: Main: 268247040 21:43:27 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57412/tests/kraken/driver.html?testName=ai-astar) 21:43:29 INFO - PROCESS | 6473 | RSS: Main: 269320192 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | __start_tp_report 21:43:29 INFO - PROCESS | 6473 | _x_x_mozilla_page_load 21:43:29 INFO - PROCESS | 6473 | _x_x_mozilla_page_load_details 21:43:29 INFO - PROCESS | 6473 | |i|pagename|runs| 21:43:29 INFO - PROCESS | 6473 | |0;ai-astar;106;122;110;122;106;173;168;117;116;117 21:43:29 INFO - PROCESS | 6473 | |1;audio-beat-detection;148;113;138;165;109;137;135;112;165;100 21:43:29 INFO - PROCESS | 6473 | |2;audio-dft;201;244;274;279;245;207;234;198;196;207 21:43:29 INFO - PROCESS | 6473 | |3;audio-fft;72;83;77;152;60;72;83;84;163;61 21:43:29 INFO - PROCESS | 6473 | |4;audio-oscillator;82;93;142;57;102;112;152;57;85;151 21:43:29 INFO - PROCESS | 6473 | |5;imaging-gaussian-blur;90;79;134;87;90;87;90;88;81;122 21:43:29 INFO - PROCESS | 6473 | |6;imaging-darkroom;93;150;140;96;116;152;103;151;111;150 21:43:29 INFO - PROCESS | 6473 | |7;imaging-desaturate;90;123;128;90;92;92;92;92;91;91 21:43:29 INFO - PROCESS | 6473 | |8;json-parse-financial;56;59;63;60;60;61;58;57;56;60 21:43:29 INFO - PROCESS | 6473 | |9;json-stringify-tinderbox;68;73;68;80;80;74;77;76;74;73 21:43:29 INFO - PROCESS | 6473 | |10;stanford-crypto-aes;88;91;91;91;87;87;92;87;110;108 21:43:29 INFO - PROCESS | 6473 | |11;stanford-crypto-ccm;141;138;144;141;135;141;139;140;157;140 21:43:29 INFO - PROCESS | 6473 | |12;stanford-crypto-pbkdf2;188;171;171;199;179;171;170;172;172;173 21:43:29 INFO - PROCESS | 6473 | |13;stanford-crypto-sha256-iterative;69;71;69;69;70;67;70;69;68;68 21:43:29 INFO - PROCESS | 6473 | __end_tp_report 21:43:29 INFO - PROCESS | 6473 | __start_cc_report 21:43:29 INFO - PROCESS | 6473 | _x_x_mozilla_cycle_collect,1042 21:43:29 INFO - PROCESS | 6473 | __end_cc_report 21:43:29 INFO - PROCESS | 6473 | __startTimestamp1471063409886__endTimestamp 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | ------- Summary: start ------- 21:43:29 INFO - PROCESS | 6473 | Number of tests: 14 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | [#0] ai-astar Cycles:10 Average:125.70 Median:119.50 stddev:24.32 (20.3%) stddev-sans-first:24.73 21:43:29 INFO - PROCESS | 6473 | Values: 106.0 122.0 110.0 122.0 106.0 173.0 168.0 117.0 116.0 117.0 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | [#1] audio-beat-detection Cycles:10 Average:132.20 Median:137.50 stddev:23.14 (16.8%) stddev-sans-first:23.82 21:43:29 INFO - PROCESS | 6473 | Values: 148.0 113.0 138.0 165.0 109.0 137.0 135.0 112.0 165.0 100.0 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | [#2] audio-dft Cycles:10 Average:228.50 Median:239.00 stddev:31.32 (13.1%) stddev-sans-first:31.60 21:43:29 INFO - PROCESS | 6473 | Values: 201.0 244.0 274.0 279.0 245.0 207.0 234.0 198.0 196.0 207.0 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | [#3] audio-fft Cycles:10 Average:90.70 Median:74.50 stddev:36.30 (48.7%) stddev-sans-first:37.87 21:43:29 INFO - PROCESS | 6473 | Values: 72.0 83.0 77.0 152.0 60.0 72.0 83.0 84.0 163.0 61.0 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:57.00 stddev:35.60 (62.5%) stddev-sans-first:36.91 21:43:29 INFO - PROCESS | 6473 | Values: 82.0 93.0 142.0 57.0 102.0 112.0 152.0 57.0 85.0 151.0 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:87.50 stddev:18.12 (20.7%) stddev-sans-first:19.13 21:43:29 INFO - PROCESS | 6473 | Values: 90.0 79.0 134.0 87.0 90.0 87.0 90.0 88.0 81.0 122.0 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | [#6] imaging-darkroom Cycles:10 Average:126.20 Median:150.50 stddev:24.70 (16.4%) stddev-sans-first:23.09 21:43:29 INFO - PROCESS | 6473 | Values: 93.0 150.0 140.0 96.0 116.0 152.0 103.0 151.0 111.0 150.0 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | [#7] imaging-desaturate Cycles:10 Average:98.10 Median:91.50 stddev:14.51 (15.9%) stddev-sans-first:15.09 21:43:29 INFO - PROCESS | 6473 | Values: 90.0 123.0 128.0 90.0 92.0 92.0 92.0 92.0 91.0 91.0 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:60.00 stddev:2.26 (3.8%) stddev-sans-first:2.12 21:43:29 INFO - PROCESS | 6473 | Values: 56.0 59.0 63.0 60.0 60.0 61.0 58.0 57.0 56.0 60.0 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | [#9] json-stringify-tinderbox Cycles:10 Average:74.30 Median:75.00 stddev:4.19 (5.6%) stddev-sans-first:3.77 21:43:29 INFO - PROCESS | 6473 | Values: 68.0 73.0 68.0 80.0 80.0 74.0 77.0 76.0 74.0 73.0 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | [#10] stanford-crypto-aes Cycles:10 Average:93.20 Median:89.50 stddev:8.56 (9.6%) stddev-sans-first:8.87 21:43:29 INFO - PROCESS | 6473 | Values: 88.0 91.0 91.0 91.0 87.0 87.0 92.0 87.0 110.0 108.0 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:141.00 stddev:5.89 (4.2%) stddev-sans-first:6.24 21:43:29 INFO - PROCESS | 6473 | Values: 141.0 138.0 144.0 141.0 135.0 141.0 139.0 140.0 157.0 140.0 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:172.50 stddev:9.61 (5.6%) stddev-sans-first:9.26 21:43:29 INFO - PROCESS | 6473 | Values: 188.0 171.0 171.0 199.0 179.0 171.0 170.0 172.0 172.0 173.0 21:43:29 INFO - PROCESS | 6473 | 21:43:29 INFO - PROCESS | 6473 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.15 (1.7%) stddev-sans-first:1.22 21:43:29 INFO - PROCESS | 6473 | Values: 69.0 71.0 69.0 69.0 70.0 67.0 70.0 69.0 68.0 68.0 21:43:29 INFO - PROCESS | 6473 | -------- Summary: end -------- 21:43:29 INFO - PROCESS | 6473 | 21:43:30 INFO - TEST-INFO | 6473: exit 0 21:43:30 INFO - TEST-OK | kraken | took 61235ms 21:43:30 INFO - SUITE-END | took 1175s 21:43:31 INFO - Completed test suite (00:19:35) 21:43:31 INFO - javascript benchmark 21:43:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7377.153443254292, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2870.3685189258363, 3342.882999095032, 3358.244395011124, 3366.764326497146, 3414.8634054637823, 5683.062294721366, 5704.600677952545, 5719.256496655435, 5772.769089236431, 5843.328017278014, 5629.831105066844, 5666.631668941526, 5673.574481913853, 5742.6841523716175, 5879.911801322984, 5059.089363914503, 5160.0, 5166.302549155872, 5237.135872581039, 5265.8946821063555, 4660.906781864378, 5240.187770895517, 5316.627836051478, 5337.813176538822, 5392.379876314215, 4262.488501379854, 5202.219667049935, 5246.895062098756, 5255.132903071008, 5318.0, 5262.789488420459, 5270.1040823060175, 5288.444713305124, 5295.364556253275, 5317.12267475866, 5218.478152184751, 5220.373555173365, 5256.237845512417, 5262.421133675292, 5282.735863206863, 5447.264619276426, 5699.487046165865, 5779.566532510079, 5805.245318108618, 5829.329627092896, 6151.477124444427, 6189.257289125334, 6241.0, 6246.0630905364105, 6258.499320054385, 6231.9688401557705, 6245.156903818017, 6246.87506249877, 6269.090981807658, 6273.905891411587, 5772.451617096369, 5804.854878628068, 5870.119482077723, 5881.970590147107, 5942.97028514859, 6264.561480696399, 6265.0, 6277.937220627735, 6282.968585157045, 6290.339514350927, 6106.877862442815, 6122.785702500391, 6204.13142160098, 6222.097795819672, 6237.376262373817, 6149.877002459926, 6159.5072394208355, 6181.474574661204, 6208.099825525273, 6246.094316324107, 6237.500999919996, 6252.718627661766, 6275.748970041147, 6289.056641503811, 6297.559170858088, 6219.0, 6220.782272620527, 6259.280182778948, 6263.843403914939, 6267.2165979252595, 4936.185529387611, 4950.331705219749, 4971.178692108939, 4980.078685443204, 5010.248462730547, 4448.799804008828, 4491.955080449219, 4497.887552811206, 4506.459224892968, 4530.524294949048, 5678.290213723285, 5730.7421166047625, 5739.426057394227, 5754.568407369464, 5759.740811663485, 5015.849524514198, 5218.478152184751, 6138.1738283688655, 6177.289611694623, 6182.505399568024, 5762.942370576325, 5766.221560089418, 5780.421957804186, 5797.130430435384, 5815.3021637402935, 4657.371254880615, 5464.562834973192, 5482.424345443751, 5489.204065410493, 5522.22688823565, 6182.1345011698395, 6255.186825712628, 6282.654454005074, 6315.27374351937, 6317.778877739257, 6246.531510136667, 6249.718762655601, 6252.937470625236, 6266.624002559861, 6269.62382257066, 6323.620582765049, 6338.429541341301, 6343.238811342669, 6353.078803573549, 6368.904466432915, 6084.482818960438, 6127.830981140938, 6174.135621012972, 6211.0, 6231.189945307081, 6075.392460753889, 6215.533834962486, 6234.438900498977, 6234.906476402767, 6235.939890218764, 5205.947940520547, 6063.484603808549, 6070.150178974859, 6129.1112788644505, 6194.0708893664505, 4440.955590444183, 6055.969720151371, 6147.262328520606, 6154.107654390178, 6200.534959877937, 5108.974455127701, 5982.0727787193055, 6056.06131049688, 6074.787382441594, 6084.178635884099, 6142.293636231891, 6143.969280153749, 6197.690115494297, 6216.875662486816, 6221.595596286227, 5951.018082016419, 6014.36849130835, 6051.4553690168095, 6095.786647467317, 6114.877702445837], "value": 5684.85770481935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [462.962962962963, 476.8521758254941, 506.5036264460828, 545.4055079962844, 551.9254900588419, 36522.0, 39243.99999999996, 39313.0, 39316.606833931655, 39321.60678393219, 40102.19795604086, 40403.38386464538, 40686.98282542938, 40824.97937551563, 40851.18297634045, 9513.667021654244, 9665.226781857435, 9693.176080033205, 9717.56270967808, 9753.073458021512, 9596.0, 9710.854337184948, 9720.416774993488, 9721.659741909034, 9754.268429867752, 9664.80670386592, 9714.222862171046, 9734.51327433629, 9741.512924353789, 9790.706278811647, 9685.079917407835, 9711.854322185138, 9723.65967191152, 9736.464494452803, 9759.609615615367, 9568.33021688482, 9621.0, 9636.469994150319, 9643.228541716646, 9695.854562181574, 38331.04172395685, 38441.654542090895, 38530.807345963374, 38636.613633863584, 38746.225075498616, 2636.248669129308, 3267.1995361136674, 3301.7688761786685, 3497.720182385403, 3525.5416795816636, 28650.426991460055, 30034.69965300341, 30036.948706795374, 30137.698623013708, 30903.38193236145, 3107.5027995520836, 3125.2030732163153, 3136.38840426117, 3212.7590430717555, 3226.91932701682, 432758.0, 449034.0, 450626.0, 451667.0, 455471.0, 29067.273318167216, 31779.205519861727, 32424.35151296961, 32530.674693253237, 32574.348513029607, 33414.665853341154, 33466.99599012033, 34148.0, 35062.82468587641, 35526.64473355285, 16541.751873721903, 16724.24740886663, 16739.916300418663, 16748.832511674726, 16812.915935420246, 12732.936335318263, 12798.232106073665, 12813.0, 12832.80750788739, 12869.970402367975, 18096.638067238582, 18467.261309547466, 18507.889526628445, 18508.44474665762, 18516.722249166272, 7370.926290737131, 7405.333519983227, 7476.476646634684, 7480.139783924918, 7524.2851929066655, 715.1560363048613, 907.9591418386188, 910.4127837544746, 962.8266911955915, 997.4962643864802, 30090.097297081124, 30189.245268868453, 30818.0, 31547.84226078901, 32179.35641287161, 942.7407462947745, 1013.2198207380276, 1021.7292417509366, 1044.6187141693226, 1059.8659434405267, 12719.87280127187, 14535.127892326494, 15195.468158614396, 15486.922565387102, 15518.9224053879, 689777.0, 698417.0, 698531.0, 700387.0, 700393.0, 51512.48487515152, 52463.73768131135, 53542.46457535375, 53791.731041344545, 54344.728276358364, 1305.6017914535967, 1346.0913883128849, 1361.251311778518, 1379.675776192594, 1381.599336192493, 28599.28501787472, 28696.282592935342, 28777.712222877504, 29576.0, 29764.70235297706, 47863.5213647873, 48388.0, 48521.51478485311, 48700.269495958295, 49028.50971490239, 592181.0, 593942.0, 594695.0, 595416.0, 595994.0, 25321.493570128863, 25452.745472545037, 25679.614805777554, 25685.3578660535, 25847.741522584533, 40963.59036409717, 41290.55483058199, 44171.77914110409, 45176.0, 45685.086298273185, 30143.246418839706, 30347.78608855621, 35805.0, 37206.25587488289, 37844.50637817509, 35717.46423803593, 36880.81559592185, 37040.81479592585, 38038.85883423502, 38272.808635956644, 36748.81625591855, 36784.44823327599, 37921.81039094787, 38521.422178667905, 38710.41934371043, 29346.853265733534, 31884.7246110153, 35022.64977350194, 35140.0, 35338.0, 24931.62602560927, 25338.873305633355, 25364.873175634002, 25666.871665641553, 25682.357941051625], "value": 18915.18332428479, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.409475465313, 359.3764818040699, 367.1445531910649, 372.07539264926635, 390.71282607283644, 19865.50336241593, 20881.791182088175, 21057.684134737992, 21710.023048962776, 22102.88948555255, 20510.589788204226, 20925.47686307843, 21040.789592104073, 21396.89301553494, 21424.25015124471, 5245.554127899133, 5864.061750119981, 5993.351828247223, 6076.301225359096, 6081.695915204245, 5960.850978725523, 6020.367861374559, 6026.487748541357, 6045.939540604581, 6072.301685306202, 5762.0, 5851.853703657422, 5859.824205273827, 5886.970565147169, 5938.52491800657, 5799.246098007232, 5903.527717782567, 5903.881922361572, 5908.409159084079, 5935.851603709899, 4979.601631869442, 5166.844994650129, 5175.430702622709, 5182.32629758129, 5193.272941788153, 25748.97004119833, 25917.74082259172, 26062.609060864103, 26359.604605930926, 26713.198604041714, 2187.9234226802146, 2242.551489702066, 2296.5751336002727, 2387.725411577656, 2756.9035083772173, 15438.29829779784, 15549.0, 15780.605484862856, 16049.438269660623, 16463.670726585402, 1622.772811806348, 1863.515485973643, 1896.3078476356168, 1905.2759951218586, 1921.1258877210976, 114047.0, 119000.0, 119825.40087299507, 119837.40081299625, 120458.0, 10410.531526081344, 10538.631147909786, 10628.574857005633, 10924.449553895016, 11155.27490713101, 13603.795943060863, 13693.794593081111, 13720.313984300745, 13728.65678358049, 13729.588112356645, 8289.4197406181, 8433.608454605044, 8492.787680308042, 8564.143585641386, 8701.17338852808, 8521.488710677379, 8536.402451828437, 8566.700165494178, 8796.648134074565, 8840.823183536293, 6511.73953041873, 6599.274079851212, 6637.535372523877, 6645.501587380966, 6681.164854393201, 1793.3812834572052, 1830.8626852986079, 1835.1374853818684, 1852.2405813616622, 1867.1224524473748, 889.5952341684518, 892.9330300227379, 903.3676426501476, 913.55235934393, 932.7901222225081, 18980.715289270673, 21779.328129216887, 22498.437539061328, 22534.704344479036, 22689.886550567142, 839.5214727605206, 938.6433155400904, 943.4009404028492, 951.2390087929629, 1006.8489726541078, 11454.312741235553, 11737.0, 11945.940270298594, 11967.102467314986, 12068.637940861789, 591877.0, 592138.0, 598103.0, 598198.0, 607160.0, 83113.92215194668, 93509.0, 115665.0, 120626.0, 123162.38418807849, 949.2453499467939, 980.299086153418, 1011.9949400253099, 1014.5383850348074, 1021.5709402051157, 17149.74275385895, 19238.326658566883, 19506.512337191118, 19571.51071223174, 19777.70333445028, 38397.0, 45737.0, 51727.67225474787, 55358.0, 57036.42963570477, 82461.17538824775, 82543.0, 83101.16898830935, 84621.0, 85205.57397212974, 7118.430525557839, 7985.680572777024, 8071.51570905724, 8132.796680083045, 8219.30135938428, 10241.436720980417, 12860.678483037998, 13022.934885325512, 13106.475740970636, 13399.665008374868, 11235.943820280847, 11282.830757538479, 11614.6515604532, 11635.47640356203, 11679.941600291944, 9963.750906227402, 10540.104091152338, 11139.832902506307, 11231.382273974683, 11448.3703396314, 11022.283551569442, 11416.429178540873, 11508.136889733136, 11682.591109311134, 11851.703707407383, 7930.167332430012, 8075.83848323042, 8154.143814899588, 8179.959100204461, 8230.588470576327, 9412.67055653049, 11347.943260283646, 11493.0, 11522.42387880586, 11543.884561154617], "value": 9752.001515442886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.3629793996822, 1507.811523559555, 1689.400262906668, 1820.7997120316754, 1863.9813601863987, 7748.0, 8332.875006874894, 8550.786230344229, 8886.977997530286, 8898.955505222473, 8467.491950482976, 8705.173008564192, 8745.562721863913, 8750.737477875658, 8794.16455436734, 2309.976900230997, 2336.0889253191267, 2363.385519764865, 2364.1016413762745, 2377.239283429303, 2315.8842057897123, 2344.648302754592, 2355.4582446037334, 2369.4668699542635, 2370.8103351731907, 2332.346942856003, 2337.135259953811, 2350.459394339303, 2354.0583766493455, 2354.776296251862, 2320.3271051395077, 2332.8483648562874, 2342.8594284342907, 2343.4727186383097, 2345.3081341004445, 2316.513532158249, 2322.744498105207, 2327.104064934995, 2328.7438381777993, 2338.228384633084, 7798.454108212427, 8801.559922003938, 8857.468551886908, 8869.512176830272, 8881.555922203928, 4304.440422745054, 5192.428832828386, 5275.129603615399, 5285.233641122054, 5293.39126000511, 3513.9824300878586, 3592.3533763922483, 3621.076625460517, 3675.0261180786847, 3696.149885526317, 1057.302180560834, 1099.8405231241504, 1101.8567586213821, 1110.8333749937494, 1125.8029844777132, 11119.0, 11154.107671386351, 11365.659030229106, 11383.829242561369, 11397.202195846212, 4535.9773201133785, 4633.837815676435, 4771.093492236464, 4792.257200133985, 4808.61531077513, 9759.170470509944, 9805.80388392228, 9810.264230182765, 9836.262280329003, 9838.212942964547, 5230.476952304815, 5282.207668849704, 5308.177232528964, 5308.203769434615, 5319.175527793198, 4400.0, 4708.364370809897, 4856.053069651384, 4874.122657921608, 4882.292067650242, 3298.3073554553334, 3844.3272427325105, 3933.92132157361, 3993.0815912340327, 4025.2352053109817, 1270.244204698203, 1270.314030423561, 1270.606112105232, 1285.2095960984113, 1297.202220634303, 837.0917554453365, 847.9109693482219, 894.5035505294494, 900.1763386501409, 943.3113826906397, 5589.692566908859, 5651.547876169897, 5771.0, 5968.612040217372, 5999.370066143079, 947.6872632031414, 949.2832911152174, 968.9951550242345, 979.740368802268, 1008.742770593494, 3284.261041265696, 3736.7944763038295, 3975.980120099381, 3977.3238549446664, 4042.8382864685673, 10362.430066346424, 10626.149908007495, 10727.40999245049, 10739.892601073889, 10762.246642734934, 10600.416977066336, 10601.0, 10715.732106697238, 10744.301620394806, 10750.301230419998, 7464.925350746423, 7716.5370077795515, 8097.959510202293, 8130.227628375414, 8214.014318281845, 5891.263592050994, 5933.9109913352195, 5939.554533410098, 5997.910031349446, 6146.354632763496, 9839.5080245986, 9872.45701486425, 9907.51387291912, 10039.447830369108, 10080.798384032132, 9832.360896541702, 9992.500374981368, 10048.542961270721, 10085.243606729671, 10280.845787313046, 6875.621840798804, 7425.851482970203, 7523.0, 7840.647170877438, 8148.796280093045, 8239.176082391712, 8372.41393102477, 8373.916260837314, 8389.161083891562, 8406.537640429835, 7425.220351862977, 7426.628668566442, 7522.887156692764, 7523.3229009389415, 7547.886781698388, 7220.0613920190035, 7337.376323012603, 7344.265573442613, 7379.520331178456, 7415.629218539159, 6032.215811944419, 6893.379595836399, 6939.757108501179, 6951.304869513008, 7015.228324884157, 4105.404716316058, 4741.454732705783, 4834.129856625841, 4835.927461088157, 4927.507249275187, 4943.382077240345, 5101.234814777813, 5109.412417572027, 5127.66670166438, 5193.37679478465], "value": 4564.580050475588, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.96364436267646, 308.48175065889313, 309.8032749204255, 317.13106089315266, 317.9395914776194, 5769.538436925046, 5820.359760426355, 5836.737346819393, 5859.912101318473, 5877.412258774126, 5658.199191400263, 5665.855450225134, 5674.815196149481, 5699.373068962411, 5727.541796656268, 3923.274194274054, 4006.0786019215598, 4084.1219137885423, 4182.728122672017, 4353.216421044211, 4272.978635106821, 4301.849435269766, 4308.913821723564, 4320.481542214923, 4354.084202950708, 3556.78659280444, 3956.109875278054, 4277.871663850074, 4300.462442194726, 4311.417958575584, 3985.804258722401, 4110.403991421242, 4300.268954277749, 4355.671520186342, 4378.9562104378865, 3019.4564978303897, 3282.556854824592, 3296.8186749728757, 3393.506856982944, 3733.533308336458, 4598.631704672097, 5580.386157522669, 5583.888322233533, 5603.0, 5623.212750214973, 4321.719088259285, 4839.419269687624, 4983.401991761012, 5015.166430966492, 5085.338905942241, 5981.401859814027, 5982.970085149546, 6006.8498287542725, 6034.909476357858, 6048.39516048396, 3811.275857587077, 3993.101552150743, 4137.565555616647, 4150.398192262135, 4173.561776013506, 4985.476524964863, 5471.932973070253, 5716.685582292972, 6351.333110023427, 6393.648349340784, 4050.974512743628, 4055.4727885374714, 4071.877843664695, 4093.6111069448357, 4110.280700877334, 4141.192467468875, 4155.2728272552185, 4155.940235239995, 4158.875233742992, 4193.580641935782, 4515.216489486635, 4844.159219496569, 4924.272698209687, 4930.630202734809, 4947.6289278304275, 5327.786888524493, 5551.584345991827, 5976.234971967632, 6042.879142417127, 6048.334683184846, 1385.8475567687547, 1410.9506167284096, 1416.553785557546, 1416.5750274917484, 1421.474054599784, 801.8493461882217, 845.8477474054729, 860.6858496648678, 865.5585651317873, 897.8238507555124, 5159.716215608178, 5270.657407268515, 5449.972750136224, 5508.779648814083, 5586.441355864462, 5626.690532020696, 5906.911396329058, 6101.908471372844, 6119.816405507842, 6141.324454310023, 5312.937412517512, 5483.122700367922, 5509.851158048365, 5509.933774834437, 5561.6663000220115, 2709.403931135147, 2720.687120981073, 2842.3178437175343, 3176.6029246344206, 3228.9838550807094, 4894.755262236874, 5345.224942383333, 6177.81466556004, 6271.3728627136925, 6286.717097730613, 5220.014885784067, 6137.478314343241, 6222.666500062476, 6256.374362563707, 6284.209000434854, 5860.765569377262, 5949.757382226697, 5988.790392336422, 6260.154879091356, 6290.496760259169, 4930.619426560569, 5793.9860524408905, 6036.577439579188, 6085.300190478151, 6127.877442451037, 5431.0, 5539.8892022158525, 5969.492593129633, 6008.489278411384, 6052.818415447544, 5839.240898683144, 6214.5960512566535, 6301.527385446018, 6312.928161335821, 6313.747450101944, 3521.7710848794745, 3961.3265744824025, 3967.6429121379215, 3979.8607048753156, 3999.580044095328, 5418.9924591851905, 5443.618946673695, 6035.913535563641, 6115.0, 6118.357572454828, 5206.9586082782835, 5224.111900976767, 5825.330087040044, 5921.644701317935, 5944.6730429826775, 5459.7270136492225, 5838.795642152504, 5848.970755146197, 5859.882802344015, 5879.676617786063, 4638.489766125656, 5314.441983591822, 5566.638168519034, 5754.518516297747, 5779.624324418899, 4472.865814025585, 5977.432143946318, 5989.580729348903, 6023.157537188919, 6023.45788879003, 5640.661560306395, 5844.4155584442915, 5883.941160588511, 5905.557083218861, 5930.584859059824], "value": 4307.058951534757, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.5942518512593, 657.4970147836906, 667.3560014585923, 669.8727241824056, 727.4471401734681, 15175.013624114425, 15467.69064618707, 15490.91563590549, 15502.534923952286, 15516.0, 14209.502667406618, 14236.359363828627, 14325.78511322331, 14327.0, 14355.64110897228, 671.2582596231167, 821.9095899451056, 829.3821103278051, 836.7657056024323, 860.1441565642194, 841.2302742990187, 846.6909578004015, 854.8418542569644, 857.6998050682274, 858.6479543387212, 875.8598624220126, 897.7486303834937, 902.1970446302796, 902.3999040638, 902.9638814447447, 862.8878245828065, 888.6711916590871, 890.8173824366022, 894.190757364586, 897.9326550508738, 658.2035736758528, 659.304433822322, 664.2626684380334, 666.2072134160334, 671.0839703804321, 14366.784498232535, 14457.0, 14620.926895365561, 14621.268936553237, 14667.046641968345, 13415.798763018562, 14287.357068931922, 14378.352974116086, 14457.78313325301, 14500.202488863108, 11246.775064498746, 11899.226550274205, 11989.681135075134, 12150.088743344197, 12459.0, 3888.6305800948867, 3924.2543916655745, 3936.9212615747524, 4061.7969101544804, 4071.348584226539, 91329.54335228281, 114890.42554787257, 116907.0, 119253.0, 120251.0, 11043.282186657842, 11113.0, 11145.665630031112, 11153.832692509619, 11351.091912646969, 22144.0, 22566.0, 22570.661440078413, 22570.887145564167, 22715.864206789596, 8173.795655108551, 8215.465994710325, 8359.414840961195, 8484.745457636282, 8504.65981360751, 4493.146302202571, 4581.496035436099, 4681.32120842476, 4791.401074865642, 4800.73595952219, 3247.886323978649, 3300.752443566742, 3341.298327351235, 3349.0, 3362.9663703363144, 624.8406656302614, 631.4916492223804, 637.5664548107239, 656.4617014048434, 663.3996233408676, 604.2054698072021, 611.7308384310888, 650.2099948562519, 660.5640277416882, 688.3495097133261, 8923.553822308859, 9490.952545237229, 9496.0, 9552.092551207625, 9717.46553939526, 620.4480683977125, 631.4948041566728, 641.6535071061575, 673.1719984419192, 686.5468790598181, 3973.5827738087664, 4521.864344069683, 4596.287575425815, 4604.677672562955, 4608.700434471749, 128474.71525284814, 154673.22663386835, 159501.25236850197, 160093.0, 161362.0, 126451.0, 128901.0, 131307.0, 134833.0, 136417.0, 82173.58913205395, 99841.0, 104339.0, 104605.0, 107120.46439767751, 8723.607437665447, 8876.644934202817, 8883.511406872683, 8902.530318909965, 8977.865332020156, 63224.367756321844, 64289.35710643021, 65394.34605653882, 67169.66415167892, 67308.0, 90315.0, 96444.0355596463, 98858.50570747387, 99686.5015674917, 101738.0, 10026.69919902404, 11099.778004440028, 11832.822507662564, 12134.150609457252, 12306.323152226714, 14469.0, 15021.173835439156, 15084.547463576111, 15119.470818521298, 15136.091834489966, 12141.635750927486, 13127.237259687863, 13620.318984050957, 13861.09902856311, 14141.222232777296, 13645.863541364459, 13692.3838427273, 14223.431062757374, 14435.711285774016, 14575.708485830437, 13293.867061329649, 13618.591442256748, 13852.16886986784, 14055.134274167716, 14150.292485375896, 11117.44412779374, 11304.208705390543, 11549.480273387886, 11903.226290291102, 11995.0, 10139.64511242103, 10753.516091776046, 10979.725506862073, 11628.88371116278, 11828.881711182778], "value": 7817.810829031407, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1613.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 122.0, 110.0, 122.0, 106.0, 173.0, 168.0, 117.0, 116.0, 117.0], "value": 125.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 113.0, 138.0, 165.0, 109.0, 137.0, 135.0, 112.0, 165.0, 100.0], "value": 132.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 244.0, 274.0, 279.0, 245.0, 207.0, 234.0, 198.0, 196.0, 207.0], "value": 228.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 83.0, 77.0, 152.0, 60.0, 72.0, 83.0, 84.0, 163.0, 61.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 93.0, 142.0, 57.0, 102.0, 112.0, 152.0, 57.0, 85.0, 151.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 79.0, 134.0, 87.0, 90.0, 87.0, 90.0, 88.0, 81.0, 122.0], "value": 94.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 150.0, 140.0, 96.0, 116.0, 152.0, 103.0, 151.0, 111.0, 150.0], "value": 126.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 123.0, 128.0, 90.0, 92.0, 92.0, 92.0, 92.0, 91.0, 91.0], "value": 98.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 63.0, 60.0, 60.0, 61.0, 58.0, 57.0, 56.0, 60.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 68.0, 80.0, 80.0, 74.0, 77.0, 76.0, 74.0, 73.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 91.0, 91.0, 87.0, 87.0, 92.0, 87.0, 110.0, 108.0], "value": 93.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 144.0, 141.0, 135.0, 141.0, 139.0, 140.0, 157.0, 140.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 171.0, 171.0, 199.0, 179.0, 171.0, 170.0, 172.0, 172.0, 173.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 69.0, 69.0, 70.0, 67.0, 70.0, 69.0, 68.0, 68.0], "value": 69.0, "unit": "score"}]}]} 21:43:31 INFO - Return code: 0 21:43:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:43:31 ERROR - # TBPL SUCCESS # 21:43:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:43:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:43:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:43:31 INFO - 2016-08-12 21:43:31.198 screenresolution[6478:110257] starting screenresolution argv=screenresolution get 21:43:31 INFO - 2016-08-12 21:43:31.200 screenresolution[6478:110257] Display 0: 1600x1200x32@60 21:43:31 INFO - 2016-08-12 21:43:31.206 screenresolution[6479:110260] starting screenresolution argv=screenresolution list 21:43:31 INFO - Available Modes on Display 0 21:43:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:43:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:43:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:43:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:43:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:43:31 INFO - Intel Iris: 21:43:31 INFO - Chipset Model: Intel Iris 21:43:31 INFO - Type: GPU 21:43:31 INFO - Bus: Built-In 21:43:31 INFO - VRAM (Dynamic, Max): 1536 MB 21:43:31 INFO - Vendor: Intel (0x8086) 21:43:31 INFO - Device ID: 0x0a2e 21:43:31 INFO - Revision ID: 0x0009 21:43:31 INFO - Displays: 21:43:31 INFO - Display: 21:43:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:43:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:43:31 INFO - Display Serial Number: 1600x1200 60 21:43:31 INFO - Main Display: Yes 21:43:31 INFO - Mirror: Off 21:43:31 INFO - Online: Yes 21:43:31 INFO - Rotation: Supported 21:43:31 INFO - Return code: 0 21:43:31 INFO - Running post-action listener: _resource_record_post_action 21:43:31 INFO - [mozharness: 2016-08-13 04:43:31.440217Z] Finished run-tests step (success) 21:43:31 INFO - Running post-run listener: _resource_record_post_run 21:43:31 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 1481728; Write bytes: 705996800; Read time: 20; Write time: 1994 21:43:31 INFO - TinderboxPrint: CPU usage
54.4% 21:43:31 INFO - TinderboxPrint: I/O read bytes / time
1,481,728 / 20 21:43:31 INFO - TinderboxPrint: I/O write bytes / time
705,996,800 / 1,994 21:43:31 INFO - TinderboxPrint: CPU idle
2,209.1 (45.6%) 21:43:31 INFO - TinderboxPrint: CPU system
979.2 (20.2%) 21:43:31 INFO - TinderboxPrint: CPU user
1,657.4 (34.2%) 21:43:31 INFO - TinderboxPrint: Swap in / out
406,970,368 / 0 21:43:31 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 405594624; Write bytes: 407386112; Read time: 31393; Write time: 843 21:43:31 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1362432; Write bytes: 297041920; Read time: 16; Write time: 1142 21:43:31 INFO - Running post-run listener: _upload_blobber_files 21:43:31 INFO - Blob upload gear active. 21:43:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:43:31 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 21:43:31 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'] 21:43:31 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 21:43:32 INFO - (blobuploader) - INFO - Open directory for files ... 21:43:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:43:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:43:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:33 INFO - (blobuploader) - INFO - Done attempting. 21:43:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:43:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:43:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:34 INFO - (blobuploader) - INFO - Done attempting. 21:43:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:43:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:43:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:36 INFO - (blobuploader) - INFO - Done attempting. 21:43:36 INFO - (blobuploader) - INFO - Iteration through files over. 21:43:36 INFO - Return code: 0 21:43:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:43:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:43:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bc53bf2e2a66d68e2db70bc7f9d38638cdbc4e169f1951c8a993d0ccc226f61e5a82e6f1391677c79bc900c409d728827de26e6c0fb827b4599b9c035b00195", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c060174ad193ab27f880516fa8329c6174db33035fd1bbf4beec68592de00a6bf03b0504e19ef4dce9e1541975e61d304589a3891c5e2b89692f61d9f51cced1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38978e3ca1041a0f373cc4a1552b98cf93b8be63d8e7b24c82a1ad633c44f45b89a4e14205824bc142a3a9ce0fbdd4214b084a04bf18427766600dd6ade346bf"} 21:43:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:43:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:43:36 INFO - Contents: 21:43:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bc53bf2e2a66d68e2db70bc7f9d38638cdbc4e169f1951c8a993d0ccc226f61e5a82e6f1391677c79bc900c409d728827de26e6c0fb827b4599b9c035b00195", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c060174ad193ab27f880516fa8329c6174db33035fd1bbf4beec68592de00a6bf03b0504e19ef4dce9e1541975e61d304589a3891c5e2b89692f61d9f51cced1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38978e3ca1041a0f373cc4a1552b98cf93b8be63d8e7b24c82a1ad633c44f45b89a4e14205824bc142a3a9ce0fbdd4214b084a04bf18427766600dd6ade346bf"} 21:43:36 INFO - Running post-run listener: copy_logs_to_upload_dir 21:43:36 INFO - Copying logs to upload dir... 21:43:36 INFO - mkdir: /builds/slave/test/build/upload/logs 21:43:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.147832 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-12 21:43:37.024087) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 21:43:37.027853) ========= 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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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/1bc53bf2e2a66d68e2db70bc7f9d38638cdbc4e169f1951c8a993d0ccc226f61e5a82e6f1391677c79bc900c409d728827de26e6c0fb827b4599b9c035b00195", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c060174ad193ab27f880516fa8329c6174db33035fd1bbf4beec68592de00a6bf03b0504e19ef4dce9e1541975e61d304589a3891c5e2b89692f61d9f51cced1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38978e3ca1041a0f373cc4a1552b98cf93b8be63d8e7b24c82a1ad633c44f45b89a4e14205824bc142a3a9ce0fbdd4214b084a04bf18427766600dd6ade346bf"} build_url:https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/OdPFSTTsSjqY4144X9dEdQ/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/1bc53bf2e2a66d68e2db70bc7f9d38638cdbc4e169f1951c8a993d0ccc226f61e5a82e6f1391677c79bc900c409d728827de26e6c0fb827b4599b9c035b00195", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c060174ad193ab27f880516fa8329c6174db33035fd1bbf4beec68592de00a6bf03b0504e19ef4dce9e1541975e61d304589a3891c5e2b89692f61d9f51cced1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38978e3ca1041a0f373cc4a1552b98cf93b8be63d8e7b24c82a1ad633c44f45b89a4e14205824bc142a3a9ce0fbdd4214b084a04bf18427766600dd6ade346bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 21:43:37.060628) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:43:37.060922) ========= 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.AGK0Eb9Uzk/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.OIVOhuPFSQ/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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.005265 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:43:37.111546) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 21:43:37.111844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 21:43:37.112151) ========= ========= Total master_lag: 1.36 =========