builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0278 starttime: 1470428232.67 results: success (0) buildid: 20160805105821 builduid: c353205a982a43e3a12ee1a3f9d90355 revision: 192132a4cbc78fa948ad1e37c204f537043fc37e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 13:17:12.673388) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 13:17:12.674424) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 13:17:12.675089) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 13:17:12.704041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 13:17:12.704798) ========= 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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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-05 13:17:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2016-08-05 13:17:12 (18.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119704 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 13:17:12.851727) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 13:17:12.852446) ========= 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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.025943 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 13:17:12.905186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 13:17:12.906045) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 192132a4cbc78fa948ad1e37c204f537043fc37e --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 192132a4cbc78fa948ad1e37c204f537043fc37e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NQ6D3VztYn/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.FzQiKW2zK0/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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-05 13:17:12,988 truncating revision to first 12 chars 2016-08-05 13:17:12,988 Setting DEBUG logging. 2016-08-05 13:17:12,988 attempt 1/10 2016-08-05 13:17:12,988 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/192132a4cbc7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 13:17:14,173 unpacking tar archive at: mozilla-central-192132a4cbc7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.473045 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 13:17:14.404663) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 13:17:14.405469) ========= script_repo_revision: 192132a4cbc78fa948ad1e37c204f537043fc37e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 13:17:14.406201) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 13:17:14.406525) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 13:17:14.422889) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-05 13:17:14.423477) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 13:17:14 INFO - MultiFileLogger online at 20160805 13:17:14 in /builds/slave/test 13:17:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:17:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:17:14 INFO - {'append_to_log': False, 13:17:14 INFO - 'base_work_dir': '/builds/slave/test', 13:17:14 INFO - 'blob_upload_branch': 'Firefox', 13:17:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:17:14 INFO - 'branch': 'Firefox', 13:17:14 INFO - 'buildbot_json_path': 'buildprops.json', 13:17:14 INFO - 'config_files': ('talos/mac_config.py',), 13:17:14 INFO - 'default_actions': ('clobber', 13:17:14 INFO - 'read-buildbot-config', 13:17:14 INFO - 'download-and-extract', 13:17:14 INFO - 'populate-webroot', 13:17:14 INFO - 'create-virtualenv', 13:17:14 INFO - 'install', 13:17:14 INFO - 'run-tests'), 13:17:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:17:14 INFO - 'download_minidump_stackwalk': True, 13:17:14 INFO - 'download_symbols': 'ondemand', 13:17:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:17:14 INFO - 'tooltool.py': '/tools/tooltool.py', 13:17:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:17:14 INFO - '/tools/misc-python/virtualenv.py')}, 13:17:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:17:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:17:14 INFO - 'installer_path': 'installer.exe', 13:17:14 INFO - 'log_level': 'info', 13:17:14 INFO - 'log_name': 'talos', 13:17:14 INFO - 'log_to_console': True, 13:17:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:17:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:17:14 INFO - 'opt_config_files': (), 13:17:14 INFO - 'pip_index': False, 13:17:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:17:14 INFO - 'cmd': ('bash', 13:17:14 INFO - '-c', 13:17:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:17:14 INFO - 'enabled': True, 13:17:14 INFO - 'halt_on_failure': False, 13:17:14 INFO - 'name': 'check_screen_resolution'},), 13:17:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:17:14 INFO - 'cmd': ('bash', 13:17:14 INFO - '-c', 13:17:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:17:14 INFO - 'enabled': True, 13:17:14 INFO - 'halt_on_failure': False, 13:17:14 INFO - 'name': 'check_screen_resolution'},), 13:17:14 INFO - 'run_cmd_checks_enabled': True, 13:17:14 INFO - 'sps_profile': False, 13:17:14 INFO - 'sps_profile_interval': 0, 13:17:14 INFO - 'suite': 'dromaeojs', 13:17:14 INFO - 'system_bits': '32', 13:17:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:17:14 INFO - 'title': 't-yosemite-r7-0278', 13:17:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:17:14 INFO - 'use_talos_json': True, 13:17:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:17:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:17:14 INFO - 'work_dir': 'build'} 13:17:14 INFO - [mozharness: 2016-08-05 20:17:14.621293Z] Running clobber step. 13:17:14 INFO - Running pre-action listener: _resource_record_pre_action 13:17:14 INFO - Running main action method: clobber 13:17:14 INFO - rmtree: /builds/slave/test/build 13:17:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:17:16 INFO - Running post-action listener: _resource_record_post_action 13:17:16 INFO - [mozharness: 2016-08-05 20:17:16.549448Z] Finished clobber step (success) 13:17:16 INFO - [mozharness: 2016-08-05 20:17:16.549579Z] Running read-buildbot-config step. 13:17:16 INFO - Running pre-action listener: _resource_record_pre_action 13:17:16 INFO - Running main action method: read_buildbot_config 13:17:16 INFO - Using buildbot properties: 13:17:16 INFO - { 13:17:16 INFO - "project": "", 13:17:16 INFO - "product": "firefox", 13:17:16 INFO - "script_repo_revision": "production", 13:17:16 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 13:17:16 INFO - "repository": "", 13:17:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 13:17:16 INFO - "buildid": "20160805105821", 13:17:16 INFO - "pgo_build": "False", 13:17:16 INFO - "basedir": "/builds/slave/test", 13:17:16 INFO - "buildnumber": 33, 13:17:16 INFO - "slavename": "t-yosemite-r7-0278", 13:17:16 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:17:16 INFO - "platform": "yosemite_r7", 13:17:16 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:17:16 INFO - "branch": "mozilla-central", 13:17:16 INFO - "repo_path": "mozilla-central", 13:17:16 INFO - "revision": "192132a4cbc78fa948ad1e37c204f537043fc37e", 13:17:16 INFO - "stage_platform": "macosx64", 13:17:16 INFO - "builduid": "c353205a982a43e3a12ee1a3f9d90355", 13:17:16 INFO - "slavebuilddir": "test" 13:17:16 INFO - } 13:17:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 13:17:16 INFO - Running post-action listener: _resource_record_post_action 13:17:16 INFO - [mozharness: 2016-08-05 20:17:16.553018Z] Finished read-buildbot-config step (success) 13:17:16 INFO - [mozharness: 2016-08-05 20:17:16.553163Z] Running download-and-extract step. 13:17:16 INFO - Running pre-action listener: _resource_record_pre_action 13:17:16 INFO - Running main action method: download_and_extract 13:17:16 INFO - mkdir: /builds/slave/test/build/tests 13:17: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')]} 13:17:16 INFO - trying https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 13:17:16 INFO - Downloading https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/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 13:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/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 13:17:17 INFO - Downloaded 1199 bytes. 13:17:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 13:17:17 INFO - Using the following test package requirements: 13:17:17 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:17:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:17:17 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 13:17:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:17:17 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 13:17:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:17:17 INFO - u'jsshell-mac.zip'], 13:17:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:17:17 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 13:17:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:17:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:17:17 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 13:17:17 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:17:17 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 13:17:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:17:17 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 13:17:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:17:17 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 13:17:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:17:17 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')]} 13:17:17 INFO - trying https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:17:17 INFO - Downloading https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/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 13:17:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/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 13:17:18 INFO - Downloaded 16320546 bytes. 13:17:18 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:17:25 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 13:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:25 INFO - trying https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:17:25 INFO - Downloading https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/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 13:17:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/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 13:17:26 INFO - Downloaded 16320546 bytes. 13:17:26 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:33 INFO - trying https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 13:17:33 INFO - Downloading https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/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 13:17:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/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 13:17:34 INFO - Downloaded 14413723 bytes. 13:17:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 13:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:35 INFO - trying https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:17:35 INFO - Downloading https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 13:17:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/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 13:17:38 INFO - Downloaded 111441249 bytes. 13:17:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:17:38 INFO - mkdir: /builds/slave/test/properties 13:17:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:17:38 INFO - Writing to file /builds/slave/test/properties/build_url 13:17:38 INFO - Contents: 13:17:38 INFO - build_url:https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:17:39 INFO - Running post-action listener: _resource_record_post_action 13:17:39 INFO - Running post-action listener: set_extra_try_arguments 13:17:39 INFO - [mozharness: 2016-08-05 20:17:39.100912Z] Finished download-and-extract step (success) 13:17:39 INFO - [mozharness: 2016-08-05 20:17:39.101046Z] Running populate-webroot step. 13:17:39 INFO - Running pre-action listener: _resource_record_pre_action 13:17:39 INFO - Running main action method: populate_webroot 13:17:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:17:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:17:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:17:39 INFO - '--tppagecycles', 13:17:39 INFO - '7'], 13:17:39 INFO - 'tests': ['tsvgm']}}, 13:17:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:17:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:17:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:17:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:17:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:17:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:17:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:39 INFO - 'talos_options': ['--disable-e10s'], 13:17:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:39 INFO - 'talos_options': ['--disable-e10s'], 13:17:39 INFO - 'tests': ['damp', 'tps']}, 13:17:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:39 INFO - 'tests': ['damp', 'tps']}, 13:17:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:17:39 INFO - 'tests': ['dromaeo_dom']}, 13:17:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:17:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:17:39 INFO - 'tests': ['basic_compositor_video']}, 13:17:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:17:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:17:39 INFO - 'tests': ['a11yr', 13:17:39 INFO - 'ts_paint', 13:17:39 INFO - 'tpaint', 13:17:39 INFO - 'sessionrestore', 13:17:39 INFO - 'sessionrestore_no_auto_restore', 13:17:39 INFO - 'tabpaint']}, 13:17:39 INFO - 'other-e10s': {'tests': ['a11yr', 13:17:39 INFO - 'ts_paint', 13:17:39 INFO - 'tpaint', 13:17:39 INFO - 'sessionrestore', 13:17:39 INFO - 'sessionrestore_no_auto_restore', 13:17:39 INFO - 'tabpaint']}, 13:17:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:17:39 INFO - 'ts_paint', 13:17:39 INFO - 'tpaint', 13:17:39 INFO - 'sessionrestore', 13:17:39 INFO - 'sessionrestore_no_auto_restore', 13:17:39 INFO - 'tabpaint']}, 13:17:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:17:39 INFO - 'ts_paint', 13:17:39 INFO - 'tpaint', 13:17:39 INFO - 'sessionrestore', 13:17:39 INFO - 'sessionrestore_no_auto_restore', 13:17:39 INFO - 'tabpaint']}, 13:17:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:17:39 INFO - 'tests': ['a11yr', 13:17:39 INFO - 'ts_paint', 13:17:39 INFO - 'tpaint', 13:17:39 INFO - 'sessionrestore', 13:17:39 INFO - 'sessionrestore_no_auto_restore', 13:17:39 INFO - 'tabpaint']}, 13:17:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:17:39 INFO - 'tests': ['a11yr', 13:17:39 INFO - 'ts_paint', 13:17:39 INFO - 'tpaint', 13:17:39 INFO - 'sessionrestore', 13:17:39 INFO - 'sessionrestore_no_auto_restore', 13:17:39 INFO - 'tabpaint']}, 13:17:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:17:39 INFO - 'tests': ['tsvgx', 13:17:39 INFO - 'tsvgr_opacity', 13:17:39 INFO - 'tart', 13:17:39 INFO - 'tscrollx', 13:17:39 INFO - 'cart']}, 13:17:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:17:39 INFO - 'tsvgr_opacity', 13:17:39 INFO - 'tart', 13:17:39 INFO - 'tscrollx', 13:17:39 INFO - 'cart']}, 13:17:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:39 INFO - 'talos_options': ['--disable-e10s'], 13:17:39 INFO - 'tests': ['tp5o']}, 13:17:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:39 INFO - 'tests': ['tp5o']}, 13:17:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:39 INFO - 'talos_options': ['--disable-e10s', 13:17:39 INFO - '--xperf_path', 13:17:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:39 INFO - 'tests': ['tp5n']}, 13:17:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:39 INFO - 'talos_options': ['--xperf_path', 13:17:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:39 INFO - 'tests': ['tp5n']}}, 13:17:39 INFO - 'talos.zip': {'path': '', 13:17:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:17:39 INFO - Running post-action listener: _resource_record_post_action 13:17:39 INFO - [mozharness: 2016-08-05 20:17:39.119859Z] Finished populate-webroot step (success) 13:17:39 INFO - [mozharness: 2016-08-05 20:17:39.119994Z] Running create-virtualenv step. 13:17:39 INFO - Running pre-action listener: _resource_record_pre_action 13:17:39 INFO - Running main action method: create_virtualenv 13:17:39 INFO - Creating virtualenv /builds/slave/test/build/venv 13:17:39 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 13:17:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:17:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:17:39 INFO - Using real prefix '/tools/python27' 13:17:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:17:39 INFO - Installing distribute.............................................................................................................................................................................................done. 13:17:42 INFO - Installing pip.................done. 13:17:42 INFO - Return code: 0 13:17:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d942a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac59470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a6d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89eb20>, '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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 13:17:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:17:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NQ6D3VztYn/Render', 13:17:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:42 INFO - 'HOME': '/Users/cltbld', 13:17:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:42 INFO - 'LOGNAME': 'cltbld', 13:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:42 INFO - 'MOZ_NO_REMOTE': '1', 13:17:42 INFO - 'NO_EM_RESTART': '1', 13:17:42 INFO - 'PAGER': '/bin/cat', 13:17:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:42 INFO - 'PWD': '/builds/slave/test', 13:17:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:42 INFO - 'SHELL': '/bin/bash', 13:17:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FzQiKW2zK0/Listeners', 13:17:42 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:17:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:42 INFO - 'USER': 'cltbld', 13:17:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:42 INFO - 'XPC_FLAGS': '0x0', 13:17:42 INFO - 'XPC_SERVICE_NAME': '0', 13:17:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:43 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 13:17:43 INFO - Cleaning up... 13:17:43 INFO - Return code: 0 13:17:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d942a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac59470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a6d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89eb20>, '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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 13:17:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NQ6D3VztYn/Render', 13:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:43 INFO - 'HOME': '/Users/cltbld', 13:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:43 INFO - 'LOGNAME': 'cltbld', 13:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:43 INFO - 'MOZ_NO_REMOTE': '1', 13:17:43 INFO - 'NO_EM_RESTART': '1', 13:17:43 INFO - 'PAGER': '/bin/cat', 13:17:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:43 INFO - 'PWD': '/builds/slave/test', 13:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:43 INFO - 'SHELL': '/bin/bash', 13:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FzQiKW2zK0/Listeners', 13:17:43 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:43 INFO - 'USER': 'cltbld', 13:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:43 INFO - 'XPC_FLAGS': '0x0', 13:17:43 INFO - 'XPC_SERVICE_NAME': '0', 13:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:43 INFO - Downloading/unpacking psutil>=3.1.1 13:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:17:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:45 INFO - Installing collected packages: psutil 13:17:45 INFO - Running setup.py install for psutil 13:17:46 INFO - building 'psutil._psutil_osx' extension 13:17:46 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 13:17:46 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 13:17:46 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 13:17:46 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 13:17:46 INFO - building 'psutil._psutil_posix' extension 13:17:46 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 13:17:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:17:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:17:46 INFO - ^ 13:17:46 INFO - 1 warning generated. 13:17:46 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 13:17:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:47 INFO - Successfully installed psutil 13:17:47 INFO - Cleaning up... 13:17:47 INFO - Return code: 0 13:17:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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')]} 13:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:47 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 0x10d942a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac59470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a6d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89eb20>, '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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 13:17:47 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 13:17:47 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 13:17:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NQ6D3VztYn/Render', 13:17:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:47 INFO - 'HOME': '/Users/cltbld', 13:17:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:47 INFO - 'LOGNAME': 'cltbld', 13:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:47 INFO - 'MOZ_NO_REMOTE': '1', 13:17:47 INFO - 'NO_EM_RESTART': '1', 13:17:47 INFO - 'PAGER': '/bin/cat', 13:17:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:47 INFO - 'PWD': '/builds/slave/test', 13:17:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:47 INFO - 'SHELL': '/bin/bash', 13:17:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FzQiKW2zK0/Listeners', 13:17:47 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:17:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:47 INFO - 'USER': 'cltbld', 13:17:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:47 INFO - 'XPC_FLAGS': '0x0', 13:17:47 INFO - 'XPC_SERVICE_NAME': '0', 13:17:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:17:49 INFO - Installing collected packages: mozsystemmonitor 13:17:49 INFO - Running setup.py install for mozsystemmonitor 13:17:50 INFO - Successfully installed mozsystemmonitor 13:17:50 INFO - Cleaning up... 13:17:50 INFO - Return code: 0 13:17:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:17:50 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')]} 13:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:50 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')]} 13:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:50 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 0x10d942a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac59470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a6d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89eb20>, '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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 13:17:50 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 13:17:50 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 13:17:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NQ6D3VztYn/Render', 13:17:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:50 INFO - 'HOME': '/Users/cltbld', 13:17:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:50 INFO - 'LOGNAME': 'cltbld', 13:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:50 INFO - 'MOZ_NO_REMOTE': '1', 13:17:50 INFO - 'NO_EM_RESTART': '1', 13:17:50 INFO - 'PAGER': '/bin/cat', 13:17:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:50 INFO - 'PWD': '/builds/slave/test', 13:17:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:50 INFO - 'SHELL': '/bin/bash', 13:17:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FzQiKW2zK0/Listeners', 13:17:50 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:17:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:50 INFO - 'USER': 'cltbld', 13:17:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:50 INFO - 'XPC_FLAGS': '0x0', 13:17:50 INFO - 'XPC_SERVICE_NAME': '0', 13:17:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:50 INFO - Downloading/unpacking jsonschema==2.5.1 13:17:50 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 13:17:50 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 13:17:50 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 13:17:50 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 13:17:50 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 13:17:50 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 13:17:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:17:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:53 INFO - Downloading functools32-3.2.3-2.tar.gz 13:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:17:53 INFO - warning: no files found matching '*.txt' 13:17:53 INFO - no previously-included directories found matching 'build' 13:17:53 INFO - no previously-included directories found matching 'dist' 13:17:53 INFO - no previously-included directories found matching '.git*' 13:17:53 INFO - Installing collected packages: jsonschema, functools32 13:17:53 INFO - Running setup.py install for functools32 13:17:53 INFO - warning: no files found matching '*.txt' 13:17:53 INFO - no previously-included directories found matching 'build' 13:17:53 INFO - no previously-included directories found matching 'dist' 13:17:53 INFO - no previously-included directories found matching '.git*' 13:17:53 INFO - Successfully installed jsonschema functools32 13:17:53 INFO - Cleaning up... 13:17:53 INFO - Return code: 0 13:17:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d942a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac59470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a6d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89eb20>, '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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 13:17:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:17:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:17:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NQ6D3VztYn/Render', 13:17:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:53 INFO - 'HOME': '/Users/cltbld', 13:17:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:53 INFO - 'LOGNAME': 'cltbld', 13:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:53 INFO - 'MOZ_NO_REMOTE': '1', 13:17:53 INFO - 'NO_EM_RESTART': '1', 13:17:53 INFO - 'PAGER': '/bin/cat', 13:17:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:53 INFO - 'PWD': '/builds/slave/test', 13:17:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:53 INFO - 'SHELL': '/bin/bash', 13:17:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FzQiKW2zK0/Listeners', 13:17:53 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:17:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:53 INFO - 'USER': 'cltbld', 13:17:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:53 INFO - 'XPC_FLAGS': '0x0', 13:17:53 INFO - 'XPC_SERVICE_NAME': '0', 13:17:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:17:53 INFO - Cleaning up... 13:17:53 INFO - Return code: 0 13:17:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d942a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac59470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a6d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89eb20>, '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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 13:17:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:17:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:17:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NQ6D3VztYn/Render', 13:17:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:53 INFO - 'HOME': '/Users/cltbld', 13:17:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:53 INFO - 'LOGNAME': 'cltbld', 13:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:53 INFO - 'MOZ_NO_REMOTE': '1', 13:17:53 INFO - 'NO_EM_RESTART': '1', 13:17:53 INFO - 'PAGER': '/bin/cat', 13:17:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:53 INFO - 'PWD': '/builds/slave/test', 13:17:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:53 INFO - 'SHELL': '/bin/bash', 13:17:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FzQiKW2zK0/Listeners', 13:17:53 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:17:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:53 INFO - 'USER': 'cltbld', 13:17:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:53 INFO - 'XPC_FLAGS': '0x0', 13:17:53 INFO - 'XPC_SERVICE_NAME': '0', 13:17:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:54 INFO - Downloading/unpacking blobuploader==1.2.4 13:17:54 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 13:17:54 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 13:17:54 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 13:17:54 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 13:17:54 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 13:17:54 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 13:17:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:17:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:17:56 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 13:17:56 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 13:17:56 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 13:17:56 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 13:17:56 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 13:17:56 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 13:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:17:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:57 INFO - Downloading docopt-0.6.1.tar.gz 13:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:17:57 INFO - Installing collected packages: blobuploader, requests, docopt 13:17:57 INFO - Running setup.py install for blobuploader 13:17:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:17:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:17:58 INFO - Running setup.py install for requests 13:17:58 INFO - Running setup.py install for docopt 13:17:58 INFO - Successfully installed blobuploader requests docopt 13:17:58 INFO - Cleaning up... 13:17:58 INFO - Return code: 0 13:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:58 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 0x10d942a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac59470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a6d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89eb20>, '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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 13:17:58 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 13:17:58 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 13:17:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NQ6D3VztYn/Render', 13:17:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:58 INFO - 'HOME': '/Users/cltbld', 13:17:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:58 INFO - 'LOGNAME': 'cltbld', 13:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:58 INFO - 'MOZ_NO_REMOTE': '1', 13:17:58 INFO - 'NO_EM_RESTART': '1', 13:17:58 INFO - 'PAGER': '/bin/cat', 13:17:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:58 INFO - 'PWD': '/builds/slave/test', 13:17:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:58 INFO - 'SHELL': '/bin/bash', 13:17:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FzQiKW2zK0/Listeners', 13:17:58 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:17:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:58 INFO - 'USER': 'cltbld', 13:17:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:58 INFO - 'XPC_FLAGS': '0x0', 13:17:58 INFO - 'XPC_SERVICE_NAME': '0', 13:17:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:59 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-tvYlLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:59 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-3t2Gpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:59 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-tfGjhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:59 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-7E9uOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:59 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-gReF3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:59 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-B4aFpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:59 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-kqpNVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:59 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-VIZolh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:59 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-rielVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:18:00 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-4CGxRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:18:00 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-N3U5WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:18:00 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-gA1ez6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:18:00 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-5DaV3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:18:00 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Mr9QAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:00 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-OPQeAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:18:00 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-_vLsND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:18:00 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-TCkSnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:18:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:18:00 INFO - Running setup.py install for manifestparser 13:18:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:18:01 INFO - Running setup.py install for mozcrash 13:18:01 INFO - Running setup.py install for mozdebug 13:18:01 INFO - Running setup.py install for mozdevice 13:18:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:18:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:18:01 INFO - Running setup.py install for mozfile 13:18:01 INFO - Running setup.py install for mozhttpd 13:18:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:18:01 INFO - Running setup.py install for mozinfo 13:18:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:18:01 INFO - Running setup.py install for mozInstall 13:18:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:18:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:18:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:18:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:18:02 INFO - Running setup.py install for mozleak 13:18:02 INFO - Running setup.py install for mozlog 13:18:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:18:02 INFO - Running setup.py install for moznetwork 13:18:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:18:02 INFO - Running setup.py install for mozprocess 13:18:02 INFO - Running setup.py install for mozprofile 13:18:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:18:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:18:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:18:02 INFO - Running setup.py install for mozrunner 13:18:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:18:02 INFO - Running setup.py install for mozscreenshot 13:18:03 INFO - Running setup.py install for moztest 13:18:03 INFO - Running setup.py install for mozversion 13:18:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:18:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:18:03 INFO - Cleaning up... 13:18:03 INFO - Return code: 0 13:18:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:03 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 0x10d942a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac59470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a6d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89eb20>, '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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 13:18:03 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 13:18:03 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 13:18:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NQ6D3VztYn/Render', 13:18:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:03 INFO - 'HOME': '/Users/cltbld', 13:18:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:03 INFO - 'LOGNAME': 'cltbld', 13:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:03 INFO - 'MOZ_NO_REMOTE': '1', 13:18:03 INFO - 'NO_EM_RESTART': '1', 13:18:03 INFO - 'PAGER': '/bin/cat', 13:18:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:03 INFO - 'PWD': '/builds/slave/test', 13:18:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:03 INFO - 'SHELL': '/bin/bash', 13:18:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FzQiKW2zK0/Listeners', 13:18:03 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:18:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:03 INFO - 'USER': 'cltbld', 13:18:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:03 INFO - 'XPC_FLAGS': '0x0', 13:18:03 INFO - 'XPC_SERVICE_NAME': '0', 13:18:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:18:03 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-DoSoGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:18:03 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)) 13:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:18:03 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-JtcCmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:18:03 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)) 13:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:18:03 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-iu1ZVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:18:04 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)) 13:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:18:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-ik7Bln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:18:04 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)) 13:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:18:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-XUeUHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:18:04 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)) 13:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:18:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Q2aeVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:18:04 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)) 13:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:18:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Pl_bZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:18:04 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)) 13:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:18:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Itzu2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:18:04 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)) 13:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:18:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-BkCX8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:18:04 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)) 13:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:18:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-iNK0dB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:18:04 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)) 13:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:18:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-8LpA4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:18:04 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)) 13:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:18:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-L6h6wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:18:05 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)) 13:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:18:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Sf5x2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:18:05 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)) 13:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:18:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-ySyIFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:18:05 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)) 13:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-MaZz32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:05 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)) 13:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:18:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-QzWzP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:18:05 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)) 13:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:18:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-nnXc0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:18:05 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)) 13:18:05 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)) 13:18:05 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)) 13:18:05 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)) 13:18:05 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)) 13:18:05 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)) 13:18:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18:08 INFO - Downloading blessings-1.6.tar.gz 13:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:18:08 INFO - Installing collected packages: blessings 13:18:08 INFO - Running setup.py install for blessings 13:18:08 INFO - Successfully installed blessings 13:18:08 INFO - Cleaning up... 13:18:08 INFO - Return code: 0 13:18:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:18:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:18:08 INFO - Reading from file tmpfile_stdout 13:18:08 INFO - Current package versions: 13:18:08 INFO - blessings == 1.6 13:18:08 INFO - blobuploader == 1.2.4 13:18:08 INFO - docopt == 0.6.1 13:18:08 INFO - functools32 == 3.2.3-2 13:18:08 INFO - jsonschema == 2.5.1 13:18:08 INFO - manifestparser == 1.1 13:18:08 INFO - mozInstall == 1.12 13:18:08 INFO - mozcrash == 0.17 13:18:08 INFO - mozdebug == 0.1 13:18:08 INFO - mozdevice == 0.48 13:18:08 INFO - mozfile == 1.2 13:18:08 INFO - mozhttpd == 0.7 13:18:08 INFO - mozinfo == 0.9 13:18:08 INFO - mozleak == 0.1 13:18:08 INFO - mozlog == 3.3 13:18:08 INFO - moznetwork == 0.27 13:18:08 INFO - mozprocess == 0.23 13:18:08 INFO - mozprofile == 0.28 13:18:08 INFO - mozrunner == 6.12 13:18:08 INFO - mozscreenshot == 0.1 13:18:08 INFO - mozsystemmonitor == 0.3 13:18:08 INFO - moztest == 0.7 13:18:08 INFO - mozversion == 1.4 13:18:08 INFO - psutil == 3.1.1 13:18:08 INFO - requests == 1.2.3 13:18:08 INFO - wsgiref == 0.1.2 13:18:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:08 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 0x10d942a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac59470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a6d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89eb20>, '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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 13:18:08 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 13:18:08 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 13:18:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NQ6D3VztYn/Render', 13:18:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:08 INFO - 'HOME': '/Users/cltbld', 13:18:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:08 INFO - 'LOGNAME': 'cltbld', 13:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:08 INFO - 'MOZ_NO_REMOTE': '1', 13:18:08 INFO - 'NO_EM_RESTART': '1', 13:18:08 INFO - 'PAGER': '/bin/cat', 13:18:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:08 INFO - 'PWD': '/builds/slave/test', 13:18:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:08 INFO - 'SHELL': '/bin/bash', 13:18:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FzQiKW2zK0/Listeners', 13:18:08 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:18:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:08 INFO - 'USER': 'cltbld', 13:18:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:08 INFO - 'XPC_FLAGS': '0x0', 13:18:08 INFO - 'XPC_SERVICE_NAME': '0', 13:18:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:08 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)) 13:18:08 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)) 13:18:08 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)) 13:18:08 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)) 13:18:08 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)) 13:18:08 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)) 13:18:08 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)) 13:18:08 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)) 13:18:08 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)) 13:18:08 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)) 13:18:08 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)) 13:18:08 INFO - Cleaning up... 13:18:08 INFO - Return code: 0 13:18:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18: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')]} 13:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d942a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9d7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac59470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a6d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89eb20>, '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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 13:18: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', 'jsonschema'] in /builds/slave/test/build 13:18: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 jsonschema 13:18:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NQ6D3VztYn/Render', 13:18:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:09 INFO - 'HOME': '/Users/cltbld', 13:18:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:09 INFO - 'LOGNAME': 'cltbld', 13:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:09 INFO - 'MOZ_NO_REMOTE': '1', 13:18:09 INFO - 'NO_EM_RESTART': '1', 13:18:09 INFO - 'PAGER': '/bin/cat', 13:18:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:09 INFO - 'PWD': '/builds/slave/test', 13:18:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:09 INFO - 'SHELL': '/bin/bash', 13:18:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FzQiKW2zK0/Listeners', 13:18:09 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:18:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:09 INFO - 'USER': 'cltbld', 13:18:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:09 INFO - 'XPC_FLAGS': '0x0', 13:18:09 INFO - 'XPC_SERVICE_NAME': '0', 13:18:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:18:09 INFO - Cleaning up... 13:18:09 INFO - Return code: 0 13:18:09 INFO - Running post-action listener: _resource_record_post_action 13:18:09 INFO - Running post-action listener: _start_resource_monitoring 13:18:09 INFO - Starting resource monitoring. 13:18:09 INFO - [mozharness: 2016-08-05 20:18:09.636352Z] Finished create-virtualenv step (success) 13:18:09 INFO - [mozharness: 2016-08-05 20:18:09.637338Z] Running install step. 13:18:09 INFO - Running pre-action listener: _resource_record_pre_action 13:18:09 INFO - Running main action method: install 13:18:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:18:09 INFO - Reading from file tmpfile_stdout 13:18:09 INFO - Detecting whether we're running mozinstall >=1.0... 13:18:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:18:09 INFO - Reading from file tmpfile_stdout 13:18:09 INFO - Output received: 13:18:09 INFO - Usage: mozinstall [options] installer 13:18:09 INFO - Options: 13:18:09 INFO - -h, --help show this help message and exit 13:18:09 INFO - -d DEST, --destination=DEST 13:18:09 INFO - Directory to install application into. [default: 13:18:09 INFO - "/builds/slave/test"] 13:18:09 INFO - --app=APP Application being installed. [default: firefox] 13:18:09 INFO - mkdir: /builds/slave/test/build/application 13:18:09 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'] 13:18:09 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 13:18:43 INFO - Reading from file tmpfile_stdout 13:18:43 INFO - Output received: 13:18:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:18:43 INFO - Running post-action listener: _resource_record_post_action 13:18:43 INFO - [mozharness: 2016-08-05 20:18:43.937204Z] Finished install step (success) 13:18:43 INFO - [mozharness: 2016-08-05 20:18:43.937384Z] Running run-tests step. 13:18:43 INFO - Running pre-action listener: _resource_record_pre_action 13:18:43 INFO - Running main action method: run_tests 13:18:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:18:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:18:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:18:43 INFO - 2016-08-05 13:18:43.951 screenresolution[1655:7529] starting screenresolution argv=screenresolution get 13:18:43 INFO - 2016-08-05 13:18:43.954 screenresolution[1655:7529] Display 0: 1600x1200x32@60 13:18:43 INFO - 2016-08-05 13:18:43.960 screenresolution[1656:7531] starting screenresolution argv=screenresolution list 13:18:43 INFO - Available Modes on Display 0 13:18:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:18:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:18:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:18:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:18:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:18:44 INFO - Intel Iris: 13:18:44 INFO - Chipset Model: Intel Iris 13:18:44 INFO - Type: GPU 13:18:44 INFO - Bus: Built-In 13:18:44 INFO - VRAM (Dynamic, Max): 1536 MB 13:18:44 INFO - Vendor: Intel (0x8086) 13:18:44 INFO - Device ID: 0x0a2e 13:18:44 INFO - Revision ID: 0x0009 13:18:44 INFO - Displays: 13:18:44 INFO - Display: 13:18:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:18:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:18:44 INFO - Display Serial Number: 1600x1200 60 13:18:44 INFO - Main Display: Yes 13:18:44 INFO - Mirror: Off 13:18:44 INFO - Online: Yes 13:18:44 INFO - Rotation: Supported 13:18:44 INFO - Return code: 0 13:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:18:44 INFO - Python 2.7.3 13:18:44 INFO - Return code: 0 13:18:44 INFO - grabbing minidump binary from tooltool 13:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:44 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 0x10d8a6d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:18:44 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 13:18:44 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 13:18:44 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 13:18:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:18:44 INFO - Return code: 0 13:18:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:18:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:18:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:18:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:18:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0278 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:18:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NQ6D3VztYn/Render', 13:18:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:44 INFO - 'HOME': '/Users/cltbld', 13:18:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:44 INFO - 'LOGNAME': 'cltbld', 13:18:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:18:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:44 INFO - 'MOZ_NO_REMOTE': '1', 13:18:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:18:44 INFO - 'NO_EM_RESTART': '1', 13:18:44 INFO - 'PAGER': '/bin/cat', 13:18:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:44 INFO - 'PWD': '/builds/slave/test', 13:18:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:18:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:44 INFO - 'SHELL': '/bin/bash', 13:18:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FzQiKW2zK0/Listeners', 13:18:44 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 13:18:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:44 INFO - 'USER': 'cltbld', 13:18:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:44 INFO - 'XPC_FLAGS': '0x0', 13:18:44 INFO - 'XPC_SERVICE_NAME': '0', 13:18:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:18:44 INFO - mozversion application_buildid: 20160805105821 13:18:44 INFO - mozversion application_changeset: 192132a4cbc78fa948ad1e37c204f537043fc37e 13:18:44 INFO - mozversion application_display_name: Nightly 13:18:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:18:44 INFO - mozversion application_name: Firefox 13:18:44 INFO - mozversion application_remotingname: firefox 13:18:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:18:44 INFO - mozversion application_vendor: Mozilla 13:18:44 INFO - mozversion application_version: 51.0a1 13:18:44 INFO - mozversion platform_buildid: 20160805105821 13:18:44 INFO - mozversion platform_changeset: 192132a4cbc78fa948ad1e37c204f537043fc37e 13:18:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:18:44 INFO - mozversion platform_version: 51.0a1 13:18:44 INFO - using testdate: 1470428324 13:18:44 INFO - actual date: 1470428324 13:18:44 INFO - starting webserver on 'localhost:49271' 13:18:44 INFO - SUITE-START | Running 2 tests 13:18:44 INFO - TEST-START | dromaeo_css 13:18:44 INFO - operating with platform_type : mac_ 13:18:44 INFO - Initialising browser for dromaeo_css test... 13:18:44 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpFcHhe3/profile http://localhost:49271/getInfo.html) 13:18:46 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 13:18:46 INFO - PROCESS | 1666 | colorDepth:24 13:18:46 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 13:18:46 INFO - PROCESS | 1666 | __metrics 13:18:47 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:18:47 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:18:47 INFO - TEST-INFO | 1666: exit 0 13:18:47 INFO - Browser initialized. 13:18:47 INFO - Running cycle 1/1 for dromaeo_css test... 13:18:47 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpFcHhe3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:59 INFO - PROCESS | 1668 | RSS: Main: 243408896 13:18:59 INFO - PROCESS | 1668 | 13:19:51 INFO - PROCESS | 1668 | 1470428391612 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] 13:22:03 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 13:22:05 INFO - PROCESS | 1668 | RSS: Main: 368578560 13:22:05 INFO - PROCESS | 1668 | 13:25:07 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 13:25:08 INFO - PROCESS | 1668 | RSS: Main: 399548416 13:25:08 INFO - PROCESS | 1668 | 13:28:11 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 13:28:11 INFO - PROCESS | 1668 | RSS: Main: 359157760 13:28:11 INFO - PROCESS | 1668 | 13:31:14 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 13:31:14 INFO - PROCESS | 1668 | RSS: Main: 367730688 13:31:14 INFO - PROCESS | 1668 | 13:34:17 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 13:34:18 INFO - PROCESS | 1668 | RSS: Main: 354881536 13:34:18 INFO - PROCESS | 1668 | 13:37:21 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 13:37:22 INFO - PROCESS | 1668 | RSS: Main: 394887168 13:37:22 INFO - PROCESS | 1668 | 13:37:22 INFO - PROCESS | 1668 | __start_tp_report 13:37:22 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 13:37:22 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 13:37:22 INFO - PROCESS | 1668 | |i|pagename|runs| 13:37:22 INFO - PROCESS | 1668 | |0;dojo.html;3184.394964956658;3360.6135294441146;3362.394768941591;3395.7792743471655;3426.3318652862686;5585.218069470277;5611.102223644218;5691.630044047134;5699.772009119641;5704.1443783432505;4592.517785632511;4773.641976851733;5576.107822748361;5662.688552129631;5760.049591817345;5152.484751524846;5204;5205.245239440279;5219.086659834533;5297.814576489824;5178.8705282368055;5233.8953220935555;5357.866053348658;5362.1420572708375;5375.381831089416;5298.761555730001;5311.468853114697;5334.27987221724;5341.385740639818;5356.330458692663;5163.7159956202395;5193;5270;5277.287566178555;5297.417284098746;5167.018266529348;5207.323048003773;5216.087184742692;5217.634765566412;5218.243354713545;5717.8570535736935;5718.714064296769;5725.713714314267;5731.942680573225;5740.425957404268;5023.271625614266;6191.473724733403;6215.409536094064;6219.564630475868;6220.222472190976;6225.284092329395;6237.6257424554215;6268.561200715952;6323.810285691437;6324.430801227865;5783;5802.1296805479515;5832.825015249549;5850.912236316459;5852.590318677651;6264.060390941395;6278.560500764994;6294.527910406738;6314.147590075281;6329.873402531924;6203.16257305258;6210.161628180138;6220.720067596969;6225.750969961241;6228.844278893064;6304.211973503312;6310.495160387158;6320.304766475684;6326.5255105867245;6338.936610633927;4678.508756580578;5996.850078747979;6112.9680474315155;6200.81397558074;6234.2830574483605;6075.027995520695;6082.9695851520455;6090.208272924491;6095.8476038098515;6141.109539116893;4843.491433399513;4855.587275081658;4864.610831133501;4875.024995001014;4905.190643543847;4368.4321038264825;4383.189110014658;4385.539518350527;4392.846250381222;4476.776161191928;5666;5690.4025077367105;5706.71466426677;5710.5146062585145;5714.285714285715;5382.730863456812;6109.175261339662;6240.469560087444;6269.467095296951;6274.215723034621;5742.942570574241;5750.856228594319;5751.338596061507;5768.394318596571;5790.247267855152;5395.001924643953;5438.184272359178;5440.211169380417;5448.972755136199;5453.536449401766;5303.946960530499;6268.153799237045;6272.341404152498;6382.32985536512;6427.871442571122;6256.0303153011355;6270.184875966095;6277.2153480814895;6302.527310451643;6305.5901366411035;6298.905516417166;6315.90526142099;6329.7151628175925;6332.746690132343;6359.872802544016;6067.120267561268;6138.51101655979;6149.72326245329;6185.907211391923;6220.253569571681;6291.402316779899;6325.77859774924;6328.9050664240995;6335.049742538656;6342.112104305309;5973.970130149321;6133.141360209664;6134.834381467507;6152.661603611844;6153.046277826944;5909.674967876808;6044.365341639241;6086.60437071589;6134.4172303631085;6136.5090792737365;5840.094785308284;5893.057110862242;5978.880422391441;6020.759169633166;6033.9698301508215;5352.84913743547;5514.80698175562;6111;6131.63210207389;6178.073289006685;5810.854728631818;5873.4126587340925;5906.468417842415;5951.137085122719;5968.880622387441 13:37:22 INFO - PROCESS | 1668 | |1;ext.html;484.15514926453335;501.79928028788504;518.9802038993378;541.4287926237818;543.4293991309127;30042.399152016947;39294.659953903916;40310.193796124135;40789.79605101974;43305.35041974373;42091.368629470584;42460.57539424605;42461.78769106158;42530.574694253046;42726.93182670427;9705.272104592148;9893.961134080926;9894.455804930725;9895.158911492532;9908.752281192956;9692.46691431971;9802.5588848502;9815.50922453878;9815.90184098157;9829.262805289633;9798.951005244964;9805.705828825146;9841.458719770446;9867.309288349818;9868.309218354718;9775.413475191475;9792.314537982344;9820.4107753535;9827.557759900821;9830.55762490686;9708.660196893075;9792.657256996043;9793.608255669764;9794.461304628243;9835.262355323379;39962;40234;40270.59729402727;40347;40389.79805100985;3315.469524876008;3378.814165220912;3414.095264754842;3498.5801703795705;3836.3478208704587;30736.846315768278;30962.53556196659;31507.909946001513;31511.212219694462;31980.680193198004;3136.7069037283572;3210.614726232867;3222.540830320409;3242.7567932405163;3313.204830840605;517186;517809;518306;518426.407867962;519589;55721;56182.43817561854;56254.71872640692;56295;56313.71843140758;50075;59105.40894591085;59703;59751;59865;15680.529584112495;16294.185290735415;16415.753763693556;16761.83238167627;16802.747958780627;10654.360738355723;12558.686032849251;12692.80960785589;12726.745465090646;12727;18748.906255468635;18806.153723082494;18809.717854232196;18824;18933.81066189348;7859.842803143905;7944.443888927835;7969.681212751541;8013.719519816778;8028.397870159762;863.8272345530919;899.869518919753;952.1908374089147;997.3866072365588;1066.2056767708107;26110;29108.7089129106;29935;30013.699863001526;30488.54267185994;708.8334241453255;999.7550600103021;1014.6600888702368;1089.7929393415384;1140.995923587238;14948.925255373653;15252.694946101015;16158.27287772053;16399.688024957974;16408;641022;642640;645790;646706;647231;58234;58655.70672146612;58662.41337586655;58678.11982820261;58746.70626646839;1155.2721785275223;1250.2685928731794;1399.9090059146122;1408.7323408552343;1425.1377916360452;27734.5839812407;30962.761489540168;30998;31547;32367.352652946338;51544.74227628838;52562.474375255755;52629.21056184084;52666.73666631642;52778.73610632076;613998;626780;627068;627997;629504;43158;44164.77917610391;44312;44999.775001124784;46247.76876115733;48104.51895481;48200.5179948196;48497.27254091262;48682.75658621684;49033.774155646395;39799.80100099481;40000.799995999834;40044;41400.79299603483;41429;38605.42091868568;39746;39748.00629984274;40939.1812163761;41175.38236926388;37553.18351123622;37883.62116378801;38016.23967520579;38703.419448707726;39155.80422097985;32806.507902381;33755;33888.66111338855;34872.47691284683;35298.5287280472;21990.6805591665;24813.00747970061;25400.983960641366;25422.872885635454;26087 13:37:22 INFO - PROCESS | 1668 | |2;jquery.html;316.82732910563743;356.89293212036415;364.60986744183737;379.273690881961;407.6758976613592;14968.775468367983;15867.206639668013;20325.78045317282;20467.48831279219;21286.36140915775;20556.588868222665;20813.583728325426;20931.790682093175;21447;21704.782952170473;5671.489565939054;5987.580869339148;6003.099535069731;6004.489618382421;6015.939840601582;4176.665866730669;5717.828465146032;5978.641281523101;6663;6670.23292321382;6083.878322433548;6691.531592788507;6706.094677218562;6707.631080290582;6713.992901064855;5902.527797776189;6522.282548919615;6605.24039735427;6609.6695165241545;6611.735530578771;4213.4522512073545;5511.696856672881;5745.913811292834;5747.252857128588;5748.683822389767;26811.65941702907;26818;26857.925682972855;27087.72912270872;27201.863990680118;2058.835293176542;2172.0225898345807;2208.6576580630026;2403.327068420845;2671.7996150288805;9969.302148849583;10023;10385.740356491073;10390.532426040847;10399.896001039968;1848.380792434536;1855.703087506006;1945.9610807783906;1964.4401345616432;1974.634692581877;95589;105261.94738052675;105831;105969;106500.46749766202;9441.669541566149;11337;11425.31448113116;11436.828447573293;11761;11879.346635934933;12566.874331256753;13563.864361356458;14274.643133921527;14320.856791432161;7074.540154890019;7948.085970113395;8623.353248506388;8718.476891386537;8770.693025744069;7031.8945215821805;8493.768403581445;8517.48895066298;8575.842261294645;8708.564571771387;4449.7330160190495;4520.819167233274;4522.389477420572;4611.515790841913;4618.699784513996;1848.6395152945047;1887.6224755049045;1898;1928.4407521818796;1952.9121189546504;805.04602046575;906.5920335848895;966.990330096704;1020.7222503549643;1033.9793204135874;21998.780012199673;22489.77510224877;22521;22534.887325563268;22935.311940641808;821.9958900205461;891.4829398948594;929.1962452478692;936.9156775890202;965.1699538396973;9779.804403911881;11516.424178791027;11641;11676.47455864488;11719.531218751325;594559;595974;598194;603358;605962;75719;87786;134448;138248.6175138256;142113;978.8091322192247;983.8130755156354;1030.7629245273629;1033.7312298802215;1039.194624166262;19425.222991080765;19767.308144214883;19816.504587385432;20064.197432102552;20165;38309.81414347214;50149.997000060524;51048.23427648514;54721.63195920134;54933.70397776146;61292;82763;84419;84436.57781711298;85391;7087.539309944837;7952.880706789519;8012.639431225492;8216.589170541569;8334.6666133354;8863.64545418176;10010.699679009642;11360.091192704398;12456.564020259248;13253.734925301247;6376.458001069961;7598.848023039619;7954.761357159295;7989.880151797844;8251.422400431911;6593.80218593443;6797.5581587196675;7129.500934934505;7381.372583330477;8028.9197108028175;7664.195259497896;8163.959180204061;8181.222783835764;8216.46592971455;8246.876296855671;11863.822042669195;11922.52309907594;12363.88725014717;12533.561325353568;12540.49838006506;11529.769404612029;11856.992155666865;12038.157328986887;12043.976262017826;12097.57658481949 13:37:22 INFO - PROCESS | 1668 | |3;mootools.html;1381.0677792490067;1533.2027345780195;1551.6508785523256;1745.816689247629;1887.7829049659285;7744.728934487294;8430.199131082545;8783.560821958892;8795.95602021989;8883.289336853053;8675.436096653713;8716.041235464094;8737.689346598014;8753.95623021884;8757.12428757124;2370.810335173186;2382.9523409531885;2383.797377222938;2389.593769059264;2390.8565486070893;2321.4776675248017;2368.159303447277;2370.9288721338303;2373.32360277321;2374.5607062693457;2340.871252081135;2352.2120089769946;2357;2368.2539999900064;2368.5144545368244;2302.435903203726;2328.2549584133085;2331.405491599631;2331.9972411862977;2355.1286024170995;2315;2344.6248600224053;2345.859248445082;2347.8708671023087;2350.882455877216;8519.574021298973;8647.827043459158;8730.563471826446;8748.343874209397;8815.074417186168;5159.922601160985;5353.57171426285;5356.892862142735;5362.839114826562;5373.328333958255;3060.6480254770763;3551.1299731565673;3578.8568457261676;3625.1843335249623;3637.272545490886;1066.1311031509294;1085.3813326403954;1096.9561217551288;1103.4813637590319;1110.7001109700416;11282.379469129195;11319.603813866557;11411.48648310828;11416.94291528537;11419.200655954086;3711.851525938986;3857.9197824609155;4333.783310834446;4586.564276393738;4594.471635761864;7785.676435005949;8982.730518084469;9010.053944335881;9013.324000699842;9019.909800901907;5133.358330208724;5139.948600514022;5155.046316431472;5155.123628983082;5160.587153027824;4387.254166791653;4555.157295900269;4682.438107427062;4808.831690890802;4826.565609095198;3095.65339077502;3757.511523501982;3833.3483307837732;3869.3422118239405;3883.37865941448;1070.0797314309686;1075.7740874416304;1084.904246710812;1084.9620263290747;1085.2674444749762;841.7794198412204;857.566928701002;899.3659470073583;904.1681652879366;943.3113826906259;5636.126400407943;5696.202531645573;5962.314333851576;5982.850428739229;6032.698365081728;782.8356045230565;872.1104473437059;943.1935694980692;955.3455882720359;988.9703308900745;3684.8526058957877;3918.8432462701744;3925.941110883339;4057.736247143926;4069.308217603015;8104.432689711663;10353.896461035294;10355.741106472398;10359.015893490106;10378.844317335246;8728.25809806161;10316.226283028653;10333.328333658288;10342.844857327145;10365.9481702591;7191.604461754549;8094.757157285173;8105.51366917975;8153.103158652543;8324.6670133194;5874.441928016831;5932.940670593239;5968.253968253968;6050.394960503914;6142.723577438936;9861.161801246973;10159.593616255266;10179.592816287563;10195;10212.693619191436;9920.255980801325;10177.134943529883;10314.329568578018;10317.638882639072;10325.432101234204;6960.269171736894;7178.533395329287;7180.640967951686;7532.811679708051;7704.845903081795;7844.411669124953;7856.292933636;7942.166072562298;7943.086545047394;8134.959325203336;7209.35115839577;7546.056742907137;7551.282628150317;7633.503822251536;7678.961605191938;7275.717703349198;7335.193128755725;7377.299156580117;7423.740169094056;7551.207123252199;6834.760783372757;6995.195552511323;7001.229864714775;7002.369786719016;7004.789856304319;4930.186519224431;4935.925961110514;5015.097282489187;5040.873978150576;5145.819896303611;4928.630352723489;4951.8266860659705;5112.514311140436;5124.461931497139;5214.634975551675 13:37:22 INFO - PROCESS | 1668 | |4;prototype.html;264.8080141897125;289.67185454690247;299.92501874531354;315.59288517812024;315.7931554831586;4971.279164521142;5002.949380630068;5092.363454568179;5099.634241400677;5290.153575427932;5071.782772134679;5224.667709734022;5236.345456817898;5249.790008399669;5289.867753306169;3365.2428203654226;3719.0330514066336;4059.289624315748;4064.227796718614;4091.365838295069;3346.6111563701033;3730.2725968436166;4061.8984525386804;4096.996235922204;4104.21466662003;3344.933101337972;3811.4473401356786;4050.6354428101463;4060.523080920636;4085.22380747657;3315.624016033343;4015.6586690131376;4040.1111755413763;4058.3709525023373;4063.817128229237;2810;2960.3635218427926;2971.821690698565;3572.321258960815;3582.5700915889997;4726.149293127236;4870.245112007609;5106.927545215509;5201.385037399009;5209.453007434203;4097.795110244476;4537.636989040869;4596.977015114937;4625.4911959684405;4649.488556258809;5497.151993604492;5500.889982200373;5548.750306236229;5555.444455554452;5559.972200139014;3299.9835000825083;3497.562804649419;3735.4684579322347;3919.8249417971533;3932.980335098306;4892.779824907852;5758.88482230353;5785.768569257225;5800.9129863052085;5841.422815839742;3964.801759911993;3971.332040542979;3971.4439978403047;3975.960240397559;3988.74073185242;3359.6304406515264;3869.6517313441364;4038.5153781545814;4043.2317859606583;4049.5140583130215;3866.130120722815;4209.642180414638;4490.057088011554;4619.284010978304;4625.976870115628;4349.391085248068;4984;5210.635255532076;5578.470045345685;5608.495235428831;1128.5203788389902;1135.4776802670865;1327.794191900257;1352.2765320553456;1365.50841696989;826.6156237349661;901.9458832470073;918.9386258871015;925.8194652042922;943.1323182671958;4358.629516491071;5062.898742025212;5125.513076257749;5127.025865085622;5130.563902068291;4779.545943135397;5206.557442617344;5620.4660557247;5643.266375371176;5653.321601407775;4040.585794971795;4065.4714887064492;4155.771432571238;4512.751798651106;5095.770690318945;2087.6242276390394;2270.5685919675207;2423.793977511931;2526.393665520299;2544.440223150904;4276.230278549829;4446.421965144576;4957.380327459067;4963.808685915426;4985.651004429727;4195.321871251463;4800.3279540864305;4840.75796210188;4867.951320486821;4874.268859671078;5058.595312375075;5368.778732760313;5692.003899317603;6059.7273122709585;6064;4887.731174785279;5821.94178058214;5842.883142337215;5846.619969701956;5850.619709719025;5016.698998059982;5409.7024663642305;5571.08077167279;5667.914981275202;5710.685912274865;6043.7884674036195;6058.545609079425;6069.666168360783;6085.2393450818645;6087.695615219132;3404.2170300830453;3740.3641380965846;3905.1408690088133;3922.8626998054933;3942;4153.8961525962095;5308.548773354154;5444.8366549003595;5466.037123085731;5766.481016708516;5445.59158063139;5473.8378340556055;5493.395726470165;5516.503514683698;5551.944480555143;4916.778744956414;5646.3788983212635;5649.406812284816;5665.5157078397315;5689.004424225826;4831.70494015354;5001.24981252815;5099.643024988215;5293.497117773805;5514.531264842533;4696.8121275148615;5664.252837373952;5665.745041473061;5698;5719.170720245625;4632.953670463252;5052.343195384577;5517.344796561096;5554.000839546761;5561.249231353715 13:37:22 INFO - PROCESS | 1668 | |5;yui.html;703.236987868163;717.4977515738981;763.3625922354834;763.7779552715652;821.9383546234033;14175.574732758021;16458.506244812645;16461.423850165233;16477.67044659109;16496.42262520812;12389.62831115068;14591.197484138369;14912.105273683586;14913.105213687186;14951.252437378142;680.5100327764027;698.0227681246245;823.8681810910241;839.4459656626627;861.4960248254747;844.6579135450122;863.4215075899162;865.1607940297932;867.7310033889482;868;917.0050495212702;920.7375897869109;921.6589861751162;922.4142669404943;924.5100096948628;731.1591669580025;754.1402800807084;757.307064036406;910.0489987962562;916.3722849847876;556.7160748018499;558.3969313141797;652.7062821730241;670.5038271678972;671.4326394196896;15012.774808377882;15081.54755357341;15084.849151508453;15100.622484437978;15123.924380378137;13911.930440347733;14177.645558861008;14213.431462741479;14213.93395495342;14284.857151428456;12635.11554191207;12807.231566106064;12827.358632068452;13072.673183170402;13389.330533473385;4563.7489938053395;4574.359589657417;4647.18674232008;4724.338592597039;4737.265723812815;112604;114186;114534;114657;115321.42339288334;9434.245260379153;11068.059214966817;11097.667069987914;11177;11694.239874408137;21821.127154913625;21936.561268774534;22002;22033.889830550746;22077.558448830932;7931.881021784678;7933.761987140395;7941;7962.044554653478;8208.876866847002;3737.7757334560015;4411.7573533455325;4433.844815431445;4494.011317510208;4535.047639995571;3470.236547959445;3579.856805727794;3581.068922080278;3595.1551385424405;3597.9100522487147;702.64516419209;729.2160927003492;746.7349091072699;746.8356961468468;749.1010787055556;610.4749915073033;655.7999810057978;655.8327626455318;685.7874059041714;686.193722376206;8863.202311791969;9516.571754270935;9692.127708506268;9762.17021553176;9909.950450247703;568.4060157135802;622.6326467384265;624.3880996623335;669.1024780652717;680.7379159023712;4163.666906647461;4770.570648641569;4781.330613714083;4784.2823576463115;4786.64100192487;105018;141601;145234;165722;165726;108241.45879270553;140324;141075;142060.28969855086;144987;114918.42540787242;119184.8081519191;122646;123550;126626.10060849095;8991.595378207865;9050.864237036318;9100.954495227481;9128.543572821465;9205.447673139633;55233.72383138059;67573.66213168902;67709;68975;71716;97623;98513.52229716416;100300;100919.98160036905;101042;12048.75902481963;12293.508259669514;12328.691782705504;12430.440630171483;12485.058570404219;13463;13487.258200798658;13493.865061349261;13648.969889064898;14009.579712608638;12230.510779568718;12319.815202771786;12402.13185077036;12498.43757030954;12906.225626462443;10385.63650272237;12326.322052286852;12346.567870124503;12673.366331683563;13079.869201308245;11874.940625296818;12049.518019279481;12101.805829607754;12139.332336721212;12184.75630487403;10096.444695541815;10412.219083568914;10635.840462392916;10878.945605271923;11010.284331518425;9141.680041198526;10702.411367374869;10912.072473839495;10914.836277455686;11367.715807104889 13:37:22 INFO - PROCESS | 1668 | __end_tp_report 13:37:22 INFO - PROCESS | 1668 | __start_cc_report 13:37:22 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1276 13:37:22 INFO - PROCESS | 1668 | __end_cc_report 13:37:22 INFO - PROCESS | 1668 | __startTimestamp1470429442025__endTimestamp 13:37:22 INFO - PROCESS | 1668 | 13:37:22 INFO - PROCESS | 1668 | ------- Summary: start ------- 13:37:22 INFO - PROCESS | 1668 | Number of tests: 6 13:37:22 INFO - PROCESS | 1668 | 13:37:22 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5711.12 Median:5852.59 stddev:656.04 (11.2%) stddev-sans-first:627.40 13:37:22 INFO - PROCESS | 1668 | Values: 3184.4 3360.6 3362.4 3395.8 3426.3 5585.2 5611.1 5691.6 5699.8 5704.1 4592.5 4773.6 5576.1 5662.7 5760.0 5152.5 5204.0 5205.2 5219.1 5297.8 5178.9 5233.9 5357.9 5362.1 5375.4 5298.8 5311.5 5334.3 5341.4 5356.3 5163.7 5193.0 5270.0 5277.3 5297.4 5167.0 5207.3 5216.1 5217.6 5218.2 5717.9 5718.7 5725.7 5731.9 5740.4 5023.3 6191.5 6215.4 6219.6 6220.2 6225.3 6237.6 6268.6 6323.8 6324.4 5783.0 5802.1 5832.8 5850.9 5852.6 6264.1 6278.6 6294.5 6314.1 6329.9 6203.2 6210.2 6220.7 6225.8 6228.8 6304.2 6310.5 6320.3 6326.5 6338.9 4678.5 5996.9 6113.0 6200.8 6234.3 6075.0 6083.0 6090.2 6095.8 6141.1 4843.5 4855.6 4864.6 4875.0 4905.2 4368.4 4383.2 4385.5 4392.8 4476.8 5666.0 5690.4 5706.7 5710.5 5714.3 5382.7 6109.2 6240.5 6269.5 6274.2 5742.9 5750.9 5751.3 5768.4 5790.2 5395.0 5438.2 5440.2 5449.0 5453.5 5303.9 6268.2 6272.3 6382.3 6427.9 6256.0 6270.2 6277.2 6302.5 6305.6 6298.9 6315.9 6329.7 6332.7 6359.9 6067.1 6138.5 6149.7 6185.9 6220.3 6291.4 6325.8 6328.9 6335.0 6342.1 5974.0 6133.1 6134.8 6152.7 6153.0 5909.7 6044.4 6086.6 6134.4 6136.5 5840.1 5893.1 5978.9 6020.8 6034.0 5352.8 5514.8 6111.0 6131.6 6178.1 5810.9 5873.4 5906.5 5951.1 5968.9 13:37:22 INFO - PROCESS | 1668 | 13:37:22 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:72977.53 Median:42496.18 stddev:159963.70 (376.4%) stddev-sans-first:160319.84 13:37:22 INFO - PROCESS | 1668 | Values: 484.2 501.8 519.0 541.4 543.4 30042.4 39294.7 40310.2 40789.8 43305.4 42091.4 42460.6 42461.8 42530.6 42726.9 9705.3 9894.0 9894.5 9895.2 9908.8 9692.5 9802.6 9815.5 9815.9 9829.3 9799.0 9805.7 9841.5 9867.3 9868.3 9775.4 9792.3 9820.4 9827.6 9830.6 9708.7 9792.7 9793.6 9794.5 9835.3 39962.0 40234.0 40270.6 40347.0 40389.8 3315.5 3378.8 3414.1 3498.6 3836.3 30736.8 30962.5 31507.9 31511.2 31980.7 3136.7 3210.6 3222.5 3242.8 3313.2 517186.0 517809.0 518306.0 518426.4 519589.0 55721.0 56182.4 56254.7 56295.0 56313.7 50075.0 59105.4 59703.0 59751.0 59865.0 15680.5 16294.2 16415.8 16761.8 16802.7 10654.4 12558.7 12692.8 12726.7 12727.0 18748.9 18806.2 18809.7 18824.0 18933.8 7859.8 7944.4 7969.7 8013.7 8028.4 863.8 899.9 952.2 997.4 1066.2 26110.0 29108.7 29935.0 30013.7 30488.5 708.8 999.8 1014.7 1089.8 1141.0 14948.9 15252.7 16158.3 16399.7 16408.0 641022.0 642640.0 645790.0 646706.0 647231.0 58234.0 58655.7 58662.4 58678.1 58746.7 1155.3 1250.3 1399.9 1408.7 1425.1 27734.6 30962.8 30998.0 31547.0 32367.4 51544.7 52562.5 52629.2 52666.7 52778.7 613998.0 626780.0 627068.0 627997.0 629504.0 43158.0 44164.8 44312.0 44999.8 46247.8 48104.5 48200.5 48497.3 48682.8 49033.8 39799.8 40000.8 40044.0 41400.8 41429.0 38605.4 39746.0 39748.0 40939.2 41175.4 37553.2 37883.6 38016.2 38703.4 39155.8 32806.5 33755.0 33888.7 34872.5 35298.5 21990.7 24813.0 25401.0 25422.9 26087.0 13:37:22 INFO - PROCESS | 1668 | 13:37:22 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:34173.62 Median:4331.59 stddev:99635.76 (2300.2%) stddev-sans-first:99882.83 13:37:22 INFO - PROCESS | 1668 | Values: 316.8 356.9 364.6 379.3 407.7 14968.8 15867.2 20325.8 20467.5 21286.4 20556.6 20813.6 20931.8 21447.0 21704.8 5671.5 5987.6 6003.1 6004.5 6015.9 4176.7 5717.8 5978.6 6663.0 6670.2 6083.9 6691.5 6706.1 6707.6 6714.0 5902.5 6522.3 6605.2 6609.7 6611.7 4213.5 5511.7 5745.9 5747.3 5748.7 26811.7 26818.0 26857.9 27087.7 27201.9 2058.8 2172.0 2208.7 2403.3 2671.8 9969.3 10023.0 10385.7 10390.5 10399.9 1848.4 1855.7 1946.0 1964.4 1974.6 95589.0 105261.9 105831.0 105969.0 106500.5 9441.7 11337.0 11425.3 11436.8 11761.0 11879.3 12566.9 13563.9 14274.6 14320.9 7074.5 7948.1 8623.4 8718.5 8770.7 7031.9 8493.8 8517.5 8575.8 8708.6 4449.7 4520.8 4522.4 4611.5 4618.7 1848.6 1887.6 1898.0 1928.4 1952.9 805.0 906.6 967.0 1020.7 1034.0 21998.8 22489.8 22521.0 22534.9 22935.3 822.0 891.5 929.2 936.9 965.2 9779.8 11516.4 11641.0 11676.5 11719.5 594559.0 595974.0 598194.0 603358.0 605962.0 75719.0 87786.0 134448.0 138248.6 142113.0 978.8 983.8 1030.8 1033.7 1039.2 19425.2 19767.3 19816.5 20064.2 20165.0 38309.8 50150.0 51048.2 54721.6 54933.7 61292.0 82763.0 84419.0 84436.6 85391.0 7087.5 7952.9 8012.6 8216.6 8334.7 8863.6 10010.7 11360.1 12456.6 13253.7 6376.5 7598.8 7954.8 7989.9 8251.4 6593.8 6797.6 7129.5 7381.4 8028.9 7664.2 8164.0 8181.2 8216.5 8246.9 11863.8 11922.5 12363.9 12533.6 12540.5 11529.8 11857.0 12038.2 12044.0 12097.6 13:37:22 INFO - PROCESS | 1668 | 13:37:22 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5588.96 Median:5027.99 stddev:3102.26 (61.7%) stddev-sans-first:3094.84 13:37:22 INFO - PROCESS | 1668 | Values: 1381.1 1533.2 1551.7 1745.8 1887.8 7744.7 8430.2 8783.6 8796.0 8883.3 8675.4 8716.0 8737.7 8754.0 8757.1 2370.8 2383.0 2383.8 2389.6 2390.9 2321.5 2368.2 2370.9 2373.3 2374.6 2340.9 2352.2 2357.0 2368.3 2368.5 2302.4 2328.3 2331.4 2332.0 2355.1 2315.0 2344.6 2345.9 2347.9 2350.9 8519.6 8647.8 8730.6 8748.3 8815.1 5159.9 5353.6 5356.9 5362.8 5373.3 3060.6 3551.1 3578.9 3625.2 3637.3 1066.1 1085.4 1097.0 1103.5 1110.7 11282.4 11319.6 11411.5 11416.9 11419.2 3711.9 3857.9 4333.8 4586.6 4594.5 7785.7 8982.7 9010.1 9013.3 9019.9 5133.4 5139.9 5155.0 5155.1 5160.6 4387.3 4555.2 4682.4 4808.8 4826.6 3095.7 3757.5 3833.3 3869.3 3883.4 1070.1 1075.8 1084.9 1085.0 1085.3 841.8 857.6 899.4 904.2 943.3 5636.1 5696.2 5962.3 5982.9 6032.7 782.8 872.1 943.2 955.3 989.0 3684.9 3918.8 3925.9 4057.7 4069.3 8104.4 10353.9 10355.7 10359.0 10378.8 8728.3 10316.2 10333.3 10342.8 10365.9 7191.6 8094.8 8105.5 8153.1 8324.7 5874.4 5932.9 5968.3 6050.4 6142.7 9861.2 10159.6 10179.6 10195.0 10212.7 9920.3 10177.1 10314.3 10317.6 10325.4 6960.3 7178.5 7180.6 7532.8 7704.8 7844.4 7856.3 7942.2 7943.1 8135.0 7209.4 7546.1 7551.3 7633.5 7679.0 7275.7 7335.2 7377.3 7423.7 7551.2 6834.8 6995.2 7001.2 7002.4 7004.8 4930.2 4935.9 5015.1 5040.9 5145.8 4928.6 4951.8 5112.5 5124.5 5214.6 13:37:22 INFO - PROCESS | 1668 | 13:37:22 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:4401.14 Median:4890.26 stddev:1386.61 (28.4%) stddev-sans-first:1355.29 13:37:22 INFO - PROCESS | 1668 | Values: 264.8 289.7 299.9 315.6 315.8 4971.3 5002.9 5092.4 5099.6 5290.2 5071.8 5224.7 5236.3 5249.8 5289.9 3365.2 3719.0 4059.3 4064.2 4091.4 3346.6 3730.3 4061.9 4097.0 4104.2 3344.9 3811.4 4050.6 4060.5 4085.2 3315.6 4015.7 4040.1 4058.4 4063.8 2810.0 2960.4 2971.8 3572.3 3582.6 4726.1 4870.2 5106.9 5201.4 5209.5 4097.8 4537.6 4597.0 4625.5 4649.5 5497.2 5500.9 5548.8 5555.4 5560.0 3300.0 3497.6 3735.5 3919.8 3933.0 4892.8 5758.9 5785.8 5800.9 5841.4 3964.8 3971.3 3971.4 3976.0 3988.7 3359.6 3869.7 4038.5 4043.2 4049.5 3866.1 4209.6 4490.1 4619.3 4626.0 4349.4 4984.0 5210.6 5578.5 5608.5 1128.5 1135.5 1327.8 1352.3 1365.5 826.6 901.9 918.9 925.8 943.1 4358.6 5062.9 5125.5 5127.0 5130.6 4779.5 5206.6 5620.5 5643.3 5653.3 4040.6 4065.5 4155.8 4512.8 5095.8 2087.6 2270.6 2423.8 2526.4 2544.4 4276.2 4446.4 4957.4 4963.8 4985.7 4195.3 4800.3 4840.8 4868.0 4874.3 5058.6 5368.8 5692.0 6059.7 6064.0 4887.7 5821.9 5842.9 5846.6 5850.6 5016.7 5409.7 5571.1 5667.9 5710.7 6043.8 6058.5 6069.7 6085.2 6087.7 3404.2 3740.4 3905.1 3922.9 3942.0 4153.9 5308.5 5444.8 5466.0 5766.5 5445.6 5473.8 5493.4 5516.5 5551.9 4916.8 5646.4 5649.4 5665.5 5689.0 4831.7 5001.2 5099.6 5293.5 5514.5 4696.8 5664.3 5665.7 5698.0 5719.2 4633.0 5052.3 5517.3 5554.0 5561.2 13:37:22 INFO - PROCESS | 1668 | 13:37:22 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:25596.00 Median:12773.90 stddev:41445.67 (324.5%) stddev-sans-first:41519.80 13:37:22 INFO - PROCESS | 1668 | Values: 703.2 717.5 763.4 763.8 821.9 14175.6 16458.5 16461.4 16477.7 16496.4 12389.6 14591.2 14912.1 14913.1 14951.3 680.5 698.0 823.9 839.4 861.5 844.7 863.4 865.2 867.7 868.0 917.0 920.7 921.7 922.4 924.5 731.2 754.1 757.3 910.0 916.4 556.7 558.4 652.7 670.5 671.4 15012.8 15081.5 15084.8 15100.6 15123.9 13911.9 14177.6 14213.4 14213.9 14284.9 12635.1 12807.2 12827.4 13072.7 13389.3 4563.7 4574.4 4647.2 4724.3 4737.3 112604.0 114186.0 114534.0 114657.0 115321.4 9434.2 11068.1 11097.7 11177.0 11694.2 21821.1 21936.6 22002.0 22033.9 22077.6 7931.9 7933.8 7941.0 7962.0 8208.9 3737.8 4411.8 4433.8 4494.0 4535.0 3470.2 3579.9 3581.1 3595.2 3597.9 702.6 729.2 746.7 746.8 749.1 610.5 655.8 655.8 685.8 686.2 8863.2 9516.6 9692.1 9762.2 9910.0 568.4 622.6 624.4 669.1 680.7 4163.7 4770.6 4781.3 4784.3 4786.6 105018.0 141601.0 145234.0 165722.0 165726.0 108241.5 140324.0 141075.0 142060.3 144987.0 114918.4 119184.8 122646.0 123550.0 126626.1 8991.6 9050.9 9101.0 9128.5 9205.4 55233.7 67573.7 67709.0 68975.0 71716.0 97623.0 98513.5 100300.0 100920.0 101042.0 12048.8 12293.5 12328.7 12430.4 12485.1 13463.0 13487.3 13493.9 13649.0 14009.6 12230.5 12319.8 12402.1 12498.4 12906.2 10385.6 12326.3 12346.6 12673.4 13079.9 11874.9 12049.5 12101.8 12139.3 12184.8 10096.4 10412.2 10635.8 10878.9 11010.3 9141.7 10702.4 10912.1 10914.8 11367.7 13:37:22 INFO - PROCESS | 1668 | -------- Summary: end -------- 13:37:22 INFO - PROCESS | 1668 | 13:37:22 INFO - TEST-INFO | 1668: exit 0 13:37:22 INFO - TEST-OK | dromaeo_css | took 1118115ms 13:37:22 INFO - TEST-START | kraken 13:37:22 INFO - operating with platform_type : mac_ 13:37:22 INFO - Initialising browser for kraken test... 13:37:22 INFO - TEST-INFO | started process 1790 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpsTuhwc/profile http://localhost:49271/getInfo.html) 13:37:24 INFO - PROCESS | 1790 | __metrics Screen width/height:1600/1200 13:37:24 INFO - PROCESS | 1790 | colorDepth:24 13:37:24 INFO - PROCESS | 1790 | Browser inner width/height: 1024/689 13:37:24 INFO - PROCESS | 1790 | __metrics 13:37:25 INFO - PROCESS | 1790 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:37:25 INFO - PROCESS | 1790 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:37:25 INFO - TEST-INFO | 1790: exit 0 13:37:25 INFO - Browser initialized. 13:37:25 INFO - Running cycle 1/1 for kraken test... 13:37:25 INFO - TEST-INFO | started process 1791 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpsTuhwc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:37 INFO - PROCESS | 1791 | RSS: Main: 243343360 13:37:37 INFO - PROCESS | 1791 | 13:37:40 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 13:37:41 INFO - PROCESS | 1791 | RSS: Main: 294240256 13:37:41 INFO - PROCESS | 1791 | 13:37:43 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 13:37:44 INFO - PROCESS | 1791 | RSS: Main: 299552768 13:37:44 INFO - PROCESS | 1791 | 13:37:48 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 13:37:48 INFO - PROCESS | 1791 | RSS: Main: 395149312 13:37:48 INFO - PROCESS | 1791 | 13:37:50 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 13:37:51 INFO - PROCESS | 1791 | RSS: Main: 298692608 13:37:51 INFO - PROCESS | 1791 | 13:37:53 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:37:54 INFO - PROCESS | 1791 | RSS: Main: 302530560 13:37:54 INFO - PROCESS | 1791 | 13:37:57 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 13:37:57 INFO - PROCESS | 1791 | RSS: Main: 340029440 13:37:57 INFO - PROCESS | 1791 | 13:38:00 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 13:38:01 INFO - PROCESS | 1791 | RSS: Main: 343760896 13:38:01 INFO - PROCESS | 1791 | 13:38:04 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 13:38:04 INFO - PROCESS | 1791 | RSS: Main: 339718144 13:38:04 INFO - PROCESS | 1791 | 13:38:06 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:38:06 INFO - PROCESS | 1791 | RSS: Main: 314458112 13:38:06 INFO - PROCESS | 1791 | 13:38:08 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:38:09 INFO - PROCESS | 1791 | RSS: Main: 318574592 13:38:09 INFO - PROCESS | 1791 | 13:38:11 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:38:12 INFO - PROCESS | 1791 | RSS: Main: 325812224 13:38:12 INFO - PROCESS | 1791 | 13:38:15 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:38:15 INFO - PROCESS | 1791 | RSS: Main: 332197888 13:38:15 INFO - PROCESS | 1791 | 13:38:18 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:38:19 INFO - PROCESS | 1791 | RSS: Main: 333434880 13:38:19 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 13:38:21 INFO - PROCESS | 1791 | RSS: Main: 376672256 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | __start_tp_report 13:38:21 INFO - PROCESS | 1791 | _x_x_mozilla_page_load 13:38:21 INFO - PROCESS | 1791 | _x_x_mozilla_page_load_details 13:38:21 INFO - PROCESS | 1791 | |i|pagename|runs| 13:38:21 INFO - PROCESS | 1791 | |0;ai-astar;102;111;112;112;112;114;111;112;111;111 13:38:21 INFO - PROCESS | 1791 | |1;audio-beat-detection;171;140;161;146;108;136;129;108;163;109 13:38:21 INFO - PROCESS | 1791 | |2;audio-dft;185;187;221;196;266;185;181;183;184;184 13:38:21 INFO - PROCESS | 1791 | |3;audio-fft;77;60;59;108;72;84;87;72;85;57 13:38:21 INFO - PROCESS | 1791 | |4;audio-oscillator;84;70;93;71;76;92;130;95;53;110 13:38:21 INFO - PROCESS | 1791 | |5;imaging-gaussian-blur;87;86;86;85;87;84;89;85;89;89 13:38:21 INFO - PROCESS | 1791 | |6;imaging-darkroom;92;94;93;94;94;94;96;95;94;93 13:38:21 INFO - PROCESS | 1791 | |7;imaging-desaturate;88;85;85;86;84;84;84;85;84;85 13:38:21 INFO - PROCESS | 1791 | |8;json-parse-financial;56;53;54;53;52;53;52;53;53;52 13:38:21 INFO - PROCESS | 1791 | |9;json-stringify-tinderbox;64;66;83;76;73;70;71;70;71;70 13:38:21 INFO - PROCESS | 1791 | |10;stanford-crypto-aes;86;84;86;87;85;85;86;83;94;103 13:38:21 INFO - PROCESS | 1791 | |11;stanford-crypto-ccm;143;145;141;137;137;132;128;147;149;138 13:38:21 INFO - PROCESS | 1791 | |12;stanford-crypto-pbkdf2;167;165;166;166;165;167;165;164;165;165 13:38:21 INFO - PROCESS | 1791 | |13;stanford-crypto-sha256-iterative;66;66;67;66;66;69;65;66;67;67 13:38:21 INFO - PROCESS | 1791 | __end_tp_report 13:38:21 INFO - PROCESS | 1791 | __start_cc_report 13:38:21 INFO - PROCESS | 1791 | _x_x_mozilla_cycle_collect,2081 13:38:21 INFO - PROCESS | 1791 | __end_cc_report 13:38:21 INFO - PROCESS | 1791 | __startTimestamp1470429501284__endTimestamp 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | ------- Summary: start ------- 13:38:21 INFO - PROCESS | 1791 | Number of tests: 14 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.22 (2.9%) stddev-sans-first:0.97 13:38:21 INFO - PROCESS | 1791 | Values: 102.0 111.0 112.0 112.0 112.0 114.0 111.0 112.0 111.0 111.0 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:143.00 stddev:23.64 (16.5%) stddev-sans-first:21.66 13:38:21 INFO - PROCESS | 1791 | Values: 171.0 140.0 161.0 146.0 108.0 136.0 129.0 108.0 163.0 109.0 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | [#2] audio-dft Cycles:10 Average:197.20 Median:186.00 stddev:26.91 (14.5%) stddev-sans-first:28.17 13:38:21 INFO - PROCESS | 1791 | Values: 185.0 187.0 221.0 196.0 266.0 185.0 181.0 183.0 184.0 184.0 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | [#3] audio-fft Cycles:10 Average:76.10 Median:74.50 stddev:15.74 (21.1%) stddev-sans-first:16.69 13:38:21 INFO - PROCESS | 1791 | Values: 77.0 60.0 59.0 108.0 72.0 84.0 87.0 72.0 85.0 57.0 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:80.00 stddev:21.94 (27.4%) stddev-sans-first:23.24 13:38:21 INFO - PROCESS | 1791 | Values: 84.0 70.0 93.0 71.0 76.0 92.0 130.0 95.0 53.0 110.0 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:87.00 stddev:1.83 (2.1%) stddev-sans-first:1.94 13:38:21 INFO - PROCESS | 1791 | Values: 87.0 86.0 86.0 85.0 87.0 84.0 89.0 85.0 89.0 89.0 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:1.10 (1.2%) stddev-sans-first:0.93 13:38:21 INFO - PROCESS | 1791 | Values: 92.0 94.0 93.0 94.0 94.0 94.0 96.0 95.0 94.0 93.0 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:1.25 (1.5%) stddev-sans-first:0.71 13:38:21 INFO - PROCESS | 1791 | Values: 88.0 85.0 85.0 86.0 84.0 84.0 84.0 85.0 84.0 85.0 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:1.20 (2.3%) stddev-sans-first:0.67 13:38:21 INFO - PROCESS | 1791 | Values: 56.0 53.0 54.0 53.0 52.0 53.0 52.0 53.0 53.0 52.0 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.00 stddev:5.25 (7.4%) stddev-sans-first:4.84 13:38:21 INFO - PROCESS | 1791 | Values: 64.0 66.0 83.0 76.0 73.0 70.0 71.0 70.0 71.0 70.0 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:86.00 stddev:6.08 (7.1%) stddev-sans-first:6.41 13:38:21 INFO - PROCESS | 1791 | Values: 86.0 84.0 86.0 87.0 85.0 85.0 86.0 83.0 94.0 103.0 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:142.00 stddev:6.62 (4.7%) stddev-sans-first:6.91 13:38:21 INFO - PROCESS | 1791 | Values: 143.0 145.0 141.0 137.0 137.0 132.0 128.0 147.0 149.0 138.0 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:165.50 stddev:0.97 (0.6%) stddev-sans-first:0.87 13:38:21 INFO - PROCESS | 1791 | Values: 167.0 165.0 166.0 166.0 165.0 167.0 165.0 164.0 165.0 165.0 13:38:21 INFO - PROCESS | 1791 | 13:38:21 INFO - PROCESS | 1791 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 13:38:21 INFO - PROCESS | 1791 | Values: 66.0 66.0 67.0 66.0 66.0 69.0 65.0 66.0 67.0 67.0 13:38:21 INFO - PROCESS | 1791 | -------- Summary: end -------- 13:38:21 INFO - PROCESS | 1791 | 13:38:22 INFO - TEST-INFO | 1791: exit 0 13:38:22 INFO - TEST-OK | kraken | took 59496ms 13:38:22 INFO - SUITE-END | took 1177s 13:38:22 INFO - Completed test suite (00:19:37) 13:38:22 INFO - javascript benchmark 13:38:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3184.394964956658, 3360.6135294441146, 3362.394768941591, 3395.7792743471655, 3426.3318652862686, 5585.218069470277, 5611.102223644218, 5691.630044047134, 5699.772009119641, 5704.1443783432505, 4592.517785632511, 4773.641976851733, 5576.107822748361, 5662.688552129631, 5760.049591817345, 5152.484751524846, 5204.0, 5205.245239440279, 5219.086659834533, 5297.814576489824, 5178.8705282368055, 5233.8953220935555, 5357.866053348658, 5362.1420572708375, 5375.381831089416, 5298.761555730001, 5311.468853114697, 5334.27987221724, 5341.385740639818, 5356.330458692663, 5163.7159956202395, 5193.0, 5270.0, 5277.287566178555, 5297.417284098746, 5167.018266529348, 5207.323048003773, 5216.087184742692, 5217.634765566412, 5218.243354713545, 5717.8570535736935, 5718.714064296769, 5725.713714314267, 5731.942680573225, 5740.425957404268, 5023.271625614266, 6191.473724733403, 6215.409536094064, 6219.564630475868, 6220.222472190976, 6225.284092329395, 6237.6257424554215, 6268.561200715952, 6323.810285691437, 6324.430801227865, 5783.0, 5802.1296805479515, 5832.825015249549, 5850.912236316459, 5852.590318677651, 6264.060390941395, 6278.560500764994, 6294.527910406738, 6314.147590075281, 6329.873402531924, 6203.16257305258, 6210.161628180138, 6220.720067596969, 6225.750969961241, 6228.844278893064, 6304.211973503312, 6310.495160387158, 6320.304766475684, 6326.5255105867245, 6338.936610633927, 4678.508756580578, 5996.850078747979, 6112.9680474315155, 6200.81397558074, 6234.2830574483605, 6075.027995520695, 6082.9695851520455, 6090.208272924491, 6095.8476038098515, 6141.109539116893, 4843.491433399513, 4855.587275081658, 4864.610831133501, 4875.024995001014, 4905.190643543847, 4368.4321038264825, 4383.189110014658, 4385.539518350527, 4392.846250381222, 4476.776161191928, 5666.0, 5690.4025077367105, 5706.71466426677, 5710.5146062585145, 5714.285714285715, 5382.730863456812, 6109.175261339662, 6240.469560087444, 6269.467095296951, 6274.215723034621, 5742.942570574241, 5750.856228594319, 5751.338596061507, 5768.394318596571, 5790.247267855152, 5395.001924643953, 5438.184272359178, 5440.211169380417, 5448.972755136199, 5453.536449401766, 5303.946960530499, 6268.153799237045, 6272.341404152498, 6382.32985536512, 6427.871442571122, 6256.0303153011355, 6270.184875966095, 6277.2153480814895, 6302.527310451643, 6305.5901366411035, 6298.905516417166, 6315.90526142099, 6329.7151628175925, 6332.746690132343, 6359.872802544016, 6067.120267561268, 6138.51101655979, 6149.72326245329, 6185.907211391923, 6220.253569571681, 6291.402316779899, 6325.77859774924, 6328.9050664240995, 6335.049742538656, 6342.112104305309, 5973.970130149321, 6133.141360209664, 6134.834381467507, 6152.661603611844, 6153.046277826944, 5909.674967876808, 6044.365341639241, 6086.60437071589, 6134.4172303631085, 6136.5090792737365, 5840.094785308284, 5893.057110862242, 5978.880422391441, 6020.759169633166, 6033.9698301508215, 5352.84913743547, 5514.80698175562, 6111.0, 6131.63210207389, 6178.073289006685, 5810.854728631818, 5873.4126587340925, 5906.468417842415, 5951.137085122719, 5968.880622387441], "value": 5670.47518110024, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.15514926453335, 501.79928028788504, 518.9802038993378, 541.4287926237818, 543.4293991309127, 30042.399152016947, 39294.659953903916, 40310.193796124135, 40789.79605101974, 43305.35041974373, 42091.368629470584, 42460.57539424605, 42461.78769106158, 42530.574694253046, 42726.93182670427, 9705.272104592148, 9893.961134080926, 9894.455804930725, 9895.158911492532, 9908.752281192956, 9692.46691431971, 9802.5588848502, 9815.50922453878, 9815.90184098157, 9829.262805289633, 9798.951005244964, 9805.705828825146, 9841.458719770446, 9867.309288349818, 9868.309218354718, 9775.413475191475, 9792.314537982344, 9820.4107753535, 9827.557759900821, 9830.55762490686, 9708.660196893075, 9792.657256996043, 9793.608255669764, 9794.461304628243, 9835.262355323379, 39962.0, 40234.0, 40270.59729402727, 40347.0, 40389.79805100985, 3315.469524876008, 3378.814165220912, 3414.095264754842, 3498.5801703795705, 3836.3478208704587, 30736.846315768278, 30962.53556196659, 31507.909946001513, 31511.212219694462, 31980.680193198004, 3136.7069037283572, 3210.614726232867, 3222.540830320409, 3242.7567932405163, 3313.204830840605, 517186.0, 517809.0, 518306.0, 518426.407867962, 519589.0, 55721.0, 56182.43817561854, 56254.71872640692, 56295.0, 56313.71843140758, 50075.0, 59105.40894591085, 59703.0, 59751.0, 59865.0, 15680.529584112495, 16294.185290735415, 16415.753763693556, 16761.83238167627, 16802.747958780627, 10654.360738355723, 12558.686032849251, 12692.80960785589, 12726.745465090646, 12727.0, 18748.906255468635, 18806.153723082494, 18809.717854232196, 18824.0, 18933.81066189348, 7859.842803143905, 7944.443888927835, 7969.681212751541, 8013.719519816778, 8028.397870159762, 863.8272345530919, 899.869518919753, 952.1908374089147, 997.3866072365588, 1066.2056767708107, 26110.0, 29108.7089129106, 29935.0, 30013.699863001526, 30488.54267185994, 708.8334241453255, 999.7550600103021, 1014.6600888702368, 1089.7929393415384, 1140.995923587238, 14948.925255373653, 15252.694946101015, 16158.27287772053, 16399.688024957974, 16408.0, 641022.0, 642640.0, 645790.0, 646706.0, 647231.0, 58234.0, 58655.70672146612, 58662.41337586655, 58678.11982820261, 58746.70626646839, 1155.2721785275223, 1250.2685928731794, 1399.9090059146122, 1408.7323408552343, 1425.1377916360452, 27734.5839812407, 30962.761489540168, 30998.0, 31547.0, 32367.352652946338, 51544.74227628838, 52562.474375255755, 52629.21056184084, 52666.73666631642, 52778.73610632076, 613998.0, 626780.0, 627068.0, 627997.0, 629504.0, 43158.0, 44164.77917610391, 44312.0, 44999.775001124784, 46247.76876115733, 48104.51895481, 48200.5179948196, 48497.27254091262, 48682.75658621684, 49033.774155646395, 39799.80100099481, 40000.799995999834, 40044.0, 41400.79299603483, 41429.0, 38605.42091868568, 39746.0, 39748.00629984274, 40939.1812163761, 41175.38236926388, 37553.18351123622, 37883.62116378801, 38016.23967520579, 38703.419448707726, 39155.80422097985, 32806.507902381, 33755.0, 33888.66111338855, 34872.47691284683, 35298.5287280472, 21990.6805591665, 24813.00747970061, 25400.983960641366, 25422.872885635454, 26087.0], "value": 20400.338516321604, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.82732910563743, 356.89293212036415, 364.60986744183737, 379.273690881961, 407.6758976613592, 14968.775468367983, 15867.206639668013, 20325.78045317282, 20467.48831279219, 21286.36140915775, 20556.588868222665, 20813.583728325426, 20931.790682093175, 21447.0, 21704.782952170473, 5671.489565939054, 5987.580869339148, 6003.099535069731, 6004.489618382421, 6015.939840601582, 4176.665866730669, 5717.828465146032, 5978.641281523101, 6663.0, 6670.23292321382, 6083.878322433548, 6691.531592788507, 6706.094677218562, 6707.631080290582, 6713.992901064855, 5902.527797776189, 6522.282548919615, 6605.24039735427, 6609.6695165241545, 6611.735530578771, 4213.4522512073545, 5511.696856672881, 5745.913811292834, 5747.252857128588, 5748.683822389767, 26811.65941702907, 26818.0, 26857.925682972855, 27087.72912270872, 27201.863990680118, 2058.835293176542, 2172.0225898345807, 2208.6576580630026, 2403.327068420845, 2671.7996150288805, 9969.302148849583, 10023.0, 10385.740356491073, 10390.532426040847, 10399.896001039968, 1848.380792434536, 1855.703087506006, 1945.9610807783906, 1964.4401345616432, 1974.634692581877, 95589.0, 105261.94738052675, 105831.0, 105969.0, 106500.46749766202, 9441.669541566149, 11337.0, 11425.31448113116, 11436.828447573293, 11761.0, 11879.346635934933, 12566.874331256753, 13563.864361356458, 14274.643133921527, 14320.856791432161, 7074.540154890019, 7948.085970113395, 8623.353248506388, 8718.476891386537, 8770.693025744069, 7031.8945215821805, 8493.768403581445, 8517.48895066298, 8575.842261294645, 8708.564571771387, 4449.7330160190495, 4520.819167233274, 4522.389477420572, 4611.515790841913, 4618.699784513996, 1848.6395152945047, 1887.6224755049045, 1898.0, 1928.4407521818796, 1952.9121189546504, 805.04602046575, 906.5920335848895, 966.990330096704, 1020.7222503549643, 1033.9793204135874, 21998.780012199673, 22489.77510224877, 22521.0, 22534.887325563268, 22935.311940641808, 821.9958900205461, 891.4829398948594, 929.1962452478692, 936.9156775890202, 965.1699538396973, 9779.804403911881, 11516.424178791027, 11641.0, 11676.47455864488, 11719.531218751325, 594559.0, 595974.0, 598194.0, 603358.0, 605962.0, 75719.0, 87786.0, 134448.0, 138248.6175138256, 142113.0, 978.8091322192247, 983.8130755156354, 1030.7629245273629, 1033.7312298802215, 1039.194624166262, 19425.222991080765, 19767.308144214883, 19816.504587385432, 20064.197432102552, 20165.0, 38309.81414347214, 50149.997000060524, 51048.23427648514, 54721.63195920134, 54933.70397776146, 61292.0, 82763.0, 84419.0, 84436.57781711298, 85391.0, 7087.539309944837, 7952.880706789519, 8012.639431225492, 8216.589170541569, 8334.6666133354, 8863.64545418176, 10010.699679009642, 11360.091192704398, 12456.564020259248, 13253.734925301247, 6376.458001069961, 7598.848023039619, 7954.761357159295, 7989.880151797844, 8251.422400431911, 6593.80218593443, 6797.5581587196675, 7129.500934934505, 7381.372583330477, 8028.9197108028175, 7664.195259497896, 8163.959180204061, 8181.222783835764, 8216.46592971455, 8246.876296855671, 11863.822042669195, 11922.52309907594, 12363.88725014717, 12533.561325353568, 12540.49838006506, 11529.769404612029, 11856.992155666865, 12038.157328986887, 12043.976262017826, 12097.57658481949], "value": 9344.236108253443, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.0677792490067, 1533.2027345780195, 1551.6508785523256, 1745.816689247629, 1887.7829049659285, 7744.728934487294, 8430.199131082545, 8783.560821958892, 8795.95602021989, 8883.289336853053, 8675.436096653713, 8716.041235464094, 8737.689346598014, 8753.95623021884, 8757.12428757124, 2370.810335173186, 2382.9523409531885, 2383.797377222938, 2389.593769059264, 2390.8565486070893, 2321.4776675248017, 2368.159303447277, 2370.9288721338303, 2373.32360277321, 2374.5607062693457, 2340.871252081135, 2352.2120089769946, 2357.0, 2368.2539999900064, 2368.5144545368244, 2302.435903203726, 2328.2549584133085, 2331.405491599631, 2331.9972411862977, 2355.1286024170995, 2315.0, 2344.6248600224053, 2345.859248445082, 2347.8708671023087, 2350.882455877216, 8519.574021298973, 8647.827043459158, 8730.563471826446, 8748.343874209397, 8815.074417186168, 5159.922601160985, 5353.57171426285, 5356.892862142735, 5362.839114826562, 5373.328333958255, 3060.6480254770763, 3551.1299731565673, 3578.8568457261676, 3625.1843335249623, 3637.272545490886, 1066.1311031509294, 1085.3813326403954, 1096.9561217551288, 1103.4813637590319, 1110.7001109700416, 11282.379469129195, 11319.603813866557, 11411.48648310828, 11416.94291528537, 11419.200655954086, 3711.851525938986, 3857.9197824609155, 4333.783310834446, 4586.564276393738, 4594.471635761864, 7785.676435005949, 8982.730518084469, 9010.053944335881, 9013.324000699842, 9019.909800901907, 5133.358330208724, 5139.948600514022, 5155.046316431472, 5155.123628983082, 5160.587153027824, 4387.254166791653, 4555.157295900269, 4682.438107427062, 4808.831690890802, 4826.565609095198, 3095.65339077502, 3757.511523501982, 3833.3483307837732, 3869.3422118239405, 3883.37865941448, 1070.0797314309686, 1075.7740874416304, 1084.904246710812, 1084.9620263290747, 1085.2674444749762, 841.7794198412204, 857.566928701002, 899.3659470073583, 904.1681652879366, 943.3113826906259, 5636.126400407943, 5696.202531645573, 5962.314333851576, 5982.850428739229, 6032.698365081728, 782.8356045230565, 872.1104473437059, 943.1935694980692, 955.3455882720359, 988.9703308900745, 3684.8526058957877, 3918.8432462701744, 3925.941110883339, 4057.736247143926, 4069.308217603015, 8104.432689711663, 10353.896461035294, 10355.741106472398, 10359.015893490106, 10378.844317335246, 8728.25809806161, 10316.226283028653, 10333.328333658288, 10342.844857327145, 10365.9481702591, 7191.604461754549, 8094.757157285173, 8105.51366917975, 8153.103158652543, 8324.6670133194, 5874.441928016831, 5932.940670593239, 5968.253968253968, 6050.394960503914, 6142.723577438936, 9861.161801246973, 10159.593616255266, 10179.592816287563, 10195.0, 10212.693619191436, 9920.255980801325, 10177.134943529883, 10314.329568578018, 10317.638882639072, 10325.432101234204, 6960.269171736894, 7178.533395329287, 7180.640967951686, 7532.811679708051, 7704.845903081795, 7844.411669124953, 7856.292933636, 7942.166072562298, 7943.086545047394, 8134.959325203336, 7209.35115839577, 7546.056742907137, 7551.282628150317, 7633.503822251536, 7678.961605191938, 7275.717703349198, 7335.193128755725, 7377.299156580117, 7423.740169094056, 7551.207123252199, 6834.760783372757, 6995.195552511323, 7001.229864714775, 7002.369786719016, 7004.789856304319, 4930.186519224431, 4935.925961110514, 5015.097282489187, 5040.873978150576, 5145.819896303611, 4928.630352723489, 4951.8266860659705, 5112.514311140436, 5124.461931497139, 5214.634975551675], "value": 4498.160280701624, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.8080141897125, 289.67185454690247, 299.92501874531354, 315.59288517812024, 315.7931554831586, 4971.279164521142, 5002.949380630068, 5092.363454568179, 5099.634241400677, 5290.153575427932, 5071.782772134679, 5224.667709734022, 5236.345456817898, 5249.790008399669, 5289.867753306169, 3365.2428203654226, 3719.0330514066336, 4059.289624315748, 4064.227796718614, 4091.365838295069, 3346.6111563701033, 3730.2725968436166, 4061.8984525386804, 4096.996235922204, 4104.21466662003, 3344.933101337972, 3811.4473401356786, 4050.6354428101463, 4060.523080920636, 4085.22380747657, 3315.624016033343, 4015.6586690131376, 4040.1111755413763, 4058.3709525023373, 4063.817128229237, 2810.0, 2960.3635218427926, 2971.821690698565, 3572.321258960815, 3582.5700915889997, 4726.149293127236, 4870.245112007609, 5106.927545215509, 5201.385037399009, 5209.453007434203, 4097.795110244476, 4537.636989040869, 4596.977015114937, 4625.4911959684405, 4649.488556258809, 5497.151993604492, 5500.889982200373, 5548.750306236229, 5555.444455554452, 5559.972200139014, 3299.9835000825083, 3497.562804649419, 3735.4684579322347, 3919.8249417971533, 3932.980335098306, 4892.779824907852, 5758.88482230353, 5785.768569257225, 5800.9129863052085, 5841.422815839742, 3964.801759911993, 3971.332040542979, 3971.4439978403047, 3975.960240397559, 3988.74073185242, 3359.6304406515264, 3869.6517313441364, 4038.5153781545814, 4043.2317859606583, 4049.5140583130215, 3866.130120722815, 4209.642180414638, 4490.057088011554, 4619.284010978304, 4625.976870115628, 4349.391085248068, 4984.0, 5210.635255532076, 5578.470045345685, 5608.495235428831, 1128.5203788389902, 1135.4776802670865, 1327.794191900257, 1352.2765320553456, 1365.50841696989, 826.6156237349661, 901.9458832470073, 918.9386258871015, 925.8194652042922, 943.1323182671958, 4358.629516491071, 5062.898742025212, 5125.513076257749, 5127.025865085622, 5130.563902068291, 4779.545943135397, 5206.557442617344, 5620.4660557247, 5643.266375371176, 5653.321601407775, 4040.585794971795, 4065.4714887064492, 4155.771432571238, 4512.751798651106, 5095.770690318945, 2087.6242276390394, 2270.5685919675207, 2423.793977511931, 2526.393665520299, 2544.440223150904, 4276.230278549829, 4446.421965144576, 4957.380327459067, 4963.808685915426, 4985.651004429727, 4195.321871251463, 4800.3279540864305, 4840.75796210188, 4867.951320486821, 4874.268859671078, 5058.595312375075, 5368.778732760313, 5692.003899317603, 6059.7273122709585, 6064.0, 4887.731174785279, 5821.94178058214, 5842.883142337215, 5846.619969701956, 5850.619709719025, 5016.698998059982, 5409.7024663642305, 5571.08077167279, 5667.914981275202, 5710.685912274865, 6043.7884674036195, 6058.545609079425, 6069.666168360783, 6085.2393450818645, 6087.695615219132, 3404.2170300830453, 3740.3641380965846, 3905.1408690088133, 3922.8626998054933, 3942.0, 4153.8961525962095, 5308.548773354154, 5444.8366549003595, 5466.037123085731, 5766.481016708516, 5445.59158063139, 5473.8378340556055, 5493.395726470165, 5516.503514683698, 5551.944480555143, 4916.778744956414, 5646.3788983212635, 5649.406812284816, 5665.5157078397315, 5689.004424225826, 4831.70494015354, 5001.24981252815, 5099.643024988215, 5293.497117773805, 5514.531264842533, 4696.8121275148615, 5664.252837373952, 5665.745041473061, 5698.0, 5719.170720245625, 4632.953670463252, 5052.343195384577, 5517.344796561096, 5554.000839546761, 5561.249231353715], "value": 3962.4704416788973, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.236987868163, 717.4977515738981, 763.3625922354834, 763.7779552715652, 821.9383546234033, 14175.574732758021, 16458.506244812645, 16461.423850165233, 16477.67044659109, 16496.42262520812, 12389.62831115068, 14591.197484138369, 14912.105273683586, 14913.105213687186, 14951.252437378142, 680.5100327764027, 698.0227681246245, 823.8681810910241, 839.4459656626627, 861.4960248254747, 844.6579135450122, 863.4215075899162, 865.1607940297932, 867.7310033889482, 868.0, 917.0050495212702, 920.7375897869109, 921.6589861751162, 922.4142669404943, 924.5100096948628, 731.1591669580025, 754.1402800807084, 757.307064036406, 910.0489987962562, 916.3722849847876, 556.7160748018499, 558.3969313141797, 652.7062821730241, 670.5038271678972, 671.4326394196896, 15012.774808377882, 15081.54755357341, 15084.849151508453, 15100.622484437978, 15123.924380378137, 13911.930440347733, 14177.645558861008, 14213.431462741479, 14213.93395495342, 14284.857151428456, 12635.11554191207, 12807.231566106064, 12827.358632068452, 13072.673183170402, 13389.330533473385, 4563.7489938053395, 4574.359589657417, 4647.18674232008, 4724.338592597039, 4737.265723812815, 112604.0, 114186.0, 114534.0, 114657.0, 115321.42339288334, 9434.245260379153, 11068.059214966817, 11097.667069987914, 11177.0, 11694.239874408137, 21821.127154913625, 21936.561268774534, 22002.0, 22033.889830550746, 22077.558448830932, 7931.881021784678, 7933.761987140395, 7941.0, 7962.044554653478, 8208.876866847002, 3737.7757334560015, 4411.7573533455325, 4433.844815431445, 4494.011317510208, 4535.047639995571, 3470.236547959445, 3579.856805727794, 3581.068922080278, 3595.1551385424405, 3597.9100522487147, 702.64516419209, 729.2160927003492, 746.7349091072699, 746.8356961468468, 749.1010787055556, 610.4749915073033, 655.7999810057978, 655.8327626455318, 685.7874059041714, 686.193722376206, 8863.202311791969, 9516.571754270935, 9692.127708506268, 9762.17021553176, 9909.950450247703, 568.4060157135802, 622.6326467384265, 624.3880996623335, 669.1024780652717, 680.7379159023712, 4163.666906647461, 4770.570648641569, 4781.330613714083, 4784.2823576463115, 4786.64100192487, 105018.0, 141601.0, 145234.0, 165722.0, 165726.0, 108241.45879270553, 140324.0, 141075.0, 142060.28969855086, 144987.0, 114918.42540787242, 119184.8081519191, 122646.0, 123550.0, 126626.10060849095, 8991.595378207865, 9050.864237036318, 9100.954495227481, 9128.543572821465, 9205.447673139633, 55233.72383138059, 67573.66213168902, 67709.0, 68975.0, 71716.0, 97623.0, 98513.52229716416, 100300.0, 100919.98160036905, 101042.0, 12048.75902481963, 12293.508259669514, 12328.691782705504, 12430.440630171483, 12485.058570404219, 13463.0, 13487.258200798658, 13493.865061349261, 13648.969889064898, 14009.579712608638, 12230.510779568718, 12319.815202771786, 12402.13185077036, 12498.43757030954, 12906.225626462443, 10385.63650272237, 12326.322052286852, 12346.567870124503, 12673.366331683563, 13079.869201308245, 11874.940625296818, 12049.518019279481, 12101.805829607754, 12139.332336721212, 12184.75630487403, 10096.444695541815, 10412.219083568914, 10635.840462392916, 10878.945605271923, 11010.284331518425, 9141.680041198526, 10702.411367374869, 10912.072473839495, 10914.836277455686, 11367.715807104889], "value": 7844.245142233631, "unit": "score"}], "name": "dromaeo_css", "value": 7298.499737424631, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 112.0, 112.0, 112.0, 114.0, 111.0, 112.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 140.0, 161.0, 146.0, 108.0, 136.0, 129.0, 108.0, 163.0, 109.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 221.0, 196.0, 266.0, 185.0, 181.0, 183.0, 184.0, 184.0], "value": 197.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 60.0, 59.0, 108.0, 72.0, 84.0, 87.0, 72.0, 85.0, 57.0], "value": 76.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 93.0, 71.0, 76.0, 92.0, 130.0, 95.0, 53.0, 110.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 85.0, 87.0, 84.0, 89.0, 85.0, 89.0, 89.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 93.0, 94.0, 94.0, 94.0, 96.0, 95.0, 94.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 85.0, 86.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 53.0, 52.0, 53.0, 52.0, 53.0, 53.0, 52.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 83.0, 76.0, 73.0, 70.0, 71.0, 70.0, 71.0, 70.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 87.0, 85.0, 85.0, 86.0, 83.0, 94.0, 103.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 145.0, 141.0, 137.0, 137.0, 132.0, 128.0, 147.0, 149.0, 138.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 166.0, 166.0, 165.0, 167.0, 165.0, 164.0, 165.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 69.0, 65.0, 66.0, 67.0, 67.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1458.3, "alertThreshold": 2.0}]} 13:38:22 INFO - Return code: 0 13:38:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:38:22 INFO - # TBPL SUCCESS # 13:38:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:38:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:38:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:38:22 INFO - 2016-08-05 13:38:22.629 screenresolution[1801:9961] starting screenresolution argv=screenresolution get 13:38:22 INFO - 2016-08-05 13:38:22.632 screenresolution[1801:9961] Display 0: 1600x1200x32@60 13:38:22 INFO - 2016-08-05 13:38:22.638 screenresolution[1802:9964] starting screenresolution argv=screenresolution list 13:38:22 INFO - Available Modes on Display 0 13:38:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:38:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:38:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:38:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:38:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:38:22 INFO - Intel Iris: 13:38:22 INFO - Chipset Model: Intel Iris 13:38:22 INFO - Type: GPU 13:38:22 INFO - Bus: Built-In 13:38:22 INFO - VRAM (Dynamic, Max): 1536 MB 13:38:22 INFO - Vendor: Intel (0x8086) 13:38:22 INFO - Device ID: 0x0a2e 13:38:22 INFO - Revision ID: 0x0009 13:38:22 INFO - Displays: 13:38:22 INFO - Display: 13:38:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:38:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:38:22 INFO - Display Serial Number: 1600x1200 60 13:38:22 INFO - Main Display: Yes 13:38:22 INFO - Mirror: Off 13:38:22 INFO - Online: Yes 13:38:22 INFO - Rotation: Supported 13:38:22 INFO - Return code: 0 13:38:22 INFO - Running post-action listener: _resource_record_post_action 13:38:22 INFO - [mozharness: 2016-08-05 20:38:22.870902Z] Finished run-tests step (success) 13:38:22 INFO - Running post-run listener: _resource_record_post_run 13:38:22 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 37114880; Write bytes: 707400704; Read time: 244; Write time: 2039 13:38:22 INFO - TinderboxPrint: CPU usage
53.3% 13:38:22 INFO - TinderboxPrint: I/O read bytes / time
37,114,880 / 244 13:38:22 INFO - TinderboxPrint: I/O write bytes / time
707,400,704 / 2,039 13:38:22 INFO - TinderboxPrint: CPU idle
2,264.1 (46.7%) 13:38:22 INFO - TinderboxPrint: CPU system
968.4 (20.0%) 13:38:22 INFO - TinderboxPrint: CPU user
1,617.1 (33.3%) 13:38:22 INFO - TinderboxPrint: Swap in / out
441,200,640 / 0 13:38:22 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400151040; Write bytes: 395364352; Read time: 29711; Write time: 825 13:38:22 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 34980864; Write bytes: 298105856; Read time: 222; Write time: 1175 13:38:23 INFO - Running post-run listener: _upload_blobber_files 13:38:23 INFO - Blob upload gear active. 13:38:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:38:23 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 13:38:23 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'] 13:38:23 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 13:38:23 INFO - (blobuploader) - INFO - Open directory for files ... 13:38:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:38:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:38:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:24 INFO - (blobuploader) - INFO - Done attempting. 13:38:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:38:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:38:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:28 INFO - (blobuploader) - INFO - Done attempting. 13:38:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:38:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:38:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:30 INFO - (blobuploader) - INFO - Done attempting. 13:38:30 INFO - (blobuploader) - INFO - Iteration through files over. 13:38:30 INFO - Return code: 0 13:38:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:38:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:38:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf3bdaf02b064274d356cb65d174675190f1402208c2ad3ed718e0480687acf5f26a71d69f52cf65ab0cadc2a70e9ce937af88761d24245712f81bce705e3e51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/982d8366ed3f09170546615dc87ddbd6ad847b006d94b33190c2d63ac518d853af9f464496a60763737cf86d625ef599b490b14e7ea8751b272b7036af99b390", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07e67e3fb0ecfe38756a24216d1aa7e7dc5116985c018bd72fb646ca5322a346f6700d5cd9ec5a506d3f25652a5b565a78d75d8efdfa7f21166a80571753ce56"} 13:38:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:38:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:38:30 INFO - Contents: 13:38:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf3bdaf02b064274d356cb65d174675190f1402208c2ad3ed718e0480687acf5f26a71d69f52cf65ab0cadc2a70e9ce937af88761d24245712f81bce705e3e51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/982d8366ed3f09170546615dc87ddbd6ad847b006d94b33190c2d63ac518d853af9f464496a60763737cf86d625ef599b490b14e7ea8751b272b7036af99b390", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07e67e3fb0ecfe38756a24216d1aa7e7dc5116985c018bd72fb646ca5322a346f6700d5cd9ec5a506d3f25652a5b565a78d75d8efdfa7f21166a80571753ce56"} 13:38:30 INFO - Running post-run listener: copy_logs_to_upload_dir 13:38:30 INFO - Copying logs to upload dir... 13:38:30 INFO - mkdir: /builds/slave/test/build/upload/logs 13:38:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.432995 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-05 13:38:30.904988) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:30.908948) ========= 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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf3bdaf02b064274d356cb65d174675190f1402208c2ad3ed718e0480687acf5f26a71d69f52cf65ab0cadc2a70e9ce937af88761d24245712f81bce705e3e51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/982d8366ed3f09170546615dc87ddbd6ad847b006d94b33190c2d63ac518d853af9f464496a60763737cf86d625ef599b490b14e7ea8751b272b7036af99b390", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07e67e3fb0ecfe38756a24216d1aa7e7dc5116985c018bd72fb646ca5322a346f6700d5cd9ec5a506d3f25652a5b565a78d75d8efdfa7f21166a80571753ce56"} build_url:https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010931 build_url: 'https://queue.taskcluster.net/v1/task/H2oMvlZxSkuI-seuzaIwww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf3bdaf02b064274d356cb65d174675190f1402208c2ad3ed718e0480687acf5f26a71d69f52cf65ab0cadc2a70e9ce937af88761d24245712f81bce705e3e51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/982d8366ed3f09170546615dc87ddbd6ad847b006d94b33190c2d63ac518d853af9f464496a60763737cf86d625ef599b490b14e7ea8751b272b7036af99b390", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07e67e3fb0ecfe38756a24216d1aa7e7dc5116985c018bd72fb646ca5322a346f6700d5cd9ec5a506d3f25652a5b565a78d75d8efdfa7f21166a80571753ce56"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:30.945784) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:30.946603) ========= 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.NQ6D3VztYn/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.FzQiKW2zK0/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.005170 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 13:38:30.999942) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 13:38:31.000673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 13:38:31.001543) ========= ========= Total master_lag: 0.20 =========