builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0368 starttime: 1470657923.27 results: success (0) buildid: 20160805131321 builduid: 3935528495d04780899dc77e8ecc8206 revision: f54fea6078ddf0023a4307a25264c6ece653e503 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:23.272327) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:23.272785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:23.273063) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:23.295799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:23.296121) ========= 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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-08 05:05:23-- 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% 8.22M=0.001s 2016-08-08 05:05:23 (8.22 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120369 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:23.438228) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:23.438783) ========= 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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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.020477 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:23.489438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:05:23.490032) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f54fea6078ddf0023a4307a25264c6ece653e503 --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 f54fea6078ddf0023a4307a25264c6ece653e503 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8s3o4tbnSg/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.RwppwRZ9UY/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-08 05:05:23,575 truncating revision to first 12 chars 2016-08-08 05:05:23,575 Setting DEBUG logging. 2016-08-08 05:05:23,575 attempt 1/10 2016-08-08 05:05:23,575 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f54fea6078dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 05:05:24,690 unpacking tar archive at: fx-team-f54fea6078dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.405482 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:05:24.918782) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:24.919124) ========= script_repo_revision: f54fea6078ddf0023a4307a25264c6ece653e503 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:24.919573) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:24.919887) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:05:24.938767) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-08 05:05:24.939188) ========= /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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 05:05:25 INFO - MultiFileLogger online at 20160808 05:05:25 in /builds/slave/test 05:05:25 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 05:05:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:05:25 INFO - {'append_to_log': False, 05:05:25 INFO - 'base_work_dir': '/builds/slave/test', 05:05:25 INFO - 'blob_upload_branch': 'Fx-Team', 05:05:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:05:25 INFO - 'branch': 'Fx-Team', 05:05:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:05:25 INFO - 'config_files': ('talos/mac_config.py',), 05:05:25 INFO - 'default_actions': ('clobber', 05:05:25 INFO - 'read-buildbot-config', 05:05:25 INFO - 'download-and-extract', 05:05:25 INFO - 'populate-webroot', 05:05:25 INFO - 'create-virtualenv', 05:05:25 INFO - 'install', 05:05:25 INFO - 'run-tests'), 05:05:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:05:25 INFO - 'download_minidump_stackwalk': True, 05:05:25 INFO - 'download_symbols': 'ondemand', 05:05:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:05:25 INFO - 'tooltool.py': '/tools/tooltool.py', 05:05:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:05:25 INFO - '/tools/misc-python/virtualenv.py')}, 05:05:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:05:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:05:25 INFO - 'installer_path': 'installer.exe', 05:05:25 INFO - 'log_level': 'info', 05:05:25 INFO - 'log_name': 'talos', 05:05:25 INFO - 'log_to_console': True, 05:05:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:05:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:05:25 INFO - 'opt_config_files': (), 05:05:25 INFO - 'pip_index': False, 05:05:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:05:25 INFO - 'cmd': ('bash', 05:05:25 INFO - '-c', 05:05:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:05:25 INFO - 'enabled': True, 05:05:25 INFO - 'halt_on_failure': False, 05:05:25 INFO - 'name': 'check_screen_resolution'},), 05:05:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:05:25 INFO - 'cmd': ('bash', 05:05:25 INFO - '-c', 05:05:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:05:25 INFO - 'enabled': True, 05:05:25 INFO - 'halt_on_failure': False, 05:05:25 INFO - 'name': 'check_screen_resolution'},), 05:05:25 INFO - 'run_cmd_checks_enabled': True, 05:05:25 INFO - 'sps_profile': False, 05:05:25 INFO - 'sps_profile_interval': 0, 05:05:25 INFO - 'suite': 'dromaeojs-e10s', 05:05:25 INFO - 'system_bits': '32', 05:05:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:05:25 INFO - 'title': 't-yosemite-r7-0368', 05:05:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:05:25 INFO - 'use_talos_json': True, 05:05:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:05:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:05:25 INFO - 'work_dir': 'build'} 05:05:25 INFO - [mozharness: 2016-08-08 12:05:25.148921Z] Running clobber step. 05:05:25 INFO - Running pre-action listener: _resource_record_pre_action 05:05:25 INFO - Running main action method: clobber 05:05:25 INFO - rmtree: /builds/slave/test/build 05:05:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:05:26 INFO - Running post-action listener: _resource_record_post_action 05:05:26 INFO - [mozharness: 2016-08-08 12:05:26.763655Z] Finished clobber step (success) 05:05:26 INFO - [mozharness: 2016-08-08 12:05:26.763731Z] Running read-buildbot-config step. 05:05:26 INFO - Running pre-action listener: _resource_record_pre_action 05:05:26 INFO - Running main action method: read_buildbot_config 05:05:26 INFO - Using buildbot properties: 05:05:26 INFO - { 05:05:26 INFO - "project": "", 05:05:26 INFO - "product": "firefox", 05:05:26 INFO - "script_repo_revision": "production", 05:05:26 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:05:26 INFO - "repository": "", 05:05:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:05:26 INFO - "buildid": "20160805131321", 05:05:26 INFO - "pgo_build": "False", 05:05:26 INFO - "basedir": "/builds/slave/test", 05:05:26 INFO - "buildnumber": 72, 05:05:26 INFO - "slavename": "t-yosemite-r7-0368", 05:05:26 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:05:26 INFO - "platform": "yosemite_r7", 05:05:26 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:05:26 INFO - "branch": "fx-team", 05:05:26 INFO - "repo_path": "integration/fx-team", 05:05:26 INFO - "revision": "f54fea6078ddf0023a4307a25264c6ece653e503", 05:05:26 INFO - "stage_platform": "macosx64", 05:05:26 INFO - "builduid": "3935528495d04780899dc77e8ecc8206", 05:05:26 INFO - "slavebuilddir": "test" 05:05:26 INFO - } 05:05:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:05:26 INFO - Running post-action listener: _resource_record_post_action 05:05:26 INFO - [mozharness: 2016-08-08 12:05:26.766741Z] Finished read-buildbot-config step (success) 05:05:26 INFO - [mozharness: 2016-08-08 12:05:26.766848Z] Running download-and-extract step. 05:05:26 INFO - Running pre-action listener: _resource_record_pre_action 05:05:26 INFO - Running main action method: download_and_extract 05:05:26 INFO - mkdir: /builds/slave/test/build/tests 05:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:26 INFO - trying https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:05:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:27 INFO - Downloaded 1199 bytes. 05:05:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:05:27 INFO - Using the following test package requirements: 05:05:27 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:05:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:27 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:05:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:27 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:05:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:27 INFO - u'jsshell-mac.zip'], 05:05:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:27 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:05:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:05:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:27 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:05:27 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:27 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:05:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:27 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:05:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:05:27 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:05:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:27 INFO - trying https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:05:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:28 INFO - Downloaded 16320553 bytes. 05:05:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:05:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:35 INFO - trying https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:05:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:36 INFO - Downloaded 16320553 bytes. 05:05:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:05: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')]} 05:05:43 INFO - trying https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:05:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:45 INFO - Downloaded 14413723 bytes. 05:05:45 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 05:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:45 INFO - trying https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:05:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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 05:05:48 INFO - Downloaded 111902381 bytes. 05:05:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:05:48 INFO - mkdir: /builds/slave/test/properties 05:05:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:05:48 INFO - Writing to file /builds/slave/test/properties/build_url 05:05:48 INFO - Contents: 05:05:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:05:49 INFO - Running post-action listener: _resource_record_post_action 05:05:49 INFO - Running post-action listener: set_extra_try_arguments 05:05:49 INFO - [mozharness: 2016-08-08 12:05:49.388390Z] Finished download-and-extract step (success) 05:05:49 INFO - [mozharness: 2016-08-08 12:05:49.388532Z] Running populate-webroot step. 05:05:49 INFO - Running pre-action listener: _resource_record_pre_action 05:05:49 INFO - Running main action method: populate_webroot 05:05:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:05:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:05:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:05:49 INFO - '--tppagecycles', 05:05:49 INFO - '7'], 05:05:49 INFO - 'tests': ['tsvgm']}}, 05:05:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:05:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:05:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:05:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:05:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:05:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:05:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:49 INFO - 'talos_options': ['--disable-e10s'], 05:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:49 INFO - 'talos_options': ['--disable-e10s'], 05:05:49 INFO - 'tests': ['damp', 'tps']}, 05:05:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:49 INFO - 'tests': ['damp', 'tps']}, 05:05:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:05:49 INFO - 'tests': ['dromaeo_dom']}, 05:05:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:05:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:05:49 INFO - 'tests': ['basic_compositor_video']}, 05:05:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:05:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:05:49 INFO - 'tests': ['a11yr', 05:05:49 INFO - 'ts_paint', 05:05:49 INFO - 'tpaint', 05:05:49 INFO - 'sessionrestore', 05:05:49 INFO - 'sessionrestore_no_auto_restore', 05:05:49 INFO - 'tabpaint']}, 05:05:49 INFO - 'other-e10s': {'tests': ['a11yr', 05:05:49 INFO - 'ts_paint', 05:05:49 INFO - 'tpaint', 05:05:49 INFO - 'sessionrestore', 05:05:49 INFO - 'sessionrestore_no_auto_restore', 05:05:49 INFO - 'tabpaint']}, 05:05:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:05:49 INFO - 'ts_paint', 05:05:49 INFO - 'tpaint', 05:05:49 INFO - 'sessionrestore', 05:05:49 INFO - 'sessionrestore_no_auto_restore', 05:05:49 INFO - 'tabpaint']}, 05:05:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:05:49 INFO - 'ts_paint', 05:05:49 INFO - 'tpaint', 05:05:49 INFO - 'sessionrestore', 05:05:49 INFO - 'sessionrestore_no_auto_restore', 05:05:49 INFO - 'tabpaint']}, 05:05:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:05:49 INFO - 'tests': ['a11yr', 05:05:49 INFO - 'ts_paint', 05:05:49 INFO - 'tpaint', 05:05:49 INFO - 'sessionrestore', 05:05:49 INFO - 'sessionrestore_no_auto_restore', 05:05:49 INFO - 'tabpaint']}, 05:05:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:05:49 INFO - 'tests': ['a11yr', 05:05:49 INFO - 'ts_paint', 05:05:49 INFO - 'tpaint', 05:05:49 INFO - 'sessionrestore', 05:05:49 INFO - 'sessionrestore_no_auto_restore', 05:05:49 INFO - 'tabpaint']}, 05:05:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:05:49 INFO - 'tests': ['tsvgx', 05:05:49 INFO - 'tsvgr_opacity', 05:05:49 INFO - 'tart', 05:05:49 INFO - 'tscrollx', 05:05:49 INFO - 'cart']}, 05:05:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:05:49 INFO - 'tsvgr_opacity', 05:05:49 INFO - 'tart', 05:05:49 INFO - 'tscrollx', 05:05:49 INFO - 'cart']}, 05:05:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:49 INFO - 'talos_options': ['--disable-e10s'], 05:05:49 INFO - 'tests': ['tp5o']}, 05:05:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:49 INFO - 'tests': ['tp5o']}, 05:05:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:49 INFO - 'talos_options': ['--disable-e10s', 05:05:49 INFO - '--xperf_path', 05:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:49 INFO - 'tests': ['tp5n']}, 05:05:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:49 INFO - 'talos_options': ['--xperf_path', 05:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:49 INFO - 'tests': ['tp5n']}}, 05:05:49 INFO - 'talos.zip': {'path': '', 05:05:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:05:49 INFO - Running post-action listener: _resource_record_post_action 05:05:49 INFO - [mozharness: 2016-08-08 12:05:49.407272Z] Finished populate-webroot step (success) 05:05:49 INFO - [mozharness: 2016-08-08 12:05:49.407361Z] Running create-virtualenv step. 05:05:49 INFO - Running pre-action listener: _resource_record_pre_action 05:05:49 INFO - Running main action method: create_virtualenv 05:05:49 INFO - Creating virtualenv /builds/slave/test/build/venv 05:05:49 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 05:05:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:05:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:05:49 INFO - Using real prefix '/tools/python27' 05:05:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:05:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:05:53 INFO - Installing pip.................done. 05:05:53 INFO - Return code: 0 05:05:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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')]} 05:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101041a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb209d8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa5d30>, '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 0x100d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9db20>, '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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 05:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8s3o4tbnSg/Render', 05:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:53 INFO - 'HOME': '/Users/cltbld', 05:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:53 INFO - 'LOGNAME': 'cltbld', 05:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:53 INFO - 'MOZ_NO_REMOTE': '1', 05:05:53 INFO - 'NO_EM_RESTART': '1', 05:05:53 INFO - 'PAGER': '/bin/cat', 05:05:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:53 INFO - 'PWD': '/builds/slave/test', 05:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:53 INFO - 'SHELL': '/bin/bash', 05:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwppwRZ9UY/Listeners', 05:05:53 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 05:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:53 INFO - 'USER': 'cltbld', 05:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:53 INFO - 'XPC_FLAGS': '0x0', 05:05:53 INFO - 'XPC_SERVICE_NAME': '0', 05:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:53 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 05:05:53 INFO - Cleaning up... 05:05:53 INFO - Return code: 0 05:05:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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')]} 05:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101041a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb209d8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa5d30>, '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 0x100d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9db20>, '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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 05:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8s3o4tbnSg/Render', 05:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:53 INFO - 'HOME': '/Users/cltbld', 05:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:53 INFO - 'LOGNAME': 'cltbld', 05:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:53 INFO - 'MOZ_NO_REMOTE': '1', 05:05:53 INFO - 'NO_EM_RESTART': '1', 05:05:53 INFO - 'PAGER': '/bin/cat', 05:05:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:53 INFO - 'PWD': '/builds/slave/test', 05:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:53 INFO - 'SHELL': '/bin/bash', 05:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwppwRZ9UY/Listeners', 05:05:53 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 05:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:53 INFO - 'USER': 'cltbld', 05:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:53 INFO - 'XPC_FLAGS': '0x0', 05:05:53 INFO - 'XPC_SERVICE_NAME': '0', 05:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:53 INFO - Downloading/unpacking psutil>=3.1.1 05:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:05:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:56 INFO - Installing collected packages: psutil 05:05:56 INFO - Running setup.py install for psutil 05:05:56 INFO - building 'psutil._psutil_osx' extension 05:05:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:05:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:05:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:05:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:05:57 INFO - building 'psutil._psutil_posix' extension 05:05:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:05:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:05:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:05:57 INFO - ^ 05:05:57 INFO - 1 warning generated. 05:05:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:05:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:57 INFO - Successfully installed psutil 05:05:57 INFO - Cleaning up... 05:05:57 INFO - Return code: 0 05:05:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101041a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb209d8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa5d30>, '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 0x100d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9db20>, '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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 05:05:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:05:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8s3o4tbnSg/Render', 05:05:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:57 INFO - 'HOME': '/Users/cltbld', 05:05:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:57 INFO - 'LOGNAME': 'cltbld', 05:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:57 INFO - 'MOZ_NO_REMOTE': '1', 05:05:57 INFO - 'NO_EM_RESTART': '1', 05:05:57 INFO - 'PAGER': '/bin/cat', 05:05:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:57 INFO - 'PWD': '/builds/slave/test', 05:05:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:57 INFO - 'SHELL': '/bin/bash', 05:05:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwppwRZ9UY/Listeners', 05:05:57 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 05:05:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:57 INFO - 'USER': 'cltbld', 05:05:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:57 INFO - 'XPC_FLAGS': '0x0', 05:05:57 INFO - 'XPC_SERVICE_NAME': '0', 05:05:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:06:00 INFO - Installing collected packages: mozsystemmonitor 05:06:00 INFO - Running setup.py install for mozsystemmonitor 05:06:00 INFO - Successfully installed mozsystemmonitor 05:06:00 INFO - Cleaning up... 05:06:00 INFO - Return code: 0 05:06:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101041a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb209d8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa5d30>, '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 0x100d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9db20>, '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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 05:06:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:06:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8s3o4tbnSg/Render', 05:06:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:00 INFO - 'HOME': '/Users/cltbld', 05:06:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:00 INFO - 'LOGNAME': 'cltbld', 05:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:00 INFO - 'MOZ_NO_REMOTE': '1', 05:06:00 INFO - 'NO_EM_RESTART': '1', 05:06:00 INFO - 'PAGER': '/bin/cat', 05:06:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:00 INFO - 'PWD': '/builds/slave/test', 05:06:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:00 INFO - 'SHELL': '/bin/bash', 05:06:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwppwRZ9UY/Listeners', 05:06:00 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 05:06:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:00 INFO - 'USER': 'cltbld', 05:06:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:00 INFO - 'XPC_FLAGS': '0x0', 05:06:00 INFO - 'XPC_SERVICE_NAME': '0', 05:06:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:00 INFO - Downloading/unpacking jsonschema==2.5.1 05:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:06:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:03 INFO - Downloading functools32-3.2.3-2.tar.gz 05:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:06:03 INFO - warning: no files found matching '*.txt' 05:06:03 INFO - no previously-included directories found matching 'build' 05:06:03 INFO - no previously-included directories found matching 'dist' 05:06:03 INFO - no previously-included directories found matching '.git*' 05:06:03 INFO - Installing collected packages: jsonschema, functools32 05:06:03 INFO - Running setup.py install for functools32 05:06:03 INFO - warning: no files found matching '*.txt' 05:06:03 INFO - no previously-included directories found matching 'build' 05:06:03 INFO - no previously-included directories found matching 'dist' 05:06:03 INFO - no previously-included directories found matching '.git*' 05:06:03 INFO - Successfully installed jsonschema functools32 05:06:03 INFO - Cleaning up... 05:06:03 INFO - Return code: 0 05:06:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:06:03 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')]} 05:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:03 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')]} 05:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:03 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 0x101041a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb209d8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa5d30>, '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 0x100d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9db20>, '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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 05:06:03 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 05:06:03 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 05:06:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8s3o4tbnSg/Render', 05:06:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:03 INFO - 'HOME': '/Users/cltbld', 05:06:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:03 INFO - 'LOGNAME': 'cltbld', 05:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:03 INFO - 'MOZ_NO_REMOTE': '1', 05:06:03 INFO - 'NO_EM_RESTART': '1', 05:06:03 INFO - 'PAGER': '/bin/cat', 05:06:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:03 INFO - 'PWD': '/builds/slave/test', 05:06:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:03 INFO - 'SHELL': '/bin/bash', 05:06:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwppwRZ9UY/Listeners', 05:06:03 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 05:06:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:03 INFO - 'USER': 'cltbld', 05:06:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:03 INFO - 'XPC_FLAGS': '0x0', 05:06:03 INFO - 'XPC_SERVICE_NAME': '0', 05:06:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:06:04 INFO - Cleaning up... 05:06:04 INFO - Return code: 0 05:06:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101041a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb209d8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa5d30>, '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 0x100d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9db20>, '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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 05:06:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:06:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8s3o4tbnSg/Render', 05:06:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:04 INFO - 'HOME': '/Users/cltbld', 05:06:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:04 INFO - 'LOGNAME': 'cltbld', 05:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:04 INFO - 'MOZ_NO_REMOTE': '1', 05:06:04 INFO - 'NO_EM_RESTART': '1', 05:06:04 INFO - 'PAGER': '/bin/cat', 05:06:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:04 INFO - 'PWD': '/builds/slave/test', 05:06:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:04 INFO - 'SHELL': '/bin/bash', 05:06:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwppwRZ9UY/Listeners', 05:06:04 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 05:06:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:04 INFO - 'USER': 'cltbld', 05:06:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:04 INFO - 'XPC_FLAGS': '0x0', 05:06:04 INFO - 'XPC_SERVICE_NAME': '0', 05:06:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:04 INFO - Downloading/unpacking blobuploader==1.2.4 05:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:06 INFO - Downloading blobuploader-1.2.4.tar.gz 05:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:06:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:06:06 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 05:06:06 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 05:06:06 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 05:06:06 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 05:06:06 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 05:06:06 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 05:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:06:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:08 INFO - Downloading docopt-0.6.1.tar.gz 05:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:06:08 INFO - Installing collected packages: blobuploader, requests, docopt 05:06:08 INFO - Running setup.py install for blobuploader 05:06:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:06:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:06:08 INFO - Running setup.py install for requests 05:06:08 INFO - Running setup.py install for docopt 05:06:08 INFO - Successfully installed blobuploader requests docopt 05:06:08 INFO - Cleaning up... 05:06:09 INFO - Return code: 0 05:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101041a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb209d8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa5d30>, '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 0x100d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9db20>, '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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 05:06:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:06:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8s3o4tbnSg/Render', 05:06:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:09 INFO - 'HOME': '/Users/cltbld', 05:06:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:09 INFO - 'LOGNAME': 'cltbld', 05:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:09 INFO - 'MOZ_NO_REMOTE': '1', 05:06:09 INFO - 'NO_EM_RESTART': '1', 05:06:09 INFO - 'PAGER': '/bin/cat', 05:06:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:09 INFO - 'PWD': '/builds/slave/test', 05:06:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:09 INFO - 'SHELL': '/bin/bash', 05:06:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwppwRZ9UY/Listeners', 05:06:09 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 05:06:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:09 INFO - 'USER': 'cltbld', 05:06:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:09 INFO - 'XPC_FLAGS': '0x0', 05:06:09 INFO - 'XPC_SERVICE_NAME': '0', 05:06:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:09 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-PC1FNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:09 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-nOtKGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:09 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-BC23Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:09 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-4VyFc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:09 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-2f5BDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:09 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-4e0EmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:09 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-_lSarV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:10 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-m8sVFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:10 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-JDSi16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:10 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-3J9CI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:10 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-SVgBQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:10 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-_oStnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:10 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-vZehvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:10 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-ECvjlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:10 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-Ujh1QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:10 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-m2owBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:10 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-yWy0K6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:06:11 INFO - Running setup.py install for manifestparser 05:06:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:06:11 INFO - Running setup.py install for mozcrash 05:06:11 INFO - Running setup.py install for mozdebug 05:06:11 INFO - Running setup.py install for mozdevice 05:06:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:06:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:06:11 INFO - Running setup.py install for mozfile 05:06:11 INFO - Running setup.py install for mozhttpd 05:06:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:06:11 INFO - Running setup.py install for mozinfo 05:06:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:06:12 INFO - Running setup.py install for mozInstall 05:06:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:06:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:06:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:06:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:06:12 INFO - Running setup.py install for mozleak 05:06:12 INFO - Running setup.py install for mozlog 05:06:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:06:12 INFO - Running setup.py install for moznetwork 05:06:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:06:12 INFO - Running setup.py install for mozprocess 05:06:12 INFO - Running setup.py install for mozprofile 05:06:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:06:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:06:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:06:13 INFO - Running setup.py install for mozrunner 05:06:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:06:13 INFO - Running setup.py install for mozscreenshot 05:06:13 INFO - Running setup.py install for moztest 05:06:13 INFO - Running setup.py install for mozversion 05:06:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:06:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:06:13 INFO - Cleaning up... 05:06:13 INFO - Return code: 0 05:06:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101041a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb209d8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa5d30>, '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 0x100d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9db20>, '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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 05:06:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:06:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8s3o4tbnSg/Render', 05:06:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:13 INFO - 'HOME': '/Users/cltbld', 05:06:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:13 INFO - 'LOGNAME': 'cltbld', 05:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:13 INFO - 'MOZ_NO_REMOTE': '1', 05:06:13 INFO - 'NO_EM_RESTART': '1', 05:06:13 INFO - 'PAGER': '/bin/cat', 05:06:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:13 INFO - 'PWD': '/builds/slave/test', 05:06:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:13 INFO - 'SHELL': '/bin/bash', 05:06:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwppwRZ9UY/Listeners', 05:06:13 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 05:06:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:13 INFO - 'USER': 'cltbld', 05:06:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:13 INFO - 'XPC_FLAGS': '0x0', 05:06:13 INFO - 'XPC_SERVICE_NAME': '0', 05:06:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:13 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-bnqIy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:14 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-BQ8uVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:14 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-wwHS_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:14 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-Z7OdHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:14 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-2yJJoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:14 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-bcyZAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:14 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-5pwkIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:14 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-Gaxc7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:14 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-02FGB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:14 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)) 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:14 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-hJO0GF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:14 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)) 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:15 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-s8sR9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:15 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-q59Loz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:15 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-83IdeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:15 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-kkhHY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:15 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-VdKJqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:15 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-00PT9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:15 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-A0cqo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:06:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:18 INFO - Downloading blessings-1.6.tar.gz 05:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:06:18 INFO - Installing collected packages: blessings 05:06:18 INFO - Running setup.py install for blessings 05:06:18 INFO - Successfully installed blessings 05:06:18 INFO - Cleaning up... 05:06:18 INFO - Return code: 0 05:06:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:06:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:18 INFO - Reading from file tmpfile_stdout 05:06:18 INFO - Current package versions: 05:06:18 INFO - blessings == 1.6 05:06:18 INFO - blobuploader == 1.2.4 05:06:18 INFO - docopt == 0.6.1 05:06:18 INFO - functools32 == 3.2.3-2 05:06:18 INFO - jsonschema == 2.5.1 05:06:18 INFO - manifestparser == 1.1 05:06:18 INFO - mozInstall == 1.12 05:06:18 INFO - mozcrash == 0.17 05:06:18 INFO - mozdebug == 0.1 05:06:18 INFO - mozdevice == 0.48 05:06:18 INFO - mozfile == 1.2 05:06:18 INFO - mozhttpd == 0.7 05:06:18 INFO - mozinfo == 0.9 05:06:18 INFO - mozleak == 0.1 05:06:18 INFO - mozlog == 3.3 05:06:18 INFO - moznetwork == 0.27 05:06:18 INFO - mozprocess == 0.23 05:06:18 INFO - mozprofile == 0.28 05:06:18 INFO - mozrunner == 6.12 05:06:18 INFO - mozscreenshot == 0.1 05:06:18 INFO - mozsystemmonitor == 0.3 05:06:18 INFO - moztest == 0.7 05:06:18 INFO - mozversion == 1.4 05:06:18 INFO - psutil == 3.1.1 05:06:18 INFO - requests == 1.2.3 05:06:18 INFO - wsgiref == 0.1.2 05:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101041a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb209d8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa5d30>, '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 0x100d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9db20>, '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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 05:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8s3o4tbnSg/Render', 05:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:19 INFO - 'HOME': '/Users/cltbld', 05:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:19 INFO - 'LOGNAME': 'cltbld', 05:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:19 INFO - 'MOZ_NO_REMOTE': '1', 05:06:19 INFO - 'NO_EM_RESTART': '1', 05:06:19 INFO - 'PAGER': '/bin/cat', 05:06:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:19 INFO - 'PWD': '/builds/slave/test', 05:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:19 INFO - 'SHELL': '/bin/bash', 05:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwppwRZ9UY/Listeners', 05:06:19 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 05:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:19 INFO - 'USER': 'cltbld', 05:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:19 INFO - 'XPC_FLAGS': '0x0', 05:06:19 INFO - 'XPC_SERVICE_NAME': '0', 05:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:06:19 INFO - Cleaning up... 05:06:19 INFO - Return code: 0 05:06:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101041a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010d6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb209d8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa5d30>, '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 0x100d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9db20>, '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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 05:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8s3o4tbnSg/Render', 05:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:19 INFO - 'HOME': '/Users/cltbld', 05:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:19 INFO - 'LOGNAME': 'cltbld', 05:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:19 INFO - 'MOZ_NO_REMOTE': '1', 05:06:19 INFO - 'NO_EM_RESTART': '1', 05:06:19 INFO - 'PAGER': '/bin/cat', 05:06:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:19 INFO - 'PWD': '/builds/slave/test', 05:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:19 INFO - 'SHELL': '/bin/bash', 05:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwppwRZ9UY/Listeners', 05:06:19 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 05:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:19 INFO - 'USER': 'cltbld', 05:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:19 INFO - 'XPC_FLAGS': '0x0', 05:06:19 INFO - 'XPC_SERVICE_NAME': '0', 05:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:06:20 INFO - Cleaning up... 05:06:20 INFO - Return code: 0 05:06:20 INFO - Running post-action listener: _resource_record_post_action 05:06:20 INFO - Running post-action listener: _start_resource_monitoring 05:06:20 INFO - Starting resource monitoring. 05:06:20 INFO - [mozharness: 2016-08-08 12:06:20.231308Z] Finished create-virtualenv step (success) 05:06:20 INFO - [mozharness: 2016-08-08 12:06:20.232100Z] Running install step. 05:06:20 INFO - Running pre-action listener: _resource_record_pre_action 05:06:20 INFO - Running main action method: install 05:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:20 INFO - Reading from file tmpfile_stdout 05:06:20 INFO - Detecting whether we're running mozinstall >=1.0... 05:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:06:20 INFO - Reading from file tmpfile_stdout 05:06:20 INFO - Output received: 05:06:20 INFO - Usage: mozinstall [options] installer 05:06:20 INFO - Options: 05:06:20 INFO - -h, --help show this help message and exit 05:06:20 INFO - -d DEST, --destination=DEST 05:06:20 INFO - Directory to install application into. [default: 05:06:20 INFO - "/builds/slave/test"] 05:06:20 INFO - --app=APP Application being installed. [default: firefox] 05:06:20 INFO - mkdir: /builds/slave/test/build/application 05:06:20 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'] 05:06:20 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 05:06:54 INFO - Reading from file tmpfile_stdout 05:06:54 INFO - Output received: 05:06:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:06:54 INFO - Running post-action listener: _resource_record_post_action 05:06:54 INFO - [mozharness: 2016-08-08 12:06:54.889535Z] Finished install step (success) 05:06:54 INFO - [mozharness: 2016-08-08 12:06:54.889651Z] Running run-tests step. 05:06:54 INFO - Running pre-action listener: _resource_record_pre_action 05:06:54 INFO - Running main action method: run_tests 05:06:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:06:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:06:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:06:54 INFO - 2016-08-08 05:06:54.904 screenresolution[2479:21496] starting screenresolution argv=screenresolution get 05:06:54 INFO - 2016-08-08 05:06:54.906 screenresolution[2479:21496] Display 0: 1600x1200x32@60 05:06:54 INFO - 2016-08-08 05:06:54.912 screenresolution[2480:21498] starting screenresolution argv=screenresolution list 05:06:54 INFO - Available Modes on Display 0 05:06:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:06:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:06:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:06:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:06:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:06:55 INFO - Intel Iris: 05:06:55 INFO - Chipset Model: Intel Iris 05:06:55 INFO - Type: GPU 05:06:55 INFO - Bus: Built-In 05:06:55 INFO - VRAM (Dynamic, Max): 1536 MB 05:06:55 INFO - Vendor: Intel (0x8086) 05:06:55 INFO - Device ID: 0x0a2e 05:06:55 INFO - Revision ID: 0x0009 05:06:55 INFO - Displays: 05:06:55 INFO - Display: 05:06:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:06:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:06:55 INFO - Display Serial Number: 1600x1200 60 05:06:55 INFO - Main Display: Yes 05:06:55 INFO - Mirror: Off 05:06:55 INFO - Online: Yes 05:06:55 INFO - Rotation: Supported 05:06:55 INFO - Return code: 0 05:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:06:55 INFO - Python 2.7.3 05:06:55 INFO - Return code: 0 05:06:55 INFO - grabbing minidump binary from tooltool 05:06:55 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')]} 05:06:55 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 0x100fa5d30>, '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 0x100d0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:06:55 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 05:06:55 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 05:06:55 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 05:06:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:06:55 INFO - Return code: 0 05:06:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:06:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:06:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:06:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:06:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:06:55 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/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0368', '--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 05:06:55 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/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0368 --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 05:06:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8s3o4tbnSg/Render', 05:06:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:55 INFO - 'HOME': '/Users/cltbld', 05:06:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:55 INFO - 'LOGNAME': 'cltbld', 05:06:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:06:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:55 INFO - 'MOZ_NO_REMOTE': '1', 05:06:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:06:55 INFO - 'NO_EM_RESTART': '1', 05:06:55 INFO - 'PAGER': '/bin/cat', 05:06:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:55 INFO - 'PWD': '/builds/slave/test', 05:06:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:06:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:55 INFO - 'SHELL': '/bin/bash', 05:06:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwppwRZ9UY/Listeners', 05:06:55 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 05:06:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:55 INFO - 'USER': 'cltbld', 05:06:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:55 INFO - 'XPC_FLAGS': '0x0', 05:06:55 INFO - 'XPC_SERVICE_NAME': '0', 05:06:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:55 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/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0368', '--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 05:06:55 INFO - mozversion application_buildid: 20160805131321 05:06:55 INFO - mozversion application_changeset: f54fea6078ddf0023a4307a25264c6ece653e503 05:06:55 INFO - mozversion application_display_name: Nightly 05:06:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:06:55 INFO - mozversion application_name: Firefox 05:06:55 INFO - mozversion application_remotingname: firefox 05:06:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:06:55 INFO - mozversion application_vendor: Mozilla 05:06:55 INFO - mozversion application_version: 51.0a1 05:06:55 INFO - mozversion platform_buildid: 20160805131321 05:06:55 INFO - mozversion platform_changeset: f54fea6078ddf0023a4307a25264c6ece653e503 05:06:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:06:55 INFO - mozversion platform_version: 51.0a1 05:06:55 INFO - using testdate: 1470658015 05:06:55 INFO - actual date: 1470658015 05:06:55 INFO - starting webserver on 'localhost:53345' 05:06:55 INFO - SUITE-START | Running 2 tests 05:06:55 INFO - TEST-START | dromaeo_css 05:06:55 INFO - operating with platform_type : mac_ 05:06:55 INFO - Initialising browser for dromaeo_css test... 05:06:55 INFO - TEST-INFO | started process 2490 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmppfcwCs/profile http://localhost:53345/getInfo.html) 05:06:58 INFO - PROCESS | 2490 | __metrics Screen width/height:1600/1200 05:06:58 INFO - PROCESS | 2490 | colorDepth:24 05:06:58 INFO - PROCESS | 2490 | Browser inner width/height: 1024/689 05:06:58 INFO - PROCESS | 2490 | __metrics 05:06:58 ERROR - PROCESS | 2490 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:06:59 INFO - TEST-INFO | 2490: exit 0 05:06:59 INFO - Browser initialized. 05:06:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:06:59 INFO - TEST-INFO | started process 2493 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmppfcwCs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:11 INFO - PROCESS | 2493 | RSS: Main: 254849024 05:07:11 INFO - PROCESS | 2493 | 05:08:00 INFO - PROCESS | 2493 | 1470658080943 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] 05:10:13 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:53345/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53345/tests/dromaeo/cssquery-ext.html) 05:10:15 INFO - PROCESS | 2493 | RSS: Main: 267763712 05:10:15 INFO - PROCESS | 2493 | 05:13:17 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:53345/tests/dromaeo/cssquery-ext.html (next: http://localhost:53345/tests/dromaeo/cssquery-jquery.html) 05:13:18 INFO - PROCESS | 2493 | RSS: Main: 281747456 05:13:18 INFO - PROCESS | 2493 | 05:16:19 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:53345/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53345/tests/dromaeo/cssquery-mootools.html) 05:16:20 INFO - PROCESS | 2493 | RSS: Main: 288145408 05:16:20 INFO - PROCESS | 2493 | 05:19:22 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:53345/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53345/tests/dromaeo/cssquery-prototype.html) 05:19:23 INFO - PROCESS | 2493 | RSS: Main: 292225024 05:19:23 INFO - PROCESS | 2493 | 05:22:25 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:53345/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53345/tests/dromaeo/cssquery-yui.html) 05:22:26 INFO - PROCESS | 2493 | RSS: Main: 296185856 05:22:26 INFO - PROCESS | 2493 | 05:25:29 INFO - PROCESS | 2493 | Cycle 1(1): loaded http://localhost:53345/tests/dromaeo/cssquery-yui.html (next: http://localhost:53345/tests/dromaeo/cssquery-dojo.html) 05:25:29 INFO - PROCESS | 2493 | RSS: Main: 296370176 05:25:29 INFO - PROCESS | 2493 | 05:25:29 INFO - PROCESS | 2493 | __start_tp_report 05:25:29 INFO - PROCESS | 2493 | _x_x_mozilla_page_load 05:25:29 INFO - PROCESS | 2493 | _x_x_mozilla_page_load_details 05:25:29 INFO - PROCESS | 2493 | |i|pagename|runs| 05:25:29 INFO - PROCESS | 2493 | |0;dojo.html;2797.244743919142;3412.744044196684;3431.3823511767887;3432.4336484480064;3444.672756088171;5700.173474846145;5785.4503822136885;5846.3569007409205;5903.763849446017;5914.467697907187;5801.506871915893;5802.216700745398;5863.413658634145;5944.464998150165;5958.7616495340135;5227.555657769094;5317.361916569997;5318.707471089088;5366.4633536646215;5423.918641220384;5413.864653383657;5432.049391356517;5449.700266485342;5493;5496.587755918322;5202.76587553561;5279.5512381447625;5321.73391330432;5323.600729945269;5368.516833485005;5271.815486457994;5274;5294.57643388528;5325.334333208349;5391.838244852661;4436.622887054604;4710.811567537328;4948.430930443009;5283.762230699628;5356.946430535684;4623.352730617717;5655.462731040545;5722.542196624302;5872.618279811799;5892.116182572606;4753.906601481679;5412.296401467784;6247.500199983991;6274.905876411857;6278.340774218687;6249.812505624793;6260.843478913063;6309.779157729503;6318.842028949267;6327.873442531123;5773.480386765169;5838.620489668158;5857.472827445507;5881;5882.55880808941;6322.936770632235;6329.2721337045905;6330.208723909512;6353.714082866282;6390.648514331663;6187.690615469209;6262.874742505124;6263.185785847811;6264.154339164245;6284.811455656338;5926;6177.382261773877;6210.037444196157;6242.344553821783;6297.27581328144;5414.593905457028;6256.7810126645345;6272.40412160844;6284.277308109626;6296.685165741695;6212.751489940442;6234.688265586702;6247.468965137923;6249.156363890907;6297.149884765498;4963.329950456714;5011.548960593491;5018.397792264878;5022.347094877642;5094.872628184325;4508.143452743968;4517.88705282364;4522.095580883836;4532.546745325507;4563.383943167696;5771.769129234784;5866.941330586639;5883;5889.057750759858;5890.558208134407;5815;6191.504679625619;6208.286047104551;6220.066989951543;6222.066689996446;5811.9709401453565;5831.562632802556;5831.970840145772;5862.003459411911;5885.764569417261;5476.2333273341765;5514.779408823602;5518.392976772552;5532.529734972572;5545.029619816516;6207.689615519296;6262.342454042442;6263.404976527223;6299.244090709144;6382.968085159545;6259.061140828912;6259.843503912439;6272.874542509216;6280;6280.654563999024;6349.936500634934;6380.489560835029;6385.8722825544155;6391;6409.391107844747;5571.637843540157;5905.232319798399;6103.155845961239;6208.906866396917;6277.18396608438;6196.659183744938;6199.163112979871;6236.6258024518675;6254.4996400286955;6258.593191442542;6219.284782250099;6252.3122456530655;6252.437280644764;6256.593321434092;6260;6039.909401359071;6092.45167934888;6127.220070483952;6143.72682107623;6229.5327850410495;5062.848114556569;5975.521958243243;6089.69551522431;6104.938950610437;6120.969395152996;6192.473639740672;6197.659128747962;6255.155554000334;6256.749730010749;6261.436470717657;5558.416366281644;5613.736909195399;5946.1972633693895;6054.848628784315;6145.402195429131 05:25:29 INFO - PROCESS | 2493 | |1;ext.html;461.743732228613;467.92045352290114;497.4801332607426;505.8002089174776;528.4187393866745;33696.49455258173;35032;40399.788006359784;40413;40468.79765601172;30412.08763737086;40428.79785601075;40785;40833.795831020805;41099.794501027456;9563.426194428339;9614.759631009245;9621.518924053804;9719.07668771469;9762.707118786413;9619.711408657751;9634.71095867125;9723.270754693427;9745.366551174186;9760.853587196198;9670.806583868318;9671.177949874269;9762.414255144678;9823.165030972375;9829.164521015686;9647.421154730704;9707.757306067335;9738.074882886114;9798.559064842028;9799.412035277835;9566.760830979212;9580.56887440067;9594.520273986273;9667.613295468173;9685.854712179324;38605.80697096525;38723.8063809682;38822.41766373507;39101;39154.80422597897;3437.106352348407;3537.168765340143;3614.4578313253223;3656.4149736042104;4150.439690641755;31243.37513249722;31575.36849263025;32377.6762232377;32485.51271730926;32502;3169.3819705157503;3303.4219011672863;3329.1510664780326;3332.3501917125927;3344.4147274227157;470628;474358;478603;481689;484720.99999999645;45901;49907;56276;57016;57441.71279143578;59187.40812591905;59398.10902836461;59437;59677;59678;15693.45072922465;15748.370065197263;15900.284487198103;15999.28003239857;16016.359345626277;12531.310777907303;12536.059795515373;12543.310117943418;12544.996400287955;12574.434150463068;14540.127592344494;15070.924645376703;15079.321430535652;15084.24578771057;15298.541043768704;6218.626882387071;6294.2446906370615;6312.905306420407;6390.201224846895;6390.936090639034;768.036114676078;771.352064266008;1063.1441689440076;1064.7284942339809;1069.9518521666544;29895.701042989727;30250.24374390658;30382;30562.235944101576;30942.69057309443;760.9384908053345;1000.8598796168542;1092.7541303206715;1119.9776004480027;1142.4744617476053;12434.81347779784;12587.874121258854;14603.641162532676;15271.541853744406;15936.840631593768;667950;669377;669959;672100;675439;58463.70768146132;58779.41220587825;58835.70582147148;59017.704911475164;59095.40904590899;1334.6263046347037;1335.7528857161262;1351.067763243359;1361.673198432389;1367.9452821887014;25068.623970640092;27157.59263611087;29135.85432072826;29392;29899.70100299056;48479.27281090857;49225.753871230416;49293.75353123211;49343.519694409224;49369.259461107395;637985;641330;641351;641533;642537;25751.227463176136;26182.476350473265;26193.869030654725;26228.8688556556;26266;46433.30350044819;46750;47153.528464716284;47962.760186198844;48790.268145978545;39465.802670986464;39556;39774.80112599534;40893.79553102215;41064.973375665846;37703.62296377001;39620.603793961694;39733.403998940616;41026;41164.1767164661;38063.429048564845;38884.6111538881;39146.4128038074;39166.608333916294;39188;28429.573556396255;31284.06147815569;35446;35653;35738.463923041694;21839;23243;24277.514449710554;25905.222843313975;27559.89760409561 05:25:29 INFO - PROCESS | 2493 | |2;jquery.html;348.1730889138298;353.7276297251115;369.4550537956514;379.63744623884196;400.6874637782529;16246.675066498678;20138.59722805545;20710.585788284225;21233.57532849344;21472.141114355447;16464.83535164648;20480.975951202454;20598.176072957063;20604.66069705468;20939.371818845422;5622.381538030823;5763.682997435139;5846.824595262127;5959.493443057346;5964.3737407572235;6005.549583781212;6042.335343112254;6063.9090413643835;6131.202943617323;6181;6126.724297406605;6157;6166.84582885427;6705.396514313711;6757.493188010894;6394.689088736798;6729.798106056826;6768.3231676832165;6812.250652428229;6829.590224586515;4640.327152562893;5860.413958604148;5876.794312199053;5931;5948.821535353946;13137.27744974026;13325.13386629866;18535.814641853543;24873.88067536965;25188.748112518824;2119.4913220827043;2162.9891850540803;2181.9236326728487;2264.5810525052916;2403.0147639467737;9542.713718588453;10272.178225741924;10461.424621645807;12545.811812822814;14665.340059697339;1648.2747591059895;1839.5125291797685;1871.358970156597;1893.422506135628;1893.9526511837314;131327;131487.02769458466;132544.337278313;134809;140666.59333406636;9114.769506116721;11451.54193832254;11611.535538578531;11638.41807909618;11753.4710938008;14316.141031538142;14531.491397801026;14532.418703251962;14533.200673962821;14539.85460145385;8332.791680207922;8426.662933482592;8461.069282378934;8470;8515.40392172542;8311.875321870177;8380.20388063133;8401.95799021001;8574.614142363609;8577.828443431097;3632.964605087537;4503.639708823286;4508.571685689854;4537.115262523842;4544.477385100689;1896.5163883209693;1920.5006698258553;1927.785495138054;1934.603406301733;1943.863929524948;861.3927181337142;884.7655371326604;939.6429356844492;983.8081574093127;1030.927835051547;21103.68344474834;21687.02408391626;21689.566208676053;21819.454513637287;21923;841.6380956188898;929.5491686532026;936.9203617692573;987.9703608891601;1003.3478239144468;10773.892261077446;10879.401632910107;11555.191136620357;11563.826542601868;11591.710207244887;580263;583551;585651;595449;597725;107170.39244411184;121328;140033;141524;145279;867.3798234262532;978.280963491833;989.3964681544252;1023.9897601024044;1030.1038096855634;19174.424767257005;19955.102020408827;19957.800421996177;19964.50088747793;20047.899760501103;39654.2069158621;47831.04337913292;52826.47173528215;54385;56720.09004611915;66564;82724;84068.57965710132;84803.5759821197;85498.71751923602;6816.795496135124;7868.72459463916;8120.309773669068;8155.714549990722;8176.509409435453;11114.05530529914;11619.535218591162;12492.562760303346;12581.811272831097;13051.804222936853;10742.51658675377;10813.243072984815;10937.617183398543;11045.171612128961;11152.776944461228;10078.899211007796;10661.413622250851;10704.357738535713;11219.55121795119;11316.321020738782;10888.346699197757;10956.480009597677;11019.779604407706;11155.44222788841;11495.597654082067;7845.254700803414;7930.088039875257;8172.264496195371;8282.917170828214;8312.044114926619;9855.95072024664;10828.566857325619;10916.181286403393;11175.994160525592;11247.66257012291 05:25:29 INFO - PROCESS | 2493 | |3;mootools.html;1454.4545795326753;1512.3194562446897;1523.4591719939417;1819.4905426480582;1826.1325870211642;7109.608971506578;7851.607419629025;8304.543250121242;8731.432456890298;8742.213200811926;8496.405251632388;8535.487870727746;8594.96860376754;8598.8821453211;8609.870851937227;2307.538492301542;2334.673145759595;2341.7658234176615;2342.484653376263;2354.364321633158;2271.5116250006245;2282.0985710644286;2303.9078436862505;2317.756635553268;2320.512692334612;2285.4514916420108;2307.307807657696;2327.7555856635063;2335.4044718596733;2348.7181538215436;2264.8754318512474;2277.9316620501413;2311.6185829338137;2322.3729593009875;2327.93016209514;2031.6139933412753;2231.2636829846274;2323.1520495019367;2325.755795641467;2330.697009388786;8131.959340203321;8246.793830154234;8267.875981860278;8295.294899933513;8312.0441149268;5130.948690513084;5186.974065129651;5260.132078207092;5266.394364648077;5288.788448462057;3334.583177102862;3464.082018265162;3506.497903356087;3586.7130629549574;3598.7660802048044;1044.968650940473;1077.385890042676;1083.4528563075596;1096.4846522134585;1104.9392283424409;11173;11216.158788090845;11352.262102963363;11356.091512678966;11389.259698119678;4423.358613001097;4551.7724113794175;4629.583337499574;4691.671582989226;4720.645951553579;9639.662611808553;9670.323077384657;9678.75803104928;9691.224702023821;9692.951535242279;4049.959500405017;4716.5990890774665;4879.121758083508;5135.306733590992;5166.302549155891;3911.8044097794996;4185.665146788249;4352.39066530686;4804.543568361;4839.879003024953;3798.601146879593;3880.5731369549326;3885.592012838668;3953.940690889639;3988.102676897675;1253.8683438239036;1254.3540076860425;1254.6926003129292;1267.4359909840032;1269.5620011096157;782.5891407011251;845.2308399356556;913.6984795017761;915.0712027292303;945.2249155692266;5592.944070559323;5716.114002329646;5773.845230953742;5799;6033;389.8732911803675;433.8828516300644;440.35927725160457;455.69696152059174;456.66663335765077;3552.289542091592;3717.683996860243;3964.9778612907626;3969.206158768258;4012.6789856811383;10005.949970250102;10248;10433.739156520996;10468;10485.26603137773;10185.287029907835;10330.690079297634;10338.431386273676;10420.47897605132;10426.635067772591;7953.244441778022;7999.9600001999615;8065.354771618257;8070.435069545193;8086.989126359205;5716;5785.768569257182;5798.942010580009;5802.100674395476;5912.994790885646;9551.522423878918;9592.992735762644;9638.518074096128;9675.806483870143;9678.854817177607;9747.658831940847;9891.653792117242;9892.307538472525;9932.503374831374;10088.142507886912;5777;6917.100776898971;7406.1482929461645;7432.739854105081;7462.92537074644;8252.876206856781;8311.210435008665;8334.583270836312;8339.999200095785;8360.28937540316;7369.410447164107;7419.29516695913;7451.068616422947;7461;7575.621218939141;7180.748673796392;7324;7330.303621155982;7380.077490313711;7443.739469118555;5758.596898217253;6825.829354266183;6836.487263455161;6928.203256625351;6939.965300173467;4154.813033413443;4853.6602437829015;4903.803847846189;4980.775865086008;5049.924251136163;4895;5007.424146223086;5058.3929928408825;5131.409887862944;5143.459936706741 05:25:29 INFO - PROCESS | 2493 | |4;prototype.html;305.72332039504244;310.849238119512;312.56241262232874;314.8803454687217;317.7204060426824;4932.926006109902;5636.323641163061;5676.403977582357;5683.971580142093;5701.6008879378405;5387.19192121182;5489.780408783644;5563.805266815662;5606.074997625387;5612.579056570763;3249.675032496755;4093.7339072960312;4122.587741225883;4215.367694845782;4235.322348424253;4185.74885506869;4206.495220573535;4216.7680777557225;4230.365445183216;4230.736555942572;3417.538632284635;4005.3591425371947;4188.701502534224;4200.222958752625;4245.172191422674;4045.332520134189;4142.550107462394;4168.458100446923;4206.49522057352;4220.746755194683;3170.9682903170906;3608.9819550902075;3617.788041006266;3628.8952407603792;3630;4380.60574548289;4386.71486353386;5381.192821076831;5387.19192121181;5416.702081385522;4607.539246075399;4625.930611040837;4729.716217026955;4776.996830665565;4848.393950756155;4310.913781724379;5792.333881603628;5819.388964158787;5859.882802343972;5878.619159240515;3457.550518432613;4012.61880121388;4025.818838152261;4031.2743706132883;4035.4148648446103;5608.691521966331;5769.826905192851;6009.248843894513;6221.782237621706;6255.873942690314;3928.3125453046173;3958.5645578986287;3959.6832253419657;3971.6425521703186;3972.2849887020034;3982.7653427437585;4027.4562934003534;4041.2321658884716;4067.450894129314;4068.3287257602165;4205.17998990194;4582.839600614029;4629.055796565451;4791.928121078186;4795.856124316276;5307.310049693515;5869.354371019184;5916.852078697981;5952.494038006818;5980.581359304807;1160.9071274298035;1205.825155352469;1315.1977293850744;1353.303048929802;1394.7210557888463;722.0901663903519;740.9814754631177;840.6133178737849;844.2190973349627;865.6277800545699;4417.514073451917;5189.4032186299055;5505.421930697219;5518.944810551843;5520.585956053312;5102.872428189325;5458.8437567160745;5601.591315734273;6076.270847498328;6087.634741915499;4631.541064564652;5095.847124586268;5454.036546843213;5475.753591088411;5582.49757521825;2911.5632655101904;2983.7165469280385;3205.647378788378;3207.9469139750577;3220.8711651534145;5566.218809980848;6202.627842329474;6324.968375158187;6331.778387756406;6362.554621176473;4834.95165048345;6152.800203960274;6230.532710046765;6277.686115694197;6354.586951848208;6389.808305750835;6460.967695161494;6462.4490122371235;6492.642904640195;6527.477801775752;4657.627389808875;5024.371953505812;5161.251618515369;5596.748146333343;5986.940130598812;5006.949930500648;5094.465081166572;6017.308009578955;6073.939260607337;6090.23872015998;5295.205719142005;5351.652142610717;6169.907451388322;6407.391297826699;6434.67826608677;3377.645347238603;4132.1694639172265;4161.875143745692;4167.499900012018;4175.457190565207;6092.603980741238;6096.359882212304;6117.207331454527;6127;6142.938570614237;5254.527092561688;5528.695921724183;5928.851778705394;5982.790602328898;5993.910091348546;5844.707764611838;5894.646321220741;5914.615549989237;5928.911066334094;5932.584719069796;4978.4523702393435;5724.0521131616415;5781.364049954585;5824.058850280581;5839.854003649943;5612.607117501899;5655.745491452977;5877.853053673693;5960.970195148997;5964.884229881368;5528.55771538284;5827.854303642443;5845.824625261249;5849.53203743708;5851.385604511465 05:25:29 INFO - PROCESS | 2493 | |5;yui.html;630.3224034163275;705.5395331663452;706.6784613001086;786.7285786403693;808.5027707959605;15210.467633632825;15721.685566288681;15800.525984220463;15934.601634959132;15969.281382337793;14303.570892873204;14454.710905781878;14486.5654030379;14497.275136243172;14519.983601147924;679.2019377231758;831.8086840026767;831.8835363049163;855.3285670748463;862.06465984407;848.6011574559977;851.2423942691009;852.624845068168;853.7054716122959;857.618359829876;892.5849479991803;919.3242966419676;919.5264438814016;921.944683319003;922.6078916460511;885.9778505537413;892.2326798952895;907.9228265597466;909;913.392593925039;666.4002397841932;670.3564578005121;673.9224989126265;679.8538314262457;683.1290105115967;14653.34059967304;14793.704125917422;14804.777928331083;14824.555263342118;14874.776878346833;14653.12081275127;14655.926720366437;14667.706645867129;14696.779548306784;14975.475858344906;11896.107791915554;12175.939120304341;12391.900705477077;12406.75186496274;12432;3849.172427928009;3857.864974725899;4055.7363771354767;4072.511298644182;4085.8774236772942;118763.4061829694;120404;121319;121795.39102304431;122727;11249.10007199422;11294.04000659953;11315.20793544444;11498.942505287587;11874.168808183344;23224;23884.64173037406;23901.043958241477;23949.880250598635;23954.64068038981;8096.878546821802;8207.671693132208;8238.09380968093;8290.917090829134;8357.080721120672;4468.620167285817;4484.865454036384;4508.278675411984;4519.593236608721;4607.631389488833;3130.8434578270994;3633.5276414066;3711.0722319420147;3730.7761534307488;3760.5863355030924;692.0829900381914;721.8736721073897;725.818545363659;728.3954317916117;741.7960060983165;560.4703555140353;614.9016157414792;658.9505787065989;688.3804575881646;701.3372363116806;7341;7980.960095199487;8412.78968025792;8754.255888249443;8856.512891790884;560.6383882395832;612.4365583663041;660.6630618384562;669.8760729265101;671.9529632925746;4100.282450571198;4352.412424322739;4388.169630588252;4437.312216606431;4479.7536135512855;93611.0638893616;125304.37347813202;146521;156051;156538.21730891502;133130;134247;137238;137583;139146;117998;118031.8196818038;118461;119013;121396;8569.014563325298;8579.613917373857;8609.139086091342;8639.91360086391;8684.088170742234;49924.50075499344;60555.091673625815;62390.68804655947;63768;63794.68102659457;92723.53638231766;98110;99603;99812.51968543198;102524;10720.517576708911;11543.422828858356;11756.328089596767;11925.701857453287;12342.95084917792;13026.218426894038;13044.54344097952;13254.403551840383;13333.399997000352;13706.24615646149;12235;12308.384580770746;12329.815052774036;12569.560065397667;12742.87257127454;11773.117016223647;12065.974392176413;12531.561395351118;12864.292463914575;12873.485060597472;10143.644972426226;11870.940645296718;12312.938435307766;12317.44571494267;12790.104692671424;8291.33669306442;9406.576704048197;9512.98199424587;10166.694999150037;10243.539040743035;6205.441510264098;8549.145085491402;9628.566714497725;9790.167835734042;9877.851832222379 05:25:29 INFO - PROCESS | 2493 | __end_tp_report 05:25:29 INFO - PROCESS | 2493 | __start_cc_report 05:25:29 INFO - PROCESS | 2493 | _x_x_mozilla_cycle_collect,414 05:25:29 INFO - PROCESS | 2493 | __end_cc_report 05:25:29 INFO - PROCESS | 2493 | __startTimestamp1470659129706__endTimestamp 05:25:29 INFO - PROCESS | 2493 | 05:25:29 INFO - PROCESS | 2493 | ------- Summary: start ------- 05:25:29 INFO - PROCESS | 2493 | Number of tests: 6 05:25:29 INFO - PROCESS | 2493 | 05:25:29 INFO - PROCESS | 2493 | [#0] dojo.html Cycles:165 Average:5769.33 Median:5926.00 stddev:658.48 (11.1%) stddev-sans-first:617.85 05:25:29 INFO - PROCESS | 2493 | Values: 2797.2 3412.7 3431.4 3432.4 3444.7 5700.2 5785.5 5846.4 5903.8 5914.5 5801.5 5802.2 5863.4 5944.5 5958.8 5227.6 5317.4 5318.7 5366.5 5423.9 5413.9 5432.0 5449.7 5493.0 5496.6 5202.8 5279.6 5321.7 5323.6 5368.5 5271.8 5274.0 5294.6 5325.3 5391.8 4436.6 4710.8 4948.4 5283.8 5356.9 4623.4 5655.5 5722.5 5872.6 5892.1 4753.9 5412.3 6247.5 6274.9 6278.3 6249.8 6260.8 6309.8 6318.8 6327.9 5773.5 5838.6 5857.5 5881.0 5882.6 6322.9 6329.3 6330.2 6353.7 6390.6 6187.7 6262.9 6263.2 6264.2 6284.8 5926.0 6177.4 6210.0 6242.3 6297.3 5414.6 6256.8 6272.4 6284.3 6296.7 6212.8 6234.7 6247.5 6249.2 6297.1 4963.3 5011.5 5018.4 5022.3 5094.9 4508.1 4517.9 4522.1 4532.5 4563.4 5771.8 5866.9 5883.0 5889.1 5890.6 5815.0 6191.5 6208.3 6220.1 6222.1 5812.0 5831.6 5832.0 5862.0 5885.8 5476.2 5514.8 5518.4 5532.5 5545.0 6207.7 6262.3 6263.4 6299.2 6383.0 6259.1 6259.8 6272.9 6280.0 6280.7 6349.9 6380.5 6385.9 6391.0 6409.4 5571.6 5905.2 6103.2 6208.9 6277.2 6196.7 6199.2 6236.6 6254.5 6258.6 6219.3 6252.3 6252.4 6256.6 6260.0 6039.9 6092.5 6127.2 6143.7 6229.5 5062.8 5975.5 6089.7 6104.9 6121.0 6192.5 6197.7 6255.2 6256.7 6261.4 5558.4 5613.7 5946.2 6054.8 6145.4 05:25:29 INFO - PROCESS | 2493 | 05:25:29 INFO - PROCESS | 2493 | [#1] ext.html Cycles:180 Average:71953.46 Median:40406.39 stddev:161469.77 (399.6%) stddev-sans-first:161833.51 05:25:29 INFO - PROCESS | 2493 | Values: 461.7 467.9 497.5 505.8 528.4 33696.5 35032.0 40399.8 40413.0 40468.8 30412.1 40428.8 40785.0 40833.8 41099.8 9563.4 9614.8 9621.5 9719.1 9762.7 9619.7 9634.7 9723.3 9745.4 9760.9 9670.8 9671.2 9762.4 9823.2 9829.2 9647.4 9707.8 9738.1 9798.6 9799.4 9566.8 9580.6 9594.5 9667.6 9685.9 38605.8 38723.8 38822.4 39101.0 39154.8 3437.1 3537.2 3614.5 3656.4 4150.4 31243.4 31575.4 32377.7 32485.5 32502.0 3169.4 3303.4 3329.2 3332.4 3344.4 470628.0 474358.0 478603.0 481689.0 484721.0 45901.0 49907.0 56276.0 57016.0 57441.7 59187.4 59398.1 59437.0 59677.0 59678.0 15693.5 15748.4 15900.3 15999.3 16016.4 12531.3 12536.1 12543.3 12545.0 12574.4 14540.1 15070.9 15079.3 15084.2 15298.5 6218.6 6294.2 6312.9 6390.2 6390.9 768.0 771.4 1063.1 1064.7 1070.0 29895.7 30250.2 30382.0 30562.2 30942.7 760.9 1000.9 1092.8 1120.0 1142.5 12434.8 12587.9 14603.6 15271.5 15936.8 667950.0 669377.0 669959.0 672100.0 675439.0 58463.7 58779.4 58835.7 59017.7 59095.4 1334.6 1335.8 1351.1 1361.7 1367.9 25068.6 27157.6 29135.9 29392.0 29899.7 48479.3 49225.8 49293.8 49343.5 49369.3 637985.0 641330.0 641351.0 641533.0 642537.0 25751.2 26182.5 26193.9 26228.9 26266.0 46433.3 46750.0 47153.5 47962.8 48790.3 39465.8 39556.0 39774.8 40893.8 41065.0 37703.6 39620.6 39733.4 41026.0 41164.2 38063.4 38884.6 39146.4 39166.6 39188.0 28429.6 31284.1 35446.0 35653.0 35738.5 21839.0 23243.0 24277.5 25905.2 27559.9 05:25:29 INFO - PROCESS | 2493 | 05:25:29 INFO - PROCESS | 2493 | [#2] jquery.html Cycles:180 Average:35173.84 Median:21871.23 stddev:98900.88 (452.2%) stddev-sans-first:99143.76 05:25:29 INFO - PROCESS | 2493 | Values: 348.2 353.7 369.5 379.6 400.7 16246.7 20138.6 20710.6 21233.6 21472.1 16464.8 20481.0 20598.2 20604.7 20939.4 5622.4 5763.7 5846.8 5959.5 5964.4 6005.5 6042.3 6063.9 6131.2 6181.0 6126.7 6157.0 6166.8 6705.4 6757.5 6394.7 6729.8 6768.3 6812.3 6829.6 4640.3 5860.4 5876.8 5931.0 5948.8 13137.3 13325.1 18535.8 24873.9 25188.7 2119.5 2163.0 2181.9 2264.6 2403.0 9542.7 10272.2 10461.4 12545.8 14665.3 1648.3 1839.5 1871.4 1893.4 1894.0 131327.0 131487.0 132544.3 134809.0 140666.6 9114.8 11451.5 11611.5 11638.4 11753.5 14316.1 14531.5 14532.4 14533.2 14539.9 8332.8 8426.7 8461.1 8470.0 8515.4 8311.9 8380.2 8402.0 8574.6 8577.8 3633.0 4503.6 4508.6 4537.1 4544.5 1896.5 1920.5 1927.8 1934.6 1943.9 861.4 884.8 939.6 983.8 1030.9 21103.7 21687.0 21689.6 21819.5 21923.0 841.6 929.5 936.9 988.0 1003.3 10773.9 10879.4 11555.2 11563.8 11591.7 580263.0 583551.0 585651.0 595449.0 597725.0 107170.4 121328.0 140033.0 141524.0 145279.0 867.4 978.3 989.4 1024.0 1030.1 19174.4 19955.1 19957.8 19964.5 20047.9 39654.2 47831.0 52826.5 54385.0 56720.1 66564.0 82724.0 84068.6 84803.6 85498.7 6816.8 7868.7 8120.3 8155.7 8176.5 11114.1 11619.5 12492.6 12581.8 13051.8 10742.5 10813.2 10937.6 11045.2 11152.8 10078.9 10661.4 10704.4 11219.6 11316.3 10888.3 10956.5 11019.8 11155.4 11495.6 7845.3 7930.1 8172.3 8282.9 8312.0 9856.0 10828.6 10916.2 11176.0 11247.7 05:25:29 INFO - PROCESS | 2493 | 05:25:29 INFO - PROCESS | 2493 | [#3] mootools.html Cycles:180 Average:5539.90 Median:4887.06 stddev:3119.40 (63.8%) stddev-sans-first:3113.04 05:25:29 INFO - PROCESS | 2493 | Values: 1454.5 1512.3 1523.5 1819.5 1826.1 7109.6 7851.6 8304.5 8731.4 8742.2 8496.4 8535.5 8595.0 8598.9 8609.9 2307.5 2334.7 2341.8 2342.5 2354.4 2271.5 2282.1 2303.9 2317.8 2320.5 2285.5 2307.3 2327.8 2335.4 2348.7 2264.9 2277.9 2311.6 2322.4 2327.9 2031.6 2231.3 2323.2 2325.8 2330.7 8132.0 8246.8 8267.9 8295.3 8312.0 5130.9 5187.0 5260.1 5266.4 5288.8 3334.6 3464.1 3506.5 3586.7 3598.8 1045.0 1077.4 1083.5 1096.5 1104.9 11173.0 11216.2 11352.3 11356.1 11389.3 4423.4 4551.8 4629.6 4691.7 4720.6 9639.7 9670.3 9678.8 9691.2 9693.0 4050.0 4716.6 4879.1 5135.3 5166.3 3911.8 4185.7 4352.4 4804.5 4839.9 3798.6 3880.6 3885.6 3953.9 3988.1 1253.9 1254.4 1254.7 1267.4 1269.6 782.6 845.2 913.7 915.1 945.2 5592.9 5716.1 5773.8 5799.0 6033.0 389.9 433.9 440.4 455.7 456.7 3552.3 3717.7 3965.0 3969.2 4012.7 10005.9 10248.0 10433.7 10468.0 10485.3 10185.3 10330.7 10338.4 10420.5 10426.6 7953.2 8000.0 8065.4 8070.4 8087.0 5716.0 5785.8 5798.9 5802.1 5913.0 9551.5 9593.0 9638.5 9675.8 9678.9 9747.7 9891.7 9892.3 9932.5 10088.1 5777.0 6917.1 7406.1 7432.7 7462.9 8252.9 8311.2 8334.6 8340.0 8360.3 7369.4 7419.3 7451.1 7461.0 7575.6 7180.7 7324.0 7330.3 7380.1 7443.7 5758.6 6825.8 6836.5 6928.2 6940.0 4154.8 4853.7 4903.8 4980.8 5049.9 4895.0 5007.4 5058.4 5131.4 5143.5 05:25:29 INFO - PROCESS | 2493 | 05:25:29 INFO - PROCESS | 2493 | [#4] prototype.html Cycles:180 Average:4738.48 Median:5384.19 stddev:1501.18 (27.9%) stddev-sans-first:1468.06 05:25:29 INFO - PROCESS | 2493 | Values: 305.7 310.8 312.6 314.9 317.7 4932.9 5636.3 5676.4 5684.0 5701.6 5387.2 5489.8 5563.8 5606.1 5612.6 3249.7 4093.7 4122.6 4215.4 4235.3 4185.7 4206.5 4216.8 4230.4 4230.7 3417.5 4005.4 4188.7 4200.2 4245.2 4045.3 4142.6 4168.5 4206.5 4220.7 3171.0 3609.0 3617.8 3628.9 3630.0 4380.6 4386.7 5381.2 5387.2 5416.7 4607.5 4625.9 4729.7 4777.0 4848.4 4310.9 5792.3 5819.4 5859.9 5878.6 3457.6 4012.6 4025.8 4031.3 4035.4 5608.7 5769.8 6009.2 6221.8 6255.9 3928.3 3958.6 3959.7 3971.6 3972.3 3982.8 4027.5 4041.2 4067.5 4068.3 4205.2 4582.8 4629.1 4791.9 4795.9 5307.3 5869.4 5916.9 5952.5 5980.6 1160.9 1205.8 1315.2 1353.3 1394.7 722.1 741.0 840.6 844.2 865.6 4417.5 5189.4 5505.4 5518.9 5520.6 5102.9 5458.8 5601.6 6076.3 6087.6 4631.5 5095.8 5454.0 5475.8 5582.5 2911.6 2983.7 3205.6 3207.9 3220.9 5566.2 6202.6 6325.0 6331.8 6362.6 4835.0 6152.8 6230.5 6277.7 6354.6 6389.8 6461.0 6462.4 6492.6 6527.5 4657.6 5024.4 5161.3 5596.7 5986.9 5006.9 5094.5 6017.3 6073.9 6090.2 5295.2 5351.7 6169.9 6407.4 6434.7 3377.6 4132.2 4161.9 4167.5 4175.5 6092.6 6096.4 6117.2 6127.0 6142.9 5254.5 5528.7 5928.9 5982.8 5993.9 5844.7 5894.6 5914.6 5928.9 5932.6 4978.5 5724.1 5781.4 5824.1 5839.9 5612.6 5655.7 5877.9 5961.0 5964.9 5528.6 5827.9 5845.8 5849.5 5851.4 05:25:29 INFO - PROCESS | 2493 | 05:25:29 INFO - PROCESS | 2493 | [#5] yui.html Cycles:180 Average:25170.94 Median:4079.19 stddev:40885.28 (1002.3%) stddev-sans-first:40958.45 05:25:29 INFO - PROCESS | 2493 | Values: 630.3 705.5 706.7 786.7 808.5 15210.5 15721.7 15800.5 15934.6 15969.3 14303.6 14454.7 14486.6 14497.3 14520.0 679.2 831.8 831.9 855.3 862.1 848.6 851.2 852.6 853.7 857.6 892.6 919.3 919.5 921.9 922.6 886.0 892.2 907.9 909.0 913.4 666.4 670.4 673.9 679.9 683.1 14653.3 14793.7 14804.8 14824.6 14874.8 14653.1 14655.9 14667.7 14696.8 14975.5 11896.1 12175.9 12391.9 12406.8 12432.0 3849.2 3857.9 4055.7 4072.5 4085.9 118763.4 120404.0 121319.0 121795.4 122727.0 11249.1 11294.0 11315.2 11498.9 11874.2 23224.0 23884.6 23901.0 23949.9 23954.6 8096.9 8207.7 8238.1 8290.9 8357.1 4468.6 4484.9 4508.3 4519.6 4607.6 3130.8 3633.5 3711.1 3730.8 3760.6 692.1 721.9 725.8 728.4 741.8 560.5 614.9 659.0 688.4 701.3 7341.0 7981.0 8412.8 8754.3 8856.5 560.6 612.4 660.7 669.9 672.0 4100.3 4352.4 4388.2 4437.3 4479.8 93611.1 125304.4 146521.0 156051.0 156538.2 133130.0 134247.0 137238.0 137583.0 139146.0 117998.0 118031.8 118461.0 119013.0 121396.0 8569.0 8579.6 8609.1 8639.9 8684.1 49924.5 60555.1 62390.7 63768.0 63794.7 92723.5 98110.0 99603.0 99812.5 102524.0 10720.5 11543.4 11756.3 11925.7 12343.0 13026.2 13044.5 13254.4 13333.4 13706.2 12235.0 12308.4 12329.8 12569.6 12742.9 11773.1 12066.0 12531.6 12864.3 12873.5 10143.6 11870.9 12312.9 12317.4 12790.1 8291.3 9406.6 9513.0 10166.7 10243.5 6205.4 8549.1 9628.6 9790.2 9877.9 05:25:29 INFO - PROCESS | 2493 | -------- Summary: end -------- 05:25:29 INFO - PROCESS | 2493 | 05:25:30 INFO - TEST-INFO | 2493: exit 0 05:25:30 INFO - TEST-OK | dromaeo_css | took 1114821ms 05:25:30 INFO - TEST-START | kraken 05:25:30 INFO - operating with platform_type : mac_ 05:25:30 INFO - Initialising browser for kraken test... 05:25:30 INFO - TEST-INFO | started process 2498 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmpP0G6gz/profile http://localhost:53345/getInfo.html) 05:25:33 INFO - PROCESS | 2498 | __metrics Screen width/height:1600/1200 05:25:33 INFO - PROCESS | 2498 | colorDepth:24 05:25:33 INFO - PROCESS | 2498 | Browser inner width/height: 1024/689 05:25:33 INFO - PROCESS | 2498 | __metrics 05:25:33 ERROR - PROCESS | 2498 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:25:34 INFO - TEST-INFO | 2498: exit 0 05:25:34 INFO - Browser initialized. 05:25:34 INFO - Running cycle 1/1 for kraken test... 05:25:34 INFO - TEST-INFO | started process 2500 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmpP0G6gz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:46 INFO - PROCESS | 2500 | RSS: Main: 254906368 05:25:46 INFO - PROCESS | 2500 | 05:25:48 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:53345/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53345/tests/kraken/driver.html?testName=audio-beat-detection) 05:25:49 INFO - PROCESS | 2500 | RSS: Main: 267624448 05:25:49 INFO - PROCESS | 2500 | 05:25:52 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:53345/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53345/tests/kraken/driver.html?testName=audio-dft) 05:25:53 INFO - PROCESS | 2500 | RSS: Main: 276307968 05:25:53 INFO - PROCESS | 2500 | 05:25:56 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:53345/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53345/tests/kraken/driver.html?testName=audio-fft) 05:25:57 INFO - PROCESS | 2500 | RSS: Main: 279080960 05:25:57 INFO - PROCESS | 2500 | 05:25:59 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:53345/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53345/tests/kraken/driver.html?testName=audio-oscillator) 05:25:59 INFO - PROCESS | 2500 | RSS: Main: 280326144 05:25:59 INFO - PROCESS | 2500 | 05:26:02 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:53345/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53345/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:26:02 INFO - PROCESS | 2500 | RSS: Main: 282054656 05:26:02 INFO - PROCESS | 2500 | 05:26:05 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:53345/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53345/tests/kraken/driver.html?testName=imaging-darkroom) 05:26:06 INFO - PROCESS | 2500 | RSS: Main: 282152960 05:26:06 INFO - PROCESS | 2500 | 05:26:09 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:53345/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53345/tests/kraken/driver.html?testName=imaging-desaturate) 05:26:10 INFO - PROCESS | 2500 | RSS: Main: 282963968 05:26:10 INFO - PROCESS | 2500 | 05:26:13 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:53345/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53345/tests/kraken/driver.html?testName=json-parse-financial) 05:26:14 INFO - PROCESS | 2500 | RSS: Main: 282705920 05:26:14 INFO - PROCESS | 2500 | 05:26:15 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:53345/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53345/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:16 INFO - PROCESS | 2500 | RSS: Main: 282341376 05:26:16 INFO - PROCESS | 2500 | 05:26:18 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:53345/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53345/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:18 INFO - PROCESS | 2500 | RSS: Main: 282370048 05:26:18 INFO - PROCESS | 2500 | 05:26:21 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:53345/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53345/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:21 INFO - PROCESS | 2500 | RSS: Main: 282730496 05:26:21 INFO - PROCESS | 2500 | 05:26:24 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:53345/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53345/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:26:25 INFO - PROCESS | 2500 | RSS: Main: 282869760 05:26:25 INFO - PROCESS | 2500 | 05:26:28 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:53345/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53345/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:26:29 INFO - PROCESS | 2500 | RSS: Main: 282857472 05:26:29 INFO - PROCESS | 2500 | 05:26:30 INFO - PROCESS | 2500 | Cycle 1(1): loaded http://localhost:53345/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53345/tests/kraken/driver.html?testName=ai-astar) 05:26:31 INFO - PROCESS | 2500 | RSS: Main: 284176384 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | __start_tp_report 05:26:31 INFO - PROCESS | 2500 | _x_x_mozilla_page_load 05:26:31 INFO - PROCESS | 2500 | _x_x_mozilla_page_load_details 05:26:31 INFO - PROCESS | 2500 | |i|pagename|runs| 05:26:31 INFO - PROCESS | 2500 | |0;ai-astar;104;118;109;117;117;117;113;119;119;117 05:26:31 INFO - PROCESS | 2500 | |1;audio-beat-detection;177;143;124;184;146;164;129;110;156;128 05:26:31 INFO - PROCESS | 2500 | |2;audio-dft;201;210;235;200;201;197;198;194;197;195 05:26:31 INFO - PROCESS | 2500 | |3;audio-fft;69;72;79;164;85;85;75;61;131;61 05:26:31 INFO - PROCESS | 2500 | |4;audio-oscillator;70;72;126;104;102;122;103;100;104;152 05:26:31 INFO - PROCESS | 2500 | |5;imaging-gaussian-blur;90;87;90;87;103;132;87;131;136;110 05:26:31 INFO - PROCESS | 2500 | |6;imaging-darkroom;99;97;113;115;151;104;145;109;143;154 05:26:31 INFO - PROCESS | 2500 | |7;imaging-desaturate;127;145;91;93;91;111;94;90;91;90 05:26:31 INFO - PROCESS | 2500 | |8;json-parse-financial;55;56;56;57;56;57;56;56;56;57 05:26:31 INFO - PROCESS | 2500 | |9;json-stringify-tinderbox;65;74;69;74;73;76;74;76;100;71 05:26:31 INFO - PROCESS | 2500 | |10;stanford-crypto-aes;86;84;85;88;89;93;111;106;101;85 05:26:31 INFO - PROCESS | 2500 | |11;stanford-crypto-ccm;143;156;139;128;134;162;163;128;162;167 05:26:31 INFO - PROCESS | 2500 | |12;stanford-crypto-pbkdf2;173;171;170;170;171;174;192;237;171;168 05:26:31 INFO - PROCESS | 2500 | |13;stanford-crypto-sha256-iterative;69;70;81;91;88;90;74;69;68;70 05:26:31 INFO - PROCESS | 2500 | __end_tp_report 05:26:31 INFO - PROCESS | 2500 | __start_cc_report 05:26:31 INFO - PROCESS | 2500 | _x_x_mozilla_cycle_collect,1050 05:26:31 INFO - PROCESS | 2500 | __end_cc_report 05:26:31 INFO - PROCESS | 2500 | __startTimestamp1470659191101__endTimestamp 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | ------- Summary: start ------- 05:26:31 INFO - PROCESS | 2500 | Number of tests: 14 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | [#0] ai-astar Cycles:10 Average:115.00 Median:117.00 stddev:4.92 (4.2%) stddev-sans-first:3.23 05:26:31 INFO - PROCESS | 2500 | Values: 104.0 118.0 109.0 117.0 117.0 117.0 113.0 119.0 119.0 117.0 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:151.00 stddev:24.11 (16.0%) stddev-sans-first:22.83 05:26:31 INFO - PROCESS | 2500 | Values: 177.0 143.0 124.0 184.0 146.0 164.0 129.0 110.0 156.0 128.0 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | [#2] audio-dft Cycles:10 Average:202.80 Median:200.50 stddev:12.16 (6.1%) stddev-sans-first:12.88 05:26:31 INFO - PROCESS | 2500 | Values: 201.0 210.0 235.0 200.0 201.0 197.0 198.0 194.0 197.0 195.0 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | [#3] audio-fft Cycles:10 Average:88.20 Median:73.50 stddev:33.28 (45.3%) stddev-sans-first:34.57 05:26:31 INFO - PROCESS | 2500 | Values: 69.0 72.0 79.0 164.0 85.0 85.0 75.0 61.0 131.0 61.0 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:124.00 stddev:24.25 (19.6%) stddev-sans-first:22.05 05:26:31 INFO - PROCESS | 2500 | Values: 70.0 72.0 126.0 104.0 102.0 122.0 103.0 100.0 104.0 152.0 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | [#5] imaging-gaussian-blur Cycles:10 Average:105.30 Median:87.00 stddev:20.59 (23.7%) stddev-sans-first:21.08 05:26:31 INFO - PROCESS | 2500 | Values: 90.0 87.0 90.0 87.0 103.0 132.0 87.0 131.0 136.0 110.0 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | [#6] imaging-darkroom Cycles:10 Average:123.00 Median:148.00 stddev:22.61 (15.3%) stddev-sans-first:22.25 05:26:31 INFO - PROCESS | 2500 | Values: 99.0 97.0 113.0 115.0 151.0 104.0 145.0 109.0 143.0 154.0 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | [#7] imaging-desaturate Cycles:10 Average:102.30 Median:91.00 stddev:19.29 (21.2%) stddev-sans-first:18.28 05:26:31 INFO - PROCESS | 2500 | Values: 127.0 145.0 91.0 93.0 91.0 111.0 94.0 90.0 91.0 90.0 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 05:26:31 INFO - PROCESS | 2500 | Values: 55.0 56.0 56.0 57.0 56.0 57.0 56.0 56.0 56.0 57.0 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | [#9] json-stringify-tinderbox Cycles:10 Average:75.20 Median:74.00 stddev:9.34 (12.6%) stddev-sans-first:9.15 05:26:31 INFO - PROCESS | 2500 | Values: 65.0 74.0 69.0 74.0 73.0 76.0 74.0 76.0 100.0 71.0 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | [#10] stanford-crypto-aes Cycles:10 Average:92.80 Median:85.50 stddev:9.75 (11.4%) stddev-sans-first:10.03 05:26:31 INFO - PROCESS | 2500 | Values: 86.0 84.0 85.0 88.0 89.0 93.0 111.0 106.0 101.0 85.0 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:159.00 stddev:15.43 (9.7%) stddev-sans-first:16.25 05:26:31 INFO - PROCESS | 2500 | Values: 143.0 156.0 139.0 128.0 134.0 162.0 163.0 128.0 162.0 167.0 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:172.00 stddev:21.25 (12.4%) stddev-sans-first:22.40 05:26:31 INFO - PROCESS | 2500 | Values: 173.0 171.0 170.0 170.0 171.0 174.0 192.0 237.0 171.0 168.0 05:26:31 INFO - PROCESS | 2500 | 05:26:31 INFO - PROCESS | 2500 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.00 Median:77.50 stddev:9.53 (12.3%) stddev-sans-first:9.66 05:26:31 INFO - PROCESS | 2500 | Values: 69.0 70.0 81.0 91.0 88.0 90.0 74.0 69.0 68.0 70.0 05:26:31 INFO - PROCESS | 2500 | -------- Summary: end -------- 05:26:31 INFO - PROCESS | 2500 | 05:26:32 INFO - TEST-INFO | 2500: exit 0 05:26:32 INFO - TEST-OK | kraken | took 61763ms 05:26:32 INFO - SUITE-END | took 1176s 05:26:32 INFO - Completed test suite (00:19:36) 05:26:32 INFO - javascript benchmark 05:26:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7324.312728481724, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2797.244743919142, 3412.744044196684, 3431.3823511767887, 3432.4336484480064, 3444.672756088171, 5700.173474846145, 5785.4503822136885, 5846.3569007409205, 5903.763849446017, 5914.467697907187, 5801.506871915893, 5802.216700745398, 5863.413658634145, 5944.464998150165, 5958.7616495340135, 5227.555657769094, 5317.361916569997, 5318.707471089088, 5366.4633536646215, 5423.918641220384, 5413.864653383657, 5432.049391356517, 5449.700266485342, 5493.0, 5496.587755918322, 5202.76587553561, 5279.5512381447625, 5321.73391330432, 5323.600729945269, 5368.516833485005, 5271.815486457994, 5274.0, 5294.57643388528, 5325.334333208349, 5391.838244852661, 4436.622887054604, 4710.811567537328, 4948.430930443009, 5283.762230699628, 5356.946430535684, 4623.352730617717, 5655.462731040545, 5722.542196624302, 5872.618279811799, 5892.116182572606, 4753.906601481679, 5412.296401467784, 6247.500199983991, 6274.905876411857, 6278.340774218687, 6249.812505624793, 6260.843478913063, 6309.779157729503, 6318.842028949267, 6327.873442531123, 5773.480386765169, 5838.620489668158, 5857.472827445507, 5881.0, 5882.55880808941, 6322.936770632235, 6329.2721337045905, 6330.208723909512, 6353.714082866282, 6390.648514331663, 6187.690615469209, 6262.874742505124, 6263.185785847811, 6264.154339164245, 6284.811455656338, 5926.0, 6177.382261773877, 6210.037444196157, 6242.344553821783, 6297.27581328144, 5414.593905457028, 6256.7810126645345, 6272.40412160844, 6284.277308109626, 6296.685165741695, 6212.751489940442, 6234.688265586702, 6247.468965137923, 6249.156363890907, 6297.149884765498, 4963.329950456714, 5011.548960593491, 5018.397792264878, 5022.347094877642, 5094.872628184325, 4508.143452743968, 4517.88705282364, 4522.095580883836, 4532.546745325507, 4563.383943167696, 5771.769129234784, 5866.941330586639, 5883.0, 5889.057750759858, 5890.558208134407, 5815.0, 6191.504679625619, 6208.286047104551, 6220.066989951543, 6222.066689996446, 5811.9709401453565, 5831.562632802556, 5831.970840145772, 5862.003459411911, 5885.764569417261, 5476.2333273341765, 5514.779408823602, 5518.392976772552, 5532.529734972572, 5545.029619816516, 6207.689615519296, 6262.342454042442, 6263.404976527223, 6299.244090709144, 6382.968085159545, 6259.061140828912, 6259.843503912439, 6272.874542509216, 6280.0, 6280.654563999024, 6349.936500634934, 6380.489560835029, 6385.8722825544155, 6391.0, 6409.391107844747, 5571.637843540157, 5905.232319798399, 6103.155845961239, 6208.906866396917, 6277.18396608438, 6196.659183744938, 6199.163112979871, 6236.6258024518675, 6254.4996400286955, 6258.593191442542, 6219.284782250099, 6252.3122456530655, 6252.437280644764, 6256.593321434092, 6260.0, 6039.909401359071, 6092.45167934888, 6127.220070483952, 6143.72682107623, 6229.5327850410495, 5062.848114556569, 5975.521958243243, 6089.69551522431, 6104.938950610437, 6120.969395152996, 6192.473639740672, 6197.659128747962, 6255.155554000334, 6256.749730010749, 6261.436470717657, 5558.416366281644, 5613.736909195399, 5946.1972633693895, 6054.848628784315, 6145.402195429131], "value": 5728.0180758020415, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.743732228613, 467.92045352290114, 497.4801332607426, 505.8002089174776, 528.4187393866745, 33696.49455258173, 35032.0, 40399.788006359784, 40413.0, 40468.79765601172, 30412.08763737086, 40428.79785601075, 40785.0, 40833.795831020805, 41099.794501027456, 9563.426194428339, 9614.759631009245, 9621.518924053804, 9719.07668771469, 9762.707118786413, 9619.711408657751, 9634.71095867125, 9723.270754693427, 9745.366551174186, 9760.853587196198, 9670.806583868318, 9671.177949874269, 9762.414255144678, 9823.165030972375, 9829.164521015686, 9647.421154730704, 9707.757306067335, 9738.074882886114, 9798.559064842028, 9799.412035277835, 9566.760830979212, 9580.56887440067, 9594.520273986273, 9667.613295468173, 9685.854712179324, 38605.80697096525, 38723.8063809682, 38822.41766373507, 39101.0, 39154.80422597897, 3437.106352348407, 3537.168765340143, 3614.4578313253223, 3656.4149736042104, 4150.439690641755, 31243.37513249722, 31575.36849263025, 32377.6762232377, 32485.51271730926, 32502.0, 3169.3819705157503, 3303.4219011672863, 3329.1510664780326, 3332.3501917125927, 3344.4147274227157, 470628.0, 474358.0, 478603.0, 481689.0, 484720.99999999645, 45901.0, 49907.0, 56276.0, 57016.0, 57441.71279143578, 59187.40812591905, 59398.10902836461, 59437.0, 59677.0, 59678.0, 15693.45072922465, 15748.370065197263, 15900.284487198103, 15999.28003239857, 16016.359345626277, 12531.310777907303, 12536.059795515373, 12543.310117943418, 12544.996400287955, 12574.434150463068, 14540.127592344494, 15070.924645376703, 15079.321430535652, 15084.24578771057, 15298.541043768704, 6218.626882387071, 6294.2446906370615, 6312.905306420407, 6390.201224846895, 6390.936090639034, 768.036114676078, 771.352064266008, 1063.1441689440076, 1064.7284942339809, 1069.9518521666544, 29895.701042989727, 30250.24374390658, 30382.0, 30562.235944101576, 30942.69057309443, 760.9384908053345, 1000.8598796168542, 1092.7541303206715, 1119.9776004480027, 1142.4744617476053, 12434.81347779784, 12587.874121258854, 14603.641162532676, 15271.541853744406, 15936.840631593768, 667950.0, 669377.0, 669959.0, 672100.0, 675439.0, 58463.70768146132, 58779.41220587825, 58835.70582147148, 59017.704911475164, 59095.40904590899, 1334.6263046347037, 1335.7528857161262, 1351.067763243359, 1361.673198432389, 1367.9452821887014, 25068.623970640092, 27157.59263611087, 29135.85432072826, 29392.0, 29899.70100299056, 48479.27281090857, 49225.753871230416, 49293.75353123211, 49343.519694409224, 49369.259461107395, 637985.0, 641330.0, 641351.0, 641533.0, 642537.0, 25751.227463176136, 26182.476350473265, 26193.869030654725, 26228.8688556556, 26266.0, 46433.30350044819, 46750.0, 47153.528464716284, 47962.760186198844, 48790.268145978545, 39465.802670986464, 39556.0, 39774.80112599534, 40893.79553102215, 41064.973375665846, 37703.62296377001, 39620.603793961694, 39733.403998940616, 41026.0, 41164.1767164661, 38063.429048564845, 38884.6111538881, 39146.4128038074, 39166.608333916294, 39188.0, 28429.573556396255, 31284.06147815569, 35446.0, 35653.0, 35738.463923041694, 21839.0, 23243.0, 24277.514449710554, 25905.222843313975, 27559.89760409561], "value": 19604.907920005153, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.1730889138298, 353.7276297251115, 369.4550537956514, 379.63744623884196, 400.6874637782529, 16246.675066498678, 20138.59722805545, 20710.585788284225, 21233.57532849344, 21472.141114355447, 16464.83535164648, 20480.975951202454, 20598.176072957063, 20604.66069705468, 20939.371818845422, 5622.381538030823, 5763.682997435139, 5846.824595262127, 5959.493443057346, 5964.3737407572235, 6005.549583781212, 6042.335343112254, 6063.9090413643835, 6131.202943617323, 6181.0, 6126.724297406605, 6157.0, 6166.84582885427, 6705.396514313711, 6757.493188010894, 6394.689088736798, 6729.798106056826, 6768.3231676832165, 6812.250652428229, 6829.590224586515, 4640.327152562893, 5860.413958604148, 5876.794312199053, 5931.0, 5948.821535353946, 13137.27744974026, 13325.13386629866, 18535.814641853543, 24873.88067536965, 25188.748112518824, 2119.4913220827043, 2162.9891850540803, 2181.9236326728487, 2264.5810525052916, 2403.0147639467737, 9542.713718588453, 10272.178225741924, 10461.424621645807, 12545.811812822814, 14665.340059697339, 1648.2747591059895, 1839.5125291797685, 1871.358970156597, 1893.422506135628, 1893.9526511837314, 131327.0, 131487.02769458466, 132544.337278313, 134809.0, 140666.59333406636, 9114.769506116721, 11451.54193832254, 11611.535538578531, 11638.41807909618, 11753.4710938008, 14316.141031538142, 14531.491397801026, 14532.418703251962, 14533.200673962821, 14539.85460145385, 8332.791680207922, 8426.662933482592, 8461.069282378934, 8470.0, 8515.40392172542, 8311.875321870177, 8380.20388063133, 8401.95799021001, 8574.614142363609, 8577.828443431097, 3632.964605087537, 4503.639708823286, 4508.571685689854, 4537.115262523842, 4544.477385100689, 1896.5163883209693, 1920.5006698258553, 1927.785495138054, 1934.603406301733, 1943.863929524948, 861.3927181337142, 884.7655371326604, 939.6429356844492, 983.8081574093127, 1030.927835051547, 21103.68344474834, 21687.02408391626, 21689.566208676053, 21819.454513637287, 21923.0, 841.6380956188898, 929.5491686532026, 936.9203617692573, 987.9703608891601, 1003.3478239144468, 10773.892261077446, 10879.401632910107, 11555.191136620357, 11563.826542601868, 11591.710207244887, 580263.0, 583551.0, 585651.0, 595449.0, 597725.0, 107170.39244411184, 121328.0, 140033.0, 141524.0, 145279.0, 867.3798234262532, 978.280963491833, 989.3964681544252, 1023.9897601024044, 1030.1038096855634, 19174.424767257005, 19955.102020408827, 19957.800421996177, 19964.50088747793, 20047.899760501103, 39654.2069158621, 47831.04337913292, 52826.47173528215, 54385.0, 56720.09004611915, 66564.0, 82724.0, 84068.57965710132, 84803.5759821197, 85498.71751923602, 6816.795496135124, 7868.72459463916, 8120.309773669068, 8155.714549990722, 8176.509409435453, 11114.05530529914, 11619.535218591162, 12492.562760303346, 12581.811272831097, 13051.804222936853, 10742.51658675377, 10813.243072984815, 10937.617183398543, 11045.171612128961, 11152.776944461228, 10078.899211007796, 10661.413622250851, 10704.357738535713, 11219.55121795119, 11316.321020738782, 10888.346699197757, 10956.480009597677, 11019.779604407706, 11155.44222788841, 11495.597654082067, 7845.254700803414, 7930.088039875257, 8172.264496195371, 8282.917170828214, 8312.044114926619, 9855.95072024664, 10828.566857325619, 10916.181286403393, 11175.994160525592, 11247.66257012291], "value": 9573.094856044172, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1454.4545795326753, 1512.3194562446897, 1523.4591719939417, 1819.4905426480582, 1826.1325870211642, 7109.608971506578, 7851.607419629025, 8304.543250121242, 8731.432456890298, 8742.213200811926, 8496.405251632388, 8535.487870727746, 8594.96860376754, 8598.8821453211, 8609.870851937227, 2307.538492301542, 2334.673145759595, 2341.7658234176615, 2342.484653376263, 2354.364321633158, 2271.5116250006245, 2282.0985710644286, 2303.9078436862505, 2317.756635553268, 2320.512692334612, 2285.4514916420108, 2307.307807657696, 2327.7555856635063, 2335.4044718596733, 2348.7181538215436, 2264.8754318512474, 2277.9316620501413, 2311.6185829338137, 2322.3729593009875, 2327.93016209514, 2031.6139933412753, 2231.2636829846274, 2323.1520495019367, 2325.755795641467, 2330.697009388786, 8131.959340203321, 8246.793830154234, 8267.875981860278, 8295.294899933513, 8312.0441149268, 5130.948690513084, 5186.974065129651, 5260.132078207092, 5266.394364648077, 5288.788448462057, 3334.583177102862, 3464.082018265162, 3506.497903356087, 3586.7130629549574, 3598.7660802048044, 1044.968650940473, 1077.385890042676, 1083.4528563075596, 1096.4846522134585, 1104.9392283424409, 11173.0, 11216.158788090845, 11352.262102963363, 11356.091512678966, 11389.259698119678, 4423.358613001097, 4551.7724113794175, 4629.583337499574, 4691.671582989226, 4720.645951553579, 9639.662611808553, 9670.323077384657, 9678.75803104928, 9691.224702023821, 9692.951535242279, 4049.959500405017, 4716.5990890774665, 4879.121758083508, 5135.306733590992, 5166.302549155891, 3911.8044097794996, 4185.665146788249, 4352.39066530686, 4804.543568361, 4839.879003024953, 3798.601146879593, 3880.5731369549326, 3885.592012838668, 3953.940690889639, 3988.102676897675, 1253.8683438239036, 1254.3540076860425, 1254.6926003129292, 1267.4359909840032, 1269.5620011096157, 782.5891407011251, 845.2308399356556, 913.6984795017761, 915.0712027292303, 945.2249155692266, 5592.944070559323, 5716.114002329646, 5773.845230953742, 5799.0, 6033.0, 389.8732911803675, 433.8828516300644, 440.35927725160457, 455.69696152059174, 456.66663335765077, 3552.289542091592, 3717.683996860243, 3964.9778612907626, 3969.206158768258, 4012.6789856811383, 10005.949970250102, 10248.0, 10433.739156520996, 10468.0, 10485.26603137773, 10185.287029907835, 10330.690079297634, 10338.431386273676, 10420.47897605132, 10426.635067772591, 7953.244441778022, 7999.9600001999615, 8065.354771618257, 8070.435069545193, 8086.989126359205, 5716.0, 5785.768569257182, 5798.942010580009, 5802.100674395476, 5912.994790885646, 9551.522423878918, 9592.992735762644, 9638.518074096128, 9675.806483870143, 9678.854817177607, 9747.658831940847, 9891.653792117242, 9892.307538472525, 9932.503374831374, 10088.142507886912, 5777.0, 6917.100776898971, 7406.1482929461645, 7432.739854105081, 7462.92537074644, 8252.876206856781, 8311.210435008665, 8334.583270836312, 8339.999200095785, 8360.28937540316, 7369.410447164107, 7419.29516695913, 7451.068616422947, 7461.0, 7575.621218939141, 7180.748673796392, 7324.0, 7330.303621155982, 7380.077490313711, 7443.739469118555, 5758.596898217253, 6825.829354266183, 6836.487263455161, 6928.203256625351, 6939.965300173467, 4154.813033413443, 4853.6602437829015, 4903.803847846189, 4980.775865086008, 5049.924251136163, 4895.0, 5007.424146223086, 5058.3929928408825, 5131.409887862944, 5143.459936706741], "value": 4386.011828275773, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.72332039504244, 310.849238119512, 312.56241262232874, 314.8803454687217, 317.7204060426824, 4932.926006109902, 5636.323641163061, 5676.403977582357, 5683.971580142093, 5701.6008879378405, 5387.19192121182, 5489.780408783644, 5563.805266815662, 5606.074997625387, 5612.579056570763, 3249.675032496755, 4093.7339072960312, 4122.587741225883, 4215.367694845782, 4235.322348424253, 4185.74885506869, 4206.495220573535, 4216.7680777557225, 4230.365445183216, 4230.736555942572, 3417.538632284635, 4005.3591425371947, 4188.701502534224, 4200.222958752625, 4245.172191422674, 4045.332520134189, 4142.550107462394, 4168.458100446923, 4206.49522057352, 4220.746755194683, 3170.9682903170906, 3608.9819550902075, 3617.788041006266, 3628.8952407603792, 3630.0, 4380.60574548289, 4386.71486353386, 5381.192821076831, 5387.19192121181, 5416.702081385522, 4607.539246075399, 4625.930611040837, 4729.716217026955, 4776.996830665565, 4848.393950756155, 4310.913781724379, 5792.333881603628, 5819.388964158787, 5859.882802343972, 5878.619159240515, 3457.550518432613, 4012.61880121388, 4025.818838152261, 4031.2743706132883, 4035.4148648446103, 5608.691521966331, 5769.826905192851, 6009.248843894513, 6221.782237621706, 6255.873942690314, 3928.3125453046173, 3958.5645578986287, 3959.6832253419657, 3971.6425521703186, 3972.2849887020034, 3982.7653427437585, 4027.4562934003534, 4041.2321658884716, 4067.450894129314, 4068.3287257602165, 4205.17998990194, 4582.839600614029, 4629.055796565451, 4791.928121078186, 4795.856124316276, 5307.310049693515, 5869.354371019184, 5916.852078697981, 5952.494038006818, 5980.581359304807, 1160.9071274298035, 1205.825155352469, 1315.1977293850744, 1353.303048929802, 1394.7210557888463, 722.0901663903519, 740.9814754631177, 840.6133178737849, 844.2190973349627, 865.6277800545699, 4417.514073451917, 5189.4032186299055, 5505.421930697219, 5518.944810551843, 5520.585956053312, 5102.872428189325, 5458.8437567160745, 5601.591315734273, 6076.270847498328, 6087.634741915499, 4631.541064564652, 5095.847124586268, 5454.036546843213, 5475.753591088411, 5582.49757521825, 2911.5632655101904, 2983.7165469280385, 3205.647378788378, 3207.9469139750577, 3220.8711651534145, 5566.218809980848, 6202.627842329474, 6324.968375158187, 6331.778387756406, 6362.554621176473, 4834.95165048345, 6152.800203960274, 6230.532710046765, 6277.686115694197, 6354.586951848208, 6389.808305750835, 6460.967695161494, 6462.4490122371235, 6492.642904640195, 6527.477801775752, 4657.627389808875, 5024.371953505812, 5161.251618515369, 5596.748146333343, 5986.940130598812, 5006.949930500648, 5094.465081166572, 6017.308009578955, 6073.939260607337, 6090.23872015998, 5295.205719142005, 5351.652142610717, 6169.907451388322, 6407.391297826699, 6434.67826608677, 3377.645347238603, 4132.1694639172265, 4161.875143745692, 4167.499900012018, 4175.457190565207, 6092.603980741238, 6096.359882212304, 6117.207331454527, 6127.0, 6142.938570614237, 5254.527092561688, 5528.695921724183, 5928.851778705394, 5982.790602328898, 5993.910091348546, 5844.707764611838, 5894.646321220741, 5914.615549989237, 5928.911066334094, 5932.584719069796, 4978.4523702393435, 5724.0521131616415, 5781.364049954585, 5824.058850280581, 5839.854003649943, 5612.607117501899, 5655.745491452977, 5877.853053673693, 5960.970195148997, 5964.884229881368, 5528.55771538284, 5827.854303642443, 5845.824625261249, 5849.53203743708, 5851.385604511465], "value": 4246.268869362725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.3224034163275, 705.5395331663452, 706.6784613001086, 786.7285786403693, 808.5027707959605, 15210.467633632825, 15721.685566288681, 15800.525984220463, 15934.601634959132, 15969.281382337793, 14303.570892873204, 14454.710905781878, 14486.5654030379, 14497.275136243172, 14519.983601147924, 679.2019377231758, 831.8086840026767, 831.8835363049163, 855.3285670748463, 862.06465984407, 848.6011574559977, 851.2423942691009, 852.624845068168, 853.7054716122959, 857.618359829876, 892.5849479991803, 919.3242966419676, 919.5264438814016, 921.944683319003, 922.6078916460511, 885.9778505537413, 892.2326798952895, 907.9228265597466, 909.0, 913.392593925039, 666.4002397841932, 670.3564578005121, 673.9224989126265, 679.8538314262457, 683.1290105115967, 14653.34059967304, 14793.704125917422, 14804.777928331083, 14824.555263342118, 14874.776878346833, 14653.12081275127, 14655.926720366437, 14667.706645867129, 14696.779548306784, 14975.475858344906, 11896.107791915554, 12175.939120304341, 12391.900705477077, 12406.75186496274, 12432.0, 3849.172427928009, 3857.864974725899, 4055.7363771354767, 4072.511298644182, 4085.8774236772942, 118763.4061829694, 120404.0, 121319.0, 121795.39102304431, 122727.0, 11249.10007199422, 11294.04000659953, 11315.20793544444, 11498.942505287587, 11874.168808183344, 23224.0, 23884.64173037406, 23901.043958241477, 23949.880250598635, 23954.64068038981, 8096.878546821802, 8207.671693132208, 8238.09380968093, 8290.917090829134, 8357.080721120672, 4468.620167285817, 4484.865454036384, 4508.278675411984, 4519.593236608721, 4607.631389488833, 3130.8434578270994, 3633.5276414066, 3711.0722319420147, 3730.7761534307488, 3760.5863355030924, 692.0829900381914, 721.8736721073897, 725.818545363659, 728.3954317916117, 741.7960060983165, 560.4703555140353, 614.9016157414792, 658.9505787065989, 688.3804575881646, 701.3372363116806, 7341.0, 7980.960095199487, 8412.78968025792, 8754.255888249443, 8856.512891790884, 560.6383882395832, 612.4365583663041, 660.6630618384562, 669.8760729265101, 671.9529632925746, 4100.282450571198, 4352.412424322739, 4388.169630588252, 4437.312216606431, 4479.7536135512855, 93611.0638893616, 125304.37347813202, 146521.0, 156051.0, 156538.21730891502, 133130.0, 134247.0, 137238.0, 137583.0, 139146.0, 117998.0, 118031.8196818038, 118461.0, 119013.0, 121396.0, 8569.014563325298, 8579.613917373857, 8609.139086091342, 8639.91360086391, 8684.088170742234, 49924.50075499344, 60555.091673625815, 62390.68804655947, 63768.0, 63794.68102659457, 92723.53638231766, 98110.0, 99603.0, 99812.51968543198, 102524.0, 10720.517576708911, 11543.422828858356, 11756.328089596767, 11925.701857453287, 12342.95084917792, 13026.218426894038, 13044.54344097952, 13254.403551840383, 13333.399997000352, 13706.24615646149, 12235.0, 12308.384580770746, 12329.815052774036, 12569.560065397667, 12742.87257127454, 11773.117016223647, 12065.974392176413, 12531.561395351118, 12864.292463914575, 12873.485060597472, 10143.644972426226, 11870.940645296718, 12312.938435307766, 12317.44571494267, 12790.104692671424, 8291.33669306442, 9406.576704048197, 9512.98199424587, 10166.694999150037, 10243.539040743035, 6205.441510264098, 8549.145085491402, 9628.566714497725, 9790.167835734042, 9877.851832222379], "value": 7710.051144924013, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1617.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 118.0, 109.0, 117.0, 117.0, 117.0, 113.0, 119.0, 119.0, 117.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 143.0, 124.0, 184.0, 146.0, 164.0, 129.0, 110.0, 156.0, 128.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 210.0, 235.0, 200.0, 201.0, 197.0, 198.0, 194.0, 197.0, 195.0], "value": 202.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 79.0, 164.0, 85.0, 85.0, 75.0, 61.0, 131.0, 61.0], "value": 88.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 126.0, 104.0, 102.0, 122.0, 103.0, 100.0, 104.0, 152.0], "value": 105.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 87.0, 103.0, 132.0, 87.0, 131.0, 136.0, 110.0], "value": 105.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 97.0, 113.0, 115.0, 151.0, 104.0, 145.0, 109.0, 143.0, 154.0], "value": 123.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 145.0, 91.0, 93.0, 91.0, 111.0, 94.0, 90.0, 91.0, 90.0], "value": 102.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 57.0, 56.0, 57.0, 56.0, 56.0, 56.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 69.0, 74.0, 73.0, 76.0, 74.0, 76.0, 100.0, 71.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 88.0, 89.0, 93.0, 111.0, 106.0, 101.0, 85.0], "value": 92.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 156.0, 139.0, 128.0, 134.0, 162.0, 163.0, 128.0, 162.0, 167.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 170.0, 170.0, 171.0, 174.0, 192.0, 237.0, 171.0, 168.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 81.0, 91.0, 88.0, 90.0, 74.0, 69.0, 68.0, 70.0], "value": 77.0, "unit": "score"}]}]} 05:26:32 INFO - Return code: 0 05:26:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:26:32 ERROR - # TBPL SUCCESS # 05:26:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:26:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:26:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:26:32 INFO - 2016-08-08 05:26:32.464 screenresolution[2505:24234] starting screenresolution argv=screenresolution get 05:26:32 INFO - 2016-08-08 05:26:32.467 screenresolution[2505:24234] Display 0: 1600x1200x32@60 05:26:32 INFO - 2016-08-08 05:26:32.473 screenresolution[2506:24237] starting screenresolution argv=screenresolution list 05:26:32 INFO - Available Modes on Display 0 05:26:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:26:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:26:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:26:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:26:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:26:32 INFO - Intel Iris: 05:26:32 INFO - Chipset Model: Intel Iris 05:26:32 INFO - Type: GPU 05:26:32 INFO - Bus: Built-In 05:26:32 INFO - VRAM (Dynamic, Max): 1536 MB 05:26:32 INFO - Vendor: Intel (0x8086) 05:26:32 INFO - Device ID: 0x0a2e 05:26:32 INFO - Revision ID: 0x0009 05:26:32 INFO - Displays: 05:26:32 INFO - Display: 05:26:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:26:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:26:32 INFO - Display Serial Number: 1600x1200 60 05:26:32 INFO - Main Display: Yes 05:26:32 INFO - Mirror: Off 05:26:32 INFO - Online: Yes 05:26:32 INFO - Rotation: Supported 05:26:32 INFO - Return code: 0 05:26:32 INFO - Running post-action listener: _resource_record_post_action 05:26:32 INFO - [mozharness: 2016-08-08 12:26:32.715626Z] Finished run-tests step (success) 05:26:32 INFO - Running post-run listener: _resource_record_post_run 05:26:32 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 299008; Write bytes: 705097728; Read time: 3; Write time: 1976 05:26:32 INFO - TinderboxPrint: CPU usage
54.3% 05:26:32 INFO - TinderboxPrint: I/O read bytes / time
299,008 / 3 05:26:32 INFO - TinderboxPrint: I/O write bytes / time
705,097,728 / 1,976 05:26:32 INFO - TinderboxPrint: CPU idle
2,215.6 (45.7%) 05:26:32 INFO - TinderboxPrint: CPU system
982.5 (20.3%) 05:26:32 INFO - TinderboxPrint: CPU user
1,647.6 (34.0%) 05:26:32 INFO - TinderboxPrint: Swap in / out
406,622,208 / 0 05:26:32 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394056192; Write bytes: 389477888; Read time: 29472; Write time: 795 05:26:32 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 299008; Write bytes: 293689856; Read time: 3; Write time: 1126 05:26:33 INFO - Running post-run listener: _upload_blobber_files 05:26:33 INFO - Blob upload gear active. 05:26:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:26:33 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 05:26:33 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'] 05:26:33 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 05:26:33 INFO - (blobuploader) - INFO - Open directory for files ... 05:26:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:26:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:26:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:34 INFO - (blobuploader) - INFO - Done attempting. 05:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:26:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:26:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:35 INFO - (blobuploader) - INFO - Done attempting. 05:26:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:26:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:26:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:39 INFO - (blobuploader) - INFO - Done attempting. 05:26:39 INFO - (blobuploader) - INFO - Iteration through files over. 05:26:39 INFO - Return code: 0 05:26:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:26:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:26:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/987a5b1f9e8e00605eb5f0fe7845628ffd8152325ca78e8fe988d20494e6c1d46775e3d17c3764e32f0877ee9ec20b57be2be2ab9bd7c01046e91725c9d645c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f22dd68d85accb8aabe92e1c1c26f674b3b146d937f92ce380bba58a517b6a8c5731067e8e8bd83d281b22816cecd68af85d426705182dfb0f4c4f1be7fbac0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b50925c955c5cfcdc9de236ac762a159368a502795723ef6b06f97dee5ee93907e2ec27d5d265c23284e6801b8759e93bf7416295c53b41c9851a039a53a491"} 05:26:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:26:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:26:39 INFO - Contents: 05:26:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/987a5b1f9e8e00605eb5f0fe7845628ffd8152325ca78e8fe988d20494e6c1d46775e3d17c3764e32f0877ee9ec20b57be2be2ab9bd7c01046e91725c9d645c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f22dd68d85accb8aabe92e1c1c26f674b3b146d937f92ce380bba58a517b6a8c5731067e8e8bd83d281b22816cecd68af85d426705182dfb0f4c4f1be7fbac0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b50925c955c5cfcdc9de236ac762a159368a502795723ef6b06f97dee5ee93907e2ec27d5d265c23284e6801b8759e93bf7416295c53b41c9851a039a53a491"} 05:26:39 INFO - Running post-run listener: copy_logs_to_upload_dir 05:26:39 INFO - Copying logs to upload dir... 05:26:39 INFO - mkdir: /builds/slave/test/build/upload/logs 05:26:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.707362 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-08 05:26:39.686698) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 05:26:39.690102) ========= 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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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/987a5b1f9e8e00605eb5f0fe7845628ffd8152325ca78e8fe988d20494e6c1d46775e3d17c3764e32f0877ee9ec20b57be2be2ab9bd7c01046e91725c9d645c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f22dd68d85accb8aabe92e1c1c26f674b3b146d937f92ce380bba58a517b6a8c5731067e8e8bd83d281b22816cecd68af85d426705182dfb0f4c4f1be7fbac0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b50925c955c5cfcdc9de236ac762a159368a502795723ef6b06f97dee5ee93907e2ec27d5d265c23284e6801b8759e93bf7416295c53b41c9851a039a53a491"} build_url:https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/Xm0TwQN8QGKRoOIzRgX9RA/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/987a5b1f9e8e00605eb5f0fe7845628ffd8152325ca78e8fe988d20494e6c1d46775e3d17c3764e32f0877ee9ec20b57be2be2ab9bd7c01046e91725c9d645c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f22dd68d85accb8aabe92e1c1c26f674b3b146d937f92ce380bba58a517b6a8c5731067e8e8bd83d281b22816cecd68af85d426705182dfb0f4c4f1be7fbac0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b50925c955c5cfcdc9de236ac762a159368a502795723ef6b06f97dee5ee93907e2ec27d5d265c23284e6801b8759e93bf7416295c53b41c9851a039a53a491"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 05:26:39.725064) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:26:39.725794) ========= 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.8s3o4tbnSg/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.RwppwRZ9UY/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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.005297 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:26:39.775608) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 05:26:39.778867) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 05:26:39.779316) ========= ========= Total master_lag: 0.18 =========