builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0139 starttime: 1472496214.6 results: success (0) buildid: 20160829093230 builduid: e0652f738764420688cc1acc56d26d13 revision: 74a3d087b008307068e5893f69af5b4efe90f7d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 11:43:34.596705) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 11:43:34.597437) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 11:43:34.597724) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 11:43:34.623588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 11:43:34.624019) ========= 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.Ygmr5JafzW/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.pLZCGwRh1D/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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-29 11:43:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 150M=0s 2016-08-29 11:43:34 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089815 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 11:43:34.736686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 11:43:34.736994) ========= 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.Ygmr5JafzW/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.pLZCGwRh1D/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.028238 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 11:43:34.785545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-29 11:43:34.785852) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 74a3d087b008307068e5893f69af5b4efe90f7d0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 74a3d087b008307068e5893f69af5b4efe90f7d0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ygmr5JafzW/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.pLZCGwRh1D/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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-29 11:43:34,864 truncating revision to first 12 chars 2016-08-29 11:43:34,864 Setting DEBUG logging. 2016-08-29 11:43:34,864 attempt 1/10 2016-08-29 11:43:34,864 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/74a3d087b008?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 11:43:36,125 unpacking tar archive at: mozilla-central-74a3d087b008/testing/mozharness/ program finished with exit code 0 elapsedTime=1.509000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-29 11:43:36.318027) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 11:43:36.318395) ========= script_repo_revision: 74a3d087b008307068e5893f69af5b4efe90f7d0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 11:43:36.318804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 11:43:36.319107) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 11:43:36.338535) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 36 secs) (at 2016-08-29 11:43:36.339038) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ygmr5JafzW/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.pLZCGwRh1D/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:43:36 INFO - MultiFileLogger online at 20160829 11:43:36 in /builds/slave/test 11:43:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:43:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:43:36 INFO - {'append_to_log': False, 11:43:36 INFO - 'base_work_dir': '/builds/slave/test', 11:43:36 INFO - 'blob_upload_branch': 'Firefox', 11:43:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:43:36 INFO - 'branch': 'Firefox', 11:43:36 INFO - 'buildbot_json_path': 'buildprops.json', 11:43:36 INFO - 'config_files': ('talos/mac_config.py',), 11:43:36 INFO - 'default_actions': ('clobber', 11:43:36 INFO - 'read-buildbot-config', 11:43:36 INFO - 'download-and-extract', 11:43:36 INFO - 'populate-webroot', 11:43:36 INFO - 'create-virtualenv', 11:43:36 INFO - 'install', 11:43:36 INFO - 'run-tests'), 11:43:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:43:36 INFO - 'download_minidump_stackwalk': True, 11:43:36 INFO - 'download_symbols': 'ondemand', 11:43:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:43:36 INFO - 'tooltool.py': '/tools/tooltool.py', 11:43:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:43:36 INFO - '/tools/misc-python/virtualenv.py')}, 11:43:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:43:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:43:36 INFO - 'installer_path': 'installer.exe', 11:43:36 INFO - 'log_level': 'info', 11:43:36 INFO - 'log_name': 'talos', 11:43:36 INFO - 'log_to_console': True, 11:43:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:43:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:43:36 INFO - 'opt_config_files': (), 11:43:36 INFO - 'pip_index': False, 11:43:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:43:36 INFO - 'cmd': ('bash', 11:43:36 INFO - '-c', 11:43:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:43:36 INFO - 'enabled': True, 11:43:36 INFO - 'halt_on_failure': False, 11:43:36 INFO - 'name': 'check_screen_resolution'},), 11:43:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:43:36 INFO - 'cmd': ('bash', 11:43:36 INFO - '-c', 11:43:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:43:36 INFO - 'enabled': True, 11:43:36 INFO - 'halt_on_failure': False, 11:43:36 INFO - 'name': 'check_screen_resolution'},), 11:43:36 INFO - 'run_cmd_checks_enabled': True, 11:43:36 INFO - 'sps_profile': False, 11:43:36 INFO - 'sps_profile_interval': 0, 11:43:36 INFO - 'suite': 'dromaeojs-e10s', 11:43:36 INFO - 'system_bits': '32', 11:43:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:43:36 INFO - 'title': 't-yosemite-r7-0139', 11:43:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:43:36 INFO - 'use_talos_json': True, 11:43:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:43:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:43:36 INFO - 'work_dir': 'build'} 11:43:36 INFO - [mozharness: 2016-08-29 18:43:36.538713Z] Running clobber step. 11:43:36 INFO - Running pre-action listener: _resource_record_pre_action 11:43:36 INFO - Running main action method: clobber 11:43:36 INFO - rmtree: /builds/slave/test/build 11:43:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:43:38 INFO - Running post-action listener: _resource_record_post_action 11:43:38 INFO - [mozharness: 2016-08-29 18:43:38.577663Z] Finished clobber step (success) 11:43:38 INFO - [mozharness: 2016-08-29 18:43:38.577794Z] Running read-buildbot-config step. 11:43:38 INFO - Running pre-action listener: _resource_record_pre_action 11:43:38 INFO - Running main action method: read_buildbot_config 11:43:38 INFO - Using buildbot properties: 11:43:38 INFO - { 11:43:38 INFO - "project": "", 11:43:38 INFO - "product": "firefox", 11:43:38 INFO - "script_repo_revision": "production", 11:43:38 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 11:43:38 INFO - "repository": "", 11:43:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 11:43:38 INFO - "buildid": "20160829093230", 11:43:38 INFO - "pgo_build": "False", 11:43:38 INFO - "basedir": "/builds/slave/test", 11:43:38 INFO - "buildnumber": 72, 11:43:38 INFO - "slavename": "t-yosemite-r7-0139", 11:43:38 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:43:38 INFO - "platform": "yosemite_r7", 11:43:38 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 11:43:38 INFO - "branch": "mozilla-central", 11:43:38 INFO - "repo_path": "mozilla-central", 11:43:38 INFO - "revision": "74a3d087b008307068e5893f69af5b4efe90f7d0", 11:43:38 INFO - "stage_platform": "macosx64", 11:43:38 INFO - "builduid": "e0652f738764420688cc1acc56d26d13", 11:43:38 INFO - "slavebuilddir": "test" 11:43:38 INFO - } 11:43:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:43:38 INFO - Running post-action listener: _resource_record_post_action 11:43:38 INFO - [mozharness: 2016-08-29 18:43:38.580974Z] Finished read-buildbot-config step (success) 11:43:38 INFO - [mozharness: 2016-08-29 18:43:38.581083Z] Running download-and-extract step. 11:43:38 INFO - Running pre-action listener: _resource_record_pre_action 11:43:38 INFO - Running main action method: download_and_extract 11:43:38 INFO - mkdir: /builds/slave/test/build/tests 11:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:43:38 INFO - trying https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:43:38 INFO - Downloading https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 11:43:39 INFO - Downloaded 1199 bytes. 11:43:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:43:39 INFO - Using the following test package requirements: 11:43:39 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:43:39 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:43:39 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:43:39 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:43:39 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:43:39 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:43:39 INFO - u'jsshell-mac.zip'], 11:43:39 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:43:39 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:43:39 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:43:39 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:43:39 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:43:39 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:43:39 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:43:39 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:43:39 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:43:39 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:43:39 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:43:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:43:39 INFO - trying https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:43:39 INFO - Downloading https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:43:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:43:40 INFO - Downloaded 16369825 bytes. 11:43:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:43:47 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:43:47 INFO - trying https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:43:47 INFO - Downloading https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:43:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:43:48 INFO - Downloaded 16369825 bytes. 11:43:48 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:43: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')]} 11:43:55 INFO - trying https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:43:55 INFO - Downloading https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:43:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:43:57 INFO - Downloaded 14413998 bytes. 11:43:57 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 11:43: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')]} 11:43:57 INFO - trying https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:43:57 INFO - Downloading https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:43:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 11:44:00 INFO - Downloaded 111542104 bytes. 11:44:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:44:00 INFO - mkdir: /builds/slave/test/properties 11:44:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:44:00 INFO - Writing to file /builds/slave/test/properties/build_url 11:44:00 INFO - Contents: 11:44:00 INFO - build_url:https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:44:00 INFO - Running post-action listener: _resource_record_post_action 11:44:00 INFO - Running post-action listener: set_extra_try_arguments 11:44:00 INFO - [mozharness: 2016-08-29 18:44:00.896195Z] Finished download-and-extract step (success) 11:44:00 INFO - [mozharness: 2016-08-29 18:44:00.896320Z] Running populate-webroot step. 11:44:00 INFO - Running pre-action listener: _resource_record_pre_action 11:44:00 INFO - Running main action method: populate_webroot 11:44:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:44:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:44:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:44:00 INFO - '--tppagecycles', 11:44:00 INFO - '7'], 11:44:00 INFO - 'tests': ['tsvgm']}}, 11:44:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:44:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:44:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:44:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:44:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:44:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:44:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'talos_options': ['--disable-e10s'], 11:44:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'talos_options': ['--disable-e10s'], 11:44:00 INFO - 'tests': ['damp', 'tps']}, 11:44:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'tests': ['damp', 'tps']}, 11:44:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:44:00 INFO - 'tests': ['dromaeo_dom']}, 11:44:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:44:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:44:00 INFO - 'tests': ['basic_compositor_video']}, 11:44:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:44:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:44:00 INFO - 'tests': ['a11yr', 11:44:00 INFO - 'ts_paint', 11:44:00 INFO - 'tpaint', 11:44:00 INFO - 'sessionrestore', 11:44:00 INFO - 'sessionrestore_no_auto_restore', 11:44:00 INFO - 'tabpaint']}, 11:44:00 INFO - 'other-e10s': {'tests': ['a11yr', 11:44:00 INFO - 'ts_paint', 11:44:00 INFO - 'tpaint', 11:44:00 INFO - 'sessionrestore', 11:44:00 INFO - 'sessionrestore_no_auto_restore', 11:44:00 INFO - 'tabpaint']}, 11:44:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:44:00 INFO - 'ts_paint', 11:44:00 INFO - 'tpaint', 11:44:00 INFO - 'sessionrestore', 11:44:00 INFO - 'sessionrestore_no_auto_restore', 11:44:00 INFO - 'tabpaint']}, 11:44:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:44:00 INFO - 'ts_paint', 11:44:00 INFO - 'tpaint', 11:44:00 INFO - 'sessionrestore', 11:44:00 INFO - 'sessionrestore_no_auto_restore', 11:44:00 INFO - 'tabpaint']}, 11:44:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:44:00 INFO - 'tests': ['a11yr', 11:44:00 INFO - 'ts_paint', 11:44:00 INFO - 'tpaint', 11:44:00 INFO - 'sessionrestore', 11:44:00 INFO - 'sessionrestore_no_auto_restore', 11:44:00 INFO - 'tabpaint']}, 11:44:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:44:00 INFO - 'tests': ['a11yr', 11:44:00 INFO - 'ts_paint', 11:44:00 INFO - 'tpaint', 11:44:00 INFO - 'sessionrestore', 11:44:00 INFO - 'sessionrestore_no_auto_restore', 11:44:00 INFO - 'tabpaint']}, 11:44:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:44:00 INFO - 'tests': ['tsvgx', 11:44:00 INFO - 'tsvgr_opacity', 11:44:00 INFO - 'tart', 11:44:00 INFO - 'tscrollx', 11:44:00 INFO - 'cart']}, 11:44:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:44:00 INFO - 'tsvgr_opacity', 11:44:00 INFO - 'tart', 11:44:00 INFO - 'tscrollx', 11:44:00 INFO - 'cart']}, 11:44:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'talos_options': ['--disable-e10s'], 11:44:00 INFO - 'tests': ['tp5o']}, 11:44:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'tests': ['tp5o']}, 11:44:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'talos_options': ['--disable-e10s', 11:44:00 INFO - '--xperf_path', 11:44:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:00 INFO - 'tests': ['tp5n']}, 11:44:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:00 INFO - 'talos_options': ['--xperf_path', 11:44:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:00 INFO - 'tests': ['tp5n']}}, 11:44:00 INFO - 'talos.zip': {'path': '', 11:44:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:44:00 INFO - Running post-action listener: _resource_record_post_action 11:44:00 INFO - [mozharness: 2016-08-29 18:44:00.915055Z] Finished populate-webroot step (success) 11:44:00 INFO - [mozharness: 2016-08-29 18:44:00.915168Z] Running create-virtualenv step. 11:44:00 INFO - Running pre-action listener: _resource_record_pre_action 11:44:00 INFO - Running main action method: create_virtualenv 11:44:00 INFO - Creating virtualenv /builds/slave/test/build/venv 11:44:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:44:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:44:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:44:01 INFO - Using real prefix '/tools/python27' 11:44:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:44:01 INFO - Installing distribute.............................................................................................................................................................................................done. 11:44:04 INFO - Installing pip.................done. 11:44:04 INFO - Return code: 0 11:44:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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')]} 11:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a87a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e0bc5e840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079ebd30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e3b20>, '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.Ygmr5JafzW/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.pLZCGwRh1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:44: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', 'pip>=1.5'] in /builds/slave/test/build 11:44: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 pip>=1.5 11:44:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ygmr5JafzW/Render', 11:44:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:04 INFO - 'HOME': '/Users/cltbld', 11:44:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:04 INFO - 'LOGNAME': 'cltbld', 11:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:04 INFO - 'MOZ_NO_REMOTE': '1', 11:44:04 INFO - 'NO_EM_RESTART': '1', 11:44:04 INFO - 'PAGER': '/bin/cat', 11:44:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:04 INFO - 'PWD': '/builds/slave/test', 11:44:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:04 INFO - 'SHELL': '/bin/bash', 11:44:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLZCGwRh1D/Listeners', 11:44:04 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 11:44:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:04 INFO - 'USER': 'cltbld', 11:44:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:04 INFO - 'XPC_FLAGS': '0x0', 11:44:04 INFO - 'XPC_SERVICE_NAME': '0', 11:44:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:44:04 INFO - Cleaning up... 11:44:04 INFO - Return code: 0 11:44:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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')]} 11:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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', '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 0x107a87a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e0bc5e840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079ebd30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e3b20>, '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.Ygmr5JafzW/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.pLZCGwRh1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:44: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:44: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 psutil>=3.1.1 11:44:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ygmr5JafzW/Render', 11:44:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:04 INFO - 'HOME': '/Users/cltbld', 11:44:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:04 INFO - 'LOGNAME': 'cltbld', 11:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:04 INFO - 'MOZ_NO_REMOTE': '1', 11:44:04 INFO - 'NO_EM_RESTART': '1', 11:44:04 INFO - 'PAGER': '/bin/cat', 11:44:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:04 INFO - 'PWD': '/builds/slave/test', 11:44:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:04 INFO - 'SHELL': '/bin/bash', 11:44:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLZCGwRh1D/Listeners', 11:44:04 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 11:44:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:04 INFO - 'USER': 'cltbld', 11:44:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:04 INFO - 'XPC_FLAGS': '0x0', 11:44:04 INFO - 'XPC_SERVICE_NAME': '0', 11:44:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:05 INFO - Downloading/unpacking psutil>=3.1.1 11:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:44:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:08 INFO - Installing collected packages: psutil 11:44:08 INFO - Running setup.py install for psutil 11:44:08 INFO - building 'psutil._psutil_osx' extension 11:44:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:44:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:44:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:44:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:44:09 INFO - building 'psutil._psutil_posix' extension 11:44:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:44:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:44:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:44:09 INFO - ^ 11:44:09 INFO - 1 warning generated. 11:44:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:44:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:09 INFO - Successfully installed psutil 11:44:09 INFO - Cleaning up... 11:44:09 INFO - Return code: 0 11:44:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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')]} 11:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:09 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 0x107a87a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e0bc5e840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079ebd30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e3b20>, '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.Ygmr5JafzW/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.pLZCGwRh1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:44:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:44:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ygmr5JafzW/Render', 11:44:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:09 INFO - 'HOME': '/Users/cltbld', 11:44:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:09 INFO - 'LOGNAME': 'cltbld', 11:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:09 INFO - 'MOZ_NO_REMOTE': '1', 11:44:09 INFO - 'NO_EM_RESTART': '1', 11:44:09 INFO - 'PAGER': '/bin/cat', 11:44:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:09 INFO - 'PWD': '/builds/slave/test', 11:44:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:09 INFO - 'SHELL': '/bin/bash', 11:44:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLZCGwRh1D/Listeners', 11:44:09 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 11:44:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:09 INFO - 'USER': 'cltbld', 11:44:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:09 INFO - 'XPC_FLAGS': '0x0', 11:44:09 INFO - 'XPC_SERVICE_NAME': '0', 11:44:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:44:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:44:12 INFO - Installing collected packages: mozsystemmonitor 11:44:12 INFO - Running setup.py install for mozsystemmonitor 11:44:12 INFO - Successfully installed mozsystemmonitor 11:44:12 INFO - Cleaning up... 11:44:12 INFO - Return code: 0 11:44:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:12 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 0x107a87a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e0bc5e840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079ebd30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e3b20>, '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.Ygmr5JafzW/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.pLZCGwRh1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:44:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ygmr5JafzW/Render', 11:44:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:12 INFO - 'HOME': '/Users/cltbld', 11:44:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:12 INFO - 'LOGNAME': 'cltbld', 11:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:12 INFO - 'MOZ_NO_REMOTE': '1', 11:44:12 INFO - 'NO_EM_RESTART': '1', 11:44:12 INFO - 'PAGER': '/bin/cat', 11:44:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:12 INFO - 'PWD': '/builds/slave/test', 11:44:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:12 INFO - 'SHELL': '/bin/bash', 11:44:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLZCGwRh1D/Listeners', 11:44:12 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 11:44:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:12 INFO - 'USER': 'cltbld', 11:44:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:12 INFO - 'XPC_FLAGS': '0x0', 11:44:12 INFO - 'XPC_SERVICE_NAME': '0', 11:44:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:13 INFO - Downloading/unpacking jsonschema==2.5.1 11:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:44:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44:15 INFO - Downloading functools32-3.2.3-2.tar.gz 11:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:44:15 INFO - warning: no files found matching '*.txt' 11:44:15 INFO - no previously-included directories found matching 'build' 11:44:15 INFO - no previously-included directories found matching 'dist' 11:44:15 INFO - no previously-included directories found matching '.git*' 11:44:15 INFO - Installing collected packages: jsonschema, functools32 11:44:16 INFO - Running setup.py install for functools32 11:44:16 INFO - warning: no files found matching '*.txt' 11:44:16 INFO - no previously-included directories found matching 'build' 11:44:16 INFO - no previously-included directories found matching 'dist' 11:44:16 INFO - no previously-included directories found matching '.git*' 11:44:16 INFO - Successfully installed jsonschema functools32 11:44:16 INFO - Cleaning up... 11:44:16 INFO - Return code: 0 11:44:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:16 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 0x107a87a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e0bc5e840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079ebd30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e3b20>, '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.Ygmr5JafzW/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.pLZCGwRh1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:44:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:44:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ygmr5JafzW/Render', 11:44:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:16 INFO - 'HOME': '/Users/cltbld', 11:44:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:16 INFO - 'LOGNAME': 'cltbld', 11:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:16 INFO - 'MOZ_NO_REMOTE': '1', 11:44:16 INFO - 'NO_EM_RESTART': '1', 11:44:16 INFO - 'PAGER': '/bin/cat', 11:44:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:16 INFO - 'PWD': '/builds/slave/test', 11:44:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:16 INFO - 'SHELL': '/bin/bash', 11:44:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLZCGwRh1D/Listeners', 11:44:16 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 11:44:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:16 INFO - 'USER': 'cltbld', 11:44:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:16 INFO - 'XPC_FLAGS': '0x0', 11:44:16 INFO - 'XPC_SERVICE_NAME': '0', 11:44:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:44:16 INFO - Cleaning up... 11:44:16 INFO - Return code: 0 11:44:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:16 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 0x107a87a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e0bc5e840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079ebd30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e3b20>, '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.Ygmr5JafzW/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.pLZCGwRh1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:44:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:44:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ygmr5JafzW/Render', 11:44:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:16 INFO - 'HOME': '/Users/cltbld', 11:44:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:16 INFO - 'LOGNAME': 'cltbld', 11:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:16 INFO - 'MOZ_NO_REMOTE': '1', 11:44:16 INFO - 'NO_EM_RESTART': '1', 11:44:16 INFO - 'PAGER': '/bin/cat', 11:44:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:16 INFO - 'PWD': '/builds/slave/test', 11:44:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:16 INFO - 'SHELL': '/bin/bash', 11:44:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLZCGwRh1D/Listeners', 11:44:16 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 11:44:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:16 INFO - 'USER': 'cltbld', 11:44:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:16 INFO - 'XPC_FLAGS': '0x0', 11:44:16 INFO - 'XPC_SERVICE_NAME': '0', 11:44:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:16 INFO - Downloading/unpacking blobuploader==1.2.4 11:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:19 INFO - Downloading blobuploader-1.2.4.tar.gz 11:44:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:44:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:44:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:20 INFO - Downloading docopt-0.6.1.tar.gz 11:44:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:44:20 INFO - Installing collected packages: blobuploader, requests, docopt 11:44:20 INFO - Running setup.py install for blobuploader 11:44:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:44:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:44:20 INFO - Running setup.py install for requests 11:44:21 INFO - Running setup.py install for docopt 11:44:21 INFO - Successfully installed blobuploader requests docopt 11:44:21 INFO - Cleaning up... 11:44:21 INFO - Return code: 0 11:44:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:21 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 0x107a87a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e0bc5e840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079ebd30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e3b20>, '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.Ygmr5JafzW/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.pLZCGwRh1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:44:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ygmr5JafzW/Render', 11:44:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:21 INFO - 'HOME': '/Users/cltbld', 11:44:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:21 INFO - 'LOGNAME': 'cltbld', 11:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:21 INFO - 'MOZ_NO_REMOTE': '1', 11:44:21 INFO - 'NO_EM_RESTART': '1', 11:44:21 INFO - 'PAGER': '/bin/cat', 11:44:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:21 INFO - 'PWD': '/builds/slave/test', 11:44:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:21 INFO - 'SHELL': '/bin/bash', 11:44:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLZCGwRh1D/Listeners', 11:44:21 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 11:44:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:21 INFO - 'USER': 'cltbld', 11:44:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:21 INFO - 'XPC_FLAGS': '0x0', 11:44:21 INFO - 'XPC_SERVICE_NAME': '0', 11:44:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:22 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-fYFNfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:22 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-rdXQHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:22 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-G543eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:22 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ZKMEq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:22 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-hlu9su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:22 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ogAoa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:22 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-rYhm_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:22 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-hi0yeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:22 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-mcT_JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:22 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-NRVAo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:23 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-SH3lg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:23 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-KaE_s0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:23 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-GdiUBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:23 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-wRtg0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:23 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-B7aCNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:23 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-8Qx4xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:23 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-FQ8uBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:44:23 INFO - Running setup.py install for manifestparser 11:44:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:44:23 INFO - Running setup.py install for mozcrash 11:44:24 INFO - Running setup.py install for mozdebug 11:44:24 INFO - Running setup.py install for mozdevice 11:44:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:44:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:44:24 INFO - Running setup.py install for mozfile 11:44:24 INFO - Running setup.py install for mozhttpd 11:44:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:44:24 INFO - Running setup.py install for mozinfo 11:44:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:44:24 INFO - Running setup.py install for mozInstall 11:44:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:44:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:44:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:44:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:44:25 INFO - Running setup.py install for mozleak 11:44:25 INFO - Running setup.py install for mozlog 11:44:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:44:25 INFO - Running setup.py install for moznetwork 11:44:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:44:25 INFO - Running setup.py install for mozprocess 11:44:25 INFO - Running setup.py install for mozprofile 11:44:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:44:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:44:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:44:25 INFO - Running setup.py install for mozrunner 11:44:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:44:26 INFO - Running setup.py install for mozscreenshot 11:44:26 INFO - Running setup.py install for moztest 11:44:26 INFO - Running setup.py install for mozversion 11:44:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:44:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:44:26 INFO - Cleaning up... 11:44:26 INFO - Return code: 0 11:44:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:26 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 0x107a87a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e0bc5e840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079ebd30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e3b20>, '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.Ygmr5JafzW/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.pLZCGwRh1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:44:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ygmr5JafzW/Render', 11:44:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:26 INFO - 'HOME': '/Users/cltbld', 11:44:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:26 INFO - 'LOGNAME': 'cltbld', 11:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:26 INFO - 'MOZ_NO_REMOTE': '1', 11:44:26 INFO - 'NO_EM_RESTART': '1', 11:44:26 INFO - 'PAGER': '/bin/cat', 11:44:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:26 INFO - 'PWD': '/builds/slave/test', 11:44:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:26 INFO - 'SHELL': '/bin/bash', 11:44:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLZCGwRh1D/Listeners', 11:44:26 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 11:44:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:26 INFO - 'USER': 'cltbld', 11:44:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:26 INFO - 'XPC_FLAGS': '0x0', 11:44:26 INFO - 'XPC_SERVICE_NAME': '0', 11:44:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:26 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-xpfjoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:26 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-MQtWLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:26 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-pz4bYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:27 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-bavbxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:27 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-8ibiVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:27 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-RjB9ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:27 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ahA8LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:27 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-i2aIys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:27 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-b7ARop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:27 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-cmK3Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:27 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-TmeKt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:27 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-H1FBZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:28 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-0B2m22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:28 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-zgmv5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:28 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ZijUFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:28 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-UMc6qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:28 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-PlUDNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:44:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:31 INFO - Downloading blessings-1.6.tar.gz 11:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:44:31 INFO - Installing collected packages: blessings 11:44:31 INFO - Running setup.py install for blessings 11:44:31 INFO - Successfully installed blessings 11:44:31 INFO - Cleaning up... 11:44:31 INFO - Return code: 0 11:44:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:44:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:31 INFO - Reading from file tmpfile_stdout 11:44:31 INFO - Current package versions: 11:44:31 INFO - blessings == 1.6 11:44:31 INFO - blobuploader == 1.2.4 11:44:31 INFO - docopt == 0.6.1 11:44:31 INFO - functools32 == 3.2.3-2 11:44:31 INFO - jsonschema == 2.5.1 11:44:31 INFO - manifestparser == 1.1 11:44:31 INFO - mozInstall == 1.12 11:44:31 INFO - mozcrash == 0.17 11:44:31 INFO - mozdebug == 0.1 11:44:31 INFO - mozdevice == 0.48 11:44:31 INFO - mozfile == 1.2 11:44:31 INFO - mozhttpd == 0.7 11:44:31 INFO - mozinfo == 0.9 11:44:31 INFO - mozleak == 0.1 11:44:31 INFO - mozlog == 3.3 11:44:31 INFO - moznetwork == 0.27 11:44:31 INFO - mozprocess == 0.23 11:44:31 INFO - mozprofile == 0.28 11:44:31 INFO - mozrunner == 6.12 11:44:31 INFO - mozscreenshot == 0.1 11:44:31 INFO - mozsystemmonitor == 0.3 11:44:31 INFO - moztest == 0.7 11:44:31 INFO - mozversion == 1.4 11:44:31 INFO - psutil == 3.1.1 11:44:31 INFO - requests == 1.2.3 11:44:31 INFO - wsgiref == 0.1.2 11:44:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:32 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 0x107a87a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e0bc5e840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079ebd30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e3b20>, '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.Ygmr5JafzW/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.pLZCGwRh1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:44:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ygmr5JafzW/Render', 11:44:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:32 INFO - 'HOME': '/Users/cltbld', 11:44:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:32 INFO - 'LOGNAME': 'cltbld', 11:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:32 INFO - 'MOZ_NO_REMOTE': '1', 11:44:32 INFO - 'NO_EM_RESTART': '1', 11:44:32 INFO - 'PAGER': '/bin/cat', 11:44:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:32 INFO - 'PWD': '/builds/slave/test', 11:44:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:32 INFO - 'SHELL': '/bin/bash', 11:44:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLZCGwRh1D/Listeners', 11:44:32 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 11:44:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:32 INFO - 'USER': 'cltbld', 11:44:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:32 INFO - 'XPC_FLAGS': '0x0', 11:44:32 INFO - 'XPC_SERVICE_NAME': '0', 11:44:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:44:32 INFO - Cleaning up... 11:44:32 INFO - Return code: 0 11:44:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:32 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 0x107a87a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b1c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e0bc5e840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079ebd30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e3b20>, '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.Ygmr5JafzW/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.pLZCGwRh1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:44:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ygmr5JafzW/Render', 11:44:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:32 INFO - 'HOME': '/Users/cltbld', 11:44:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:32 INFO - 'LOGNAME': 'cltbld', 11:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:32 INFO - 'MOZ_NO_REMOTE': '1', 11:44:32 INFO - 'NO_EM_RESTART': '1', 11:44:32 INFO - 'PAGER': '/bin/cat', 11:44:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:32 INFO - 'PWD': '/builds/slave/test', 11:44:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:32 INFO - 'SHELL': '/bin/bash', 11:44:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLZCGwRh1D/Listeners', 11:44:32 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 11:44:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:32 INFO - 'USER': 'cltbld', 11:44:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:32 INFO - 'XPC_FLAGS': '0x0', 11:44:32 INFO - 'XPC_SERVICE_NAME': '0', 11:44:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:44:32 INFO - Cleaning up... 11:44:32 INFO - Return code: 0 11:44:32 INFO - Running post-action listener: _resource_record_post_action 11:44:32 INFO - Running post-action listener: _start_resource_monitoring 11:44:32 INFO - Starting resource monitoring. 11:44:32 INFO - [mozharness: 2016-08-29 18:44:32.571357Z] Finished create-virtualenv step (success) 11:44:32 INFO - [mozharness: 2016-08-29 18:44:32.572382Z] Running install step. 11:44:32 INFO - Running pre-action listener: _resource_record_pre_action 11:44:32 INFO - Running main action method: install 11:44:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:32 INFO - Reading from file tmpfile_stdout 11:44:32 INFO - Detecting whether we're running mozinstall >=1.0... 11:44:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:44:32 INFO - Reading from file tmpfile_stdout 11:44:32 INFO - Output received: 11:44:32 INFO - Usage: mozinstall [options] installer 11:44:32 INFO - Options: 11:44:32 INFO - -h, --help show this help message and exit 11:44:32 INFO - -d DEST, --destination=DEST 11:44:32 INFO - Directory to install application into. [default: 11:44:32 INFO - "/builds/slave/test"] 11:44:32 INFO - --app=APP Application being installed. [default: firefox] 11:44:32 INFO - mkdir: /builds/slave/test/build/application 11:44:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:45:07 INFO - Reading from file tmpfile_stdout 11:45:07 INFO - Output received: 11:45:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:45:07 INFO - Running post-action listener: _resource_record_post_action 11:45:07 INFO - [mozharness: 2016-08-29 18:45:07.157694Z] Finished install step (success) 11:45:07 INFO - [mozharness: 2016-08-29 18:45:07.157828Z] Running run-tests step. 11:45:07 INFO - Running pre-action listener: _resource_record_pre_action 11:45:07 INFO - Running main action method: run_tests 11:45:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:45:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:45:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:45:07 INFO - 2016-08-29 11:45:07.172 screenresolution[1633:7402] starting screenresolution argv=screenresolution get 11:45:07 INFO - 2016-08-29 11:45:07.175 screenresolution[1633:7402] Display 0: 1600x1200x32@60 11:45:07 INFO - 2016-08-29 11:45:07.181 screenresolution[1634:7404] starting screenresolution argv=screenresolution list 11:45:07 INFO - Available Modes on Display 0 11:45:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:45:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:45:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:45:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:45:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:45:07 INFO - Intel Iris: 11:45:07 INFO - Chipset Model: Intel Iris 11:45:07 INFO - Type: GPU 11:45:07 INFO - Bus: Built-In 11:45:07 INFO - VRAM (Dynamic, Max): 1536 MB 11:45:07 INFO - Vendor: Intel (0x8086) 11:45:07 INFO - Device ID: 0x0a2e 11:45:07 INFO - Revision ID: 0x0009 11:45:07 INFO - Displays: 11:45:07 INFO - Display: 11:45:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:45:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:45:07 INFO - Display Serial Number: 1600x1200 60 11:45:07 INFO - Main Display: Yes 11:45:07 INFO - Mirror: Off 11:45:07 INFO - Online: Yes 11:45:07 INFO - Rotation: Supported 11:45:07 INFO - Return code: 0 11:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:45:07 INFO - Python 2.7.3 11:45:07 INFO - Return code: 0 11:45:07 INFO - grabbing minidump binary from tooltool 11:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:07 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 0x1079ebd30>, '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 0x107750db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:45:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:45:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:45:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:45:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:45:07 INFO - Return code: 0 11:45:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:45:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:45:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:45:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:45:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0139 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:45:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ygmr5JafzW/Render', 11:45:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:07 INFO - 'HOME': '/Users/cltbld', 11:45:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:07 INFO - 'LOGNAME': 'cltbld', 11:45:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:45:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:07 INFO - 'MOZ_NO_REMOTE': '1', 11:45:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:45:07 INFO - 'NO_EM_RESTART': '1', 11:45:07 INFO - 'PAGER': '/bin/cat', 11:45:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:07 INFO - 'PWD': '/builds/slave/test', 11:45:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:45:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:07 INFO - 'SHELL': '/bin/bash', 11:45:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLZCGwRh1D/Listeners', 11:45:07 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 11:45:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:07 INFO - 'USER': 'cltbld', 11:45:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:07 INFO - 'XPC_FLAGS': '0x0', 11:45:07 INFO - 'XPC_SERVICE_NAME': '0', 11:45:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:45:07 INFO - mozversion application_buildid: 20160829093230 11:45:07 INFO - mozversion application_changeset: 74a3d087b008307068e5893f69af5b4efe90f7d0 11:45:07 INFO - mozversion application_display_name: Nightly 11:45:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:45:07 INFO - mozversion application_name: Firefox 11:45:07 INFO - mozversion application_remotingname: firefox 11:45:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:45:07 INFO - mozversion application_vendor: Mozilla 11:45:07 INFO - mozversion application_version: 51.0a1 11:45:07 INFO - mozversion platform_buildid: 20160829093230 11:45:07 INFO - mozversion platform_changeset: 74a3d087b008307068e5893f69af5b4efe90f7d0 11:45:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:45:07 INFO - mozversion platform_version: 51.0a1 11:45:07 INFO - using testdate: 1472496307 11:45:07 INFO - actual date: 1472496307 11:45:07 INFO - starting webserver on 'localhost:49262' 11:45:07 INFO - SUITE-START | Running 2 tests 11:45:07 INFO - TEST-START | dromaeo_css 11:45:07 INFO - operating with platform_type : mac_ 11:45:07 INFO - Initialising browser for dromaeo_css test... 11:45:07 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpWuJaP_/profile http://localhost:49262/getInfo.html) 11:45:10 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 11:45:10 INFO - PROCESS | 1647 | colorDepth:24 11:45:10 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 11:45:10 INFO - PROCESS | 1647 | __metrics 11:45:11 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 11:45:11 INFO - TEST-INFO | 1647: exit 0 11:45:11 INFO - Browser initialized. 11:45:11 INFO - Running cycle 1/1 for dromaeo_css test... 11:45:11 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpWuJaP_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:45:23 INFO - PROCESS | 1650 | RSS: Main: 243822592 11:45:23 INFO - PROCESS | 1650 | 11:46:13 INFO - PROCESS | 1650 | 1472496373323 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:48:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 11:48:27 INFO - PROCESS | 1650 | RSS: Main: 262676480 11:48:27 INFO - PROCESS | 1650 | 11:51:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 11:51:29 INFO - PROCESS | 1650 | RSS: Main: 270540800 11:51:29 INFO - PROCESS | 1650 | 11:54:31 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 11:54:32 INFO - PROCESS | 1650 | RSS: Main: 277188608 11:54:32 INFO - PROCESS | 1650 | 11:57:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 11:57:35 INFO - PROCESS | 1650 | RSS: Main: 273448960 11:57:35 INFO - PROCESS | 1650 | 12:00:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 12:00:38 INFO - PROCESS | 1650 | RSS: Main: 278843392 12:00:38 INFO - PROCESS | 1650 | 12:03:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 12:03:41 INFO - PROCESS | 1650 | RSS: Main: 281722880 12:03:41 INFO - PROCESS | 1650 | 12:03:41 INFO - PROCESS | 1650 | __start_tp_report 12:03:41 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 12:03:41 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 12:03:41 INFO - PROCESS | 1650 | |i|pagename|runs| 12:03:41 INFO - PROCESS | 1650 | |0;dojo.html;3307.1566750478623;3448.517207590937;3460.7923524588527;3505.5092287079815;3508.3334166508375;4951.900961980758;5618.269624948761;5891.086881533359;5924.881502369961;6002.249718785152;5196.844094677156;5635.929173457041;5834.066549352105;5889.970550147254;5920;5239.973800130994;5325.387580428262;5349.277847490597;5390.164524498709;5445.700486473243;5431.674099554019;5465.699386533739;5470.234167216593;5503.229547863302;5511.22842802008;5182.326297581328;5214.217867319894;5276.366835979668;5370.570354371641;5381.219723140122;4640.559146881074;5289.391719952217;5295.523402893758;5334.066538355811;5400.945990540123;5324.54741346986;5333.359996800409;5333.973330133324;5389.892202155935;5422.43064478232;5744.138379243147;5830.2420685310635;5920.733566989496;5962.731677074542;5978.103284507315;5281.102212623825;6157.168782214389;6175.938240617581;6195.597286176384;6239.438450539473;6254.186955695776;6264.248290205159;6280.497560195174;6337.809865704036;6345.587536810139;5877.206577112121;5966.970165149233;6014.380920716371;6024.518038556905;6035.818925432244;5448.482394172547;6453.774117905851;6461.25695545009;6471.417572418505;6483.448906842971;6155.630662160284;6184.134221209034;6198.008318668992;6204.658743769136;6221.346758590374;6142.345304543789;6160.014397696347;6198.318184999646;6201.782937597162;6247.125402443661;6176;6176.320604733476;6230.096635987757;6237.906431403532;6252.499800015988;6163.907541386883;6216.285127210429;6251.718672659741;6252.718627661766;6259.311475737665;4983.651144419856;5043.36957880265;5059.038782631288;5074.49255074497;5143.742812859342;4549.977250113794;4552.499225085238;4554.225781617067;4570.88572785683;4618.722876627413;5879.147523609138;5977.103434484775;5985.16207730918;5993.430624090704;6024.367441418675;6121.910283036266;6205.193324867739;6219.346968568326;6261.499080073583;6307.95918673423;5979.581429299994;5994.850128746816;6006.849828754316;6023.608465449819;6048.697565121726;4731.4795372509;5565.387807341189;5595.7481913313995;5617.691026993472;5641.294838145232;5510.256115424447;6309.873802524015;6439.774607888701;6440.066190402459;6463.3213512580505;6257.624542527281;6319.115323854572;6323.620582765049;6333.8733225336155;6335.619862808247;6510.44661203803;6513.934860651333;6531.869362612816;6544;6554.4756419485375;5187.19598462239;6046.667433291035;6153.446189842935;6168.19813424252;6271.96864015677;6200.3799620037635;6256.99888017915;6264.373562643699;6311.211098612674;6412.583182093149;6220.409061139185;6235.282942461675;6242.625442473466;6253.530985176039;6270.811875643738;5111.565516931102;6142.468080853617;6156.846078848064;6190.102435146789;6234.688265586793;4985.8005679772405;6043.848903777441;6209.006558950547;6211.13044173807;6213.875722485434;5858;6207.6275423474735;6216.7824126155365;6238.376162383725;6246.281677607133;6028.4272994065495;6108.328083910855;6124.869201255775;6149.877002460015;6162.137300777984 12:03:41 INFO - PROCESS | 1650 | |1;ext.html;489.97550122493914;494.31043694046804;498.6534358620758;537.3900622793132;539.8704310965367;37271;39445.21109577807;39471.85545517715;39582.60417395829;39607.81176564704;32385.67614323856;36883.63116368842;39808.004799880015;40350.79824600873;40536.78389648308;8035.598220089001;9738;9789.951050244774;9800.166985806214;9844.310898237127;9674.613015479408;9707.174890134347;9735.17251033663;9745.610175593003;9756.707298781048;8329.583520823935;9745.707628771113;9758.853617195748;9776.560054797515;9778.951105244463;9750.12248897599;9768.120869121742;9780.951095244478;9782.608695652236;9783.804323913482;9628.3260171788;9687.951560242223;9736;9748.951255243679;9754.122129008352;38142.80928595339;38393.61606383928;38555.22889542222;38618;38699.64551240721;3386.3565922474895;3424.229548351601;3425.383430982422;3483.6168021517615;3854.5759966403953;29753.851230743923;29942.101736947927;30038.399232015236;30039.399212015636;30258.394832103455;2493.638422428756;3217.089177711996;3234.951475727866;3259.3481303739345;3310.7682462227654;478871.05644717626;479038;480094;480253;483673;43865.78067109644;54684;54895.72552137214;55035.17447238295;56213;31479.055628331185;31919.36161276808;57910.42089579134;58571.021463176105;58620.70689646524;15976.76034859478;16511;16521.91739041321;16531;16559.17204139788;12765.170263932814;12876.935615321863;12879.291638959947;12942.80585791195;12943.352832358345;15896.502769390716;17806.705759434546;18593.34923277679;18618.534536636693;18719.532011699543;7799;7924.247196516321;8005.119436862057;8035.156308587631;8043.19568043191;823.7652269103277;918.554501066982;990.65327135502;997.8553109799038;1043.4052590023614;26269.868650656623;29689.9608513701;29953.260516383638;30077.699223007927;30181.396372072875;1007.4811472091878;1025.3027941000043;1048.3709774135457;1055.8152323343538;1076.3380520979542;11683.383300630423;13536.323183840768;15287.847121528865;15334;15567.922160389126;652819;665763;665909;668721;673631;56145.473453694685;56404.717976409855;56816.863662726515;57333.71333143308;57704;1337.5920344294889;1355.5865461034282;1368.7878378851094;1381.8272715910512;1387.5559820857432;30141.849290753406;30243.848780755954;30685.693143068285;30920;31290.843545782125;45126.64620061272;47535;55368;55396;55408.33774986757;521584;529776;615452;616948;621426;41508.58491415047;41978.1604367917;42155.017943508945;42320;42558.787206063775;41797.58202417937;45465;46760;47105.293420598035;47137;38142.237155257295;38653.806730966164;38928.7046477514;39739.40390894197;42113.736587902415;32150.517742233416;38141.618583813804;38570.03574910649;39804.40293395659;39963.40054899121;30213;36793.31933252933;37738.811305943294;37858.62141378551;38008.80995595115;28916.566251506665;32403.18992025218;34235.31529369448;34253.801116960785;34262;24772.25683229506;24948.0020799166;25208.495830082928;25637.3590660235;25688.486230275663 12:03:41 INFO - PROCESS | 1650 | |2;jquery.html;365.78053168099143;367.3534579140712;370.30198076625567;379.68106790296144;394.2017414735161;19816.40550783477;20523.589528209428;21040.263590774324;21594.460138496546;21803.563928721414;17429;20089.095990680416;20097.995100245003;20243.88658623775;20647.380578582666;5302.151655735083;5772.191893134965;6009.4891934185425;6022.69886505673;6059.394060593927;5931.4068593140555;5986.790462333819;6021.036634138539;6033.818985430444;6039.607425517349;5630.127330263796;5858.033424484976;5911.201987731644;5937.643741375531;5993.310769261525;5576.581756368248;5717.771289148429;5805.071188609823;5826.038703613898;5860.73626686798;5055.51972562606;5081.949180508184;5101.744912754348;5105.872353191163;5109.335786347789;24953.62569561458;25178.748212517825;25289.114880979076;25345;25473.490530189476;2333.183385814968;2354.2584086012853;2376.988115059431;2381.5594115088766;2481.330040888968;15098.773518397233;15164.469243576532;15323.693526129526;15537.456189033443;15636.369036128413;1863.2733234038735;1868.4955062133283;1877.3898482992945;1881.6707076261737;1885.377825317642;100897;101257.49371253171;101677.4916125422;102440.48779756128;104660.95339046589;10509.632162874263;10550.261481696207;10809.67570972872;11039.724006899893;11273.35076257079;13322.333883305795;13352.132111412728;13384.19694818314;13410.195388276734;13427.932860335635;8229.83540329202;8504;8514.063453020162;8623;8669.349798764992;8586;8609.311255099577;8614;8729.301655867515;8792.692255771017;6420.903686444707;6502.414782669583;6535.8366040848405;6564.343565643398;6586.407223349922;1628.4951664983894;1878.3238034307637;1881.5578339090303;1883.7833649130525;1885.53804317943;742.1873049011324;814.5519964019884;849.4521033933202;863.1109956744563;899.5292696441365;15855.445059422866;18360.081995900153;20177.899110504353;21003.78996210049;21766.34700958974;820.8399362124328;970.3838062830154;976.5263847034183;983.4099540275778;993.1905497019906;11093.500792464358;11506.586539182053;11565.595204167814;11595.826062609067;11620.07039436843;246006;246766;247157;252499;602217;107522.31194220207;110773;111359.88640113495;113158.43420782844;113685.43157284161;1004.9899501004896;1026.630413051301;1066.5467176450134;1069.3690722473777;1071.1698433713777;18828.05859706982;18902.621947560696;18978.24087036503;19207.423777286705;19257.8074219256;47657.04685906193;49854;51621.48378516167;51914.74042629763;52936.94126117533;51272.74363628158;54532.72733636307;72007.27992720215;75726;80159;6507.772227971998;6760.898586521304;7626.847463050819;7874.881876771968;8047;10845.182459978;11140.275882067639;12325;12351.75296494083;12607.747845043232;9244.457774112174;9727.832660080836;9736.371179781561;9964.202863770735;10523.736906577396;9947.502624868872;10633.840492392466;10713.250072494851;11023.173262005543;11054.115670746482;9571.760705982128;9783.972682868196;10546.8417973732;11127.721806954567;11327.376994265065;7728.536287822749;7906.802329941797;7983.121856595653;8054.194580541899;8124.675012999413;10505.474726263808;10679.359238445408;10904.727381815517;10973.3964631946;11012.449377531251 12:03:41 INFO - PROCESS | 1650 | |3;mootools.html;1479.2825479642372;1508.683176532928;1737.9217935192914;1819.045001374279;1847.7413162157309;7780.494267872585;8242.876356854653;8275.08974012858;8799.5600219989;8813.338999575033;8299.543525106117;8527.488350698963;8530.91469085309;8538.829223415529;8582.91417085829;2325.0932136466836;2327.6624889391114;2339.2982105368324;2343.5078633486987;2344.0975224538506;2297.4600968772324;2328.662343960125;2352.0826877517784;2353.8823058847074;2362.6574146748712;2320.9439704934216;2329.9534009319805;2336.6261398176293;2341.285907798121;2352.9529409411803;2273.920412785553;2289.107248173214;2298.1726578431753;2321.1527792355755;2324.8605083695033;1924.9711254331196;2289.645105008726;2313.248194336847;2334.789868911789;2335.2060299498253;8662.30701543875;8721.956390218073;8788.824223515494;8789.472631642058;8815.51514666693;5195.558377537914;5347.598930080259;5352;5354;5360.463953604647;3506.403911335079;3565.5721313442295;3650;3655.4516822476576;3692.5015122958325;1059.639722494348;1085.218642577351;1103.8289065194908;1111.0889070961814;1118.664400679801;11331;11334.149938754626;11430.371329576787;11451.026662733677;11475.540978360856;4530.252508336153;4605.4933957264675;4805.1590971579835;4808.783604737795;4840.080384726891;9298.977112517618;9812.26408019387;9820.705378838646;9889.75275618101;9904.15814655748;4257.531671516131;5205.193195054772;5344.679319240858;5345.118055520873;5364.034473794676;3847.499825022785;4668.066386722669;4672.345871577982;4788.736619485892;4814.133455977888;3922;3941.172353805733;3982.542007669097;4021.3967904814513;4085.7752823594988;1106.4965440724452;1291.754566632337;1294.9482020719065;1305.09948135786;1308.4962289518603;858.1375717404094;893.7006102955582;894.9552522373855;906.60109551797;916.9312301577409;5477.20580515823;5551.833444996657;5792.9420705793245;5837.066069428956;5973.522118230531;898.0929261445987;933.7665583604099;937.095702646949;948.4688574398359;997.2420960070253;3917.7061720370516;3933.213357328546;3992.161646054361;4029.4157347185082;4054.71616986814;9830.410175389356;10470.73823154412;10596;10651.627193048205;10658.413787241776;8769.868451973225;10451.529681164366;10655.73360665974;10658.094062004662;10692.786144277072;7170.892436613455;7923.286904178767;8039;8144.063432705197;8239.217274358927;5107.9489205107475;5365.95363904035;5739.655620662774;5767.971160144172;5773.874094551522;9719.514024298898;9803.950980245054;9902.207823374258;9954.104130628279;10049.743782027246;9943;10092.596296148073;10159.187265018632;10184.796304074025;10254.179665626583;6491.642959637265;6493.058506516623;6970.372666460043;6989.685464154024;7098.787036388917;8219.30135938428;8401.62192701342;8473.49159050459;8475.152484751476;8478.703245386381;7338.596377199306;7449.4412919032375;7450.92549074524;7503.13713922884;7572.659230334538;7225.602591857499;7241.45689073311;7303.269673032654;7404;7415;6908;6922;6999.335063168991;7012.929870701431;7034.894476582957;4439.644828413655;4873.7806798694855;4893.828715994923;4942.357493525818;4995.675281106716;4890.462049174517;4949.059678661043;4978.153713868579;4998.375203099613;5053.418856831511 12:03:41 INFO - PROCESS | 1650 | |4;prototype.html;301.29797571658037;305.7156844134954;309.8806959320661;314.54862272638763;315.2371261547056;5083.949160508394;5280.970210808894;5327.36071671399;5327.706976116312;5636.802711905089;4991.875203119924;5314.335708036496;5418.620696551243;5442.720960574262;5458.863528411792;3549.73376996725;3952.4071389291694;4098.159877225162;4213.389058586503;4222.831086756526;3316.535685004101;3572.4462708280257;4187.099773548686;4197.41236226927;4197.8530751423705;4191.1617676464675;4194.769287689176;4211.957880421187;4224.345226489899;4228.957710422887;4208.684348673862;4217.135487225127;4218.704690671654;4219.767912764797;4245.936310955338;2947.661018982823;3186.49016157416;3516.2440075383915;3678.1724112074835;3680.35593771089;3775.754575952554;4249.80875860587;4316.762578058206;4759.571638552547;5293.444188360205;4462.3752674625575;4774.570288674036;4877.853664390074;4881.243407271879;4933.605311575066;4398.988232706495;5396.1905714143195;5719.571032172604;5910.586258961875;5944.97027514864;3189.712925836686;3589.3847768504015;4002.4996875390575;4047.655949244318;4078.938815917764;6143.87712245757;6157.692115394212;6158.630482171084;6184.226971628502;6292.716827742763;3632.2372301816386;3709.9443508347395;4075.8165882534763;4111.753294802322;4124.175164967019;4038.212548553004;4069.084455997436;4104.548499665035;4118.155778065489;4201.978990105091;4444.622207112367;4815.277708343707;4840.2255639097575;4847.563719265213;4881.585065269421;5128.205128205134;5840.737166827503;5855.6668065631975;5935.3884290911865;5984.31180414258;1266.7403182347596;1328.8804007639164;1406.2687402550616;1415.7451658701532;1420.708754705283;929.0594627612629;952.1335584617964;969.7139343893568;978.7960808205946;980.3627941337983;4685.695429797052;5083.669561478492;5284.682919024871;5419.403865574784;5419.566434685215;4940.925886111711;5196.9740151299;5878.5297176225795;5925.881482370414;5952.916479232234;4041.403645559987;4461.553844615577;4982.003599280159;5362.115250983544;5382.515573598316;2406.821826247249;2696.2180967519594;2704.905328313539;2707.28257011892;2732.0465866905256;4445.755483448376;4596.448426188812;5224.686518808883;5242.086638376965;5320.893582128336;4663.771213443245;5081.898362032739;5128.871648237382;5145.974270128625;5168.534831865075;4955.82654607087;4994.500549944976;5132.9743351283005;5134.741988212912;5170.5346518813485;4188.91622167561;4477.910441791211;4611.60196697722;4621.376114224671;4744.5492678195515;4211.873643790691;4897.4328214970865;4950.391122885148;4989.850304490871;5009.119756140307;4237.618614324726;4626.907461850811;5116.692998420107;5119.928043174065;5176.663516871391;3355.7650964433233;3560.6973407260675;3588.9641103589674;3601.261741342966;3631.9818400907825;3799.7340186186702;4318.762468064287;4803.471618121934;5042.647014708935;5068.645194836474;4504.707194032378;4671.019085991844;4762.4285085789925;4912.410510738734;5025.84922452327;4349.586384425138;4767.617390956584;4903.26451032348;4903.975480122576;4939.506049395031;3974.2448934702315;4736.8578942631775;4784.210605250095;4817;5155.05476569707;4651.209284425453;5096.490350964874;5147.639665223398;5322.973385133049;5323.0684630190335;5397.109476936262;5692.886142277049;5833.591648584558;5833.649981000984;5891.734871930687 12:03:41 INFO - PROCESS | 1650 | |5;yui.html;719.2591630620459;719.3957076056114;772.7295446593693;790.7904405332591;808.9150639182885;15544.689106217884;16205.432809851658;16210.594735131628;16278.51164465068;16321.10233937133;14437.711245775079;14634.414623415078;14664.926675366609;14682.339294731735;14702.926485367558;685.2736099734298;846.5174850335327;856.4047986649281;867.7700409391516;883.9834190680705;860.2515811244226;877.8507653698855;878.8418084744743;879.6041781198454;880.6433394475216;915.8809354783868;923.5520772425368;925.051821882569;925.0841666749936;926.4302453990781;879.3404946290283;914.2548822709471;914.2548822709471;914.4102054175053;914.9980771055716;676.5534747066912;680.8536164724608;680.9863802723968;683.719674933275;685.3215316836346;14423.855761442355;14753.114813111248;14782.26088695561;14789.260536973108;14835.554933352018;14277.714445711132;14362.85637143636;14386.712265754626;14419.855801441956;14577.562673119823;11702.707432314175;11797.174197806156;11993.460294286779;12090.09324300681;12381.566645167375;3777.0274625296993;3847.5190601174854;3848.230353929225;3848.3265428549894;3891.610838916114;90349.09650903473;95825.0417495823;119777;124926;125102;11167.553297868157;11205;11230.3261804292;11246;11613.735321612205;22955.885220574124;22967.196148134735;23020.4244893879;23020.53958920812;23940.04239830422;8004.359651227888;8095.5142691438705;8135.511869287861;8149.061624719814;8223.629936652866;4388.166248412791;4473.284274516127;4581.266997280419;4629.166749985035;4649.744264065441;3544.858205671796;3644.01611564876;3658.158623516606;3676.5036720042986;3678.8528458861347;558.3216392083638;563.8618538458104;660.1220376898713;663.0518358746941;680.8536164724608;548.9341279046461;564.4158296163451;565.799141304839;655.6235387753014;661.1801366305842;8723.869141962876;9067.727968160965;9109.590068446936;9337.71986840396;10069.949650251701;528.8598521391834;583.5228958559951;584.1179818474135;628.6542401679059;638.9106573292526;3792.6965842732516;3797.215508459361;4115.724125521098;4448.243798554254;4611.584957353854;123891;128300.35849820692;132490;135681;143807.2809635945;120796.58406831815;122575;123387;125176;125204;107070;107803.46098269458;108122.45938770256;108265;110561;9588.952055239679;9678.75803104928;9769.951150244488;9779.070988256104;9796.951015245164;53821;59666.10500842577;62650.06024909539;63055.10834674967;63281.050784237355;88493.11506884849;91056.54471727599;91112.54443727739;92876.53561732148;96272;12902.612921612366;12931.806022909852;13053.869461305265;13322.200667959953;13374.665633359244;14618.195999219719;14733.189674568002;14786.556403307917;15330;15386.615334616276;13161.354830646169;13537.458501659823;13698.863011369758;13970.860291396955;14195.929020354832;12353;13560.525381611991;13720.245386503839;13743.587692368845;13975;13195.802062969255;13351.666208344868;13385.397657105648;13454.52909148175;13864.584062478141;10754.83867742;11049.944750276198;11274.830877536679;11710.355930423568;11760.117991150526;7474.701011959461;10227.897721022695;10520.263581549218;11281.830772538582;11539.134564907497 12:03:41 INFO - PROCESS | 1650 | __end_tp_report 12:03:41 INFO - PROCESS | 1650 | __start_cc_report 12:03:41 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,385 12:03:41 INFO - PROCESS | 1650 | __end_cc_report 12:03:41 INFO - PROCESS | 1650 | __startTimestamp1472497421538__endTimestamp 12:03:41 INFO - PROCESS | 1650 | 12:03:41 INFO - PROCESS | 1650 | ------- Summary: start ------- 12:03:41 INFO - PROCESS | 1650 | Number of tests: 6 12:03:41 INFO - PROCESS | 1650 | 12:03:41 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5810.95 Median:6043.85 stddev:643.35 (10.6%) stddev-sans-first:614.61 12:03:41 INFO - PROCESS | 1650 | Values: 3307.2 3448.5 3460.8 3505.5 3508.3 4951.9 5618.3 5891.1 5924.9 6002.2 5196.8 5635.9 5834.1 5890.0 5920.0 5240.0 5325.4 5349.3 5390.2 5445.7 5431.7 5465.7 5470.2 5503.2 5511.2 5182.3 5214.2 5276.4 5370.6 5381.2 4640.6 5289.4 5295.5 5334.1 5400.9 5324.5 5333.4 5334.0 5389.9 5422.4 5744.1 5830.2 5920.7 5962.7 5978.1 5281.1 6157.2 6175.9 6195.6 6239.4 6254.2 6264.2 6280.5 6337.8 6345.6 5877.2 5967.0 6014.4 6024.5 6035.8 5448.5 6453.8 6461.3 6471.4 6483.4 6155.6 6184.1 6198.0 6204.7 6221.3 6142.3 6160.0 6198.3 6201.8 6247.1 6176.0 6176.3 6230.1 6237.9 6252.5 6163.9 6216.3 6251.7 6252.7 6259.3 4983.7 5043.4 5059.0 5074.5 5143.7 4550.0 4552.5 4554.2 4570.9 4618.7 5879.1 5977.1 5985.2 5993.4 6024.4 6121.9 6205.2 6219.3 6261.5 6308.0 5979.6 5994.9 6006.8 6023.6 6048.7 4731.5 5565.4 5595.7 5617.7 5641.3 5510.3 6309.9 6439.8 6440.1 6463.3 6257.6 6319.1 6323.6 6333.9 6335.6 6510.4 6513.9 6531.9 6544.0 6554.5 5187.2 6046.7 6153.4 6168.2 6272.0 6200.4 6257.0 6264.4 6311.2 6412.6 6220.4 6235.3 6242.6 6253.5 6270.8 5111.6 6142.5 6156.8 6190.1 6234.7 4985.8 6043.8 6209.0 6211.1 6213.9 5858.0 6207.6 6216.8 6238.4 6246.3 6028.4 6108.3 6124.9 6149.9 6162.1 12:03:41 INFO - PROCESS | 1650 | 12:03:41 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:70244.59 Median:39673.61 stddev:155471.02 (391.9%) stddev-sans-first:155818.94 12:03:41 INFO - PROCESS | 1650 | Values: 490.0 494.3 498.7 537.4 539.9 37271.0 39445.2 39471.9 39582.6 39607.8 32385.7 36883.6 39808.0 40350.8 40536.8 8035.6 9738.0 9790.0 9800.2 9844.3 9674.6 9707.2 9735.2 9745.6 9756.7 8329.6 9745.7 9758.9 9776.6 9779.0 9750.1 9768.1 9781.0 9782.6 9783.8 9628.3 9688.0 9736.0 9749.0 9754.1 38142.8 38393.6 38555.2 38618.0 38699.6 3386.4 3424.2 3425.4 3483.6 3854.6 29753.9 29942.1 30038.4 30039.4 30258.4 2493.6 3217.1 3235.0 3259.3 3310.8 478871.1 479038.0 480094.0 480253.0 483673.0 43865.8 54684.0 54895.7 55035.2 56213.0 31479.1 31919.4 57910.4 58571.0 58620.7 15976.8 16511.0 16521.9 16531.0 16559.2 12765.2 12876.9 12879.3 12942.8 12943.4 15896.5 17806.7 18593.3 18618.5 18719.5 7799.0 7924.2 8005.1 8035.2 8043.2 823.8 918.6 990.7 997.9 1043.4 26269.9 29690.0 29953.3 30077.7 30181.4 1007.5 1025.3 1048.4 1055.8 1076.3 11683.4 13536.3 15287.8 15334.0 15567.9 652819.0 665763.0 665909.0 668721.0 673631.0 56145.5 56404.7 56816.9 57333.7 57704.0 1337.6 1355.6 1368.8 1381.8 1387.6 30141.8 30243.8 30685.7 30920.0 31290.8 45126.6 47535.0 55368.0 55396.0 55408.3 521584.0 529776.0 615452.0 616948.0 621426.0 41508.6 41978.2 42155.0 42320.0 42558.8 41797.6 45465.0 46760.0 47105.3 47137.0 38142.2 38653.8 38928.7 39739.4 42113.7 32150.5 38141.6 38570.0 39804.4 39963.4 30213.0 36793.3 37738.8 37858.6 38008.8 28916.6 32403.2 34235.3 34253.8 34262.0 24772.3 24948.0 25208.5 25637.4 25688.5 12:03:41 INFO - PROCESS | 1650 | 12:03:41 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:25996.96 Median:13717.48 stddev:60584.85 (441.7%) stddev-sans-first:60724.24 12:03:41 INFO - PROCESS | 1650 | Values: 365.8 367.4 370.3 379.7 394.2 19816.4 20523.6 21040.3 21594.5 21803.6 17429.0 20089.1 20098.0 20243.9 20647.4 5302.2 5772.2 6009.5 6022.7 6059.4 5931.4 5986.8 6021.0 6033.8 6039.6 5630.1 5858.0 5911.2 5937.6 5993.3 5576.6 5717.8 5805.1 5826.0 5860.7 5055.5 5081.9 5101.7 5105.9 5109.3 24953.6 25178.7 25289.1 25345.0 25473.5 2333.2 2354.3 2377.0 2381.6 2481.3 15098.8 15164.5 15323.7 15537.5 15636.4 1863.3 1868.5 1877.4 1881.7 1885.4 100897.0 101257.5 101677.5 102440.5 104661.0 10509.6 10550.3 10809.7 11039.7 11273.4 13322.3 13352.1 13384.2 13410.2 13427.9 8229.8 8504.0 8514.1 8623.0 8669.3 8586.0 8609.3 8614.0 8729.3 8792.7 6420.9 6502.4 6535.8 6564.3 6586.4 1628.5 1878.3 1881.6 1883.8 1885.5 742.2 814.6 849.5 863.1 899.5 15855.4 18360.1 20177.9 21003.8 21766.3 820.8 970.4 976.5 983.4 993.2 11093.5 11506.6 11565.6 11595.8 11620.1 246006.0 246766.0 247157.0 252499.0 602217.0 107522.3 110773.0 111359.9 113158.4 113685.4 1005.0 1026.6 1066.5 1069.4 1071.2 18828.1 18902.6 18978.2 19207.4 19257.8 47657.0 49854.0 51621.5 51914.7 52936.9 51272.7 54532.7 72007.3 75726.0 80159.0 6507.8 6760.9 7626.8 7874.9 8047.0 10845.2 11140.3 12325.0 12351.8 12607.7 9244.5 9727.8 9736.4 9964.2 10523.7 9947.5 10633.8 10713.3 11023.2 11054.1 9571.8 9784.0 10546.8 11127.7 11327.4 7728.5 7906.8 7983.1 8054.2 8124.7 10505.5 10679.4 10904.7 10973.4 11012.4 12:03:41 INFO - PROCESS | 1650 | 12:03:41 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5615.49 Median:4986.91 stddev:3127.90 (62.7%) stddev-sans-first:3121.23 12:03:41 INFO - PROCESS | 1650 | Values: 1479.3 1508.7 1737.9 1819.0 1847.7 7780.5 8242.9 8275.1 8799.6 8813.3 8299.5 8527.5 8530.9 8538.8 8582.9 2325.1 2327.7 2339.3 2343.5 2344.1 2297.5 2328.7 2352.1 2353.9 2362.7 2320.9 2330.0 2336.6 2341.3 2353.0 2273.9 2289.1 2298.2 2321.2 2324.9 1925.0 2289.6 2313.2 2334.8 2335.2 8662.3 8722.0 8788.8 8789.5 8815.5 5195.6 5347.6 5352.0 5354.0 5360.5 3506.4 3565.6 3650.0 3655.5 3692.5 1059.6 1085.2 1103.8 1111.1 1118.7 11331.0 11334.1 11430.4 11451.0 11475.5 4530.3 4605.5 4805.2 4808.8 4840.1 9299.0 9812.3 9820.7 9889.8 9904.2 4257.5 5205.2 5344.7 5345.1 5364.0 3847.5 4668.1 4672.3 4788.7 4814.1 3922.0 3941.2 3982.5 4021.4 4085.8 1106.5 1291.8 1294.9 1305.1 1308.5 858.1 893.7 895.0 906.6 916.9 5477.2 5551.8 5792.9 5837.1 5973.5 898.1 933.8 937.1 948.5 997.2 3917.7 3933.2 3992.2 4029.4 4054.7 9830.4 10470.7 10596.0 10651.6 10658.4 8769.9 10451.5 10655.7 10658.1 10692.8 7170.9 7923.3 8039.0 8144.1 8239.2 5107.9 5366.0 5739.7 5768.0 5773.9 9719.5 9804.0 9902.2 9954.1 10049.7 9943.0 10092.6 10159.2 10184.8 10254.2 6491.6 6493.1 6970.4 6989.7 7098.8 8219.3 8401.6 8473.5 8475.2 8478.7 7338.6 7449.4 7450.9 7503.1 7572.7 7225.6 7241.5 7303.3 7404.0 7415.0 6908.0 6922.0 6999.3 7012.9 7034.9 4439.6 4873.8 4893.8 4942.4 4995.7 4890.5 4949.1 4978.2 4998.4 5053.4 12:03:41 INFO - PROCESS | 1650 | 12:03:41 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4362.67 Median:4771.09 stddev:1306.52 (27.4%) stddev-sans-first:1274.13 12:03:41 INFO - PROCESS | 1650 | Values: 301.3 305.7 309.9 314.5 315.2 5083.9 5281.0 5327.4 5327.7 5636.8 4991.9 5314.3 5418.6 5442.7 5458.9 3549.7 3952.4 4098.2 4213.4 4222.8 3316.5 3572.4 4187.1 4197.4 4197.9 4191.2 4194.8 4212.0 4224.3 4229.0 4208.7 4217.1 4218.7 4219.8 4245.9 2947.7 3186.5 3516.2 3678.2 3680.4 3775.8 4249.8 4316.8 4759.6 5293.4 4462.4 4774.6 4877.9 4881.2 4933.6 4399.0 5396.2 5719.6 5910.6 5945.0 3189.7 3589.4 4002.5 4047.7 4078.9 6143.9 6157.7 6158.6 6184.2 6292.7 3632.2 3709.9 4075.8 4111.8 4124.2 4038.2 4069.1 4104.5 4118.2 4202.0 4444.6 4815.3 4840.2 4847.6 4881.6 5128.2 5840.7 5855.7 5935.4 5984.3 1266.7 1328.9 1406.3 1415.7 1420.7 929.1 952.1 969.7 978.8 980.4 4685.7 5083.7 5284.7 5419.4 5419.6 4940.9 5197.0 5878.5 5925.9 5952.9 4041.4 4461.6 4982.0 5362.1 5382.5 2406.8 2696.2 2704.9 2707.3 2732.0 4445.8 4596.4 5224.7 5242.1 5320.9 4663.8 5081.9 5128.9 5146.0 5168.5 4955.8 4994.5 5133.0 5134.7 5170.5 4188.9 4477.9 4611.6 4621.4 4744.5 4211.9 4897.4 4950.4 4989.9 5009.1 4237.6 4626.9 5116.7 5119.9 5176.7 3355.8 3560.7 3589.0 3601.3 3632.0 3799.7 4318.8 4803.5 5042.6 5068.6 4504.7 4671.0 4762.4 4912.4 5025.8 4349.6 4767.6 4903.3 4904.0 4939.5 3974.2 4736.9 4784.2 4817.0 5155.1 4651.2 5096.5 5147.6 5323.0 5323.1 5397.1 5692.9 5833.6 5833.6 5891.7 12:03:41 INFO - PROCESS | 1650 | 12:03:41 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:24303.48 Median:3667.33 stddev:37869.32 (1032.6%) stddev-sans-first:37934.15 12:03:41 INFO - PROCESS | 1650 | Values: 719.3 719.4 772.7 790.8 808.9 15544.7 16205.4 16210.6 16278.5 16321.1 14437.7 14634.4 14664.9 14682.3 14702.9 685.3 846.5 856.4 867.8 884.0 860.3 877.9 878.8 879.6 880.6 915.9 923.6 925.1 925.1 926.4 879.3 914.3 914.3 914.4 915.0 676.6 680.9 681.0 683.7 685.3 14423.9 14753.1 14782.3 14789.3 14835.6 14277.7 14362.9 14386.7 14419.9 14577.6 11702.7 11797.2 11993.5 12090.1 12381.6 3777.0 3847.5 3848.2 3848.3 3891.6 90349.1 95825.0 119777.0 124926.0 125102.0 11167.6 11205.0 11230.3 11246.0 11613.7 22955.9 22967.2 23020.4 23020.5 23940.0 8004.4 8095.5 8135.5 8149.1 8223.6 4388.2 4473.3 4581.3 4629.2 4649.7 3544.9 3644.0 3658.2 3676.5 3678.9 558.3 563.9 660.1 663.1 680.9 548.9 564.4 565.8 655.6 661.2 8723.9 9067.7 9109.6 9337.7 10069.9 528.9 583.5 584.1 628.7 638.9 3792.7 3797.2 4115.7 4448.2 4611.6 123891.0 128300.4 132490.0 135681.0 143807.3 120796.6 122575.0 123387.0 125176.0 125204.0 107070.0 107803.5 108122.5 108265.0 110561.0 9589.0 9678.8 9770.0 9779.1 9797.0 53821.0 59666.1 62650.1 63055.1 63281.1 88493.1 91056.5 91112.5 92876.5 96272.0 12902.6 12931.8 13053.9 13322.2 13374.7 14618.2 14733.2 14786.6 15330.0 15386.6 13161.4 13537.5 13698.9 13970.9 14195.9 12353.0 13560.5 13720.2 13743.6 13975.0 13195.8 13351.7 13385.4 13454.5 13864.6 10754.8 11049.9 11274.8 11710.4 11760.1 7474.7 10227.9 10520.3 11281.8 11539.1 12:03:41 INFO - PROCESS | 1650 | -------- Summary: end -------- 12:03:41 INFO - PROCESS | 1650 | 12:03:42 INFO - TEST-INFO | 1650: exit 0 12:03:42 INFO - TEST-OK | dromaeo_css | took 1114180ms 12:03:42 INFO - TEST-START | kraken 12:03:42 INFO - operating with platform_type : mac_ 12:03:42 INFO - Initialising browser for kraken test... 12:03:42 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpYEmM9K/profile http://localhost:49262/getInfo.html) 12:03:44 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 12:03:44 INFO - PROCESS | 1659 | colorDepth:24 12:03:44 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 12:03:44 INFO - PROCESS | 1659 | __metrics 12:03:44 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 12:03:45 INFO - TEST-INFO | 1659: exit 0 12:03:45 INFO - Browser initialized. 12:03:45 INFO - Running cycle 1/1 for kraken test... 12:03:45 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpYEmM9K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:03:57 INFO - PROCESS | 1661 | RSS: Main: 244023296 12:03:57 INFO - PROCESS | 1661 | 12:04:00 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 12:04:01 INFO - PROCESS | 1661 | RSS: Main: 257257472 12:04:01 INFO - PROCESS | 1661 | 12:04:04 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 12:04:04 INFO - PROCESS | 1661 | RSS: Main: 265867264 12:04:04 INFO - PROCESS | 1661 | 12:04:08 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 12:04:09 INFO - PROCESS | 1661 | RSS: Main: 263557120 12:04:09 INFO - PROCESS | 1661 | 12:04:11 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 12:04:11 INFO - PROCESS | 1661 | RSS: Main: 264925184 12:04:11 INFO - PROCESS | 1661 | 12:04:14 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:04:14 INFO - PROCESS | 1661 | RSS: Main: 266539008 12:04:14 INFO - PROCESS | 1661 | 12:04:17 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 12:04:18 INFO - PROCESS | 1661 | RSS: Main: 266838016 12:04:18 INFO - PROCESS | 1661 | 12:04:21 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 12:04:22 INFO - PROCESS | 1661 | RSS: Main: 267079680 12:04:22 INFO - PROCESS | 1661 | 12:04:25 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 12:04:25 INFO - PROCESS | 1661 | RSS: Main: 267198464 12:04:25 INFO - PROCESS | 1661 | 12:04:27 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:04:27 INFO - PROCESS | 1661 | RSS: Main: 267018240 12:04:27 INFO - PROCESS | 1661 | 12:04:29 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:04:30 INFO - PROCESS | 1661 | RSS: Main: 267026432 12:04:30 INFO - PROCESS | 1661 | 12:04:32 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:04:33 INFO - PROCESS | 1661 | RSS: Main: 267292672 12:04:33 INFO - PROCESS | 1661 | 12:04:36 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:04:36 INFO - PROCESS | 1661 | RSS: Main: 267345920 12:04:36 INFO - PROCESS | 1661 | 12:04:39 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:04:40 INFO - PROCESS | 1661 | RSS: Main: 267411456 12:04:40 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 12:04:42 INFO - PROCESS | 1661 | RSS: Main: 269504512 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | __start_tp_report 12:04:42 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 12:04:42 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 12:04:42 INFO - PROCESS | 1661 | |i|pagename|runs| 12:04:42 INFO - PROCESS | 1661 | |0;ai-astar;117;112;100;141;156;127;102;159;170;117 12:04:42 INFO - PROCESS | 1661 | |1;audio-beat-detection;144;110;160;162;101;142;117;148;151;127 12:04:42 INFO - PROCESS | 1661 | |2;audio-dft;208;235;197;203;206;218;281;234;270;279 12:04:42 INFO - PROCESS | 1661 | |3;audio-fft;70;83;77;145;74;82;51;70;160;82 12:04:42 INFO - PROCESS | 1661 | |4;audio-oscillator;70;74;117;71;72;80;141;100;106;113 12:04:42 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;108;105;90;88;89;88;91;117;136;97 12:04:42 INFO - PROCESS | 1661 | |6;imaging-darkroom;93;137;95;128;103;151;155;100;96;94 12:04:42 INFO - PROCESS | 1661 | |7;imaging-desaturate;88;97;83;92;103;91;98;151;146;96 12:04:42 INFO - PROCESS | 1661 | |8;json-parse-financial;56;58;58;58;56;57;57;56;57;58 12:04:42 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;69;71;69;75;82;76;75;76;75;72 12:04:42 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;87;86;89;90;91;87;94;106;75;112 12:04:42 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;139;141;139;136;138;138;140;139;175;138 12:04:42 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;241;173;169;167;171;177;170;154;183;191 12:04:42 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;69;70;82;81;91;85;87;91;67;63 12:04:42 INFO - PROCESS | 1661 | __end_tp_report 12:04:42 INFO - PROCESS | 1661 | __start_cc_report 12:04:42 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,973 12:04:42 INFO - PROCESS | 1661 | __end_cc_report 12:04:42 INFO - PROCESS | 1661 | __startTimestamp1472497482519__endTimestamp 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | ------- Summary: start ------- 12:04:42 INFO - PROCESS | 1661 | Number of tests: 14 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:130.10 Median:134.00 stddev:24.93 (18.6%) stddev-sans-first:25.99 12:04:42 INFO - PROCESS | 1661 | Values: 117.0 112.0 100.0 141.0 156.0 127.0 102.0 159.0 170.0 117.0 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:146.00 stddev:21.25 (14.6%) stddev-sans-first:22.35 12:04:42 INFO - PROCESS | 1661 | Values: 144.0 110.0 160.0 162.0 101.0 142.0 117.0 148.0 151.0 127.0 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:233.10 Median:234.50 stddev:32.61 (13.9%) stddev-sans-first:33.30 12:04:42 INFO - PROCESS | 1661 | Values: 208.0 235.0 197.0 203.0 206.0 218.0 281.0 234.0 270.0 279.0 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:89.40 Median:75.50 stddev:34.71 (46.0%) stddev-sans-first:36.10 12:04:42 INFO - PROCESS | 1661 | Values: 70.0 83.0 77.0 145.0 74.0 82.0 51.0 70.0 160.0 82.0 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:70.50 stddev:24.64 (34.9%) stddev-sans-first:24.50 12:04:42 INFO - PROCESS | 1661 | Values: 70.0 74.0 117.0 71.0 72.0 80.0 141.0 100.0 106.0 113.0 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:100.90 Median:88.50 stddev:15.86 (17.9%) stddev-sans-first:16.62 12:04:42 INFO - PROCESS | 1661 | Values: 108.0 105.0 90.0 88.0 89.0 88.0 91.0 117.0 136.0 97.0 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:115.20 Median:124.00 stddev:24.95 (20.1%) stddev-sans-first:25.14 12:04:42 INFO - PROCESS | 1661 | Values: 93.0 137.0 95.0 128.0 103.0 151.0 155.0 100.0 96.0 94.0 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:104.50 Median:91.50 stddev:23.88 (26.1%) stddev-sans-first:24.57 12:04:42 INFO - PROCESS | 1661 | Values: 88.0 97.0 83.0 92.0 103.0 91.0 98.0 151.0 146.0 96.0 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.50 stddev:0.88 (1.5%) stddev-sans-first:0.83 12:04:42 INFO - PROCESS | 1661 | Values: 56.0 58.0 58.0 58.0 56.0 57.0 57.0 56.0 57.0 58.0 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:74.00 Median:75.00 stddev:3.92 (5.2%) stddev-sans-first:3.71 12:04:42 INFO - PROCESS | 1661 | Values: 69.0 71.0 69.0 75.0 82.0 76.0 75.0 76.0 75.0 72.0 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:88.00 stddev:10.48 (11.9%) stddev-sans-first:10.97 12:04:42 INFO - PROCESS | 1661 | Values: 87.0 86.0 89.0 90.0 91.0 87.0 94.0 106.0 75.0 112.0 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:139.00 stddev:11.57 (8.3%) stddev-sans-first:12.21 12:04:42 INFO - PROCESS | 1661 | Values: 139.0 141.0 139.0 136.0 138.0 138.0 140.0 139.0 175.0 138.0 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:175.00 stddev:23.70 (13.5%) stddev-sans-first:10.40 12:04:42 INFO - PROCESS | 1661 | Values: 241.0 173.0 169.0 167.0 171.0 177.0 170.0 154.0 183.0 191.0 12:04:42 INFO - PROCESS | 1661 | 12:04:42 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.60 Median:83.50 stddev:10.44 (12.5%) stddev-sans-first:10.48 12:04:42 INFO - PROCESS | 1661 | Values: 69.0 70.0 82.0 81.0 91.0 85.0 87.0 91.0 67.0 63.0 12:04:42 INFO - PROCESS | 1661 | -------- Summary: end -------- 12:04:42 INFO - PROCESS | 1661 | 12:04:43 INFO - TEST-INFO | 1661: exit 0 12:04:43 INFO - TEST-OK | kraken | took 61206ms 12:04:43 INFO - SUITE-END | took 1175s 12:04:43 INFO - Completed test suite (00:19:35) 12:04:43 INFO - javascript benchmark 12:04:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7282.87316491375, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.1566750478623, 3448.517207590937, 3460.7923524588527, 3505.5092287079815, 3508.3334166508375, 4951.900961980758, 5618.269624948761, 5891.086881533359, 5924.881502369961, 6002.249718785152, 5196.844094677156, 5635.929173457041, 5834.066549352105, 5889.970550147254, 5920.0, 5239.973800130994, 5325.387580428262, 5349.277847490597, 5390.164524498709, 5445.700486473243, 5431.674099554019, 5465.699386533739, 5470.234167216593, 5503.229547863302, 5511.22842802008, 5182.326297581328, 5214.217867319894, 5276.366835979668, 5370.570354371641, 5381.219723140122, 4640.559146881074, 5289.391719952217, 5295.523402893758, 5334.066538355811, 5400.945990540123, 5324.54741346986, 5333.359996800409, 5333.973330133324, 5389.892202155935, 5422.43064478232, 5744.138379243147, 5830.2420685310635, 5920.733566989496, 5962.731677074542, 5978.103284507315, 5281.102212623825, 6157.168782214389, 6175.938240617581, 6195.597286176384, 6239.438450539473, 6254.186955695776, 6264.248290205159, 6280.497560195174, 6337.809865704036, 6345.587536810139, 5877.206577112121, 5966.970165149233, 6014.380920716371, 6024.518038556905, 6035.818925432244, 5448.482394172547, 6453.774117905851, 6461.25695545009, 6471.417572418505, 6483.448906842971, 6155.630662160284, 6184.134221209034, 6198.008318668992, 6204.658743769136, 6221.346758590374, 6142.345304543789, 6160.014397696347, 6198.318184999646, 6201.782937597162, 6247.125402443661, 6176.0, 6176.320604733476, 6230.096635987757, 6237.906431403532, 6252.499800015988, 6163.907541386883, 6216.285127210429, 6251.718672659741, 6252.718627661766, 6259.311475737665, 4983.651144419856, 5043.36957880265, 5059.038782631288, 5074.49255074497, 5143.742812859342, 4549.977250113794, 4552.499225085238, 4554.225781617067, 4570.88572785683, 4618.722876627413, 5879.147523609138, 5977.103434484775, 5985.16207730918, 5993.430624090704, 6024.367441418675, 6121.910283036266, 6205.193324867739, 6219.346968568326, 6261.499080073583, 6307.95918673423, 5979.581429299994, 5994.850128746816, 6006.849828754316, 6023.608465449819, 6048.697565121726, 4731.4795372509, 5565.387807341189, 5595.7481913313995, 5617.691026993472, 5641.294838145232, 5510.256115424447, 6309.873802524015, 6439.774607888701, 6440.066190402459, 6463.3213512580505, 6257.624542527281, 6319.115323854572, 6323.620582765049, 6333.8733225336155, 6335.619862808247, 6510.44661203803, 6513.934860651333, 6531.869362612816, 6544.0, 6554.4756419485375, 5187.19598462239, 6046.667433291035, 6153.446189842935, 6168.19813424252, 6271.96864015677, 6200.3799620037635, 6256.99888017915, 6264.373562643699, 6311.211098612674, 6412.583182093149, 6220.409061139185, 6235.282942461675, 6242.625442473466, 6253.530985176039, 6270.811875643738, 5111.565516931102, 6142.468080853617, 6156.846078848064, 6190.102435146789, 6234.688265586793, 4985.8005679772405, 6043.848903777441, 6209.006558950547, 6211.13044173807, 6213.875722485434, 5858.0, 6207.6275423474735, 6216.7824126155365, 6238.376162383725, 6246.281677607133, 6028.4272994065495, 6108.328083910855, 6124.869201255775, 6149.877002460015, 6162.137300777984], "value": 5773.184583474163, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.97550122493914, 494.31043694046804, 498.6534358620758, 537.3900622793132, 539.8704310965367, 37271.0, 39445.21109577807, 39471.85545517715, 39582.60417395829, 39607.81176564704, 32385.67614323856, 36883.63116368842, 39808.004799880015, 40350.79824600873, 40536.78389648308, 8035.598220089001, 9738.0, 9789.951050244774, 9800.166985806214, 9844.310898237127, 9674.613015479408, 9707.174890134347, 9735.17251033663, 9745.610175593003, 9756.707298781048, 8329.583520823935, 9745.707628771113, 9758.853617195748, 9776.560054797515, 9778.951105244463, 9750.12248897599, 9768.120869121742, 9780.951095244478, 9782.608695652236, 9783.804323913482, 9628.3260171788, 9687.951560242223, 9736.0, 9748.951255243679, 9754.122129008352, 38142.80928595339, 38393.61606383928, 38555.22889542222, 38618.0, 38699.64551240721, 3386.3565922474895, 3424.229548351601, 3425.383430982422, 3483.6168021517615, 3854.5759966403953, 29753.851230743923, 29942.101736947927, 30038.399232015236, 30039.399212015636, 30258.394832103455, 2493.638422428756, 3217.089177711996, 3234.951475727866, 3259.3481303739345, 3310.7682462227654, 478871.05644717626, 479038.0, 480094.0, 480253.0, 483673.0, 43865.78067109644, 54684.0, 54895.72552137214, 55035.17447238295, 56213.0, 31479.055628331185, 31919.36161276808, 57910.42089579134, 58571.021463176105, 58620.70689646524, 15976.76034859478, 16511.0, 16521.91739041321, 16531.0, 16559.17204139788, 12765.170263932814, 12876.935615321863, 12879.291638959947, 12942.80585791195, 12943.352832358345, 15896.502769390716, 17806.705759434546, 18593.34923277679, 18618.534536636693, 18719.532011699543, 7799.0, 7924.247196516321, 8005.119436862057, 8035.156308587631, 8043.19568043191, 823.7652269103277, 918.554501066982, 990.65327135502, 997.8553109799038, 1043.4052590023614, 26269.868650656623, 29689.9608513701, 29953.260516383638, 30077.699223007927, 30181.396372072875, 1007.4811472091878, 1025.3027941000043, 1048.3709774135457, 1055.8152323343538, 1076.3380520979542, 11683.383300630423, 13536.323183840768, 15287.847121528865, 15334.0, 15567.922160389126, 652819.0, 665763.0, 665909.0, 668721.0, 673631.0, 56145.473453694685, 56404.717976409855, 56816.863662726515, 57333.71333143308, 57704.0, 1337.5920344294889, 1355.5865461034282, 1368.7878378851094, 1381.8272715910512, 1387.5559820857432, 30141.849290753406, 30243.848780755954, 30685.693143068285, 30920.0, 31290.843545782125, 45126.64620061272, 47535.0, 55368.0, 55396.0, 55408.33774986757, 521584.0, 529776.0, 615452.0, 616948.0, 621426.0, 41508.58491415047, 41978.1604367917, 42155.017943508945, 42320.0, 42558.787206063775, 41797.58202417937, 45465.0, 46760.0, 47105.293420598035, 47137.0, 38142.237155257295, 38653.806730966164, 38928.7046477514, 39739.40390894197, 42113.736587902415, 32150.517742233416, 38141.618583813804, 38570.03574910649, 39804.40293395659, 39963.40054899121, 30213.0, 36793.31933252933, 37738.811305943294, 37858.62141378551, 38008.80995595115, 28916.566251506665, 32403.18992025218, 34235.31529369448, 34253.801116960785, 34262.0, 24772.25683229506, 24948.0020799166, 25208.495830082928, 25637.3590660235, 25688.486230275663], "value": 19818.09512026578, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.78053168099143, 367.3534579140712, 370.30198076625567, 379.68106790296144, 394.2017414735161, 19816.40550783477, 20523.589528209428, 21040.263590774324, 21594.460138496546, 21803.563928721414, 17429.0, 20089.095990680416, 20097.995100245003, 20243.88658623775, 20647.380578582666, 5302.151655735083, 5772.191893134965, 6009.4891934185425, 6022.69886505673, 6059.394060593927, 5931.4068593140555, 5986.790462333819, 6021.036634138539, 6033.818985430444, 6039.607425517349, 5630.127330263796, 5858.033424484976, 5911.201987731644, 5937.643741375531, 5993.310769261525, 5576.581756368248, 5717.771289148429, 5805.071188609823, 5826.038703613898, 5860.73626686798, 5055.51972562606, 5081.949180508184, 5101.744912754348, 5105.872353191163, 5109.335786347789, 24953.62569561458, 25178.748212517825, 25289.114880979076, 25345.0, 25473.490530189476, 2333.183385814968, 2354.2584086012853, 2376.988115059431, 2381.5594115088766, 2481.330040888968, 15098.773518397233, 15164.469243576532, 15323.693526129526, 15537.456189033443, 15636.369036128413, 1863.2733234038735, 1868.4955062133283, 1877.3898482992945, 1881.6707076261737, 1885.377825317642, 100897.0, 101257.49371253171, 101677.4916125422, 102440.48779756128, 104660.95339046589, 10509.632162874263, 10550.261481696207, 10809.67570972872, 11039.724006899893, 11273.35076257079, 13322.333883305795, 13352.132111412728, 13384.19694818314, 13410.195388276734, 13427.932860335635, 8229.83540329202, 8504.0, 8514.063453020162, 8623.0, 8669.349798764992, 8586.0, 8609.311255099577, 8614.0, 8729.301655867515, 8792.692255771017, 6420.903686444707, 6502.414782669583, 6535.8366040848405, 6564.343565643398, 6586.407223349922, 1628.4951664983894, 1878.3238034307637, 1881.5578339090303, 1883.7833649130525, 1885.53804317943, 742.1873049011324, 814.5519964019884, 849.4521033933202, 863.1109956744563, 899.5292696441365, 15855.445059422866, 18360.081995900153, 20177.899110504353, 21003.78996210049, 21766.34700958974, 820.8399362124328, 970.3838062830154, 976.5263847034183, 983.4099540275778, 993.1905497019906, 11093.500792464358, 11506.586539182053, 11565.595204167814, 11595.826062609067, 11620.07039436843, 246006.0, 246766.0, 247157.0, 252499.0, 602217.0, 107522.31194220207, 110773.0, 111359.88640113495, 113158.43420782844, 113685.43157284161, 1004.9899501004896, 1026.630413051301, 1066.5467176450134, 1069.3690722473777, 1071.1698433713777, 18828.05859706982, 18902.621947560696, 18978.24087036503, 19207.423777286705, 19257.8074219256, 47657.04685906193, 49854.0, 51621.48378516167, 51914.74042629763, 52936.94126117533, 51272.74363628158, 54532.72733636307, 72007.27992720215, 75726.0, 80159.0, 6507.772227971998, 6760.898586521304, 7626.847463050819, 7874.881876771968, 8047.0, 10845.182459978, 11140.275882067639, 12325.0, 12351.75296494083, 12607.747845043232, 9244.457774112174, 9727.832660080836, 9736.371179781561, 9964.202863770735, 10523.736906577396, 9947.502624868872, 10633.840492392466, 10713.250072494851, 11023.173262005543, 11054.115670746482, 9571.760705982128, 9783.972682868196, 10546.8417973732, 11127.721806954567, 11327.376994265065, 7728.536287822749, 7906.802329941797, 7983.121856595653, 8054.194580541899, 8124.675012999413, 10505.474726263808, 10679.359238445408, 10904.727381815517, 10973.3964631946, 11012.449377531251], "value": 9303.456569046857, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.2825479642372, 1508.683176532928, 1737.9217935192914, 1819.045001374279, 1847.7413162157309, 7780.494267872585, 8242.876356854653, 8275.08974012858, 8799.5600219989, 8813.338999575033, 8299.543525106117, 8527.488350698963, 8530.91469085309, 8538.829223415529, 8582.91417085829, 2325.0932136466836, 2327.6624889391114, 2339.2982105368324, 2343.5078633486987, 2344.0975224538506, 2297.4600968772324, 2328.662343960125, 2352.0826877517784, 2353.8823058847074, 2362.6574146748712, 2320.9439704934216, 2329.9534009319805, 2336.6261398176293, 2341.285907798121, 2352.9529409411803, 2273.920412785553, 2289.107248173214, 2298.1726578431753, 2321.1527792355755, 2324.8605083695033, 1924.9711254331196, 2289.645105008726, 2313.248194336847, 2334.789868911789, 2335.2060299498253, 8662.30701543875, 8721.956390218073, 8788.824223515494, 8789.472631642058, 8815.51514666693, 5195.558377537914, 5347.598930080259, 5352.0, 5354.0, 5360.463953604647, 3506.403911335079, 3565.5721313442295, 3650.0, 3655.4516822476576, 3692.5015122958325, 1059.639722494348, 1085.218642577351, 1103.8289065194908, 1111.0889070961814, 1118.664400679801, 11331.0, 11334.149938754626, 11430.371329576787, 11451.026662733677, 11475.540978360856, 4530.252508336153, 4605.4933957264675, 4805.1590971579835, 4808.783604737795, 4840.080384726891, 9298.977112517618, 9812.26408019387, 9820.705378838646, 9889.75275618101, 9904.15814655748, 4257.531671516131, 5205.193195054772, 5344.679319240858, 5345.118055520873, 5364.034473794676, 3847.499825022785, 4668.066386722669, 4672.345871577982, 4788.736619485892, 4814.133455977888, 3922.0, 3941.172353805733, 3982.542007669097, 4021.3967904814513, 4085.7752823594988, 1106.4965440724452, 1291.754566632337, 1294.9482020719065, 1305.09948135786, 1308.4962289518603, 858.1375717404094, 893.7006102955582, 894.9552522373855, 906.60109551797, 916.9312301577409, 5477.20580515823, 5551.833444996657, 5792.9420705793245, 5837.066069428956, 5973.522118230531, 898.0929261445987, 933.7665583604099, 937.095702646949, 948.4688574398359, 997.2420960070253, 3917.7061720370516, 3933.213357328546, 3992.161646054361, 4029.4157347185082, 4054.71616986814, 9830.410175389356, 10470.73823154412, 10596.0, 10651.627193048205, 10658.413787241776, 8769.868451973225, 10451.529681164366, 10655.73360665974, 10658.094062004662, 10692.786144277072, 7170.892436613455, 7923.286904178767, 8039.0, 8144.063432705197, 8239.217274358927, 5107.9489205107475, 5365.95363904035, 5739.655620662774, 5767.971160144172, 5773.874094551522, 9719.514024298898, 9803.950980245054, 9902.207823374258, 9954.104130628279, 10049.743782027246, 9943.0, 10092.596296148073, 10159.187265018632, 10184.796304074025, 10254.179665626583, 6491.642959637265, 6493.058506516623, 6970.372666460043, 6989.685464154024, 7098.787036388917, 8219.30135938428, 8401.62192701342, 8473.49159050459, 8475.152484751476, 8478.703245386381, 7338.596377199306, 7449.4412919032375, 7450.92549074524, 7503.13713922884, 7572.659230334538, 7225.602591857499, 7241.45689073311, 7303.269673032654, 7404.0, 7415.0, 6908.0, 6922.0, 6999.335063168991, 7012.929870701431, 7034.894476582957, 4439.644828413655, 4873.7806798694855, 4893.828715994923, 4942.357493525818, 4995.675281106716, 4890.462049174517, 4949.059678661043, 4978.153713868579, 4998.375203099613, 5053.418856831511], "value": 4532.023710647213, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.29797571658037, 305.7156844134954, 309.8806959320661, 314.54862272638763, 315.2371261547056, 5083.949160508394, 5280.970210808894, 5327.36071671399, 5327.706976116312, 5636.802711905089, 4991.875203119924, 5314.335708036496, 5418.620696551243, 5442.720960574262, 5458.863528411792, 3549.73376996725, 3952.4071389291694, 4098.159877225162, 4213.389058586503, 4222.831086756526, 3316.535685004101, 3572.4462708280257, 4187.099773548686, 4197.41236226927, 4197.8530751423705, 4191.1617676464675, 4194.769287689176, 4211.957880421187, 4224.345226489899, 4228.957710422887, 4208.684348673862, 4217.135487225127, 4218.704690671654, 4219.767912764797, 4245.936310955338, 2947.661018982823, 3186.49016157416, 3516.2440075383915, 3678.1724112074835, 3680.35593771089, 3775.754575952554, 4249.80875860587, 4316.762578058206, 4759.571638552547, 5293.444188360205, 4462.3752674625575, 4774.570288674036, 4877.853664390074, 4881.243407271879, 4933.605311575066, 4398.988232706495, 5396.1905714143195, 5719.571032172604, 5910.586258961875, 5944.97027514864, 3189.712925836686, 3589.3847768504015, 4002.4996875390575, 4047.655949244318, 4078.938815917764, 6143.87712245757, 6157.692115394212, 6158.630482171084, 6184.226971628502, 6292.716827742763, 3632.2372301816386, 3709.9443508347395, 4075.8165882534763, 4111.753294802322, 4124.175164967019, 4038.212548553004, 4069.084455997436, 4104.548499665035, 4118.155778065489, 4201.978990105091, 4444.622207112367, 4815.277708343707, 4840.2255639097575, 4847.563719265213, 4881.585065269421, 5128.205128205134, 5840.737166827503, 5855.6668065631975, 5935.3884290911865, 5984.31180414258, 1266.7403182347596, 1328.8804007639164, 1406.2687402550616, 1415.7451658701532, 1420.708754705283, 929.0594627612629, 952.1335584617964, 969.7139343893568, 978.7960808205946, 980.3627941337983, 4685.695429797052, 5083.669561478492, 5284.682919024871, 5419.403865574784, 5419.566434685215, 4940.925886111711, 5196.9740151299, 5878.5297176225795, 5925.881482370414, 5952.916479232234, 4041.403645559987, 4461.553844615577, 4982.003599280159, 5362.115250983544, 5382.515573598316, 2406.821826247249, 2696.2180967519594, 2704.905328313539, 2707.28257011892, 2732.0465866905256, 4445.755483448376, 4596.448426188812, 5224.686518808883, 5242.086638376965, 5320.893582128336, 4663.771213443245, 5081.898362032739, 5128.871648237382, 5145.974270128625, 5168.534831865075, 4955.82654607087, 4994.500549944976, 5132.9743351283005, 5134.741988212912, 5170.5346518813485, 4188.91622167561, 4477.910441791211, 4611.60196697722, 4621.376114224671, 4744.5492678195515, 4211.873643790691, 4897.4328214970865, 4950.391122885148, 4989.850304490871, 5009.119756140307, 4237.618614324726, 4626.907461850811, 5116.692998420107, 5119.928043174065, 5176.663516871391, 3355.7650964433233, 3560.6973407260675, 3588.9641103589674, 3601.261741342966, 3631.9818400907825, 3799.7340186186702, 4318.762468064287, 4803.471618121934, 5042.647014708935, 5068.645194836474, 4504.707194032378, 4671.019085991844, 4762.4285085789925, 4912.410510738734, 5025.84922452327, 4349.586384425138, 4767.617390956584, 4903.26451032348, 4903.975480122576, 4939.506049395031, 3974.2448934702315, 4736.8578942631775, 4784.210605250095, 4817.0, 5155.05476569707, 4651.209284425453, 5096.490350964874, 5147.639665223398, 5322.973385133049, 5323.0684630190335, 5397.109476936262, 5692.886142277049, 5833.591648584558, 5833.649981000984, 5891.734871930687], "value": 3963.300013444921, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.2591630620459, 719.3957076056114, 772.7295446593693, 790.7904405332591, 808.9150639182885, 15544.689106217884, 16205.432809851658, 16210.594735131628, 16278.51164465068, 16321.10233937133, 14437.711245775079, 14634.414623415078, 14664.926675366609, 14682.339294731735, 14702.926485367558, 685.2736099734298, 846.5174850335327, 856.4047986649281, 867.7700409391516, 883.9834190680705, 860.2515811244226, 877.8507653698855, 878.8418084744743, 879.6041781198454, 880.6433394475216, 915.8809354783868, 923.5520772425368, 925.051821882569, 925.0841666749936, 926.4302453990781, 879.3404946290283, 914.2548822709471, 914.2548822709471, 914.4102054175053, 914.9980771055716, 676.5534747066912, 680.8536164724608, 680.9863802723968, 683.719674933275, 685.3215316836346, 14423.855761442355, 14753.114813111248, 14782.26088695561, 14789.260536973108, 14835.554933352018, 14277.714445711132, 14362.85637143636, 14386.712265754626, 14419.855801441956, 14577.562673119823, 11702.707432314175, 11797.174197806156, 11993.460294286779, 12090.09324300681, 12381.566645167375, 3777.0274625296993, 3847.5190601174854, 3848.230353929225, 3848.3265428549894, 3891.610838916114, 90349.09650903473, 95825.0417495823, 119777.0, 124926.0, 125102.0, 11167.553297868157, 11205.0, 11230.3261804292, 11246.0, 11613.735321612205, 22955.885220574124, 22967.196148134735, 23020.4244893879, 23020.53958920812, 23940.04239830422, 8004.359651227888, 8095.5142691438705, 8135.511869287861, 8149.061624719814, 8223.629936652866, 4388.166248412791, 4473.284274516127, 4581.266997280419, 4629.166749985035, 4649.744264065441, 3544.858205671796, 3644.01611564876, 3658.158623516606, 3676.5036720042986, 3678.8528458861347, 558.3216392083638, 563.8618538458104, 660.1220376898713, 663.0518358746941, 680.8536164724608, 548.9341279046461, 564.4158296163451, 565.799141304839, 655.6235387753014, 661.1801366305842, 8723.869141962876, 9067.727968160965, 9109.590068446936, 9337.71986840396, 10069.949650251701, 528.8598521391834, 583.5228958559951, 584.1179818474135, 628.6542401679059, 638.9106573292526, 3792.6965842732516, 3797.215508459361, 4115.724125521098, 4448.243798554254, 4611.584957353854, 123891.0, 128300.35849820692, 132490.0, 135681.0, 143807.2809635945, 120796.58406831815, 122575.0, 123387.0, 125176.0, 125204.0, 107070.0, 107803.46098269458, 108122.45938770256, 108265.0, 110561.0, 9588.952055239679, 9678.75803104928, 9769.951150244488, 9779.070988256104, 9796.951015245164, 53821.0, 59666.10500842577, 62650.06024909539, 63055.10834674967, 63281.050784237355, 88493.11506884849, 91056.54471727599, 91112.54443727739, 92876.53561732148, 96272.0, 12902.612921612366, 12931.806022909852, 13053.869461305265, 13322.200667959953, 13374.665633359244, 14618.195999219719, 14733.189674568002, 14786.556403307917, 15330.0, 15386.615334616276, 13161.354830646169, 13537.458501659823, 13698.863011369758, 13970.860291396955, 14195.929020354832, 12353.0, 13560.525381611991, 13720.245386503839, 13743.587692368845, 13975.0, 13195.802062969255, 13351.666208344868, 13385.397657105648, 13454.52909148175, 13864.584062478141, 10754.83867742, 11049.944750276198, 11274.830877536679, 11710.355930423568, 11760.117991150526, 7474.701011959461, 10227.897721022695, 10520.263581549218, 11281.830772538582, 11539.134564907497], "value": 7803.664629950043, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1627.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 100.0, 141.0, 156.0, 127.0, 102.0, 159.0, 170.0, 117.0], "value": 130.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 160.0, 162.0, 101.0, 142.0, 117.0, 148.0, 151.0, 127.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 235.0, 197.0, 203.0, 206.0, 218.0, 281.0, 234.0, 270.0, 279.0], "value": 233.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 83.0, 77.0, 145.0, 74.0, 82.0, 51.0, 70.0, 160.0, 82.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 117.0, 71.0, 72.0, 80.0, 141.0, 100.0, 106.0, 113.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 105.0, 90.0, 88.0, 89.0, 88.0, 91.0, 117.0, 136.0, 97.0], "value": 100.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 137.0, 95.0, 128.0, 103.0, 151.0, 155.0, 100.0, 96.0, 94.0], "value": 115.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 97.0, 83.0, 92.0, 103.0, 91.0, 98.0, 151.0, 146.0, 96.0], "value": 104.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 58.0, 58.0, 56.0, 57.0, 57.0, 56.0, 57.0, 58.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 69.0, 75.0, 82.0, 76.0, 75.0, 76.0, 75.0, 72.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 89.0, 90.0, 91.0, 87.0, 94.0, 106.0, 75.0, 112.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 139.0, 136.0, 138.0, 138.0, 140.0, 139.0, 175.0, 138.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [241.0, 173.0, 169.0, 167.0, 171.0, 177.0, 170.0, 154.0, 183.0, 191.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 82.0, 81.0, 91.0, 85.0, 87.0, 91.0, 67.0, 63.0], "value": 78.6, "unit": "score"}]}]} 12:04:43 INFO - Return code: 0 12:04:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:04:43 ERROR - # TBPL SUCCESS # 12:04:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:04:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:04:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:04:43 INFO - 2016-08-29 12:04:43.853 screenresolution[1666:10402] starting screenresolution argv=screenresolution get 12:04:43 INFO - 2016-08-29 12:04:43.855 screenresolution[1666:10402] Display 0: 1600x1200x32@60 12:04:43 INFO - 2016-08-29 12:04:43.861 screenresolution[1667:10405] starting screenresolution argv=screenresolution list 12:04:43 INFO - Available Modes on Display 0 12:04:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:04:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:04:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:04:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:04:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:04:44 INFO - Intel Iris: 12:04:44 INFO - Chipset Model: Intel Iris 12:04:44 INFO - Type: GPU 12:04:44 INFO - Bus: Built-In 12:04:44 INFO - VRAM (Dynamic, Max): 1536 MB 12:04:44 INFO - Vendor: Intel (0x8086) 12:04:44 INFO - Device ID: 0x0a2e 12:04:44 INFO - Revision ID: 0x0009 12:04:44 INFO - Displays: 12:04:44 INFO - Display: 12:04:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:04:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:04:44 INFO - Display Serial Number: 1600x1200 60 12:04:44 INFO - Main Display: Yes 12:04:44 INFO - Mirror: Off 12:04:44 INFO - Online: Yes 12:04:44 INFO - Rotation: Supported 12:04:44 INFO - Return code: 0 12:04:44 INFO - Running post-action listener: _resource_record_post_action 12:04:44 INFO - [mozharness: 2016-08-29 19:04:44.099918Z] Finished run-tests step (success) 12:04:44 INFO - Running post-run listener: _resource_record_post_run 12:04:44 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 38126592; Write bytes: 710065152; Read time: 417; Write time: 3115 12:04:44 INFO - TinderboxPrint: CPU usage
54.6% 12:04:44 INFO - TinderboxPrint: I/O read bytes / time
38,126,592 / 417 12:04:44 INFO - TinderboxPrint: I/O write bytes / time
710,065,152 / 3,115 12:04:44 INFO - TinderboxPrint: CPU idle
2,201.9 (45.4%) 12:04:44 INFO - TinderboxPrint: CPU system
978.0 (20.2%) 12:04:44 INFO - TinderboxPrint: CPU user
1,665.8 (34.4%) 12:04:44 INFO - TinderboxPrint: Swap in / out
443,392,000 / 0 12:04:44 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 394660352; Write bytes: 389466112; Read time: 29286; Write time: 768 12:04:44 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 34015232; Write bytes: 300672000; Read time: 361; Write time: 2304 12:04:44 INFO - Running post-run listener: _upload_blobber_files 12:04:44 INFO - Blob upload gear active. 12:04:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:04:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:04:44 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:04:44 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:04:44 INFO - (blobuploader) - INFO - Open directory for files ... 12:04:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:04:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:04:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:45 INFO - (blobuploader) - INFO - Done attempting. 12:04:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:04:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:04:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:46 INFO - (blobuploader) - INFO - Done attempting. 12:04:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:04:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:04:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:48 INFO - (blobuploader) - INFO - Done attempting. 12:04:48 INFO - (blobuploader) - INFO - Iteration through files over. 12:04:48 INFO - Return code: 0 12:04:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:04:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:04:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f31a1e9100b42442098bc6f34b4fd4ac38fef731473139f904b12f9ef60d12689371ace592157d27fa9925a8df0764c846833bd354ecc6013af60fd771d0968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bca87059c9a57f0da9b232b38592e0269b6c76452d13b80fcefe5f02d2802696018525a21c75664664568901c90f8e82b61da8f37b233fa1ab03efe9b59c8367", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e6392c40829350d19902ed519b2129301910b26fd9b7cb7855aece6820de06b4c78eaca77e0399440cffa7b6f6c10be14fbc445cfe58d0fb8f2bd26f8753c31"} 12:04:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:04:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:04:48 INFO - Contents: 12:04:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f31a1e9100b42442098bc6f34b4fd4ac38fef731473139f904b12f9ef60d12689371ace592157d27fa9925a8df0764c846833bd354ecc6013af60fd771d0968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bca87059c9a57f0da9b232b38592e0269b6c76452d13b80fcefe5f02d2802696018525a21c75664664568901c90f8e82b61da8f37b233fa1ab03efe9b59c8367", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e6392c40829350d19902ed519b2129301910b26fd9b7cb7855aece6820de06b4c78eaca77e0399440cffa7b6f6c10be14fbc445cfe58d0fb8f2bd26f8753c31"} 12:04:48 INFO - Running post-run listener: copy_logs_to_upload_dir 12:04:48 INFO - Copying logs to upload dir... 12:04:48 INFO - mkdir: /builds/slave/test/build/upload/logs 12:04:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.559214 ========= master_lag: 23.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 36 secs) (at 2016-08-29 12:05:12.390024) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-08-29 12:05:12.393491) ========= 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.Ygmr5JafzW/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.pLZCGwRh1D/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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/Firefox/sha512/7f31a1e9100b42442098bc6f34b4fd4ac38fef731473139f904b12f9ef60d12689371ace592157d27fa9925a8df0764c846833bd354ecc6013af60fd771d0968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bca87059c9a57f0da9b232b38592e0269b6c76452d13b80fcefe5f02d2802696018525a21c75664664568901c90f8e82b61da8f37b233fa1ab03efe9b59c8367", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e6392c40829350d19902ed519b2129301910b26fd9b7cb7855aece6820de06b4c78eaca77e0399440cffa7b6f6c10be14fbc445cfe58d0fb8f2bd26f8753c31"} build_url:https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011151 build_url: 'https://queue.taskcluster.net/v1/task/aswjECCyRxWc1hz98Uw6iQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f31a1e9100b42442098bc6f34b4fd4ac38fef731473139f904b12f9ef60d12689371ace592157d27fa9925a8df0764c846833bd354ecc6013af60fd771d0968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bca87059c9a57f0da9b232b38592e0269b6c76452d13b80fcefe5f02d2802696018525a21c75664664568901c90f8e82b61da8f37b233fa1ab03efe9b59c8367", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e6392c40829350d19902ed519b2129301910b26fd9b7cb7855aece6820de06b4c78eaca77e0399440cffa7b6f6c10be14fbc445cfe58d0fb8f2bd26f8753c31"}' ========= master_lag: 2.47 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-08-29 12:05:14.874068) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:05:14.874460) ========= 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.Ygmr5JafzW/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.pLZCGwRh1D/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.005601 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 12:05:14.922445) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 12:05:14.922845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 12:05:14.929512) ========= ========= Total master_lag: 26.07 =========