builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0238 starttime: 1472740563.52 results: success (0) buildid: 20160901053821 builduid: 0dbbe95f11c54603b9f542742e9e69ef revision: cba87d584348ee62004f8d7893529c9b37a6bded ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 07:36:03.518661) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 07:36:03.519057) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 07:36:03.519331) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 07:36:03.567914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 07:36:03.568182) ========= 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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-01 07:36:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 6.67M=0.002s 2016-09-01 07:36:03 (6.67 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126932 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 07:36:03.716472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 07:36:03.716749) ========= 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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.020151 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 07:36:03.764486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 07:36:03.764796) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cba87d584348ee62004f8d7893529c9b37a6bded --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 cba87d584348ee62004f8d7893529c9b37a6bded --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MM0n6S4eeV/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.qfR9c4PBtS/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-01 07:36:03,843 truncating revision to first 12 chars 2016-09-01 07:36:03,844 Setting DEBUG logging. 2016-09-01 07:36:03,844 attempt 1/10 2016-09-01 07:36:03,844 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cba87d584348?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 07:36:05,414 unpacking tar archive at: fx-team-cba87d584348/testing/mozharness/ program finished with exit code 0 elapsedTime=1.848275 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 07:36:05.635858) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 07:36:05.636178) ========= script_repo_revision: cba87d584348ee62004f8d7893529c9b37a6bded ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 07:36:05.636573) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 07:36:05.636840) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 07:36:05.655341) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-09-01 07:36:05.655609) ========= /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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:05 INFO - MultiFileLogger online at 20160901 07:36:05 in /builds/slave/test 07:36:05 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 07:36:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:36:05 INFO - {'append_to_log': False, 07:36:05 INFO - 'base_work_dir': '/builds/slave/test', 07:36:05 INFO - 'blob_upload_branch': 'Fx-Team', 07:36:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:36:05 INFO - 'branch': 'Fx-Team', 07:36:05 INFO - 'buildbot_json_path': 'buildprops.json', 07:36:05 INFO - 'config_files': ('talos/mac_config.py',), 07:36:05 INFO - 'default_actions': ('clobber', 07:36:05 INFO - 'read-buildbot-config', 07:36:05 INFO - 'download-and-extract', 07:36:05 INFO - 'populate-webroot', 07:36:05 INFO - 'create-virtualenv', 07:36:05 INFO - 'install', 07:36:05 INFO - 'run-tests'), 07:36:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:36:05 INFO - 'download_minidump_stackwalk': True, 07:36:05 INFO - 'download_symbols': 'ondemand', 07:36:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:36:05 INFO - 'tooltool.py': '/tools/tooltool.py', 07:36:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:36:05 INFO - '/tools/misc-python/virtualenv.py')}, 07:36:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:36:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:36:05 INFO - 'installer_path': 'installer.exe', 07:36:05 INFO - 'log_level': 'info', 07:36:05 INFO - 'log_name': 'talos', 07:36:05 INFO - 'log_to_console': True, 07:36:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:36:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:36:05 INFO - 'opt_config_files': (), 07:36:05 INFO - 'pip_index': False, 07:36:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:36:05 INFO - 'cmd': ('bash', 07:36:05 INFO - '-c', 07:36:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:36:05 INFO - 'enabled': True, 07:36:05 INFO - 'halt_on_failure': False, 07:36:05 INFO - 'name': 'check_screen_resolution'},), 07:36:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:36:05 INFO - 'cmd': ('bash', 07:36:05 INFO - '-c', 07:36:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:36:05 INFO - 'enabled': True, 07:36:05 INFO - 'halt_on_failure': False, 07:36:05 INFO - 'name': 'check_screen_resolution'},), 07:36:05 INFO - 'run_cmd_checks_enabled': True, 07:36:05 INFO - 'sps_profile': False, 07:36:05 INFO - 'sps_profile_interval': 0, 07:36:05 INFO - 'suite': 'dromaeojs-e10s', 07:36:05 INFO - 'system_bits': '32', 07:36:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:36:05 INFO - 'title': 't-yosemite-r7-0238', 07:36:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:36:05 INFO - 'use_talos_json': True, 07:36:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:36:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:36:05 INFO - 'work_dir': 'build'} 07:36:05 INFO - [mozharness: 2016-09-01 14:36:05.859626Z] Running clobber step. 07:36:05 INFO - Running pre-action listener: _resource_record_pre_action 07:36:05 INFO - Running main action method: clobber 07:36:05 INFO - rmtree: /builds/slave/test/build 07:36:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:36:07 INFO - Running post-action listener: _resource_record_post_action 07:36:07 INFO - [mozharness: 2016-09-01 14:36:07.380957Z] Finished clobber step (success) 07:36:07 INFO - [mozharness: 2016-09-01 14:36:07.381115Z] Running read-buildbot-config step. 07:36:07 INFO - Running pre-action listener: _resource_record_pre_action 07:36:07 INFO - Running main action method: read_buildbot_config 07:36:07 INFO - Using buildbot properties: 07:36:07 INFO - { 07:36:07 INFO - "project": "", 07:36:07 INFO - "product": "firefox", 07:36:07 INFO - "script_repo_revision": "production", 07:36:07 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 07:36:07 INFO - "repository": "", 07:36:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 07:36:07 INFO - "buildid": "20160901053821", 07:36:07 INFO - "pgo_build": "False", 07:36:07 INFO - "basedir": "/builds/slave/test", 07:36:07 INFO - "buildnumber": 38, 07:36:07 INFO - "slavename": "t-yosemite-r7-0238", 07:36:07 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 07:36:07 INFO - "platform": "yosemite_r7", 07:36:07 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 07:36:07 INFO - "branch": "fx-team", 07:36:07 INFO - "repo_path": "integration/fx-team", 07:36:07 INFO - "revision": "cba87d584348ee62004f8d7893529c9b37a6bded", 07:36:07 INFO - "stage_platform": "macosx64", 07:36:07 INFO - "builduid": "0dbbe95f11c54603b9f542742e9e69ef", 07:36:07 INFO - "slavebuilddir": "test" 07:36:07 INFO - } 07:36:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 07:36:07 INFO - Running post-action listener: _resource_record_post_action 07:36:07 INFO - [mozharness: 2016-09-01 14:36:07.384582Z] Finished read-buildbot-config step (success) 07:36:07 INFO - [mozharness: 2016-09-01 14:36:07.384697Z] Running download-and-extract step. 07:36:07 INFO - Running pre-action listener: _resource_record_pre_action 07:36:07 INFO - Running main action method: download_and_extract 07:36:07 INFO - mkdir: /builds/slave/test/build/tests 07:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:07 INFO - trying https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 07:36:07 INFO - Downloading https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 07:36:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 07:36:08 INFO - Downloaded 1199 bytes. 07:36:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 07:36:08 INFO - Using the following test package requirements: 07:36:08 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:36:08 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:36:08 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 07:36:08 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:36:08 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 07:36:08 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:36:08 INFO - u'jsshell-mac.zip'], 07:36:08 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:36:08 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 07:36:08 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:36:08 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:36:08 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 07:36:08 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:36:08 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 07:36:08 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:36:08 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 07:36:08 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:36:08 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 07:36:08 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:08 INFO - trying https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:36:08 INFO - Downloading https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 07:36:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 07:36:09 INFO - Downloaded 16399883 bytes. 07:36:09 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 07:36:16 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 07:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:16 INFO - trying https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:36:16 INFO - Downloading https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 07:36:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 07:36:17 INFO - Downloaded 16399883 bytes. 07:36:17 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 07:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:24 INFO - trying https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 07:36:24 INFO - Downloading https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 07:36:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 07:36:25 INFO - Downloaded 14413998 bytes. 07:36:25 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 07:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:25 INFO - trying https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:36:25 INFO - Downloading https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 07:36:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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 07:36:28 INFO - Downloaded 111596273 bytes. 07:36:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:36:28 INFO - mkdir: /builds/slave/test/properties 07:36:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:36:28 INFO - Writing to file /builds/slave/test/properties/build_url 07:36:28 INFO - Contents: 07:36:28 INFO - build_url:https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:36:29 INFO - Running post-action listener: _resource_record_post_action 07:36:29 INFO - Running post-action listener: set_extra_try_arguments 07:36:29 INFO - [mozharness: 2016-09-01 14:36:29.323827Z] Finished download-and-extract step (success) 07:36:29 INFO - [mozharness: 2016-09-01 14:36:29.323959Z] Running populate-webroot step. 07:36:29 INFO - Running pre-action listener: _resource_record_pre_action 07:36:29 INFO - Running main action method: populate_webroot 07:36:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:36:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:36:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:36:29 INFO - '--tppagecycles', 07:36:29 INFO - '7'], 07:36:29 INFO - 'tests': ['tsvgm']}}, 07:36:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:36:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:36:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:36:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:36:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:36:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:36:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:29 INFO - 'talos_options': ['--disable-e10s'], 07:36:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:29 INFO - 'talos_options': ['--disable-e10s'], 07:36:29 INFO - 'tests': ['damp', 'tps']}, 07:36:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:29 INFO - 'tests': ['damp', 'tps']}, 07:36:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:36:29 INFO - 'tests': ['dromaeo_dom']}, 07:36:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:36:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:36:29 INFO - 'tests': ['basic_compositor_video']}, 07:36:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:36:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:36:29 INFO - 'tests': ['a11yr', 07:36:29 INFO - 'ts_paint', 07:36:29 INFO - 'tpaint', 07:36:29 INFO - 'sessionrestore', 07:36:29 INFO - 'sessionrestore_no_auto_restore', 07:36:29 INFO - 'tabpaint']}, 07:36:29 INFO - 'other-e10s': {'tests': ['a11yr', 07:36:29 INFO - 'ts_paint', 07:36:29 INFO - 'tpaint', 07:36:29 INFO - 'sessionrestore', 07:36:29 INFO - 'sessionrestore_no_auto_restore', 07:36:29 INFO - 'tabpaint']}, 07:36:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:36:29 INFO - 'ts_paint', 07:36:29 INFO - 'tpaint', 07:36:29 INFO - 'sessionrestore', 07:36:29 INFO - 'sessionrestore_no_auto_restore', 07:36:29 INFO - 'tabpaint']}, 07:36:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:36:29 INFO - 'ts_paint', 07:36:29 INFO - 'tpaint', 07:36:29 INFO - 'sessionrestore', 07:36:29 INFO - 'sessionrestore_no_auto_restore', 07:36:29 INFO - 'tabpaint']}, 07:36:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:36:29 INFO - 'tests': ['a11yr', 07:36:29 INFO - 'ts_paint', 07:36:29 INFO - 'tpaint', 07:36:29 INFO - 'sessionrestore', 07:36:29 INFO - 'sessionrestore_no_auto_restore', 07:36:29 INFO - 'tabpaint']}, 07:36:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:36:29 INFO - 'tests': ['a11yr', 07:36:29 INFO - 'ts_paint', 07:36:29 INFO - 'tpaint', 07:36:29 INFO - 'sessionrestore', 07:36:29 INFO - 'sessionrestore_no_auto_restore', 07:36:29 INFO - 'tabpaint']}, 07:36:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:36:29 INFO - 'tests': ['tsvgx', 07:36:29 INFO - 'tsvgr_opacity', 07:36:29 INFO - 'tart', 07:36:29 INFO - 'tscrollx', 07:36:29 INFO - 'cart']}, 07:36:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:36:29 INFO - 'tsvgr_opacity', 07:36:29 INFO - 'tart', 07:36:29 INFO - 'tscrollx', 07:36:29 INFO - 'cart']}, 07:36:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:29 INFO - 'talos_options': ['--disable-e10s'], 07:36:29 INFO - 'tests': ['tp5o']}, 07:36:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:29 INFO - 'tests': ['tp5o']}, 07:36:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:29 INFO - 'talos_options': ['--disable-e10s', 07:36:29 INFO - '--xperf_path', 07:36:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:29 INFO - 'tests': ['tp5n']}, 07:36:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:29 INFO - 'talos_options': ['--xperf_path', 07:36:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:29 INFO - 'tests': ['tp5n']}}, 07:36:29 INFO - 'talos.zip': {'path': '', 07:36:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:36:29 INFO - Running post-action listener: _resource_record_post_action 07:36:29 INFO - [mozharness: 2016-09-01 14:36:29.342551Z] Finished populate-webroot step (success) 07:36:29 INFO - [mozharness: 2016-09-01 14:36:29.342663Z] Running create-virtualenv step. 07:36:29 INFO - Running pre-action listener: _resource_record_pre_action 07:36:29 INFO - Running main action method: create_virtualenv 07:36:29 INFO - Creating virtualenv /builds/slave/test/build/venv 07:36:29 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 07:36:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:36:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:36:29 INFO - Using real prefix '/tools/python27' 07:36:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:36:30 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:33 INFO - Installing pip.................done. 07:36:33 INFO - Return code: 0 07:36:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36:33 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')]} 07:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:33 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')]} 07:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:33 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 0x1007d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10086b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10073ad30>, '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 0x10049fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100732b20>, '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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:33 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 07:36:33 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 07:36:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MM0n6S4eeV/Render', 07:36:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:33 INFO - 'HOME': '/Users/cltbld', 07:36:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:33 INFO - 'LOGNAME': 'cltbld', 07:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:33 INFO - 'MOZ_NO_REMOTE': '1', 07:36:33 INFO - 'NO_EM_RESTART': '1', 07:36:33 INFO - 'PAGER': '/bin/cat', 07:36:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:33 INFO - 'PWD': '/builds/slave/test', 07:36:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:33 INFO - 'SHELL': '/bin/bash', 07:36:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qfR9c4PBtS/Listeners', 07:36:33 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:33 INFO - 'USER': 'cltbld', 07:36:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:33 INFO - 'XPC_FLAGS': '0x0', 07:36:33 INFO - 'XPC_SERVICE_NAME': '0', 07:36:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:33 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 07:36:33 INFO - Cleaning up... 07:36:33 INFO - Return code: 0 07:36:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:36:33 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')]} 07:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:33 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')]} 07:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:33 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 0x1007d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10086b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10073ad30>, '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 0x10049fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100732b20>, '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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:33 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 07:36:33 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 07:36:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MM0n6S4eeV/Render', 07:36:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:33 INFO - 'HOME': '/Users/cltbld', 07:36:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:33 INFO - 'LOGNAME': 'cltbld', 07:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:33 INFO - 'MOZ_NO_REMOTE': '1', 07:36:33 INFO - 'NO_EM_RESTART': '1', 07:36:33 INFO - 'PAGER': '/bin/cat', 07:36:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:33 INFO - 'PWD': '/builds/slave/test', 07:36:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:33 INFO - 'SHELL': '/bin/bash', 07:36:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qfR9c4PBtS/Listeners', 07:36:33 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:33 INFO - 'USER': 'cltbld', 07:36:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:33 INFO - 'XPC_FLAGS': '0x0', 07:36:33 INFO - 'XPC_SERVICE_NAME': '0', 07:36:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:33 INFO - Downloading/unpacking psutil>=3.1.1 07:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:36 INFO - Installing collected packages: psutil 07:36:36 INFO - Running setup.py install for psutil 07:36:36 INFO - building 'psutil._psutil_osx' extension 07:36:36 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 07:36:36 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 07:36:36 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 07:36:36 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 07:36:37 INFO - building 'psutil._psutil_posix' extension 07:36:37 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 07:36:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:36:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:36:37 INFO - ^ 07:36:37 INFO - 1 warning generated. 07:36:37 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 07:36:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:37 INFO - Successfully installed psutil 07:36:37 INFO - Cleaning up... 07:36:37 INFO - Return code: 0 07:36:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1007d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10086b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10073ad30>, '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 0x10049fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100732b20>, '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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:36:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MM0n6S4eeV/Render', 07:36:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:37 INFO - 'HOME': '/Users/cltbld', 07:36:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:37 INFO - 'LOGNAME': 'cltbld', 07:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:37 INFO - 'MOZ_NO_REMOTE': '1', 07:36:37 INFO - 'NO_EM_RESTART': '1', 07:36:37 INFO - 'PAGER': '/bin/cat', 07:36:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:37 INFO - 'PWD': '/builds/slave/test', 07:36:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:37 INFO - 'SHELL': '/bin/bash', 07:36:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qfR9c4PBtS/Listeners', 07:36:37 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:37 INFO - 'USER': 'cltbld', 07:36:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:37 INFO - 'XPC_FLAGS': '0x0', 07:36:37 INFO - 'XPC_SERVICE_NAME': '0', 07:36:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:36:37 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 07:36:37 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 07:36:37 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 07:36:37 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 07:36:37 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 07:36:37 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 07:36:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:36:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:36:40 INFO - Installing collected packages: mozsystemmonitor 07:36:40 INFO - Running setup.py install for mozsystemmonitor 07:36:40 INFO - Successfully installed mozsystemmonitor 07:36:40 INFO - Cleaning up... 07:36:40 INFO - Return code: 0 07:36:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:36:40 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')]} 07:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:40 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')]} 07:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:40 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 0x1007d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10086b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10073ad30>, '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 0x10049fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100732b20>, '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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:40 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 07:36:40 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 07:36:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MM0n6S4eeV/Render', 07:36:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:40 INFO - 'HOME': '/Users/cltbld', 07:36:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:40 INFO - 'LOGNAME': 'cltbld', 07:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:40 INFO - 'MOZ_NO_REMOTE': '1', 07:36:40 INFO - 'NO_EM_RESTART': '1', 07:36:40 INFO - 'PAGER': '/bin/cat', 07:36:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:40 INFO - 'PWD': '/builds/slave/test', 07:36:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:40 INFO - 'SHELL': '/bin/bash', 07:36:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qfR9c4PBtS/Listeners', 07:36:40 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:40 INFO - 'USER': 'cltbld', 07:36:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:40 INFO - 'XPC_FLAGS': '0x0', 07:36:40 INFO - 'XPC_SERVICE_NAME': '0', 07:36:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:40 INFO - Downloading/unpacking jsonschema==2.5.1 07:36:40 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 07:36:40 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 07:36:40 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 07:36:40 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 07:36:40 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 07:36:40 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 07:36:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:43 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 07:36:43 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 07:36:43 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 07:36:43 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 07:36:43 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 07:36:43 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 07:36:43 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:43 INFO - warning: no files found matching '*.txt' 07:36:43 INFO - no previously-included directories found matching 'build' 07:36:43 INFO - no previously-included directories found matching 'dist' 07:36:43 INFO - no previously-included directories found matching '.git*' 07:36:43 INFO - Installing collected packages: jsonschema, functools32 07:36:43 INFO - Running setup.py install for functools32 07:36:43 INFO - warning: no files found matching '*.txt' 07:36:43 INFO - no previously-included directories found matching 'build' 07:36:43 INFO - no previously-included directories found matching 'dist' 07:36:43 INFO - no previously-included directories found matching '.git*' 07:36:43 INFO - Successfully installed jsonschema functools32 07:36:43 INFO - Cleaning up... 07:36:43 INFO - Return code: 0 07:36:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:36:43 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')]} 07:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:43 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')]} 07:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:43 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 0x1007d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10086b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10073ad30>, '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 0x10049fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100732b20>, '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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:43 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 07:36:43 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 07:36:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MM0n6S4eeV/Render', 07:36:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:43 INFO - 'HOME': '/Users/cltbld', 07:36:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:43 INFO - 'LOGNAME': 'cltbld', 07:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:43 INFO - 'MOZ_NO_REMOTE': '1', 07:36:43 INFO - 'NO_EM_RESTART': '1', 07:36:43 INFO - 'PAGER': '/bin/cat', 07:36:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:43 INFO - 'PWD': '/builds/slave/test', 07:36:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:43 INFO - 'SHELL': '/bin/bash', 07:36:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qfR9c4PBtS/Listeners', 07:36:43 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:43 INFO - 'USER': 'cltbld', 07:36:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:43 INFO - 'XPC_FLAGS': '0x0', 07:36:43 INFO - 'XPC_SERVICE_NAME': '0', 07:36:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:36:44 INFO - Cleaning up... 07:36:44 INFO - Return code: 0 07:36:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1007d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10086b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10073ad30>, '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 0x10049fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100732b20>, '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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MM0n6S4eeV/Render', 07:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:44 INFO - 'HOME': '/Users/cltbld', 07:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:44 INFO - 'LOGNAME': 'cltbld', 07:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:44 INFO - 'MOZ_NO_REMOTE': '1', 07:36:44 INFO - 'NO_EM_RESTART': '1', 07:36:44 INFO - 'PAGER': '/bin/cat', 07:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:44 INFO - 'PWD': '/builds/slave/test', 07:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:44 INFO - 'SHELL': '/bin/bash', 07:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qfR9c4PBtS/Listeners', 07:36:44 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:44 INFO - 'USER': 'cltbld', 07:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:44 INFO - 'XPC_FLAGS': '0x0', 07:36:44 INFO - 'XPC_SERVICE_NAME': '0', 07:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:44 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:44 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 07:36:44 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 07:36:44 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 07:36:44 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 07:36:44 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 07:36:44 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 07:36:46 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:47 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 07:36:47 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 07:36:47 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 07:36:47 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 07:36:47 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 07:36:47 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 07:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:47 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 07:36:47 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 07:36:47 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 07:36:47 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 07:36:47 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 07:36:47 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 07:36:48 INFO - Downloading docopt-0.6.1.tar.gz 07:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:48 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:48 INFO - Running setup.py install for blobuploader 07:36:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:48 INFO - Running setup.py install for requests 07:36:48 INFO - Running setup.py install for docopt 07:36:48 INFO - Successfully installed blobuploader requests docopt 07:36:48 INFO - Cleaning up... 07:36:49 INFO - Return code: 0 07:36:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:49 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 0x1007d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10086b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10073ad30>, '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 0x10049fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100732b20>, '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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:49 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 07:36:49 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 07:36:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MM0n6S4eeV/Render', 07:36:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:49 INFO - 'HOME': '/Users/cltbld', 07:36:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:49 INFO - 'LOGNAME': 'cltbld', 07:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:49 INFO - 'MOZ_NO_REMOTE': '1', 07:36:49 INFO - 'NO_EM_RESTART': '1', 07:36:49 INFO - 'PAGER': '/bin/cat', 07:36:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:49 INFO - 'PWD': '/builds/slave/test', 07:36:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:49 INFO - 'SHELL': '/bin/bash', 07:36:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qfR9c4PBtS/Listeners', 07:36:49 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:49 INFO - 'USER': 'cltbld', 07:36:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:49 INFO - 'XPC_FLAGS': '0x0', 07:36:49 INFO - 'XPC_SERVICE_NAME': '0', 07:36:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:49 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-HkDenT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:49 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-lqwYO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:49 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-YvZSca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:49 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-hLDWlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:49 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-JkRMvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:49 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-jvBO7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:49 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-ftfGVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-twlAe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-almuhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-G2b_wG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-OibPnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-P83fWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-GRhlqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-57ttTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-kFnfnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:50 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Xx8XlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:51 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-MUQlXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:51 INFO - Running setup.py install for manifestparser 07:36:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:51 INFO - Running setup.py install for mozcrash 07:36:51 INFO - Running setup.py install for mozdebug 07:36:51 INFO - Running setup.py install for mozdevice 07:36:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:51 INFO - Running setup.py install for mozfile 07:36:51 INFO - Running setup.py install for mozhttpd 07:36:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:51 INFO - Running setup.py install for mozinfo 07:36:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:52 INFO - Running setup.py install for mozInstall 07:36:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:52 INFO - Running setup.py install for mozleak 07:36:52 INFO - Running setup.py install for mozlog 07:36:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:52 INFO - Running setup.py install for moznetwork 07:36:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:52 INFO - Running setup.py install for mozprocess 07:36:52 INFO - Running setup.py install for mozprofile 07:36:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozrunner 07:36:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozscreenshot 07:36:53 INFO - Running setup.py install for moztest 07:36:53 INFO - Running setup.py install for mozversion 07:36:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:53 INFO - Cleaning up... 07:36:53 INFO - Return code: 0 07:36:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:53 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 0x1007d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10086b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10073ad30>, '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 0x10049fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100732b20>, '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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:53 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 07:36:53 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 07:36:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MM0n6S4eeV/Render', 07:36:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:53 INFO - 'HOME': '/Users/cltbld', 07:36:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:53 INFO - 'LOGNAME': 'cltbld', 07:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:53 INFO - 'MOZ_NO_REMOTE': '1', 07:36:53 INFO - 'NO_EM_RESTART': '1', 07:36:53 INFO - 'PAGER': '/bin/cat', 07:36:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:53 INFO - 'PWD': '/builds/slave/test', 07:36:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:53 INFO - 'SHELL': '/bin/bash', 07:36:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qfR9c4PBtS/Listeners', 07:36:53 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:53 INFO - 'USER': 'cltbld', 07:36:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:53 INFO - 'XPC_FLAGS': '0x0', 07:36:53 INFO - 'XPC_SERVICE_NAME': '0', 07:36:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:53 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-0Sf10s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:54 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)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:54 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-RR_h7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:54 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)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:54 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-UACpir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:54 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)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:54 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Kppj7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:54 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)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:54 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-XZMGU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:54 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)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:54 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-ugBuk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:54 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)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:54 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-nfUSkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:54 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)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:54 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-_UM4A4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:54 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)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:54 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Y2EtEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:54 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)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:54 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-dgLYB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:55 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)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:55 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-rObK8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:55 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)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:55 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-gM2q8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:55 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)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:55 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-3NoDUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:55 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)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:55 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-hTlzie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:55 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)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:55 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-F8ChsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:55 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)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:55 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-wbKiLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:55 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)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:55 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-I7yOjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:55 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)) 07:36:55 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)) 07:36:55 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)) 07:36:55 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)) 07:36:55 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)) 07:36:55 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)) 07:36:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:55 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 07:36:55 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 07:36:55 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 07:36:55 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 07:36:55 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 07:36:55 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 07:36:58 INFO - Downloading blessings-1.6.tar.gz 07:36:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:58 INFO - Installing collected packages: blessings 07:36:58 INFO - Running setup.py install for blessings 07:36:58 INFO - Successfully installed blessings 07:36:58 INFO - Cleaning up... 07:36:58 INFO - Return code: 0 07:36:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:58 INFO - Reading from file tmpfile_stdout 07:36:58 INFO - Current package versions: 07:36:58 INFO - blessings == 1.6 07:36:58 INFO - blobuploader == 1.2.4 07:36:58 INFO - docopt == 0.6.1 07:36:58 INFO - functools32 == 3.2.3-2 07:36:58 INFO - jsonschema == 2.5.1 07:36:58 INFO - manifestparser == 1.1 07:36:58 INFO - mozInstall == 1.12 07:36:58 INFO - mozcrash == 0.17 07:36:58 INFO - mozdebug == 0.1 07:36:58 INFO - mozdevice == 0.48 07:36:58 INFO - mozfile == 1.2 07:36:58 INFO - mozhttpd == 0.7 07:36:58 INFO - mozinfo == 0.9 07:36:58 INFO - mozleak == 0.1 07:36:58 INFO - mozlog == 3.3 07:36:58 INFO - moznetwork == 0.27 07:36:58 INFO - mozprocess == 0.23 07:36:58 INFO - mozprofile == 0.28 07:36:58 INFO - mozrunner == 6.12 07:36:58 INFO - mozscreenshot == 0.1 07:36:58 INFO - mozsystemmonitor == 0.3 07:36:58 INFO - moztest == 0.7 07:36:58 INFO - mozversion == 1.4 07:36:58 INFO - psutil == 3.1.1 07:36:58 INFO - requests == 1.2.3 07:36:58 INFO - wsgiref == 0.1.2 07:36:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 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 0x1007d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10086b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10073ad30>, '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 0x10049fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100732b20>, '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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:58 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 07:36:58 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 07:36:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MM0n6S4eeV/Render', 07:36:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:58 INFO - 'HOME': '/Users/cltbld', 07:36:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:58 INFO - 'LOGNAME': 'cltbld', 07:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:58 INFO - 'MOZ_NO_REMOTE': '1', 07:36:58 INFO - 'NO_EM_RESTART': '1', 07:36:58 INFO - 'PAGER': '/bin/cat', 07:36:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:58 INFO - 'PWD': '/builds/slave/test', 07:36:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:58 INFO - 'SHELL': '/bin/bash', 07:36:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qfR9c4PBtS/Listeners', 07:36:58 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:58 INFO - 'USER': 'cltbld', 07:36:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:58 INFO - 'XPC_FLAGS': '0x0', 07:36:58 INFO - 'XPC_SERVICE_NAME': '0', 07:36:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:59 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)) 07:36:59 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)) 07:36:59 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)) 07:36:59 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)) 07:36:59 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)) 07:36:59 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)) 07:36:59 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)) 07:36:59 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)) 07:36:59 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)) 07:36:59 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)) 07:36:59 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)) 07:36:59 INFO - Cleaning up... 07:36:59 INFO - Return code: 0 07:36:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:59 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 0x1007d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10086b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faef1c77b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10073ad30>, '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 0x10049fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100732b20>, '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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:59 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 07:36:59 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 07:36:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MM0n6S4eeV/Render', 07:36:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:59 INFO - 'HOME': '/Users/cltbld', 07:36:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:59 INFO - 'LOGNAME': 'cltbld', 07:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:59 INFO - 'MOZ_NO_REMOTE': '1', 07:36:59 INFO - 'NO_EM_RESTART': '1', 07:36:59 INFO - 'PAGER': '/bin/cat', 07:36:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:59 INFO - 'PWD': '/builds/slave/test', 07:36:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:59 INFO - 'SHELL': '/bin/bash', 07:36:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qfR9c4PBtS/Listeners', 07:36:59 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:59 INFO - 'USER': 'cltbld', 07:36:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:59 INFO - 'XPC_FLAGS': '0x0', 07:36:59 INFO - 'XPC_SERVICE_NAME': '0', 07:36:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:59 INFO - Cleaning up... 07:36:59 INFO - Return code: 0 07:36:59 INFO - Running post-action listener: _resource_record_post_action 07:36:59 INFO - Running post-action listener: _start_resource_monitoring 07:36:59 INFO - Starting resource monitoring. 07:36:59 INFO - [mozharness: 2016-09-01 14:36:59.417691Z] Finished create-virtualenv step (success) 07:36:59 INFO - [mozharness: 2016-09-01 14:36:59.418741Z] Running install step. 07:36:59 INFO - Running pre-action listener: _resource_record_pre_action 07:36:59 INFO - Running main action method: install 07:36:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:59 INFO - Reading from file tmpfile_stdout 07:36:59 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:59 INFO - Reading from file tmpfile_stdout 07:36:59 INFO - Output received: 07:36:59 INFO - Usage: mozinstall [options] installer 07:36:59 INFO - Options: 07:36:59 INFO - -h, --help show this help message and exit 07:36:59 INFO - -d DEST, --destination=DEST 07:36:59 INFO - Directory to install application into. [default: 07:36:59 INFO - "/builds/slave/test"] 07:36:59 INFO - --app=APP Application being installed. [default: firefox] 07:36:59 INFO - mkdir: /builds/slave/test/build/application 07:36:59 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'] 07:36:59 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 07:37:33 INFO - Reading from file tmpfile_stdout 07:37:33 INFO - Output received: 07:37:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:37:33 INFO - Running post-action listener: _resource_record_post_action 07:37:33 INFO - [mozharness: 2016-09-01 14:37:33.969944Z] Finished install step (success) 07:37:33 INFO - [mozharness: 2016-09-01 14:37:33.970073Z] Running run-tests step. 07:37:33 INFO - Running pre-action listener: _resource_record_pre_action 07:37:33 INFO - Running main action method: run_tests 07:37:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:37:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:37:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:37:33 INFO - 2016-09-01 07:37:33.983 screenresolution[2194:18202] starting screenresolution argv=screenresolution get 07:37:33 INFO - 2016-09-01 07:37:33.986 screenresolution[2194:18202] Display 0: 1600x1200x32@60 07:37:33 INFO - 2016-09-01 07:37:33.991 screenresolution[2195:18207] starting screenresolution argv=screenresolution list 07:37:33 INFO - Available Modes on Display 0 07:37:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:37:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:37:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:37:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:37:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:37:34 INFO - Intel Iris: 07:37:34 INFO - Chipset Model: Intel Iris 07:37:34 INFO - Type: GPU 07:37:34 INFO - Bus: Built-In 07:37:34 INFO - VRAM (Dynamic, Max): 1536 MB 07:37:34 INFO - Vendor: Intel (0x8086) 07:37:34 INFO - Device ID: 0x0a2e 07:37:34 INFO - Revision ID: 0x0009 07:37:34 INFO - Displays: 07:37:34 INFO - Display: 07:37:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:37:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:37:34 INFO - Display Serial Number: 1600x1200 60 07:37:34 INFO - Main Display: Yes 07:37:34 INFO - Mirror: Off 07:37:34 INFO - Online: Yes 07:37:34 INFO - Rotation: Supported 07:37:34 INFO - Return code: 0 07:37:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:34 INFO - Python 2.7.3 07:37:34 INFO - Return code: 0 07:37:34 INFO - grabbing minidump binary from tooltool 07:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:34 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 0x10073ad30>, '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 0x10049fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100732b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:34 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 07:37:34 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 07:37:34 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 07:37:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:34 INFO - Return code: 0 07:37:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:37:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:37:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:34 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/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--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 07:37:34 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/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0238 --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 07:37:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MM0n6S4eeV/Render', 07:37:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:34 INFO - 'HOME': '/Users/cltbld', 07:37:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:34 INFO - 'LOGNAME': 'cltbld', 07:37:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:34 INFO - 'MOZ_NO_REMOTE': '1', 07:37:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:34 INFO - 'NO_EM_RESTART': '1', 07:37:34 INFO - 'PAGER': '/bin/cat', 07:37:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:34 INFO - 'PWD': '/builds/slave/test', 07:37:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:34 INFO - 'SHELL': '/bin/bash', 07:37:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qfR9c4PBtS/Listeners', 07:37:34 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:37:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:34 INFO - 'USER': 'cltbld', 07:37:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:34 INFO - 'XPC_FLAGS': '0x0', 07:37:34 INFO - 'XPC_SERVICE_NAME': '0', 07:37:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:34 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/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--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 07:37:34 INFO - mozversion application_buildid: 20160901053821 07:37:34 INFO - mozversion application_changeset: cba87d584348ee62004f8d7893529c9b37a6bded 07:37:34 INFO - mozversion application_display_name: Nightly 07:37:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:34 INFO - mozversion application_name: Firefox 07:37:34 INFO - mozversion application_remotingname: firefox 07:37:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:37:34 INFO - mozversion application_vendor: Mozilla 07:37:34 INFO - mozversion application_version: 51.0a1 07:37:34 INFO - mozversion platform_buildid: 20160901053821 07:37:34 INFO - mozversion platform_changeset: cba87d584348ee62004f8d7893529c9b37a6bded 07:37:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:37:34 INFO - mozversion platform_version: 51.0a1 07:37:34 INFO - using testdate: 1472740654 07:37:34 INFO - actual date: 1472740654 07:37:34 INFO - starting webserver on 'localhost:50035' 07:37:34 INFO - SUITE-START | Running 2 tests 07:37:34 INFO - TEST-START | dromaeo_css 07:37:34 INFO - operating with platform_type : mac_ 07:37:34 INFO - Initialising browser for dromaeo_css test... 07:37:34 INFO - TEST-INFO | started process 2205 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpFVgSqa/profile http://localhost:50035/getInfo.html) 07:37:37 INFO - PROCESS | 2205 | __metrics Screen width/height:1600/1200 07:37:37 INFO - PROCESS | 2205 | colorDepth:24 07:37:37 INFO - PROCESS | 2205 | Browser inner width/height: 1024/689 07:37:37 INFO - PROCESS | 2205 | __metrics 07:37:37 ERROR - PROCESS | 2205 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 07:37:37 INFO - PROCESS | 2205 | 07:37:37 INFO - PROCESS | 2205 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x10C0011,name=PVRManager::Msg_NotifyVSync) Channel error: cannot send/recv 07:37:37 INFO - PROCESS | 2205 | 07:37:37 INFO - TEST-INFO | 2205: exit 0 07:37:37 INFO - Browser initialized. 07:37:37 INFO - Running cycle 1/1 for dromaeo_css test... 07:37:37 INFO - TEST-INFO | started process 2208 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpFVgSqa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:49 INFO - PROCESS | 2208 | RSS: Main: 245149696 07:37:49 INFO - PROCESS | 2208 | 07:38:39 INFO - PROCESS | 2208 | 1472740719523 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] 07:40:52 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:50035/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50035/tests/dromaeo/cssquery-ext.html) 07:40:53 INFO - PROCESS | 2208 | RSS: Main: 262070272 07:40:53 INFO - PROCESS | 2208 | 07:43:56 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:50035/tests/dromaeo/cssquery-ext.html (next: http://localhost:50035/tests/dromaeo/cssquery-jquery.html) 07:43:56 INFO - PROCESS | 2208 | RSS: Main: 268304384 07:43:56 INFO - PROCESS | 2208 | 07:46:58 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:50035/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50035/tests/dromaeo/cssquery-mootools.html) 07:46:59 INFO - PROCESS | 2208 | RSS: Main: 275124224 07:46:59 INFO - PROCESS | 2208 | 07:50:01 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:50035/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50035/tests/dromaeo/cssquery-prototype.html) 07:50:01 INFO - PROCESS | 2208 | RSS: Main: 271552512 07:50:01 INFO - PROCESS | 2208 | 07:53:04 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:50035/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50035/tests/dromaeo/cssquery-yui.html) 07:53:05 INFO - PROCESS | 2208 | RSS: Main: 278032384 07:53:05 INFO - PROCESS | 2208 | 07:56:08 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:50035/tests/dromaeo/cssquery-yui.html (next: http://localhost:50035/tests/dromaeo/cssquery-dojo.html) 07:56:08 INFO - PROCESS | 2208 | RSS: Main: 280846336 07:56:08 INFO - PROCESS | 2208 | 07:56:08 INFO - PROCESS | 2208 | __start_tp_report 07:56:08 INFO - PROCESS | 2208 | _x_x_mozilla_page_load 07:56:08 INFO - PROCESS | 2208 | _x_x_mozilla_page_load_details 07:56:08 INFO - PROCESS | 2208 | |i|pagename|runs| 07:56:08 INFO - PROCESS | 2208 | |0;dojo.html;2874.4394843005616;3365.7475689323323;3401.2177199244175;3431.176517635768;3436.1924947637317;5713.942860571404;5731.598788084825;5753.395893431192;5769.769209231631;5813.796517121901;5731.283589551306;5744.569157313197;5777;5782.421757824215;5814.302283725949;4195.265828480004;5224.92162617561;5252.921206181911;5278.419373868871;5327.440618735035;5314.256004159421;5338.439463856297;5349.598780091489;5380.273663055476;5405.27028851104;5161.81933632321;5171.276021357013;5176;5199.246109314147;5253.973730131325;5233.476652334774;5239.502247286502;5258.342707161605;5268.209768534713;5308.761105750251;5165.173572228426;5214.348206474191;5236.842894713165;5267.157254839246;5270.657407268515;5651.547876169897;5698.743556539925;5699.945510080648;5741.3110426748635;5814.30228372598;6102.0348389851015;6230.221222347207;6232.657203853786;6242.656653884034;6289.685515724195;4991.401031876162;5408.945255675145;6281.623102613858;6286.308506064329;6292;4588.564086411786;5231.581473482112;5683.090705487102;5764.769409223668;5815.534757219412;5260.158374660036;6215.595986260879;6299.5275354348605;6302.833975714508;6357.396047375492;5523.309586301712;6130;6133.110698948627;6149.5080393568405;6171.7531298748445;5879.147523609053;6166.691665416712;6168.753249869955;6199.690015499207;6255;6221.906671399842;6232.626042437469;6246.593971391845;6247.312795592481;6248.28144763349;6108.541859360477;6147.44672979434;6150.753969841246;6159.23009623797;6169.2288463942;4244.278472659594;4913.557779799835;4929;4949.356583644175;4966.950330496648;3570.910727231788;4443.089166720814;4443.755593442392;4462.955370446319;4503.842365517191;5540.196671482612;5872.324682661463;5941.049432090845;5964.1650168976375;6009.429104235178;6152;6164.568480206342;6179.5056395488255;6197.101420294032;6291.716872740738;5302.310699609026;5716.171155182476;5953.1070339449425;5965.880682386415;5991.700414979234;5491.121420572689;5491.423400542965;5492.093804522209;5519.9448005520235;5547.33431988164;6220.315765265817;6308.936910630835;6313.96843015782;6359.332270111571;6453.645049522322;6230;6242.937570624235;6244.281907580505;6252.843678908063;6259.467945224525;6393.041043843461;6416.871662566629;6452.12896258999;6469.288378278292;6472.967635161794;6095.498792504082;6140.933729673127;6143.603994442082;6178.66017369031;6226.377362263918;6080.4831589313635;6229.283632382153;6245.937540624535;6253.812385628438;6264.404881536247;4650.441946966385;5314.4951229633125;6071.180390647206;6195.628262304276;6215.160953271251;5040.798368065383;6055.364186760503;6084.574079814371;6102.572819902742;6111.327753947151;5115.64190506661;5917.852053698692;5990.34106248321;6010.068439391901;6040.6677632730625;5231.529162375405;6072.757089716539;6166;6170.876582468415;6192.81421557354;5921.407859214217;5954.46409823118;5968.671723055274;5996.820095397145;6058.5153187745755 07:56:08 INFO - PROCESS | 2208 | |1;ext.html;502.0862031103391;518.6991544903956;521.3405042621085;533.6397931396307;554.3126523111343;37503;38474.230515389674;38575;41141;41401.58598414019;37925.43111853324;39471.81584552461;41691;42410.57589424105;42466;9568.37805542641;9762.951185244065;9766.218702503818;9770.413775173512;9790.363626364264;9677.854832177487;9759.707208783713;9765.902340976605;9770.951145244264;9789.265805064613;9727.659531916384;9752.90247097527;9787.608495660164;9807.607695692164;9824.656137035205;8469.237768600824;9771.95114024429;9777.511124443748;9790.461524616143;9794.706158815246;7954.204579542057;8411.537365444898;9820.852687209626;9872.308938374317;9890;40069.59930400688;40229;40325;40351.192976140606;40406.19187616261;3468.7051600613727;3519.1729943463265;3929.4302326162833;4040.7777572233517;4070.7964601769795;31049.68950310513;31433;31577.84211078953;31598;32532.349353012807;3212.9357412851846;3324.3018966017166;3349.949750753741;3367.3097015111844;3392.6776956189124;403323;405537;409884;410348;412147;59620;59791.80416391648;59906.70046649739;59948.40051599428;59974;56673.71663141658;62764;62964.05553916695;63023.6848815753;63198.684006580595;16032.11823349727;16241.59396015109;16312.265948032367;16339.428120015742;16339.509814705578;12674.176178548549;12750.553730619384;12756.489740410465;12767.680807979876;12825.23048617086;15789.842101578837;16235.350585976665;16339;16371.263293151836;16425;6937.7571784987285;6998.930010699828;7047.541909775849;7058.576485410892;7108.3747288882005;742.5062333548238;869.6782190589396;920.9593159729462;1004.1063453526367;1005.0602686488157;23386;26317.736822631912;26640.20079397621;30225.372501060636;30554;893.7542175901679;1052.4316868890712;1065.9660129674203;1140.378493720924;1195.665213740154;13929.651758705912;15077.698446031018;15346.079235245697;15597.532074037797;15915.204239788196;639521;643410.7829460823;644322;645567;646364;57455.425445745845;57556;57750.7112464435;57778.13332800011;58045.70977145087;1274.4010315151863;1322.9801552976712;1346.1451977994045;1348.514534767483;1352.9932350338381;24998.87500562558;26361.736382636696;26966.460670786866;28664.14007579776;30399.392012160075;49723.005539888276;49871.75064124656;50011.24983125183;50049.49950500594;50111.999999998545;576309;579466;580093;580720;582338;26148.73851261463;26790.732092678823;26869.193924182306;40114.1977160461;40603.78188654345;46838.53161468478;46929;47163;47749.76125119352;48354.75822620864;37663.81168094142;38766.41850372303;39015.21969560536;39920.80237592877;40482;38536.6146338533;38551.22897541977;39567.010824729616;39732.2187446876;40114.1977160461;37168.814155929045;37744.62255377521;38411.61588384192;38502.80748596239;38550.6144938547;32891;33958.49062264118;34428.48357274593;34552.57119719272;35496.46755298621;25210.571304318015;25564.48871022532;25636.359091022874;26057.199455243284;26114.216573502825 07:56:08 INFO - PROCESS | 2208 | |2;jquery.html;337.9391709492291;372.064258390149;385.0988686473651;385.9983343224332;405.57414714549714;19439.611207775855;20837.270695525658;21679.783202167975;21713.67429488559;21914.561708765814;19975.600487990232;20353.28763493278;20507.48731281715;20689.482762930933;21031;5867.735951882154;5993.370696076914;6153.230846144232;6167.444929956303;6239.937600623981;4242.236397448458;6098.207233059718;6183.227096612924;6183.350748171445;6630.138082049351;6823.078884350623;6962.338577835098;6971.7211311547735;6972.860542789142;6991.755288564901;6772.322767723237;6883.346082122191;6933.20268169162;6935.445164386837;6953.6870840812035;5289.841304760864;5920.585559010871;5942.257217847769;5974.790882319141;5999.220101386835;25382.873085634452;26229.21312360632;26523;26536.336591585172;26638.600420993702;2444.9633255501003;2499.987500062506;2548.1591074945222;2888.393437378153;3028.606281183454;15464.38142474311;15574.844251557566;15861.048337099695;16068.196590170444;16160.191990400433;1824.507383006594;1902.9333973310868;1927.6530224559574;1953.2089503751004;1963.1950900130878;120437;122456.38771806173;123680;126497;126840;10145.695629131138;10206.591736330613;10363.378197308186;10843.67468975932;11092.889071109186;13302.201867887958;13370;13437.193768373929;13461.663458413617;13496.39266233022;8221.671133154607;8417.957910210409;8458.323334133254;8624.78438039054;8645.654173833102;8462.746117616482;8503.61733721984;8568.828623427622;8711.825763484694;8723.607437665194;5387.865303367447;6380.585261957958;6445.2265728112925;6544.9672751635935;6600.141981542369;1576.9448069317748;1670.574003629091;1681.8065922419078;1780.2078075256386;1883.7645294338208;849.9957500212583;857.704092088241;898.2948385517337;956.9808603827885;978.0854900667898;19571.608567828847;20643;20665.380038598865;20819.06314215864;21005.68937416883;911.813078318943;935.2471260635253;940.7365937537501;947.3415975896686;957.0859828863419;10804;10952.4523773811;10960.397178155119;10962.232643715022;10990.615328463466;566082;582818;591896;593861;599728;122805.38597306957;128908.35545822399;129909;131642;133705;949.2026697574071;951.9095685909828;978.6966040527317;983.5279066048337;1019.6431249062917;15634.530964071097;17176.742348865027;17808.821911780717;18899.622007560047;19521.902390487958;44389;44663.77668111639;47401.52598474109;52382.47617523776;55536;66853.66573167103;67804.98292525517;67850;67951;68593;8033.879491807745;8038.316743076904;8097.595120244082;8233.38249631268;8297.709580164665;11152.442377881236;12388.56640017595;12855.16441431304;12856.871431285568;13033.804492932803;7361.484696071224;8547.444416112932;9932.155766759617;11140.33158010522;11216;9749.415035097916;10196.3372380795;11073.05879000294;11222.046126079375;11571.363575003455;11062.723431914266;11522.942385288019;11789.410529473664;11807;11932.701682458008;8169.305609023062;8170.223828736261;8417.410781245255;8458.19647133546;8597.828043439222;9326.393784403992;10356.808966968594;10613.363198208132;11641.88358116408;11902.940485297519 07:56:08 INFO - PROCESS | 2208 | |3;mootools.html;1496.7006598680266;1513.0694622806973;1731.2555601091533;1849.5191250274925;1880.6708825955454;7915.327197188231;8212.178782121784;8324.625391857366;8769.60536775845;8776.034636190023;8441.324694024479;8541.060483346826;8563.957180214105;8575.399722019461;8577.14228577142;2348.6477028445697;2363.905443782255;2365.254944692425;2368.5144545368157;2376.5246950609862;2347.1784875293597;2371.336025912747;2393.1623931623967;2400.9759902401015;2403.2910291463972;2365.6215005599106;2375.8574485530835;2388.044782087162;2396.6524853896176;2402.0872068613903;2345.9882700586386;2352.3766201956496;2357.8231632627535;2364.73987861336;2377.48883989943;2273.261190113203;2331.80179684727;2348.9060437582475;2351.4591643921995;2362.220467245822;7138.964305178492;8178.877316840252;8282.006159260867;8649.956750216272;8677.479351238882;4066.2477441673386;4864.513548645107;5224.294720212761;5234.214867769827;5249.973750131263;3409.215880347534;3441.6042155152227;3611.873584424559;3627.72792040598;3635.8728794073922;1045.0542259255385;1077.7144056824948;1085.484394912418;1100.1968562949012;1106.9778604427866;11002.669919902415;11090;11100.555977760961;11117.888821111846;11123.388213648246;4075.918481630351;4486.551344865487;4563.26987681976;4755.313248014861;4779.474257831635;9625.614975401046;9708.126268635857;9719.65981190655;9723.854142187873;9734.172595329477;5275.815346462856;5298.364196296392;5312.309399778004;5316.069687804618;5317.9202311965355;4352.521222665504;4700.952990470051;4831.855044348676;4854.2233242681;4864.586510146606;3880.1075752577067;3924.156306394139;3982.769648996571;4011.8165141283393;4038.5355684096116;1294.8964082873347;1307.215670597653;1307.2940612069567;1308.6597484654058;1311.206719934426;851.2721623012359;862.8868759300558;897.8339007283673;905.7418635688929;926.5321012888583;5665.66006039639;5734.197212390269;5905.76376944926;5993.31076926159;6041.667708275999;941.580996456584;949.5299826585884;962.6101428921158;963;997.670768646345;3889.4943657324934;3914.5693973662874;3933.0757272041046;4014.277430062617;4016.3172260715746;10191.388516689023;10464.947675261727;10506.737331566772;10508.42203678805;10534.73663158412;10419.531121099568;10481.109105725945;10484.213683973732;10485.37087774736;10526.894731052744;7909.0113735783025;8006.15935326794;8014.19858014194;8045.517268963764;8046.557439340892;5453.563714902878;5454.3201922837725;5743.540516758566;5761.164631128547;5863.618864773946;9484.33609647318;9703.5148242589;9745.756356091155;9782.706518804447;9796.951015244878;8336.749897503085;9406.670766523139;9858.556364963737;9961.750956226153;9992;6882.621455819978;6900.102986611709;6925.203601585882;6946.965265173844;7004.824879378057;8020.197980201933;8084.474509156886;8175;8202.09776924526;8206.302464290364;7263.854722905407;7347.8530429392185;7355.264473552602;7425.777226683208;7480.027596412431;7148.85702285941;7161.856762864818;7228.554289142297;7230.819229519304;7362.889556656547;5925.644461332334;6020.939790602038;6198.969005154945;6846.7945961621235;6858.931410685829;4548.818047278071;4596.6092882105395;4830.8792280193275;4921.729304888266;5058.190689489664;4405.40527028847;4556.567126123013;4691.671582989158;4908.901821963612;5061.190209566452 07:56:08 INFO - PROCESS | 2208 | |4;prototype.html;301.3445755481828;305.36179385085165;314.30852125324293;314.60674157303373;318.0220820975501;4249.362595610656;4862.367892174021;5218.21726740989;5418.674879507227;5606.523445507127;5395.352557693082;5505;5513.61404701671;5529.917051244234;5540.036080696828;3558.1638314996085;4145.875623731293;4186.618415922753;4193.412922190896;4202.474690663667;3278.606567211938;3867.8839634811;4018.5177778666603;4193.811278492475;4240.194363071022;3556.128748456632;3955.9759105935445;4080.7959602019782;4080.8165631966694;4089.548210385315;3429.794212347267;4061.6596523147587;4084.1627466369323;4091.7954102294916;4101.979490102531;3060.6021217241837;3458.4466485362473;3531.876384326562;3532.2229109595846;3546.680798728127;4139.985703502631;4985.376827896513;5146.330976973007;5242.423333433319;5311.814086506993;3898.8635397761227;4652.092841895832;4675;4682.672212945095;4691.108689349013;5712.885742285131;5721.370649228582;5732.484076433141;5746.25298711169;5747.252857128547;3587.641235876418;3795.62043795621;3847.2690188864026;3899.863504777319;3926.332523471017;5390.946090539122;5870.714378503716;6053.303870054956;6119.663418512025;6145.938540614626;3481.5125882376487;3591.4612808078473;3704.388775851954;3942.3495123304333;3951.9604803951593;3861.942070868939;3921.5294164700417;3999.700022498266;4005.339119045383;4015.6948991577856;4094.9385759213637;4579.7252164870215;4660.347551342815;4668.953310466852;4670.6497012724185;4825.613950883921;5201.699575106223;5860.501857342174;5877.265341832271;5967.791127310524;1110.9888901110885;1189.2983139947473;1339.163023110556;1358.5516779462753;1365.1058556645414;867.8264347130599;890.4879694175875;912.4943842659532;913.9680111196076;916.2395211974045;4517.728936263835;5250.789968401297;5398.703071331036;5438.129899216186;5450.482204190595;4992.750362481934;5451.37309209446;5521.978433989644;5823.854403639858;5838;4464;5379.1393377059485;5390.407055223922;5444.183372494158;5453.64551304164;2388.7936592021265;2417.6944449996804;2573.3309339571847;2658.268976031568;2711.6170752916155;4321.611055005064;4596.264597664424;4645.469443223107;5127.513021223878;5253.894922101536;4828.875294870246;5069.594432445396;5094.77073531692;5114.6931184128325;5185.651730550084;4204.747715137101;4402.3616575597;4511.142882852248;5125.156132900324;5162.432132465501;4480.372747815373;4973.52751488608;5031.6729412588065;5040.395152581714;5049.924251136163;4615.353850461005;4755.07419495105;4899.951000489949;4931.7040977541465;4933.248696712615;4099.631033207026;4760.762441652418;4902.730349830794;5129;5230.555402790653;3101.4877948861495;3325.686353890248;3335.4329763939704;3345.381104495676;3444.8277586120093;3986.3291594631087;4360.171567402183;4582.404287442611;4877.244192090915;4960.866827264311;4721.787519561697;4944.588234118591;5020.272060551272;5541.972290138524;5703.857403564944;5148.58811295088;5728.942710572841;5737.340205876378;5770.662881532986;5770.711464426846;4424.469063712247;5212.322398088224;5573.554115670818;5587.916181257366;5653.40639232891;4460.598546130864;4736.573708366263;5689.833584115164;5776.671365585855;5792.594518383673;4469.9776501117285;4787.473377928494;5582.8325150245555;5696.344920334214;5721.6280941740315 07:56:08 INFO - PROCESS | 2208 | |5;yui.html;672.8889733194025;677.4411110833563;698.9930100698991;708.9822754431135;717.2289788477389;15116;16045;16237.512874613765;16260.186990650449;16273.674526509463;14597.051191672534;14708.632284192901;14729.116253024798;14757.966942314042;14786.630334241649;645.4352441613588;806.8628333183373;809.1423091522975;832.9333653307751;837.6733074101105;847.7160151349306;847.8304339132198;848.7665891879751;849.7493239494364;852.2287329966359;886.2289807867164;887.5340446265698;890.8619164029553;891.0510306523531;895.6954635423955;875.3303722652145;881.4667126388539;882.3514716683233;884.1158841158873;884.1379654836547;656.4387448731361;658.739797779879;662.0301258656092;662.6587307536622;663.9668016599151;12193.39033048353;14857.034292770935;14899.404023839033;14921.776173357408;14926.10443373401;14459.638509037253;14468.421263149461;14520.491782787552;14547.3453694584;14670.413183472649;11061.281016733887;11857;12034.157608967376;12250.897419232222;12375.319357435337;2934.970650293491;3336.799792012487;3370.9213051823426;3897.279003384383;3978.144698889753;114952;119801;120930.39534802358;121029;121129.39435302855;8750.562471876381;10062.949685251528;10823.404712740874;11188.832167517494;11508.712282193012;23183.188588399662;23299.18452854176;23442.64836027461;23499;23504.647430288558;7325.487215894943;7515.6242187891485;7975.521468711896;8074;8234.505929644121;4410.20616289071;4438.090191510732;4451.399061126771;4496.5503449655425;4576.610988065985;3533.434650455915;3612.7290453216115;3625.2024554597947;3653.1232504199334;3656.597774244831;556.2796178948272;570.4666137161767;641.1632819170933;644.7421031587403;652.6214795418646;627.9026750853625;630.3349965786048;644.0440807982623;662.6786008785735;670.9765158219438;9063.909360906438;9431.434113953184;9649.710508684751;9694.806103877883;9719.368241064309;542.0648285620298;641.6791604197902;659.3604203922283;665.1386454541381;675.8073948924631;4340.826366945287;4711.340412342275;4724.976375118103;4761.119192949315;4770.903159716346;98897;100358.49820750995;130416.04375934368;163634;169702.15148924422;92684;117083;129790.75523111998;145859;146671;118372;118976.81023189657;119291;122101;125277;9094.636214551343;9177.587008584496;9189.632414703337;9196.402233854778;9357.923838758357;65224.69550609056;65291.673541631986;66020.66989665022;66486;68888.62222755617;61164.77670446477;65267.67366163139;66050.00924986033;78363;96445;11970;11976.291446569163;12112;12186.390680465764;12348.197367171106;11827.881721182677;13049.869501304865;13233.933830330787;13246.735065298833;13775.517856875362;12030.75938481208;12257.938710306391;12442.253464792142;12596.118271720892;12664.556740514037;12085.39573021363;12297.446614902172;12490.687732806753;12530.874691252971;12593.811092833797;12166.45250963691;12323.69190770238;12366.607963361199;12453.501859925502;12464.5014199431;9994.300398972293;10096.394216347042;10236.18110551169;10339.431331276852;10551.261411701107;9903.306768526421;10209.38743675382;10314;10361.481925903523;10363.274570779973 07:56:08 INFO - PROCESS | 2208 | __end_tp_report 07:56:08 INFO - PROCESS | 2208 | __start_cc_report 07:56:08 INFO - PROCESS | 2208 | _x_x_mozilla_cycle_collect,381 07:56:08 INFO - PROCESS | 2208 | __end_cc_report 07:56:08 INFO - PROCESS | 2208 | __startTimestamp1472741768848__endTimestamp 07:56:08 INFO - PROCESS | 2208 | 07:56:08 INFO - PROCESS | 2208 | ------- Summary: start ------- 07:56:08 INFO - PROCESS | 2208 | Number of tests: 6 07:56:08 INFO - PROCESS | 2208 | 07:56:08 INFO - PROCESS | 2208 | [#0] dojo.html Cycles:165 Average:5694.75 Median:5953.11 stddev:686.58 (11.5%) stddev-sans-first:652.07 07:56:08 INFO - PROCESS | 2208 | Values: 2874.4 3365.7 3401.2 3431.2 3436.2 5713.9 5731.6 5753.4 5769.8 5813.8 5731.3 5744.6 5777.0 5782.4 5814.3 4195.3 5224.9 5252.9 5278.4 5327.4 5314.3 5338.4 5349.6 5380.3 5405.3 5161.8 5171.3 5176.0 5199.2 5254.0 5233.5 5239.5 5258.3 5268.2 5308.8 5165.2 5214.3 5236.8 5267.2 5270.7 5651.5 5698.7 5699.9 5741.3 5814.3 6102.0 6230.2 6232.7 6242.7 6289.7 4991.4 5408.9 6281.6 6286.3 6292.0 4588.6 5231.6 5683.1 5764.8 5815.5 5260.2 6215.6 6299.5 6302.8 6357.4 5523.3 6130.0 6133.1 6149.5 6171.8 5879.1 6166.7 6168.8 6199.7 6255.0 6221.9 6232.6 6246.6 6247.3 6248.3 6108.5 6147.4 6150.8 6159.2 6169.2 4244.3 4913.6 4929.0 4949.4 4967.0 3570.9 4443.1 4443.8 4463.0 4503.8 5540.2 5872.3 5941.0 5964.2 6009.4 6152.0 6164.6 6179.5 6197.1 6291.7 5302.3 5716.2 5953.1 5965.9 5991.7 5491.1 5491.4 5492.1 5519.9 5547.3 6220.3 6308.9 6314.0 6359.3 6453.6 6230.0 6242.9 6244.3 6252.8 6259.5 6393.0 6416.9 6452.1 6469.3 6473.0 6095.5 6140.9 6143.6 6178.7 6226.4 6080.5 6229.3 6245.9 6253.8 6264.4 4650.4 5314.5 6071.2 6195.6 6215.2 5040.8 6055.4 6084.6 6102.6 6111.3 5115.6 5917.9 5990.3 6010.1 6040.7 5231.5 6072.8 6166.0 6170.9 6192.8 5921.4 5954.5 5968.7 5996.8 6058.5 07:56:08 INFO - PROCESS | 2208 | 07:56:08 INFO - PROCESS | 2208 | [#1] ext.html Cycles:180 Average:68071.37 Median:221837.10 stddev:147823.30 (66.6%) stddev-sans-first:148150.93 07:56:08 INFO - PROCESS | 2208 | Values: 502.1 518.7 521.3 533.6 554.3 37503.0 38474.2 38575.0 41141.0 41401.6 37925.4 39471.8 41691.0 42410.6 42466.0 9568.4 9763.0 9766.2 9770.4 9790.4 9677.9 9759.7 9765.9 9771.0 9789.3 9727.7 9752.9 9787.6 9807.6 9824.7 8469.2 9772.0 9777.5 9790.5 9794.7 7954.2 8411.5 9820.9 9872.3 9890.0 40069.6 40229.0 40325.0 40351.2 40406.2 3468.7 3519.2 3929.4 4040.8 4070.8 31049.7 31433.0 31577.8 31598.0 32532.3 3212.9 3324.3 3349.9 3367.3 3392.7 403323.0 405537.0 409884.0 410348.0 412147.0 59620.0 59791.8 59906.7 59948.4 59974.0 56673.7 62764.0 62964.1 63023.7 63198.7 16032.1 16241.6 16312.3 16339.4 16339.5 12674.2 12750.6 12756.5 12767.7 12825.2 15789.8 16235.4 16339.0 16371.3 16425.0 6937.8 6998.9 7047.5 7058.6 7108.4 742.5 869.7 921.0 1004.1 1005.1 23386.0 26317.7 26640.2 30225.4 30554.0 893.8 1052.4 1066.0 1140.4 1195.7 13929.7 15077.7 15346.1 15597.5 15915.2 639521.0 643410.8 644322.0 645567.0 646364.0 57455.4 57556.0 57750.7 57778.1 58045.7 1274.4 1323.0 1346.1 1348.5 1353.0 24998.9 26361.7 26966.5 28664.1 30399.4 49723.0 49871.8 50011.2 50049.5 50112.0 576309.0 579466.0 580093.0 580720.0 582338.0 26148.7 26790.7 26869.2 40114.2 40603.8 46838.5 46929.0 47163.0 47749.8 48354.8 37663.8 38766.4 39015.2 39920.8 40482.0 38536.6 38551.2 39567.0 39732.2 40114.2 37168.8 37744.6 38411.6 38502.8 38550.6 32891.0 33958.5 34428.5 34552.6 35496.5 25210.6 25564.5 25636.4 26057.2 26114.2 07:56:08 INFO - PROCESS | 2208 | 07:56:08 INFO - PROCESS | 2208 | [#2] jquery.html Cycles:180 Average:34725.19 Median:1683.27 stddev:98083.79 (5827.0%) stddev-sans-first:98324.95 07:56:08 INFO - PROCESS | 2208 | Values: 337.9 372.1 385.1 386.0 405.6 19439.6 20837.3 21679.8 21713.7 21914.6 19975.6 20353.3 20507.5 20689.5 21031.0 5867.7 5993.4 6153.2 6167.4 6239.9 4242.2 6098.2 6183.2 6183.4 6630.1 6823.1 6962.3 6971.7 6972.9 6991.8 6772.3 6883.3 6933.2 6935.4 6953.7 5289.8 5920.6 5942.3 5974.8 5999.2 25382.9 26229.2 26523.0 26536.3 26638.6 2445.0 2500.0 2548.2 2888.4 3028.6 15464.4 15574.8 15861.0 16068.2 16160.2 1824.5 1902.9 1927.7 1953.2 1963.2 120437.0 122456.4 123680.0 126497.0 126840.0 10145.7 10206.6 10363.4 10843.7 11092.9 13302.2 13370.0 13437.2 13461.7 13496.4 8221.7 8418.0 8458.3 8624.8 8645.7 8462.7 8503.6 8568.8 8711.8 8723.6 5387.9 6380.6 6445.2 6545.0 6600.1 1576.9 1670.6 1681.8 1780.2 1883.8 850.0 857.7 898.3 957.0 978.1 19571.6 20643.0 20665.4 20819.1 21005.7 911.8 935.2 940.7 947.3 957.1 10804.0 10952.5 10960.4 10962.2 10990.6 566082.0 582818.0 591896.0 593861.0 599728.0 122805.4 128908.4 129909.0 131642.0 133705.0 949.2 951.9 978.7 983.5 1019.6 15634.5 17176.7 17808.8 18899.6 19521.9 44389.0 44663.8 47401.5 52382.5 55536.0 66853.7 67805.0 67850.0 67951.0 68593.0 8033.9 8038.3 8097.6 8233.4 8297.7 11152.4 12388.6 12855.2 12856.9 13033.8 7361.5 8547.4 9932.2 11140.3 11216.0 9749.4 10196.3 11073.1 11222.0 11571.4 11062.7 11522.9 11789.4 11807.0 11932.7 8169.3 8170.2 8417.4 8458.2 8597.8 9326.4 10356.8 10613.4 11641.9 11902.9 07:56:08 INFO - PROCESS | 2208 | 07:56:08 INFO - PROCESS | 2208 | [#3] mootools.html Cycles:180 Average:5551.27 Median:5059.69 stddev:3058.82 (60.5%) stddev-sans-first:3052.23 07:56:08 INFO - PROCESS | 2208 | Values: 1496.7 1513.1 1731.3 1849.5 1880.7 7915.3 8212.2 8324.6 8769.6 8776.0 8441.3 8541.1 8564.0 8575.4 8577.1 2348.6 2363.9 2365.3 2368.5 2376.5 2347.2 2371.3 2393.2 2401.0 2403.3 2365.6 2375.9 2388.0 2396.7 2402.1 2346.0 2352.4 2357.8 2364.7 2377.5 2273.3 2331.8 2348.9 2351.5 2362.2 7139.0 8178.9 8282.0 8650.0 8677.5 4066.2 4864.5 5224.3 5234.2 5250.0 3409.2 3441.6 3611.9 3627.7 3635.9 1045.1 1077.7 1085.5 1100.2 1107.0 11002.7 11090.0 11100.6 11117.9 11123.4 4075.9 4486.6 4563.3 4755.3 4779.5 9625.6 9708.1 9719.7 9723.9 9734.2 5275.8 5298.4 5312.3 5316.1 5317.9 4352.5 4701.0 4831.9 4854.2 4864.6 3880.1 3924.2 3982.8 4011.8 4038.5 1294.9 1307.2 1307.3 1308.7 1311.2 851.3 862.9 897.8 905.7 926.5 5665.7 5734.2 5905.8 5993.3 6041.7 941.6 949.5 962.6 963.0 997.7 3889.5 3914.6 3933.1 4014.3 4016.3 10191.4 10464.9 10506.7 10508.4 10534.7 10419.5 10481.1 10484.2 10485.4 10526.9 7909.0 8006.2 8014.2 8045.5 8046.6 5453.6 5454.3 5743.5 5761.2 5863.6 9484.3 9703.5 9745.8 9782.7 9797.0 8336.7 9406.7 9858.6 9961.8 9992.0 6882.6 6900.1 6925.2 6947.0 7004.8 8020.2 8084.5 8175.0 8202.1 8206.3 7263.9 7347.9 7355.3 7425.8 7480.0 7148.9 7161.9 7228.6 7230.8 7362.9 5925.6 6020.9 6199.0 6846.8 6858.9 4548.8 4596.6 4830.9 4921.7 5058.2 4405.4 4556.6 4691.7 4908.9 5061.2 07:56:08 INFO - PROCESS | 2208 | 07:56:08 INFO - PROCESS | 2208 | [#4] prototype.html Cycles:180 Average:4366.83 Median:4745.82 stddev:1347.87 (28.4%) stddev-sans-first:1316.66 07:56:08 INFO - PROCESS | 2208 | Values: 301.3 305.4 314.3 314.6 318.0 4249.4 4862.4 5218.2 5418.7 5606.5 5395.4 5505.0 5513.6 5529.9 5540.0 3558.2 4145.9 4186.6 4193.4 4202.5 3278.6 3867.9 4018.5 4193.8 4240.2 3556.1 3956.0 4080.8 4080.8 4089.5 3429.8 4061.7 4084.2 4091.8 4102.0 3060.6 3458.4 3531.9 3532.2 3546.7 4140.0 4985.4 5146.3 5242.4 5311.8 3898.9 4652.1 4675.0 4682.7 4691.1 5712.9 5721.4 5732.5 5746.3 5747.3 3587.6 3795.6 3847.3 3899.9 3926.3 5390.9 5870.7 6053.3 6119.7 6145.9 3481.5 3591.5 3704.4 3942.3 3952.0 3861.9 3921.5 3999.7 4005.3 4015.7 4094.9 4579.7 4660.3 4669.0 4670.6 4825.6 5201.7 5860.5 5877.3 5967.8 1111.0 1189.3 1339.2 1358.6 1365.1 867.8 890.5 912.5 914.0 916.2 4517.7 5250.8 5398.7 5438.1 5450.5 4992.8 5451.4 5522.0 5823.9 5838.0 4464.0 5379.1 5390.4 5444.2 5453.6 2388.8 2417.7 2573.3 2658.3 2711.6 4321.6 4596.3 4645.5 5127.5 5253.9 4828.9 5069.6 5094.8 5114.7 5185.7 4204.7 4402.4 4511.1 5125.2 5162.4 4480.4 4973.5 5031.7 5040.4 5049.9 4615.4 4755.1 4900.0 4931.7 4933.2 4099.6 4760.8 4902.7 5129.0 5230.6 3101.5 3325.7 3335.4 3345.4 3444.8 3986.3 4360.2 4582.4 4877.2 4960.9 4721.8 4944.6 5020.3 5542.0 5703.9 5148.6 5728.9 5737.3 5770.7 5770.7 4424.5 5212.3 5573.6 5587.9 5653.4 4460.6 4736.6 5689.8 5776.7 5792.6 4470.0 4787.5 5582.8 5696.3 5721.6 07:56:08 INFO - PROCESS | 2208 | 07:56:08 INFO - PROCESS | 2208 | [#5] yui.html Cycles:180 Average:24356.21 Median:3639.16 stddev:39329.43 (1080.7%) stddev-sans-first:39399.56 07:56:08 INFO - PROCESS | 2208 | Values: 672.9 677.4 699.0 709.0 717.2 15116.0 16045.0 16237.5 16260.2 16273.7 14597.1 14708.6 14729.1 14758.0 14786.6 645.4 806.9 809.1 832.9 837.7 847.7 847.8 848.8 849.7 852.2 886.2 887.5 890.9 891.1 895.7 875.3 881.5 882.4 884.1 884.1 656.4 658.7 662.0 662.7 664.0 12193.4 14857.0 14899.4 14921.8 14926.1 14459.6 14468.4 14520.5 14547.3 14670.4 11061.3 11857.0 12034.2 12250.9 12375.3 2935.0 3336.8 3370.9 3897.3 3978.1 114952.0 119801.0 120930.4 121029.0 121129.4 8750.6 10062.9 10823.4 11188.8 11508.7 23183.2 23299.2 23442.6 23499.0 23504.6 7325.5 7515.6 7975.5 8074.0 8234.5 4410.2 4438.1 4451.4 4496.6 4576.6 3533.4 3612.7 3625.2 3653.1 3656.6 556.3 570.5 641.2 644.7 652.6 627.9 630.3 644.0 662.7 671.0 9063.9 9431.4 9649.7 9694.8 9719.4 542.1 641.7 659.4 665.1 675.8 4340.8 4711.3 4725.0 4761.1 4770.9 98897.0 100358.5 130416.0 163634.0 169702.2 92684.0 117083.0 129790.8 145859.0 146671.0 118372.0 118976.8 119291.0 122101.0 125277.0 9094.6 9177.6 9189.6 9196.4 9357.9 65224.7 65291.7 66020.7 66486.0 68888.6 61164.8 65267.7 66050.0 78363.0 96445.0 11970.0 11976.3 12112.0 12186.4 12348.2 11827.9 13049.9 13233.9 13246.7 13775.5 12030.8 12257.9 12442.3 12596.1 12664.6 12085.4 12297.4 12490.7 12530.9 12593.8 12166.5 12323.7 12366.6 12453.5 12464.5 9994.3 10096.4 10236.2 10339.4 10551.3 9903.3 10209.4 10314.0 10361.5 10363.3 07:56:08 INFO - PROCESS | 2208 | -------- Summary: end -------- 07:56:08 INFO - PROCESS | 2208 | 07:56:09 INFO - TEST-INFO | 2208: exit 0 07:56:09 INFO - TEST-OK | dromaeo_css | took 1114932ms 07:56:09 INFO - TEST-START | kraken 07:56:09 INFO - operating with platform_type : mac_ 07:56:09 INFO - Initialising browser for kraken test... 07:56:09 INFO - TEST-INFO | started process 2213 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpTIgaxJ/profile http://localhost:50035/getInfo.html) 07:56:12 INFO - PROCESS | 2213 | __metrics Screen width/height:1600/1200 07:56:12 INFO - PROCESS | 2213 | colorDepth:24 07:56:12 INFO - PROCESS | 2213 | Browser inner width/height: 1024/689 07:56:12 INFO - PROCESS | 2213 | __metrics 07:56:12 ERROR - PROCESS | 2213 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 07:56:13 INFO - TEST-INFO | 2213: exit 0 07:56:13 INFO - Browser initialized. 07:56:13 INFO - Running cycle 1/1 for kraken test... 07:56:13 INFO - TEST-INFO | started process 2215 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpTIgaxJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:25 INFO - PROCESS | 2215 | RSS: Main: 245444608 07:56:25 INFO - PROCESS | 2215 | 07:56:28 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50035/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50035/tests/kraken/driver.html?testName=audio-beat-detection) 07:56:28 INFO - PROCESS | 2215 | RSS: Main: 257957888 07:56:28 INFO - PROCESS | 2215 | 07:56:31 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50035/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50035/tests/kraken/driver.html?testName=audio-dft) 07:56:32 INFO - PROCESS | 2215 | RSS: Main: 266682368 07:56:32 INFO - PROCESS | 2215 | 07:56:35 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50035/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50035/tests/kraken/driver.html?testName=audio-fft) 07:56:36 INFO - PROCESS | 2215 | RSS: Main: 264433664 07:56:36 INFO - PROCESS | 2215 | 07:56:38 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50035/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50035/tests/kraken/driver.html?testName=audio-oscillator) 07:56:39 INFO - PROCESS | 2215 | RSS: Main: 265764864 07:56:39 INFO - PROCESS | 2215 | 07:56:41 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50035/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50035/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:41 INFO - PROCESS | 2215 | RSS: Main: 267374592 07:56:41 INFO - PROCESS | 2215 | 07:56:44 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50035/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50035/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:45 INFO - PROCESS | 2215 | RSS: Main: 267956224 07:56:45 INFO - PROCESS | 2215 | 07:56:48 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50035/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50035/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:48 INFO - PROCESS | 2215 | RSS: Main: 268185600 07:56:48 INFO - PROCESS | 2215 | 07:56:51 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50035/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50035/tests/kraken/driver.html?testName=json-parse-financial) 07:56:52 INFO - PROCESS | 2215 | RSS: Main: 268587008 07:56:52 INFO - PROCESS | 2215 | 07:56:53 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50035/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50035/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:54 INFO - PROCESS | 2215 | RSS: Main: 268005376 07:56:54 INFO - PROCESS | 2215 | 07:56:56 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50035/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50035/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:57 INFO - PROCESS | 2215 | RSS: Main: 267784192 07:56:57 INFO - PROCESS | 2215 | 07:56:59 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50035/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50035/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:57:00 INFO - PROCESS | 2215 | RSS: Main: 268062720 07:57:00 INFO - PROCESS | 2215 | 07:57:02 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50035/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50035/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:57:03 INFO - PROCESS | 2215 | RSS: Main: 268042240 07:57:03 INFO - PROCESS | 2215 | 07:57:06 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50035/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50035/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:57:07 INFO - PROCESS | 2215 | RSS: Main: 268337152 07:57:07 INFO - PROCESS | 2215 | 07:57:08 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:50035/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50035/tests/kraken/driver.html?testName=ai-astar) 07:57:09 INFO - PROCESS | 2215 | RSS: Main: 270499840 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | __start_tp_report 07:57:09 INFO - PROCESS | 2215 | _x_x_mozilla_page_load 07:57:09 INFO - PROCESS | 2215 | _x_x_mozilla_page_load_details 07:57:09 INFO - PROCESS | 2215 | |i|pagename|runs| 07:57:09 INFO - PROCESS | 2215 | |0;ai-astar;117;112;126;116;120;102;116;117;116;117 07:57:09 INFO - PROCESS | 2215 | |1;audio-beat-detection;148;112;158;195;101;154;160;98;196;136 07:57:09 INFO - PROCESS | 2215 | |2;audio-dft;200;207;233;200;203;196;201;196;197;200 07:57:09 INFO - PROCESS | 2215 | |3;audio-fft;70;84;101;166;75;80;81;91;120;79 07:57:09 INFO - PROCESS | 2215 | |4;audio-oscillator;70;71;117;71;73;75;112;69;72;114 07:57:09 INFO - PROCESS | 2215 | |5;imaging-gaussian-blur;89;86;88;74;133;129;91;89;89;79 07:57:09 INFO - PROCESS | 2215 | |6;imaging-darkroom;101;98;101;100;99;99;107;99;99;99 07:57:09 INFO - PROCESS | 2215 | |7;imaging-desaturate;89;94;95;90;94;89;91;94;91;90 07:57:09 INFO - PROCESS | 2215 | |8;json-parse-financial;55;59;59;59;57;58;56;58;58;57 07:57:09 INFO - PROCESS | 2215 | |9;json-stringify-tinderbox;67;74;72;91;76;77;68;81;73;73 07:57:09 INFO - PROCESS | 2215 | |10;stanford-crypto-aes;88;87;86;86;79;102;78;74;108;112 07:57:09 INFO - PROCESS | 2215 | |11;stanford-crypto-ccm;138;144;142;143;143;142;141;143;188;141 07:57:09 INFO - PROCESS | 2215 | |12;stanford-crypto-pbkdf2;180;180;175;178;176;175;178;178;176;179 07:57:09 INFO - PROCESS | 2215 | |13;stanford-crypto-sha256-iterative;60;90;92;91;71;72;70;73;69;69 07:57:09 INFO - PROCESS | 2215 | __end_tp_report 07:57:09 INFO - PROCESS | 2215 | __start_cc_report 07:57:09 INFO - PROCESS | 2215 | _x_x_mozilla_cycle_collect,971 07:57:09 INFO - PROCESS | 2215 | __end_cc_report 07:57:09 INFO - PROCESS | 2215 | __startTimestamp1472741829116__endTimestamp 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | ------- Summary: start ------- 07:57:09 INFO - PROCESS | 2215 | Number of tests: 14 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | [#0] ai-astar Cycles:10 Average:115.90 Median:117.00 stddev:6.06 (5.2%) stddev-sans-first:6.42 07:57:09 INFO - PROCESS | 2215 | Values: 117.0 112.0 126.0 116.0 120.0 102.0 116.0 117.0 116.0 117.0 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:159.00 stddev:34.79 (21.9%) stddev-sans-first:36.89 07:57:09 INFO - PROCESS | 2215 | Values: 148.0 112.0 158.0 195.0 101.0 154.0 160.0 98.0 196.0 136.0 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | [#2] audio-dft Cycles:10 Average:203.30 Median:200.50 stddev:10.95 (5.5%) stddev-sans-first:11.55 07:57:09 INFO - PROCESS | 2215 | Values: 200.0 207.0 233.0 200.0 203.0 196.0 201.0 196.0 197.0 200.0 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | [#3] audio-fft Cycles:10 Average:94.70 Median:79.50 stddev:28.94 (36.4%) stddev-sans-first:29.29 07:57:09 INFO - PROCESS | 2215 | Values: 70.0 84.0 101.0 166.0 75.0 80.0 81.0 91.0 120.0 79.0 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | [#4] audio-oscillator Cycles:10 Average:84.40 Median:71.00 stddev:20.75 (29.2%) stddev-sans-first:21.35 07:57:09 INFO - PROCESS | 2215 | Values: 70.0 71.0 117.0 71.0 73.0 75.0 112.0 69.0 72.0 114.0 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | [#5] imaging-gaussian-blur Cycles:10 Average:94.70 Median:88.50 stddev:19.86 (22.4%) stddev-sans-first:20.96 07:57:09 INFO - PROCESS | 2215 | Values: 89.0 86.0 88.0 74.0 133.0 129.0 91.0 89.0 89.0 79.0 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | [#6] imaging-darkroom Cycles:10 Average:100.20 Median:99.00 stddev:2.57 (2.6%) stddev-sans-first:2.71 07:57:09 INFO - PROCESS | 2215 | Values: 101.0 98.0 101.0 100.0 99.0 99.0 107.0 99.0 99.0 99.0 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | [#7] imaging-desaturate Cycles:10 Average:91.70 Median:92.50 stddev:2.31 (2.5%) stddev-sans-first:2.24 07:57:09 INFO - PROCESS | 2215 | Values: 89.0 94.0 95.0 90.0 94.0 89.0 91.0 94.0 91.0 90.0 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:1.35 (2.3%) stddev-sans-first:1.05 07:57:09 INFO - PROCESS | 2215 | Values: 55.0 59.0 59.0 59.0 57.0 58.0 56.0 58.0 58.0 57.0 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | [#9] json-stringify-tinderbox Cycles:10 Average:75.20 Median:75.00 stddev:6.89 (9.2%) stddev-sans-first:6.64 07:57:09 INFO - PROCESS | 2215 | Values: 67.0 74.0 72.0 91.0 76.0 77.0 68.0 81.0 73.0 73.0 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:82.50 stddev:12.99 (15.7%) stddev-sans-first:13.75 07:57:09 INFO - PROCESS | 2215 | Values: 88.0 87.0 86.0 86.0 79.0 102.0 78.0 74.0 108.0 112.0 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:143.00 stddev:14.68 (10.3%) stddev-sans-first:15.24 07:57:09 INFO - PROCESS | 2215 | Values: 138.0 144.0 142.0 143.0 143.0 142.0 141.0 143.0 188.0 141.0 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:178.00 stddev:1.90 (1.1%) stddev-sans-first:1.79 07:57:09 INFO - PROCESS | 2215 | Values: 180.0 180.0 175.0 178.0 176.0 175.0 178.0 178.0 176.0 179.0 07:57:09 INFO - PROCESS | 2215 | 07:57:09 INFO - PROCESS | 2215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:72.50 stddev:11.14 (15.4%) stddev-sans-first:10.26 07:57:09 INFO - PROCESS | 2215 | Values: 60.0 90.0 92.0 91.0 71.0 72.0 70.0 73.0 69.0 69.0 07:57:09 INFO - PROCESS | 2215 | -------- Summary: end -------- 07:57:09 INFO - PROCESS | 2215 | 07:57:10 INFO - TEST-INFO | 2215: exit 0 07:57:10 INFO - TEST-OK | kraken | took 60559ms 07:57:10 INFO - SUITE-END | took 1175s 07:57:10 INFO - Completed test suite (00:19:35) 07:57:10 INFO - javascript benchmark 07:57:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7278.939617231669, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2874.4394843005616, 3365.7475689323323, 3401.2177199244175, 3431.176517635768, 3436.1924947637317, 5713.942860571404, 5731.598788084825, 5753.395893431192, 5769.769209231631, 5813.796517121901, 5731.283589551306, 5744.569157313197, 5777.0, 5782.421757824215, 5814.302283725949, 4195.265828480004, 5224.92162617561, 5252.921206181911, 5278.419373868871, 5327.440618735035, 5314.256004159421, 5338.439463856297, 5349.598780091489, 5380.273663055476, 5405.27028851104, 5161.81933632321, 5171.276021357013, 5176.0, 5199.246109314147, 5253.973730131325, 5233.476652334774, 5239.502247286502, 5258.342707161605, 5268.209768534713, 5308.761105750251, 5165.173572228426, 5214.348206474191, 5236.842894713165, 5267.157254839246, 5270.657407268515, 5651.547876169897, 5698.743556539925, 5699.945510080648, 5741.3110426748635, 5814.30228372598, 6102.0348389851015, 6230.221222347207, 6232.657203853786, 6242.656653884034, 6289.685515724195, 4991.401031876162, 5408.945255675145, 6281.623102613858, 6286.308506064329, 6292.0, 4588.564086411786, 5231.581473482112, 5683.090705487102, 5764.769409223668, 5815.534757219412, 5260.158374660036, 6215.595986260879, 6299.5275354348605, 6302.833975714508, 6357.396047375492, 5523.309586301712, 6130.0, 6133.110698948627, 6149.5080393568405, 6171.7531298748445, 5879.147523609053, 6166.691665416712, 6168.753249869955, 6199.690015499207, 6255.0, 6221.906671399842, 6232.626042437469, 6246.593971391845, 6247.312795592481, 6248.28144763349, 6108.541859360477, 6147.44672979434, 6150.753969841246, 6159.23009623797, 6169.2288463942, 4244.278472659594, 4913.557779799835, 4929.0, 4949.356583644175, 4966.950330496648, 3570.910727231788, 4443.089166720814, 4443.755593442392, 4462.955370446319, 4503.842365517191, 5540.196671482612, 5872.324682661463, 5941.049432090845, 5964.1650168976375, 6009.429104235178, 6152.0, 6164.568480206342, 6179.5056395488255, 6197.101420294032, 6291.716872740738, 5302.310699609026, 5716.171155182476, 5953.1070339449425, 5965.880682386415, 5991.700414979234, 5491.121420572689, 5491.423400542965, 5492.093804522209, 5519.9448005520235, 5547.33431988164, 6220.315765265817, 6308.936910630835, 6313.96843015782, 6359.332270111571, 6453.645049522322, 6230.0, 6242.937570624235, 6244.281907580505, 6252.843678908063, 6259.467945224525, 6393.041043843461, 6416.871662566629, 6452.12896258999, 6469.288378278292, 6472.967635161794, 6095.498792504082, 6140.933729673127, 6143.603994442082, 6178.66017369031, 6226.377362263918, 6080.4831589313635, 6229.283632382153, 6245.937540624535, 6253.812385628438, 6264.404881536247, 4650.441946966385, 5314.4951229633125, 6071.180390647206, 6195.628262304276, 6215.160953271251, 5040.798368065383, 6055.364186760503, 6084.574079814371, 6102.572819902742, 6111.327753947151, 5115.64190506661, 5917.852053698692, 5990.34106248321, 6010.068439391901, 6040.6677632730625, 5231.529162375405, 6072.757089716539, 6166.0, 6170.876582468415, 6192.81421557354, 5921.407859214217, 5954.46409823118, 5968.671723055274, 5996.820095397145, 6058.5153187745755], "value": 5652.184668010897, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.0862031103391, 518.6991544903956, 521.3405042621085, 533.6397931396307, 554.3126523111343, 37503.0, 38474.230515389674, 38575.0, 41141.0, 41401.58598414019, 37925.43111853324, 39471.81584552461, 41691.0, 42410.57589424105, 42466.0, 9568.37805542641, 9762.951185244065, 9766.218702503818, 9770.413775173512, 9790.363626364264, 9677.854832177487, 9759.707208783713, 9765.902340976605, 9770.951145244264, 9789.265805064613, 9727.659531916384, 9752.90247097527, 9787.608495660164, 9807.607695692164, 9824.656137035205, 8469.237768600824, 9771.95114024429, 9777.511124443748, 9790.461524616143, 9794.706158815246, 7954.204579542057, 8411.537365444898, 9820.852687209626, 9872.308938374317, 9890.0, 40069.59930400688, 40229.0, 40325.0, 40351.192976140606, 40406.19187616261, 3468.7051600613727, 3519.1729943463265, 3929.4302326162833, 4040.7777572233517, 4070.7964601769795, 31049.68950310513, 31433.0, 31577.84211078953, 31598.0, 32532.349353012807, 3212.9357412851846, 3324.3018966017166, 3349.949750753741, 3367.3097015111844, 3392.6776956189124, 403323.0, 405537.0, 409884.0, 410348.0, 412147.0, 59620.0, 59791.80416391648, 59906.70046649739, 59948.40051599428, 59974.0, 56673.71663141658, 62764.0, 62964.05553916695, 63023.6848815753, 63198.684006580595, 16032.11823349727, 16241.59396015109, 16312.265948032367, 16339.428120015742, 16339.509814705578, 12674.176178548549, 12750.553730619384, 12756.489740410465, 12767.680807979876, 12825.23048617086, 15789.842101578837, 16235.350585976665, 16339.0, 16371.263293151836, 16425.0, 6937.7571784987285, 6998.930010699828, 7047.541909775849, 7058.576485410892, 7108.3747288882005, 742.5062333548238, 869.6782190589396, 920.9593159729462, 1004.1063453526367, 1005.0602686488157, 23386.0, 26317.736822631912, 26640.20079397621, 30225.372501060636, 30554.0, 893.7542175901679, 1052.4316868890712, 1065.9660129674203, 1140.378493720924, 1195.665213740154, 13929.651758705912, 15077.698446031018, 15346.079235245697, 15597.532074037797, 15915.204239788196, 639521.0, 643410.7829460823, 644322.0, 645567.0, 646364.0, 57455.425445745845, 57556.0, 57750.7112464435, 57778.13332800011, 58045.70977145087, 1274.4010315151863, 1322.9801552976712, 1346.1451977994045, 1348.514534767483, 1352.9932350338381, 24998.87500562558, 26361.736382636696, 26966.460670786866, 28664.14007579776, 30399.392012160075, 49723.005539888276, 49871.75064124656, 50011.24983125183, 50049.49950500594, 50111.999999998545, 576309.0, 579466.0, 580093.0, 580720.0, 582338.0, 26148.73851261463, 26790.732092678823, 26869.193924182306, 40114.1977160461, 40603.78188654345, 46838.53161468478, 46929.0, 47163.0, 47749.76125119352, 48354.75822620864, 37663.81168094142, 38766.41850372303, 39015.21969560536, 39920.80237592877, 40482.0, 38536.6146338533, 38551.22897541977, 39567.010824729616, 39732.2187446876, 40114.1977160461, 37168.814155929045, 37744.62255377521, 38411.61588384192, 38502.80748596239, 38550.6144938547, 32891.0, 33958.49062264118, 34428.48357274593, 34552.57119719272, 35496.46755298621, 25210.571304318015, 25564.48871022532, 25636.359091022874, 26057.199455243284, 26114.216573502825], "value": 19820.5286788027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.9391709492291, 372.064258390149, 385.0988686473651, 385.9983343224332, 405.57414714549714, 19439.611207775855, 20837.270695525658, 21679.783202167975, 21713.67429488559, 21914.561708765814, 19975.600487990232, 20353.28763493278, 20507.48731281715, 20689.482762930933, 21031.0, 5867.735951882154, 5993.370696076914, 6153.230846144232, 6167.444929956303, 6239.937600623981, 4242.236397448458, 6098.207233059718, 6183.227096612924, 6183.350748171445, 6630.138082049351, 6823.078884350623, 6962.338577835098, 6971.7211311547735, 6972.860542789142, 6991.755288564901, 6772.322767723237, 6883.346082122191, 6933.20268169162, 6935.445164386837, 6953.6870840812035, 5289.841304760864, 5920.585559010871, 5942.257217847769, 5974.790882319141, 5999.220101386835, 25382.873085634452, 26229.21312360632, 26523.0, 26536.336591585172, 26638.600420993702, 2444.9633255501003, 2499.987500062506, 2548.1591074945222, 2888.393437378153, 3028.606281183454, 15464.38142474311, 15574.844251557566, 15861.048337099695, 16068.196590170444, 16160.191990400433, 1824.507383006594, 1902.9333973310868, 1927.6530224559574, 1953.2089503751004, 1963.1950900130878, 120437.0, 122456.38771806173, 123680.0, 126497.0, 126840.0, 10145.695629131138, 10206.591736330613, 10363.378197308186, 10843.67468975932, 11092.889071109186, 13302.201867887958, 13370.0, 13437.193768373929, 13461.663458413617, 13496.39266233022, 8221.671133154607, 8417.957910210409, 8458.323334133254, 8624.78438039054, 8645.654173833102, 8462.746117616482, 8503.61733721984, 8568.828623427622, 8711.825763484694, 8723.607437665194, 5387.865303367447, 6380.585261957958, 6445.2265728112925, 6544.9672751635935, 6600.141981542369, 1576.9448069317748, 1670.574003629091, 1681.8065922419078, 1780.2078075256386, 1883.7645294338208, 849.9957500212583, 857.704092088241, 898.2948385517337, 956.9808603827885, 978.0854900667898, 19571.608567828847, 20643.0, 20665.380038598865, 20819.06314215864, 21005.68937416883, 911.813078318943, 935.2471260635253, 940.7365937537501, 947.3415975896686, 957.0859828863419, 10804.0, 10952.4523773811, 10960.397178155119, 10962.232643715022, 10990.615328463466, 566082.0, 582818.0, 591896.0, 593861.0, 599728.0, 122805.38597306957, 128908.35545822399, 129909.0, 131642.0, 133705.0, 949.2026697574071, 951.9095685909828, 978.6966040527317, 983.5279066048337, 1019.6431249062917, 15634.530964071097, 17176.742348865027, 17808.821911780717, 18899.622007560047, 19521.902390487958, 44389.0, 44663.77668111639, 47401.52598474109, 52382.47617523776, 55536.0, 66853.66573167103, 67804.98292525517, 67850.0, 67951.0, 68593.0, 8033.879491807745, 8038.316743076904, 8097.595120244082, 8233.38249631268, 8297.709580164665, 11152.442377881236, 12388.56640017595, 12855.16441431304, 12856.871431285568, 13033.804492932803, 7361.484696071224, 8547.444416112932, 9932.155766759617, 11140.33158010522, 11216.0, 9749.415035097916, 10196.3372380795, 11073.05879000294, 11222.046126079375, 11571.363575003455, 11062.723431914266, 11522.942385288019, 11789.410529473664, 11807.0, 11932.701682458008, 8169.305609023062, 8170.223828736261, 8417.410781245255, 8458.19647133546, 8597.828043439222, 9326.393784403992, 10356.808966968594, 10613.363198208132, 11641.88358116408, 11902.940485297519], "value": 9776.47907421469, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1496.7006598680266, 1513.0694622806973, 1731.2555601091533, 1849.5191250274925, 1880.6708825955454, 7915.327197188231, 8212.178782121784, 8324.625391857366, 8769.60536775845, 8776.034636190023, 8441.324694024479, 8541.060483346826, 8563.957180214105, 8575.399722019461, 8577.14228577142, 2348.6477028445697, 2363.905443782255, 2365.254944692425, 2368.5144545368157, 2376.5246950609862, 2347.1784875293597, 2371.336025912747, 2393.1623931623967, 2400.9759902401015, 2403.2910291463972, 2365.6215005599106, 2375.8574485530835, 2388.044782087162, 2396.6524853896176, 2402.0872068613903, 2345.9882700586386, 2352.3766201956496, 2357.8231632627535, 2364.73987861336, 2377.48883989943, 2273.261190113203, 2331.80179684727, 2348.9060437582475, 2351.4591643921995, 2362.220467245822, 7138.964305178492, 8178.877316840252, 8282.006159260867, 8649.956750216272, 8677.479351238882, 4066.2477441673386, 4864.513548645107, 5224.294720212761, 5234.214867769827, 5249.973750131263, 3409.215880347534, 3441.6042155152227, 3611.873584424559, 3627.72792040598, 3635.8728794073922, 1045.0542259255385, 1077.7144056824948, 1085.484394912418, 1100.1968562949012, 1106.9778604427866, 11002.669919902415, 11090.0, 11100.555977760961, 11117.888821111846, 11123.388213648246, 4075.918481630351, 4486.551344865487, 4563.26987681976, 4755.313248014861, 4779.474257831635, 9625.614975401046, 9708.126268635857, 9719.65981190655, 9723.854142187873, 9734.172595329477, 5275.815346462856, 5298.364196296392, 5312.309399778004, 5316.069687804618, 5317.9202311965355, 4352.521222665504, 4700.952990470051, 4831.855044348676, 4854.2233242681, 4864.586510146606, 3880.1075752577067, 3924.156306394139, 3982.769648996571, 4011.8165141283393, 4038.5355684096116, 1294.8964082873347, 1307.215670597653, 1307.2940612069567, 1308.6597484654058, 1311.206719934426, 851.2721623012359, 862.8868759300558, 897.8339007283673, 905.7418635688929, 926.5321012888583, 5665.66006039639, 5734.197212390269, 5905.76376944926, 5993.31076926159, 6041.667708275999, 941.580996456584, 949.5299826585884, 962.6101428921158, 963.0, 997.670768646345, 3889.4943657324934, 3914.5693973662874, 3933.0757272041046, 4014.277430062617, 4016.3172260715746, 10191.388516689023, 10464.947675261727, 10506.737331566772, 10508.42203678805, 10534.73663158412, 10419.531121099568, 10481.109105725945, 10484.213683973732, 10485.37087774736, 10526.894731052744, 7909.0113735783025, 8006.15935326794, 8014.19858014194, 8045.517268963764, 8046.557439340892, 5453.563714902878, 5454.3201922837725, 5743.540516758566, 5761.164631128547, 5863.618864773946, 9484.33609647318, 9703.5148242589, 9745.756356091155, 9782.706518804447, 9796.951015244878, 8336.749897503085, 9406.670766523139, 9858.556364963737, 9961.750956226153, 9992.0, 6882.621455819978, 6900.102986611709, 6925.203601585882, 6946.965265173844, 7004.824879378057, 8020.197980201933, 8084.474509156886, 8175.0, 8202.09776924526, 8206.302464290364, 7263.854722905407, 7347.8530429392185, 7355.264473552602, 7425.777226683208, 7480.027596412431, 7148.85702285941, 7161.856762864818, 7228.554289142297, 7230.819229519304, 7362.889556656547, 5925.644461332334, 6020.939790602038, 6198.969005154945, 6846.7945961621235, 6858.931410685829, 4548.818047278071, 4596.6092882105395, 4830.8792280193275, 4921.729304888266, 5058.190689489664, 4405.40527028847, 4556.567126123013, 4691.671582989158, 4908.901821963612, 5061.190209566452], "value": 4507.347878432245, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.3445755481828, 305.36179385085165, 314.30852125324293, 314.60674157303373, 318.0220820975501, 4249.362595610656, 4862.367892174021, 5218.21726740989, 5418.674879507227, 5606.523445507127, 5395.352557693082, 5505.0, 5513.61404701671, 5529.917051244234, 5540.036080696828, 3558.1638314996085, 4145.875623731293, 4186.618415922753, 4193.412922190896, 4202.474690663667, 3278.606567211938, 3867.8839634811, 4018.5177778666603, 4193.811278492475, 4240.194363071022, 3556.128748456632, 3955.9759105935445, 4080.7959602019782, 4080.8165631966694, 4089.548210385315, 3429.794212347267, 4061.6596523147587, 4084.1627466369323, 4091.7954102294916, 4101.979490102531, 3060.6021217241837, 3458.4466485362473, 3531.876384326562, 3532.2229109595846, 3546.680798728127, 4139.985703502631, 4985.376827896513, 5146.330976973007, 5242.423333433319, 5311.814086506993, 3898.8635397761227, 4652.092841895832, 4675.0, 4682.672212945095, 4691.108689349013, 5712.885742285131, 5721.370649228582, 5732.484076433141, 5746.25298711169, 5747.252857128547, 3587.641235876418, 3795.62043795621, 3847.2690188864026, 3899.863504777319, 3926.332523471017, 5390.946090539122, 5870.714378503716, 6053.303870054956, 6119.663418512025, 6145.938540614626, 3481.5125882376487, 3591.4612808078473, 3704.388775851954, 3942.3495123304333, 3951.9604803951593, 3861.942070868939, 3921.5294164700417, 3999.700022498266, 4005.339119045383, 4015.6948991577856, 4094.9385759213637, 4579.7252164870215, 4660.347551342815, 4668.953310466852, 4670.6497012724185, 4825.613950883921, 5201.699575106223, 5860.501857342174, 5877.265341832271, 5967.791127310524, 1110.9888901110885, 1189.2983139947473, 1339.163023110556, 1358.5516779462753, 1365.1058556645414, 867.8264347130599, 890.4879694175875, 912.4943842659532, 913.9680111196076, 916.2395211974045, 4517.728936263835, 5250.789968401297, 5398.703071331036, 5438.129899216186, 5450.482204190595, 4992.750362481934, 5451.37309209446, 5521.978433989644, 5823.854403639858, 5838.0, 4464.0, 5379.1393377059485, 5390.407055223922, 5444.183372494158, 5453.64551304164, 2388.7936592021265, 2417.6944449996804, 2573.3309339571847, 2658.268976031568, 2711.6170752916155, 4321.611055005064, 4596.264597664424, 4645.469443223107, 5127.513021223878, 5253.894922101536, 4828.875294870246, 5069.594432445396, 5094.77073531692, 5114.6931184128325, 5185.651730550084, 4204.747715137101, 4402.3616575597, 4511.142882852248, 5125.156132900324, 5162.432132465501, 4480.372747815373, 4973.52751488608, 5031.6729412588065, 5040.395152581714, 5049.924251136163, 4615.353850461005, 4755.07419495105, 4899.951000489949, 4931.7040977541465, 4933.248696712615, 4099.631033207026, 4760.762441652418, 4902.730349830794, 5129.0, 5230.555402790653, 3101.4877948861495, 3325.686353890248, 3335.4329763939704, 3345.381104495676, 3444.8277586120093, 3986.3291594631087, 4360.171567402183, 4582.404287442611, 4877.244192090915, 4960.866827264311, 4721.787519561697, 4944.588234118591, 5020.272060551272, 5541.972290138524, 5703.857403564944, 5148.58811295088, 5728.942710572841, 5737.340205876378, 5770.662881532986, 5770.711464426846, 4424.469063712247, 5212.322398088224, 5573.554115670818, 5587.916181257366, 5653.40639232891, 4460.598546130864, 4736.573708366263, 5689.833584115164, 5776.671365585855, 5792.594518383673, 4469.9776501117285, 4787.473377928494, 5582.8325150245555, 5696.344920334214, 5721.6280941740315], "value": 3948.040519639052, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.8889733194025, 677.4411110833563, 698.9930100698991, 708.9822754431135, 717.2289788477389, 15116.0, 16045.0, 16237.512874613765, 16260.186990650449, 16273.674526509463, 14597.051191672534, 14708.632284192901, 14729.116253024798, 14757.966942314042, 14786.630334241649, 645.4352441613588, 806.8628333183373, 809.1423091522975, 832.9333653307751, 837.6733074101105, 847.7160151349306, 847.8304339132198, 848.7665891879751, 849.7493239494364, 852.2287329966359, 886.2289807867164, 887.5340446265698, 890.8619164029553, 891.0510306523531, 895.6954635423955, 875.3303722652145, 881.4667126388539, 882.3514716683233, 884.1158841158873, 884.1379654836547, 656.4387448731361, 658.739797779879, 662.0301258656092, 662.6587307536622, 663.9668016599151, 12193.39033048353, 14857.034292770935, 14899.404023839033, 14921.776173357408, 14926.10443373401, 14459.638509037253, 14468.421263149461, 14520.491782787552, 14547.3453694584, 14670.413183472649, 11061.281016733887, 11857.0, 12034.157608967376, 12250.897419232222, 12375.319357435337, 2934.970650293491, 3336.799792012487, 3370.9213051823426, 3897.279003384383, 3978.144698889753, 114952.0, 119801.0, 120930.39534802358, 121029.0, 121129.39435302855, 8750.562471876381, 10062.949685251528, 10823.404712740874, 11188.832167517494, 11508.712282193012, 23183.188588399662, 23299.18452854176, 23442.64836027461, 23499.0, 23504.647430288558, 7325.487215894943, 7515.6242187891485, 7975.521468711896, 8074.0, 8234.505929644121, 4410.20616289071, 4438.090191510732, 4451.399061126771, 4496.5503449655425, 4576.610988065985, 3533.434650455915, 3612.7290453216115, 3625.2024554597947, 3653.1232504199334, 3656.597774244831, 556.2796178948272, 570.4666137161767, 641.1632819170933, 644.7421031587403, 652.6214795418646, 627.9026750853625, 630.3349965786048, 644.0440807982623, 662.6786008785735, 670.9765158219438, 9063.909360906438, 9431.434113953184, 9649.710508684751, 9694.806103877883, 9719.368241064309, 542.0648285620298, 641.6791604197902, 659.3604203922283, 665.1386454541381, 675.8073948924631, 4340.826366945287, 4711.340412342275, 4724.976375118103, 4761.119192949315, 4770.903159716346, 98897.0, 100358.49820750995, 130416.04375934368, 163634.0, 169702.15148924422, 92684.0, 117083.0, 129790.75523111998, 145859.0, 146671.0, 118372.0, 118976.81023189657, 119291.0, 122101.0, 125277.0, 9094.636214551343, 9177.587008584496, 9189.632414703337, 9196.402233854778, 9357.923838758357, 65224.69550609056, 65291.673541631986, 66020.66989665022, 66486.0, 68888.62222755617, 61164.77670446477, 65267.67366163139, 66050.00924986033, 78363.0, 96445.0, 11970.0, 11976.291446569163, 12112.0, 12186.390680465764, 12348.197367171106, 11827.881721182677, 13049.869501304865, 13233.933830330787, 13246.735065298833, 13775.517856875362, 12030.75938481208, 12257.938710306391, 12442.253464792142, 12596.118271720892, 12664.556740514037, 12085.39573021363, 12297.446614902172, 12490.687732806753, 12530.874691252971, 12593.811092833797, 12166.45250963691, 12323.69190770238, 12366.607963361199, 12453.501859925502, 12464.5014199431, 9994.300398972293, 10096.394216347042, 10236.18110551169, 10339.431331276852, 10551.261411701107, 9903.306768526421, 10209.38743675382, 10314.0, 10361.481925903523, 10363.274570779973], "value": 7630.333615681612, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 126.0, 116.0, 120.0, 102.0, 116.0, 117.0, 116.0, 117.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 112.0, 158.0, 195.0, 101.0, 154.0, 160.0, 98.0, 196.0, 136.0], "value": 145.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 207.0, 233.0, 200.0, 203.0, 196.0, 201.0, 196.0, 197.0, 200.0], "value": 203.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 84.0, 101.0, 166.0, 75.0, 80.0, 81.0, 91.0, 120.0, 79.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 117.0, 71.0, 73.0, 75.0, 112.0, 69.0, 72.0, 114.0], "value": 84.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 74.0, 133.0, 129.0, 91.0, 89.0, 89.0, 79.0], "value": 94.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 98.0, 101.0, 100.0, 99.0, 99.0, 107.0, 99.0, 99.0, 99.0], "value": 100.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 94.0, 95.0, 90.0, 94.0, 89.0, 91.0, 94.0, 91.0, 90.0], "value": 91.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 59.0, 59.0, 57.0, 58.0, 56.0, 58.0, 58.0, 57.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 72.0, 91.0, 76.0, 77.0, 68.0, 81.0, 73.0, 73.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 86.0, 86.0, 79.0, 102.0, 78.0, 74.0, 108.0, 112.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 144.0, 142.0, 143.0, 143.0, 142.0, 141.0, 143.0, 188.0, 141.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 180.0, 175.0, 178.0, 176.0, 175.0, 178.0, 178.0, 176.0, 179.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 90.0, 92.0, 91.0, 71.0, 72.0, 70.0, 73.0, 69.0, 69.0], "value": 75.7, "unit": "score"}]}]} 07:57:10 INFO - Return code: 0 07:57:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:57:10 ERROR - # TBPL SUCCESS # 07:57:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:57:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:57:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:57:10 INFO - 2016-09-01 07:57:10.457 screenresolution[2220:21021] starting screenresolution argv=screenresolution get 07:57:10 INFO - 2016-09-01 07:57:10.460 screenresolution[2220:21021] Display 0: 1600x1200x32@60 07:57:10 INFO - 2016-09-01 07:57:10.466 screenresolution[2221:21023] starting screenresolution argv=screenresolution list 07:57:10 INFO - Available Modes on Display 0 07:57:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:57:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:57:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:57:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:57:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:57:10 INFO - Intel Iris: 07:57:10 INFO - Chipset Model: Intel Iris 07:57:10 INFO - Type: GPU 07:57:10 INFO - Bus: Built-In 07:57:10 INFO - VRAM (Dynamic, Max): 1536 MB 07:57:10 INFO - Vendor: Intel (0x8086) 07:57:10 INFO - Device ID: 0x0a2e 07:57:10 INFO - Revision ID: 0x0009 07:57:10 INFO - Displays: 07:57:10 INFO - Display: 07:57:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:57:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:57:10 INFO - Display Serial Number: 1600x1200 60 07:57:10 INFO - Main Display: Yes 07:57:10 INFO - Mirror: Off 07:57:10 INFO - Online: Yes 07:57:10 INFO - Rotation: Supported 07:57:10 INFO - Return code: 0 07:57:10 INFO - Running post-action listener: _resource_record_post_action 07:57:10 INFO - [mozharness: 2016-09-01 14:57:10.701216Z] Finished run-tests step (success) 07:57:10 INFO - Running post-run listener: _resource_record_post_run 07:57:10 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 892928; Write bytes: 708991488; Read time: 5; Write time: 2091 07:57:10 INFO - TinderboxPrint: CPU usage
54.6% 07:57:10 INFO - TinderboxPrint: I/O read bytes / time
892,928 / 5 07:57:10 INFO - TinderboxPrint: I/O write bytes / time
708,991,488 / 2,091 07:57:10 INFO - TinderboxPrint: CPU idle
2,198.4 (45.4%) 07:57:10 INFO - TinderboxPrint: CPU system
974.5 (20.1%) 07:57:10 INFO - TinderboxPrint: CPU user
1,668.9 (34.5%) 07:57:10 INFO - TinderboxPrint: Swap in / out
406,392,832 / 0 07:57:10 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 396540416; Write bytes: 390925824; Read time: 29629; Write time: 856 07:57:10 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 892928; Write bytes: 298339328; Read time: 5; Write time: 1188 07:57:11 INFO - Running post-run listener: _upload_blobber_files 07:57:11 INFO - Blob upload gear active. 07:57:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:57:11 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 07:57:11 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'] 07:57:11 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 07:57:11 INFO - (blobuploader) - INFO - Open directory for files ... 07:57:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:57:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:57:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:12 INFO - (blobuploader) - INFO - Done attempting. 07:57:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:57:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:57:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:13 INFO - (blobuploader) - INFO - Done attempting. 07:57:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:57:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:57:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:16 INFO - (blobuploader) - INFO - Done attempting. 07:57:16 INFO - (blobuploader) - INFO - Iteration through files over. 07:57:16 INFO - Return code: 0 07:57:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:57:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:57:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56f7d99ceeea0d9a5097edf56dd9034b204d721a42059c23b3a7ea9267b06ba6fe11ad37f678f1b074ecc1d6833d4cf60497a3d5885909bdfa0ee6a16896a44f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00484c55621ccbf8cc7f22a9e4e7e67004b6c739acd0459204fcae2a74d4e11d860b92b8e3b810af8bafe25450caf9339e4053c807b9010dc99891a46ae6451e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afb0b782ebe34870df37e4f1d95e7328944085f85383c1fb63a2b9f4b17242ffb39a418dfae049cb72b2c16dc1d6656be80d6ae328b9f3bf3b71bec4fcbea04f"} 07:57:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:57:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:57:16 INFO - Contents: 07:57:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56f7d99ceeea0d9a5097edf56dd9034b204d721a42059c23b3a7ea9267b06ba6fe11ad37f678f1b074ecc1d6833d4cf60497a3d5885909bdfa0ee6a16896a44f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00484c55621ccbf8cc7f22a9e4e7e67004b6c739acd0459204fcae2a74d4e11d860b92b8e3b810af8bafe25450caf9339e4053c807b9010dc99891a46ae6451e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afb0b782ebe34870df37e4f1d95e7328944085f85383c1fb63a2b9f4b17242ffb39a418dfae049cb72b2c16dc1d6656be80d6ae328b9f3bf3b71bec4fcbea04f"} 07:57:16 INFO - Running post-run listener: copy_logs_to_upload_dir 07:57:16 INFO - Copying logs to upload dir... 07:57:16 INFO - mkdir: /builds/slave/test/build/upload/logs 07:57:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.082294 ========= master_lag: 9.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-09-01 07:57:25.977182) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-09-01 07:57:25.980404) ========= 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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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/56f7d99ceeea0d9a5097edf56dd9034b204d721a42059c23b3a7ea9267b06ba6fe11ad37f678f1b074ecc1d6833d4cf60497a3d5885909bdfa0ee6a16896a44f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00484c55621ccbf8cc7f22a9e4e7e67004b6c739acd0459204fcae2a74d4e11d860b92b8e3b810af8bafe25450caf9339e4053c807b9010dc99891a46ae6451e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afb0b782ebe34870df37e4f1d95e7328944085f85383c1fb63a2b9f4b17242ffb39a418dfae049cb72b2c16dc1d6656be80d6ae328b9f3bf3b71bec4fcbea04f"} build_url:https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/QBoqATrmRuKIbduzkgWU6w/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/56f7d99ceeea0d9a5097edf56dd9034b204d721a42059c23b3a7ea9267b06ba6fe11ad37f678f1b074ecc1d6833d4cf60497a3d5885909bdfa0ee6a16896a44f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00484c55621ccbf8cc7f22a9e4e7e67004b6c739acd0459204fcae2a74d4e11d860b92b8e3b810af8bafe25450caf9339e4053c807b9010dc99891a46ae6451e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afb0b782ebe34870df37e4f1d95e7328944085f85383c1fb63a2b9f4b17242ffb39a418dfae049cb72b2c16dc1d6656be80d6ae328b9f3bf3b71bec4fcbea04f"}' ========= master_lag: 5.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-09-01 07:57:30.998174) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 07:57:30.998532) ========= 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.MM0n6S4eeV/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.qfR9c4PBtS/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.005338 ========= master_lag: 0.86 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 07:57:31.865836) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 07:57:31.866177) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 07:57:31.869139) ========= ========= Total master_lag: 15.18 =========