builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0212 starttime: 1494243651.91 results: success (0) buildid: 20170508030204 builduid: a95453a0ce9d4466ae17094c04997ca8 revision: 1fda52a1f3b81cf1a821155998dca637bb64e3d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 04:40:51.911641) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 04:40:51.912165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 04:40:51.912513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 04:40:51.940502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 04:40:51.940918) ========= 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.okRV1aHr3W/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.IgSq6uH11o/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 --2017-05-08 04:40:51-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2017-05-08 04:40:52 (18.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163310 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 04:40:52.130513) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 04:40:52.130933) ========= 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.okRV1aHr3W/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.IgSq6uH11o/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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.025892 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 04:40:52.181184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 04:40:52.181652) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1fda52a1f3b81cf1a821155998dca637bb64e3d9 --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 1fda52a1f3b81cf1a821155998dca637bb64e3d9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.okRV1aHr3W/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.IgSq6uH11o/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 2017-05-08 04:40:52,293 truncating revision to first 12 chars 2017-05-08 04:40:52,293 Setting DEBUG logging. 2017-05-08 04:40:52,293 attempt 1/10 2017-05-08 04:40:52,293 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1fda52a1f3b8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-08 04:40:52,558 unpacking tar archive at: mozilla-central-1fda52a1f3b8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542078 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 04:40:52.749357) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 04:40:52.749724) ========= script_repo_revision: 1fda52a1f3b81cf1a821155998dca637bb64e3d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 04:40:52.750156) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 04:40:52.750482) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 04:40:52.771344) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-05-08 04:40:52.771835) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.okRV1aHr3W/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.IgSq6uH11o/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:40:52 INFO - MultiFileLogger online at 20170508 04:40:52 in /builds/slave/test 04:40:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:40:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:40:52 INFO - {'append_to_log': False, 04:40:52 INFO - 'base_work_dir': '/builds/slave/test', 04:40:52 INFO - 'blob_upload_branch': 'Firefox', 04:40:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:40:52 INFO - 'branch': 'Firefox', 04:40:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:40:52 INFO - 'config_files': ('talos/mac_config.py',), 04:40:52 INFO - 'default_actions': ('clobber', 04:40:52 INFO - 'read-buildbot-config', 04:40:52 INFO - 'download-and-extract', 04:40:52 INFO - 'populate-webroot', 04:40:52 INFO - 'create-virtualenv', 04:40:52 INFO - 'install', 04:40:52 INFO - 'run-tests'), 04:40:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:40:52 INFO - 'download_minidump_stackwalk': True, 04:40:52 INFO - 'download_symbols': 'ondemand', 04:40:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:40:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:40:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:40:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:40:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:40:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:40:52 INFO - 'gecko_profile': False, 04:40:52 INFO - 'gecko_profile_interval': 0, 04:40:52 INFO - 'installer_path': 'installer.exe', 04:40:52 INFO - 'log_level': 'info', 04:40:52 INFO - 'log_name': 'talos', 04:40:52 INFO - 'log_to_console': True, 04:40:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:40:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:40:52 INFO - 'opt_config_files': (), 04:40:52 INFO - 'pip_index': False, 04:40:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:40:52 INFO - 'cmd': ('bash', 04:40:52 INFO - '-c', 04:40:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:40:52 INFO - 'enabled': True, 04:40:52 INFO - 'halt_on_failure': False, 04:40:52 INFO - 'name': 'check_screen_resolution'},), 04:40:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:40:52 INFO - 'cmd': ('bash', 04:40:52 INFO - '-c', 04:40:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:40:52 INFO - 'enabled': True, 04:40:52 INFO - 'halt_on_failure': False, 04:40:52 INFO - 'name': 'check_screen_resolution'},), 04:40:52 INFO - 'run_cmd_checks_enabled': True, 04:40:52 INFO - 'suite': 'dromaeojs-e10s', 04:40:52 INFO - 'system_bits': '32', 04:40:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:40:52 INFO - 'title': 't-yosemite-r7-0212', 04:40:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:40:52 INFO - 'use_talos_json': True, 04:40:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:40:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:40:52 INFO - 'work_dir': 'build'} 04:40:52 INFO - [mozharness: 2017-05-08 11:40:52.989228Z] Running clobber step. 04:40:52 INFO - Running pre-action listener: _resource_record_pre_action 04:40:52 INFO - Running main action method: clobber 04:40:52 INFO - rmtree: /builds/slave/test/build 04:40:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:40:55 INFO - Running post-action listener: _resource_record_post_action 04:40:55 INFO - [mozharness: 2017-05-08 11:40:55.371610Z] Finished clobber step (success) 04:40:55 INFO - [mozharness: 2017-05-08 11:40:55.371745Z] Running read-buildbot-config step. 04:40:55 INFO - Running pre-action listener: _resource_record_pre_action 04:40:55 INFO - Running main action method: read_buildbot_config 04:40:55 INFO - Using buildbot properties: 04:40:55 INFO - { 04:40:55 INFO - "project": "", 04:40:55 INFO - "product": "firefox", 04:40:55 INFO - "script_repo_revision": "production", 04:40:55 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:40:55 INFO - "repository": "", 04:40:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:40:55 INFO - "buildid": "20170508030204", 04:40:55 INFO - "stage_platform": "macosx64", 04:40:55 INFO - "basedir": "/builds/slave/test", 04:40:55 INFO - "nightly_build": "True", 04:40:55 INFO - "buildnumber": 66, 04:40:55 INFO - "slavename": "t-yosemite-r7-0212", 04:40:55 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:40:55 INFO - "platform": "yosemite_r7", 04:40:55 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:40:55 INFO - "branch": "mozilla-central", 04:40:55 INFO - "repo_path": "mozilla-central", 04:40:55 INFO - "revision": "1fda52a1f3b81cf1a821155998dca637bb64e3d9", 04:40:55 INFO - "pgo_build": "False", 04:40:55 INFO - "builduid": "a95453a0ce9d4466ae17094c04997ca8", 04:40:55 INFO - "slavebuilddir": "test" 04:40:55 INFO - } 04:40:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:40:55 INFO - Running post-action listener: _resource_record_post_action 04:40:55 INFO - [mozharness: 2017-05-08 11:40:55.375328Z] Finished read-buildbot-config step (success) 04:40:55 INFO - [mozharness: 2017-05-08 11:40:55.375468Z] Running download-and-extract step. 04:40:55 INFO - Running pre-action listener: _resource_record_pre_action 04:40:55 INFO - Running main action method: download_and_extract 04:40:55 INFO - mkdir: /builds/slave/test/build/tests 04:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:55 INFO - trying https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:40:55 INFO - Downloading https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:40:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:40:56 INFO - Downloaded 1325 bytes. 04:40:56 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:40:56 INFO - Using the following test package requirements: 04:40:56 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:56 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:40:56 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:40:56 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:56 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:40:56 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:56 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:40:56 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:56 INFO - u'jsshell-mac.zip'], 04:40:56 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:56 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:40:56 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:40:56 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:56 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:40:56 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:56 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:40:56 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:56 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:40:56 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:56 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:40:56 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:40:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:40:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:40:56 INFO - Fetch https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:40:58 INFO - Content-Length response header: 52706468 04:40:58 INFO - Bytes received: 52706468 04:41:14 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:41:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:41:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:41:14 INFO - Fetch https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:41:16 INFO - Content-Length response header: 52706468 04:41:16 INFO - Bytes received: 52706468 04:41:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:41:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:41:32 INFO - Fetch https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:41:32 INFO - Content-Length response header: 14409362 04:41:32 INFO - Bytes received: 14409362 04:41: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')]} 04:41:33 INFO - trying https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:41:33 INFO - Downloading https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:41:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:41:35 INFO - Downloaded 71009074 bytes. 04:41:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:41:35 INFO - mkdir: /builds/slave/test/properties 04:41:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:41:35 INFO - Writing to file /builds/slave/test/properties/build_url 04:41:35 INFO - Contents: 04:41:35 INFO - build_url:https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:41:36 INFO - Running post-action listener: _resource_record_post_action 04:41:36 INFO - Running post-action listener: set_extra_try_arguments 04:41:36 INFO - [mozharness: 2017-05-08 11:41:36.398411Z] Finished download-and-extract step (success) 04:41:36 INFO - [mozharness: 2017-05-08 11:41:36.398585Z] Running populate-webroot step. 04:41:36 INFO - Running pre-action listener: _resource_record_pre_action 04:41:36 INFO - Running main action method: populate_webroot 04:41:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:41:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:41:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:41:36 INFO - '--tppagecycles', 04:41:36 INFO - '7'], 04:41:36 INFO - 'tests': ['tsvgm']}}, 04:41:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:41:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:41:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:41:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:41:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:41:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:41:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:41:36 INFO - 'talos_options': ['--disable-e10s'], 04:41:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:41:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:41:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:41:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:41:36 INFO - 'talos_options': ['--disable-e10s'], 04:41:36 INFO - 'tests': ['damp', 'tps']}, 04:41:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:41:36 INFO - 'tests': ['damp', 'tps']}, 04:41:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:41:36 INFO - 'tests': ['dromaeo_dom']}, 04:41:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:41:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:41:36 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:41:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:41:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:41:36 INFO - 'tests': ['a11yr', 04:41:36 INFO - 'ts_paint', 04:41:36 INFO - 'tpaint', 04:41:36 INFO - 'sessionrestore', 04:41:36 INFO - 'sessionrestore_no_auto_restore', 04:41:36 INFO - 'tabpaint']}, 04:41:36 INFO - 'other-e10s': {'tests': ['a11yr', 04:41:36 INFO - 'ts_paint', 04:41:36 INFO - 'tpaint', 04:41:36 INFO - 'sessionrestore', 04:41:36 INFO - 'sessionrestore_no_auto_restore', 04:41:36 INFO - 'tabpaint']}, 04:41:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:41:36 INFO - 'ts_paint', 04:41:36 INFO - 'tpaint', 04:41:36 INFO - 'sessionrestore', 04:41:36 INFO - 'sessionrestore_no_auto_restore', 04:41:36 INFO - 'tabpaint']}, 04:41:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:41:36 INFO - 'ts_paint', 04:41:36 INFO - 'tpaint', 04:41:36 INFO - 'sessionrestore', 04:41:36 INFO - 'sessionrestore_no_auto_restore', 04:41:36 INFO - 'tabpaint']}, 04:41:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:41:36 INFO - 'tests': ['a11yr', 04:41:36 INFO - 'ts_paint', 04:41:36 INFO - 'tpaint', 04:41:36 INFO - 'sessionrestore', 04:41:36 INFO - 'sessionrestore_no_auto_restore', 04:41:36 INFO - 'tabpaint']}, 04:41:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:41:36 INFO - 'tests': ['a11yr', 04:41:36 INFO - 'ts_paint', 04:41:36 INFO - 'tpaint', 04:41:36 INFO - 'sessionrestore', 04:41:36 INFO - 'sessionrestore_no_auto_restore', 04:41:36 INFO - 'tabpaint']}, 04:41:36 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:41:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:41:36 INFO - 'bloom_basic_ref']}, 04:41:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:41:36 INFO - 'tests': ['tsvgx', 04:41:36 INFO - 'tsvgr_opacity', 04:41:36 INFO - 'tart', 04:41:36 INFO - 'tscrollx', 04:41:36 INFO - 'cart', 04:41:36 INFO - 'tsvg_static']}, 04:41:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:41:36 INFO - 'tsvgr_opacity', 04:41:36 INFO - 'tart', 04:41:36 INFO - 'tscrollx', 04:41:36 INFO - 'cart', 04:41:36 INFO - 'tsvg_static']}, 04:41:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:41:36 INFO - 'talos_options': ['--disable-e10s'], 04:41:36 INFO - 'tests': ['tp5o']}, 04:41:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:41:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:41:36 INFO - 'talos_options': ['--disable-e10s', 04:41:36 INFO - '--xperf_path', 04:41:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:41:36 INFO - 'tests': ['tp5n']}, 04:41:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:41:36 INFO - 'talos_options': ['--xperf_path', 04:41:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:41:36 INFO - 'tests': ['tp5n']}}, 04:41:36 INFO - 'talos.zip': {'path': '', 04:41:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:41:36 INFO - Running post-action listener: _resource_record_post_action 04:41:36 INFO - [mozharness: 2017-05-08 11:41:36.418102Z] Finished populate-webroot step (success) 04:41:36 INFO - [mozharness: 2017-05-08 11:41:36.418206Z] Running create-virtualenv step. 04:41:36 INFO - Running pre-action listener: _resource_record_pre_action 04:41:36 INFO - Running main action method: create_virtualenv 04:41:36 INFO - Creating virtualenv /builds/slave/test/build/venv 04:41:36 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 04:41:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:41:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:41:36 INFO - Using real prefix '/tools/python27' 04:41:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:41:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:41:40 INFO - Installing pip.................done. 04:41:40 INFO - Return code: 0 04:41:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:41:40 INFO - Reading from file tmpfile_stdout 04:41:40 INFO - Output received: 04:41:40 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:41:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103be4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103be7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c9db27a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038f5d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038e9be8>, '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.okRV1aHr3W/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.IgSq6uH11o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:41:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:41:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.okRV1aHr3W/Render', 04:41:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:40 INFO - 'HOME': '/Users/cltbld', 04:41:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:40 INFO - 'LOGNAME': 'cltbld', 04:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:40 INFO - 'MOZ_NO_REMOTE': '1', 04:41:40 INFO - 'NO_EM_RESTART': '1', 04:41:40 INFO - 'PAGER': '/bin/cat', 04:41:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:40 INFO - 'PWD': '/builds/slave/test', 04:41:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:40 INFO - 'SHELL': '/bin/bash', 04:41:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IgSq6uH11o/Listeners', 04:41:40 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:41:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:40 INFO - 'USER': 'cltbld', 04:41:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:40 INFO - 'XPC_FLAGS': '0x0', 04:41:40 INFO - 'XPC_SERVICE_NAME': '0', 04:41:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:40 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 04:41:40 INFO - Cleaning up... 04:41:40 INFO - Return code: 0 04:41:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103be4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103be7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c9db27a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038f5d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038e9be8>, '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.okRV1aHr3W/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.IgSq6uH11o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:41:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:41:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.okRV1aHr3W/Render', 04:41:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:40 INFO - 'HOME': '/Users/cltbld', 04:41:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:40 INFO - 'LOGNAME': 'cltbld', 04:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:40 INFO - 'MOZ_NO_REMOTE': '1', 04:41:40 INFO - 'NO_EM_RESTART': '1', 04:41:40 INFO - 'PAGER': '/bin/cat', 04:41:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:40 INFO - 'PWD': '/builds/slave/test', 04:41:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:40 INFO - 'SHELL': '/bin/bash', 04:41:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IgSq6uH11o/Listeners', 04:41:40 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:41:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:40 INFO - 'USER': 'cltbld', 04:41:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:40 INFO - 'XPC_FLAGS': '0x0', 04:41:40 INFO - 'XPC_SERVICE_NAME': '0', 04:41:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:41 INFO - Downloading/unpacking psutil>=3.1.1 04:41:41 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 04:41:41 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 04:41:41 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 04:41:41 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 04:41:41 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 04:41:41 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 04:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:41:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:41:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:41:43 INFO - Installing collected packages: psutil 04:41:43 INFO - Running setup.py install for psutil 04:41:43 INFO - building 'psutil._psutil_osx' extension 04:41:43 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 04:41:44 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 04:41:44 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 04:41:44 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 04:41:44 INFO - building 'psutil._psutil_posix' extension 04:41:44 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 04:41:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:41:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:41:44 INFO - ^ 04:41:44 INFO - 1 warning generated. 04:41:44 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 04:41:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:41:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:41:44 INFO - Successfully installed psutil 04:41:44 INFO - Cleaning up... 04:41:44 INFO - Return code: 0 04:41:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:41: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')]} 04:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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')]} 04:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103be4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103be7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c9db27a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038f5d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038e9be8>, '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.okRV1aHr3W/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.IgSq6uH11o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:41:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:41:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:41:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.okRV1aHr3W/Render', 04:41:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:44 INFO - 'HOME': '/Users/cltbld', 04:41:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:44 INFO - 'LOGNAME': 'cltbld', 04:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:44 INFO - 'MOZ_NO_REMOTE': '1', 04:41:44 INFO - 'NO_EM_RESTART': '1', 04:41:44 INFO - 'PAGER': '/bin/cat', 04:41:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:44 INFO - 'PWD': '/builds/slave/test', 04:41:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:44 INFO - 'SHELL': '/bin/bash', 04:41:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IgSq6uH11o/Listeners', 04:41:44 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:41:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:44 INFO - 'USER': 'cltbld', 04:41:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:44 INFO - 'XPC_FLAGS': '0x0', 04:41:44 INFO - 'XPC_SERVICE_NAME': '0', 04:41:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:41:46 INFO - Installing collected packages: mozsystemmonitor 04:41:46 INFO - Running setup.py install for mozsystemmonitor 04:41:46 INFO - Successfully installed mozsystemmonitor 04:41:46 INFO - Cleaning up... 04:41:46 INFO - Return code: 0 04:41:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:41:46 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')]} 04:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:46 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')]} 04:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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', '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 0x103be4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103be7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c9db27a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038f5d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038e9be8>, '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.okRV1aHr3W/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.IgSq6uH11o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:41: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:41: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 jsonschema==2.5.1 04:41:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.okRV1aHr3W/Render', 04:41:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:47 INFO - 'HOME': '/Users/cltbld', 04:41:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:47 INFO - 'LOGNAME': 'cltbld', 04:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:47 INFO - 'MOZ_NO_REMOTE': '1', 04:41:47 INFO - 'NO_EM_RESTART': '1', 04:41:47 INFO - 'PAGER': '/bin/cat', 04:41:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:47 INFO - 'PWD': '/builds/slave/test', 04:41:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:47 INFO - 'SHELL': '/bin/bash', 04:41:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IgSq6uH11o/Listeners', 04:41:47 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:41:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:47 INFO - 'USER': 'cltbld', 04:41:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:47 INFO - 'XPC_FLAGS': '0x0', 04:41:47 INFO - 'XPC_SERVICE_NAME': '0', 04:41:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:47 INFO - Downloading/unpacking jsonschema==2.5.1 04:41: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 04:41: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 04:41: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 04:41: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 04:41: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 04:41: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 04:41:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:41:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:41:49 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 04:41:49 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 04:41:49 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 04:41:49 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 04:41:49 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 04:41:49 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 04:41:49 INFO - Downloading functools32-3.2.3-2.tar.gz 04:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:41:49 INFO - warning: no files found matching '*.txt' 04:41:49 INFO - no previously-included directories found matching 'build' 04:41:49 INFO - no previously-included directories found matching 'dist' 04:41:49 INFO - no previously-included directories found matching '.git*' 04:41:49 INFO - Installing collected packages: jsonschema, functools32 04:41:49 INFO - Running setup.py install for functools32 04:41:49 INFO - warning: no files found matching '*.txt' 04:41:49 INFO - no previously-included directories found matching 'build' 04:41:49 INFO - no previously-included directories found matching 'dist' 04:41:49 INFO - no previously-included directories found matching '.git*' 04:41:49 INFO - Successfully installed jsonschema functools32 04:41:49 INFO - Cleaning up... 04:41:49 INFO - Return code: 0 04:41:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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')]} 04:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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', '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 0x103be4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103be7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c9db27a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038f5d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038e9be8>, '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.okRV1aHr3W/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.IgSq6uH11o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:41: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:41: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 functools32==3.2.3-2 04:41:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.okRV1aHr3W/Render', 04:41:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:50 INFO - 'HOME': '/Users/cltbld', 04:41:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:50 INFO - 'LOGNAME': 'cltbld', 04:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:50 INFO - 'MOZ_NO_REMOTE': '1', 04:41:50 INFO - 'NO_EM_RESTART': '1', 04:41:50 INFO - 'PAGER': '/bin/cat', 04:41:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:50 INFO - 'PWD': '/builds/slave/test', 04:41:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:50 INFO - 'SHELL': '/bin/bash', 04:41:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IgSq6uH11o/Listeners', 04:41:50 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:41:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:50 INFO - 'USER': 'cltbld', 04:41:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:50 INFO - 'XPC_FLAGS': '0x0', 04:41:50 INFO - 'XPC_SERVICE_NAME': '0', 04:41:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:41:50 INFO - Cleaning up... 04:41:50 INFO - Return code: 0 04:41:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:41: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')]} 04:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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')]} 04:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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', '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 0x103be4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103be7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c9db27a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038f5d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038e9be8>, '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.okRV1aHr3W/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.IgSq6uH11o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:41: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:41: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 blobuploader==1.2.4 04:41:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.okRV1aHr3W/Render', 04:41:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:50 INFO - 'HOME': '/Users/cltbld', 04:41:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:50 INFO - 'LOGNAME': 'cltbld', 04:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:50 INFO - 'MOZ_NO_REMOTE': '1', 04:41:50 INFO - 'NO_EM_RESTART': '1', 04:41:50 INFO - 'PAGER': '/bin/cat', 04:41:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:50 INFO - 'PWD': '/builds/slave/test', 04:41:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:50 INFO - 'SHELL': '/bin/bash', 04:41:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IgSq6uH11o/Listeners', 04:41:50 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:41:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:50 INFO - 'USER': 'cltbld', 04:41:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:50 INFO - 'XPC_FLAGS': '0x0', 04:41:50 INFO - 'XPC_SERVICE_NAME': '0', 04:41:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:50 INFO - Downloading/unpacking blobuploader==1.2.4 04:41: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 04:41: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 04:41: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 04:41: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 04:41: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 04:41: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 04:41:52 INFO - Downloading blobuploader-1.2.4.tar.gz 04:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:41:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:41: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 04:41: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 04:41: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 04:41: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 04:41: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 04:41: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 04:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:41:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:41: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 04:41: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 04:41: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 04:41: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 04:41: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 04:41: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 04:41:53 INFO - Downloading docopt-0.6.1.tar.gz 04:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:41:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:41:53 INFO - Running setup.py install for blobuploader 04:41:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:41:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:41:53 INFO - Running setup.py install for requests 04:41:53 INFO - Running setup.py install for docopt 04:41:53 INFO - Successfully installed blobuploader requests docopt 04:41:53 INFO - Cleaning up... 04:41:54 INFO - Return code: 0 04:41:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:54 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 0x103be4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103be7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c9db27a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038f5d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038e9be8>, '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.okRV1aHr3W/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.IgSq6uH11o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:41:54 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 04:41:54 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 04:41:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.okRV1aHr3W/Render', 04:41:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:54 INFO - 'HOME': '/Users/cltbld', 04:41:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:54 INFO - 'LOGNAME': 'cltbld', 04:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:54 INFO - 'MOZ_NO_REMOTE': '1', 04:41:54 INFO - 'NO_EM_RESTART': '1', 04:41:54 INFO - 'PAGER': '/bin/cat', 04:41:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:54 INFO - 'PWD': '/builds/slave/test', 04:41:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:54 INFO - 'SHELL': '/bin/bash', 04:41:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IgSq6uH11o/Listeners', 04:41:54 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:41:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:54 INFO - 'USER': 'cltbld', 04:41:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:54 INFO - 'XPC_FLAGS': '0x0', 04:41:54 INFO - 'XPC_SERVICE_NAME': '0', 04:41:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:41:54 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-9MAlh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:41:54 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-380ZOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:41:54 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-p3wpaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:41:54 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-QxgYCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:41:54 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-8dcVms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:41:54 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-E6Ek6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:41:54 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-pBNXfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:41:55 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-ckxmOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:41:55 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-y5Ccpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:41:55 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-R8Zknv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:41:55 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-JraOT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:41:55 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-7f3ENQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:41:55 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-xKXS1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:41:55 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-CyvsOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:55 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-d_KqPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:41:55 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-vjQMHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:41:56 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-WkXlzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:41:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:41:56 INFO - Running setup.py install for manifestparser 04:41:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:41:56 INFO - Running setup.py install for mozcrash 04:41:56 INFO - Running setup.py install for mozdebug 04:41:56 INFO - Running setup.py install for mozdevice 04:41:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:41:56 INFO - Running setup.py install for mozfile 04:41:56 INFO - Running setup.py install for mozhttpd 04:41:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:41:56 INFO - Running setup.py install for mozinfo 04:41:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:41:57 INFO - Running setup.py install for mozInstall 04:41:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:41:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:41:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:41:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:41:57 INFO - Running setup.py install for mozleak 04:41:57 INFO - Running setup.py install for mozlog 04:41:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:41:57 INFO - Running setup.py install for moznetwork 04:41:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:41:57 INFO - Running setup.py install for mozprocess 04:41:57 INFO - Running setup.py install for mozprofile 04:41:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:41:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:41:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:41:58 INFO - Running setup.py install for mozrunner 04:41:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:41:58 INFO - Running setup.py install for mozscreenshot 04:41:58 INFO - Running setup.py install for moztest 04:41:58 INFO - Running setup.py install for mozversion 04:41:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:41:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:41:58 INFO - Cleaning up... 04:41:58 INFO - Return code: 0 04:41:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41: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')]} 04:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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')]} 04:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:58 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 0x103be4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103be7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c9db27a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038f5d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038e9be8>, '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.okRV1aHr3W/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.IgSq6uH11o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:41:58 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 04:41:58 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 04:41:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.okRV1aHr3W/Render', 04:41:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:58 INFO - 'HOME': '/Users/cltbld', 04:41:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:58 INFO - 'LOGNAME': 'cltbld', 04:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:58 INFO - 'MOZ_NO_REMOTE': '1', 04:41:58 INFO - 'NO_EM_RESTART': '1', 04:41:58 INFO - 'PAGER': '/bin/cat', 04:41:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:58 INFO - 'PWD': '/builds/slave/test', 04:41:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:58 INFO - 'SHELL': '/bin/bash', 04:41:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IgSq6uH11o/Listeners', 04:41:58 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:41:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:58 INFO - 'USER': 'cltbld', 04:41:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:58 INFO - 'XPC_FLAGS': '0x0', 04:41:58 INFO - 'XPC_SERVICE_NAME': '0', 04:41:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:41:58 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-E1Ofmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:41:59 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)) 04:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:41:59 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-SABtoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 04:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:41:59 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-c3gDNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:41:59 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)) 04:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:41:59 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-vmY1dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 04:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:41:59 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-omeoFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:41:59 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)) 04:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:41:59 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-aspVR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:41:59 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)) 04:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:41:59 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-HR6CmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:41:59 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)) 04:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:41:59 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-TFKJf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:41:59 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)) 04:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:41:59 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-iUT8VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:41:59 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)) 04:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:41:59 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-whGDrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 04:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:00 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-BFFzhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:00 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)) 04:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:00 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-0mW2Ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 04:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:00 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Ey1XjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:00 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)) 04:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:00 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-aEhB1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 04:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:00 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-O001e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:00 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)) 04:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:00 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-xyzbdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 04:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:00 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-uzZ_QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:00 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)) 04:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:42:00 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)) 04:42:00 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:00 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:02 INFO - Downloading blessings-1.6.tar.gz 04:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:42:02 INFO - Installing collected packages: blessings 04:42:02 INFO - Running setup.py install for blessings 04:42:02 INFO - Successfully installed blessings 04:42:02 INFO - Cleaning up... 04:42:02 INFO - Return code: 0 04:42:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:42:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:02 INFO - Reading from file tmpfile_stdout 04:42:02 INFO - Current package versions: 04:42:02 INFO - blessings == 1.6 04:42:02 INFO - blobuploader == 1.2.4 04:42:02 INFO - docopt == 0.6.1 04:42:02 INFO - functools32 == 3.2.3-2 04:42:02 INFO - jsonschema == 2.5.1 04:42:02 INFO - manifestparser == 1.1 04:42:02 INFO - mozInstall == 1.12 04:42:02 INFO - mozcrash == 1.0 04:42:02 INFO - mozdebug == 0.1 04:42:02 INFO - mozdevice == 0.50 04:42:02 INFO - mozfile == 1.2 04:42:02 INFO - mozhttpd == 0.7 04:42:02 INFO - mozinfo == 0.9 04:42:02 INFO - mozleak == 0.1 04:42:02 INFO - mozlog == 3.4 04:42:02 INFO - moznetwork == 0.27 04:42:02 INFO - mozprocess == 0.25 04:42:02 INFO - mozprofile == 0.28 04:42:02 INFO - mozrunner == 6.13 04:42:02 INFO - mozscreenshot == 0.1 04:42:02 INFO - mozsystemmonitor == 0.3 04:42:02 INFO - moztest == 0.8 04:42:02 INFO - mozversion == 1.4 04:42:02 INFO - psutil == 3.1.1 04:42:02 INFO - requests == 1.2.3 04:42:02 INFO - wsgiref == 0.1.2 04:42:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:02 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')]} 04:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:02 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')]} 04:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:02 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 0x103be4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103be7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c9db27a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038f5d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038e9be8>, '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.okRV1aHr3W/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.IgSq6uH11o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:42:02 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 04:42:02 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 04:42:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.okRV1aHr3W/Render', 04:42:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:02 INFO - 'HOME': '/Users/cltbld', 04:42:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:02 INFO - 'LOGNAME': 'cltbld', 04:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:02 INFO - 'MOZ_NO_REMOTE': '1', 04:42:02 INFO - 'NO_EM_RESTART': '1', 04:42:02 INFO - 'PAGER': '/bin/cat', 04:42:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:02 INFO - 'PWD': '/builds/slave/test', 04:42:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:02 INFO - 'SHELL': '/bin/bash', 04:42:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IgSq6uH11o/Listeners', 04:42:02 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:42:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:02 INFO - 'USER': 'cltbld', 04:42:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:02 INFO - 'XPC_FLAGS': '0x0', 04:42:02 INFO - 'XPC_SERVICE_NAME': '0', 04:42:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:02 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)) 04:42:02 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)) 04:42:02 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)) 04:42:02 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)) 04:42:02 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)) 04:42:02 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)) 04:42:02 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)) 04:42:02 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)) 04:42:02 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)) 04:42:02 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)) 04:42:02 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)) 04:42:02 INFO - Cleaning up... 04:42:03 INFO - Return code: 0 04:42:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103be4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103be7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4c9db27a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1038f5d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038e9be8>, '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.okRV1aHr3W/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.IgSq6uH11o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 04:42:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:42:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.okRV1aHr3W/Render', 04:42:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:03 INFO - 'HOME': '/Users/cltbld', 04:42:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:03 INFO - 'LOGNAME': 'cltbld', 04:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:03 INFO - 'MOZ_NO_REMOTE': '1', 04:42:03 INFO - 'NO_EM_RESTART': '1', 04:42:03 INFO - 'PAGER': '/bin/cat', 04:42:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:03 INFO - 'PWD': '/builds/slave/test', 04:42:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:03 INFO - 'SHELL': '/bin/bash', 04:42:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IgSq6uH11o/Listeners', 04:42:03 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:42:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:03 INFO - 'USER': 'cltbld', 04:42:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:03 INFO - 'XPC_FLAGS': '0x0', 04:42:03 INFO - 'XPC_SERVICE_NAME': '0', 04:42:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:42:03 INFO - Cleaning up... 04:42:03 INFO - Return code: 0 04:42:03 INFO - Running post-action listener: _resource_record_post_action 04:42:03 INFO - Running post-action listener: _start_resource_monitoring 04:42:03 INFO - Starting resource monitoring. 04:42:03 INFO - [mozharness: 2017-05-08 11:42:03.307231Z] Finished create-virtualenv step (success) 04:42:03 INFO - [mozharness: 2017-05-08 11:42:03.308181Z] Running install step. 04:42:03 INFO - Running pre-action listener: _resource_record_pre_action 04:42:03 INFO - Running main action method: install 04:42:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:03 INFO - Reading from file tmpfile_stdout 04:42:03 INFO - Detecting whether we're running mozinstall >=1.0... 04:42:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:42:03 INFO - Reading from file tmpfile_stdout 04:42:03 INFO - Output received: 04:42:03 INFO - Usage: mozinstall [options] installer 04:42:03 INFO - Options: 04:42:03 INFO - -h, --help show this help message and exit 04:42:03 INFO - -d DEST, --destination=DEST 04:42:03 INFO - Directory to install application into. [default: 04:42:03 INFO - "/builds/slave/test"] 04:42:03 INFO - --app=APP Application being installed. [default: firefox] 04:42:03 INFO - mkdir: /builds/slave/test/build/application 04:42:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:42:23 INFO - Reading from file tmpfile_stdout 04:42:23 INFO - Output received: 04:42:23 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:42:23 INFO - Running post-action listener: _resource_record_post_action 04:42:23 INFO - [mozharness: 2017-05-08 11:42:23.545531Z] Finished install step (success) 04:42:23 INFO - [mozharness: 2017-05-08 11:42:23.545677Z] Running run-tests step. 04:42:23 INFO - Running pre-action listener: _resource_record_pre_action 04:42:23 INFO - Running main action method: run_tests 04:42:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:42:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:42:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:42:23 INFO - 2017-05-08 04:42:23.560 screenresolution[1629:7521] starting screenresolution argv=screenresolution get 04:42:23 INFO - 2017-05-08 04:42:23.562 screenresolution[1629:7521] Display 0: 1600x1200x32@60 04:42:23 INFO - 2017-05-08 04:42:23.568 screenresolution[1630:7523] starting screenresolution argv=screenresolution list 04:42:23 INFO - Available Modes on Display 0 04:42:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:42:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:42:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:42:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:42:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:42:23 INFO - Intel Iris: 04:42:23 INFO - Chipset Model: Intel Iris 04:42:23 INFO - Type: GPU 04:42:23 INFO - Bus: Built-In 04:42:23 INFO - VRAM (Dynamic, Max): 1536 MB 04:42:23 INFO - Vendor: Intel (0x8086) 04:42:23 INFO - Device ID: 0x0a2e 04:42:23 INFO - Revision ID: 0x0009 04:42:23 INFO - Displays: 04:42:23 INFO - Display: 04:42:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:42:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:42:23 INFO - Display Serial Number: 1600x1200 60 04:42:23 INFO - Main Display: Yes 04:42:23 INFO - Mirror: Off 04:42:23 INFO - Online: Yes 04:42:23 INFO - Rotation: Supported 04:42:23 INFO - Return code: 0 04:42:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:42:23 INFO - Python 2.7.3 04:42:23 INFO - Return code: 0 04:42:23 INFO - grabbing minidump binary from tooltool 04:42:23 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')]} 04:42:23 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 0x1038f5d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038e9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:42:23 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 04:42:23 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 04:42:23 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 04:42:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:42:23 INFO - Return code: 0 04:42:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:42:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:42:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:42:23 INFO - ENV: RUST_BACKTRACE is now 1 04:42:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:42:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:42:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0212', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0212 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:42:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.okRV1aHr3W/Render', 04:42:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:23 INFO - 'HOME': '/Users/cltbld', 04:42:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:23 INFO - 'LOGNAME': 'cltbld', 04:42:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:42:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:23 INFO - 'MOZ_NO_REMOTE': '1', 04:42:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:42:23 INFO - 'NO_EM_RESTART': '1', 04:42:23 INFO - 'PAGER': '/bin/cat', 04:42:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:23 INFO - 'PWD': '/builds/slave/test', 04:42:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:42:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:23 INFO - 'RUST_BACKTRACE': '1', 04:42:23 INFO - 'SHELL': '/bin/bash', 04:42:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IgSq6uH11o/Listeners', 04:42:23 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 04:42:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:23 INFO - 'USER': 'cltbld', 04:42:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:23 INFO - 'XPC_FLAGS': '0x0', 04:42:23 INFO - 'XPC_SERVICE_NAME': '0', 04:42:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0212', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:42:24 INFO - mozversion application_buildid: 20170508030204 04:42:24 INFO - mozversion application_changeset: 1fda52a1f3b81cf1a821155998dca637bb64e3d9 04:42:24 INFO - mozversion application_display_name: Nightly 04:42:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:42:24 INFO - mozversion application_name: Firefox 04:42:24 INFO - mozversion application_remotingname: firefox 04:42:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:42:24 INFO - mozversion application_vendor: Mozilla 04:42:24 INFO - mozversion application_version: 55.0a1 04:42:24 INFO - mozversion platform_buildid: 20170508030204 04:42:24 INFO - mozversion platform_changeset: 1fda52a1f3b81cf1a821155998dca637bb64e3d9 04:42:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:42:24 INFO - mozversion platform_version: 55.0a1 04:42:24 INFO - using testdate: 1494243744 04:42:24 INFO - actual date: 1494243744 04:42:24 INFO - starting webserver on 'localhost:49241' 04:42:24 INFO - SUITE-START | Running 2 tests 04:42:24 INFO - TEST-START | dromaeo_css 04:42:24 INFO - operating with platform_type : mac_ 04:42:24 INFO - Initialising browser for dromaeo_css test... 04:42:24 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmphsMWCp/profile http://localhost:49241/getInfo.html) 04:42:27 INFO - PID 1640 | 2017-05-08 04:42:27.112 plugin-container[1643:7707] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e47, name = 'com.apple.tsm.portname' 04:42:27 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:42:27 INFO - PID 1640 | 2017-05-08 04:42:27.112 plugin-container[1643:7707] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0xa10b, name = 'com.apple.CFPasteboardClient' 04:42:27 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:42:27 INFO - PID 1640 | 2017-05-08 04:42:27.112 plugin-container[1643:7707] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:42:27 INFO - PID 1640 | __metrics Screen width/height:1600/1200 04:42:27 INFO - PID 1640 | colorDepth:24 04:42:27 INFO - PID 1640 | Browser inner width/height: 1024/691 04:42:27 INFO - PID 1640 | __metrics 04:42:27 INFO - PID 1640 | 2017-05-08 04:42:27.637 plugin-container[1644:7763] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 04:42:27 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:42:27 INFO - PID 1640 | 2017-05-08 04:42:27.638 plugin-container[1644:7763] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9423, name = 'com.apple.CFPasteboardClient' 04:42:27 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:42:27 INFO - PID 1640 | 2017-05-08 04:42:27.638 plugin-container[1644:7763] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:42:28 INFO - TEST-INFO | 1640: exit 0 04:42:28 INFO - Browser initialized. 04:42:28 INFO - Running cycle 1/1 for dromaeo_css test... 04:42:28 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmphsMWCp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:30 INFO - PID 1645 | 2017-05-08 04:42:30.526 plugin-container[1646:7879] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x913f, name = 'com.apple.tsm.portname' 04:42:30 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:42:30 INFO - PID 1645 | 2017-05-08 04:42:30.526 plugin-container[1646:7879] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 04:42:30 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:42:30 INFO - PID 1645 | 2017-05-08 04:42:30.526 plugin-container[1646:7879] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:42:31 INFO - PID 1645 | 2017-05-08 04:42:31.195 plugin-container[1647:7925] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 04:42:31 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:42:31 INFO - PID 1645 | 2017-05-08 04:42:31.195 plugin-container[1647:7925] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x481b, name = 'com.apple.CFPasteboardClient' 04:42:31 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:42:31 INFO - PID 1645 | 2017-05-08 04:42:31.195 plugin-container[1647:7925] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:42:40 INFO - PID 1645 | RSS: Main: 233013248 04:42:40 INFO - PID 1645 | 04:45:44 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:45:45 INFO - PID 1645 | RSS: Main: 250626048 04:45:45 INFO - PID 1645 | 04:48:47 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 04:48:48 INFO - PID 1645 | RSS: Main: 254664704 04:48:48 INFO - PID 1645 | 04:51:50 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 04:51:50 INFO - PID 1645 | RSS: Main: 264310784 04:51:50 INFO - PID 1645 | 04:54:52 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 04:54:53 INFO - PID 1645 | RSS: Main: 258097152 04:54:53 INFO - PID 1645 | 04:57:56 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 04:57:56 INFO - PID 1645 | RSS: Main: 261890048 04:57:56 INFO - PID 1645 | 05:00:58 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:00:58 INFO - PID 1645 | RSS: Main: 260550656 05:00:58 INFO - PID 1645 | 05:00:58 INFO - PID 1645 | __start_tp_report 05:00:58 INFO - PID 1645 | _x_x_mozilla_page_load 05:00:58 INFO - PID 1645 | _x_x_mozilla_page_load_details 05:00:58 INFO - PID 1645 | |i|pagename|runs| 05:00:58 INFO - PID 1645 | |0;dojo.html;3075.492543730284;3641.763285386448;3668.8349024293902;3668.926621467571;3669.7798132112057;6158.4765294949875;6264.686765661716;6297.6536290504;6302.117703521505;6329.082283068964;6235.033569796688;6244.84387890303;6269.122322874801;6279.246490421156;6338.271098823637;4661.743604101773;5103.2855400244;5482.17767334901;5495.697736624484;5508.338999320087;5546.77812887484;5579.7489112990015;5606.299212598426;5635.154726790973;5657.0665840136535;5411.21537377082;5518.613697041209;5538.335399752015;5589.273394458714;5596.664200148004;4418.977905110486;5444.50999410055;5561.916571251434;5574.163875418679;5605.943940560583;5386.622936394454;5481.068218402881;5493.697846618435;5506.91739623906;5511.807086751945;5927.695906900518;5998.550108741818;6274.686265686697;6278.937210627881;6293.905591416133;6480.578762380477;6573.408393244583;6643;6708.698108585126;6730.091437655903;6824.976253561956;6827.249002609709;6851.520393572452;6857.519973601849;6874.106366172416;4798.376211092571;6277.435030847154;6334.334894836022;6354.269259035178;6380.457661098812;6767.255601883789;6858.108445902001;6873.1064961554675;6916.792496225121;6988.44092472601;6385.584936979081;6480.4815614750705;6555.246146693191;6575.769848055295;6700.698468568926;6797.52417330792;6798.5241033128195;6808.114945057111;6808.148981377328;6834.111565496453;6614.173228346457;6741.258461569223;6756.4932630052945;6757.695903684247;6764.627945462948;6448.355164483608;6448.613083215022;6560.540762146604;6745.865082698417;6771.322867713287;5334.333208348957;5356.866078348073;5377.327834020747;5389.622726409192;5390.946090539044;4722.763861806896;4776.140294746979;4777.044591081798;4779.211430114062;4806;6149.41580549847;6277.623342599459;6299.496040316763;6361.681915904186;6371.108044873721;5785.971070144622;6629.46964242869;6730.966345168341;6748.763793267212;6848.048668959649;6309.747610095545;6311.873762524724;6354.841128971812;6365.777197798055;6372.299047104815;5933.715519525014;5986.880262394815;5987.43119403656;5996.730147143389;6000.489958353589;6769.796906092825;6854.554453960476;6918.619475928872;6964.338387853045;7042.50702450844;6343.5876668016435;6428.678566071584;6853.862922741617;6864.313568643096;6888.51780375389;6351.237851457855;6586.1438013059915;6990.26602206761;6996.895046574407;7091.539049961736;6458.128152699325;6659.4006539411685;6689.331066893466;6735.696893639896;6754.527183097136;6699.464042876656;6787.253402125861;6829.590224586541;6841.589504629738;6883.655817209019;6429.453496452854;6641.9667901662115;6652.7006284716335;6653.201615806134;6662.167229096363;6397.296297407374;6481.351864813481;6627.304133066152;6629.569078009914;6633.734650613921;6258.749650013949;6332.651704156316;6495.740170393131;6509.544331896722;6525.9021114684265;5355.5983301253345;6459.935400646122;6582.243042050225;6619.470442364503;6664.66676666155;6425.453836423956;6462.127612772216;6485.54601177913;6486.383793539606;6493.22081350241 05:00:58 INFO - PID 1645 | |1;ext.html;709.982250443739;746.3432179681879;819.369085803931;1040.2562168049838;1265.7088869560007;37593;38887.61112388875;38902.61097389025;38937.61062389382;38959.805200973955;32536;38631.42052869209;38891.805540972324;38909.41635875457;38930;7879.0151231096115;8056.677732890677;8322.583870806466;8538.103499132594;8572.657093716243;8397.286230670401;8407.62165702545;8500.404971651988;8513.659453621847;8538.274246689009;8409;8483.278921291698;8507.447015943944;8539.701110461136;8545.786355341135;8456.154384561525;8509.319254459628;8518.892543969276;8521.020082690446;8522.786930326729;8342.124076971892;8387.287080598157;8392.958035209846;8401.495910245343;8429.030661473947;37670.62329376726;37754;37788.24423511514;37863.05342366435;37942.051448713726;3520.5775306963073;3603.891883243507;3642.6357364263363;3648.1791596890753;3671.889843304705;29251.853740731374;30764.692353076407;30975.606097725657;30988.76044958199;31077.91227307056;3117.703818137273;3172.12766489215;3194.185482701896;3195.760317976161;3226.951595726066;220355;255740.99999999814;268436;295706;305875.47062264546;40408.39387409191;47216.5278347219;47754.28368574474;47943.760281198374;48096.7595162022;49842;49854.252186217236;51388.74305628448;54644;54726.452735472136;14469.204193769443;14576.489822856362;14592.63518412027;14633;14633.902457315744;11569.88430115688;11619.186656934102;11660.766784664429;11664.94167529157;11672.241304315192;13971.720565588632;14017.369218385196;14029.438822447191;14038.227897465533;14052.508162214477;6029;6048.4858787003595;6053.4551890330085;6073.210482637229;6088.847778805565;902.0168016861652;1019.5615885169449;1027.198784947742;1041.6093964763213;1049.2812423489934;23233;23735;24748.5050298993;24914.501709965698;24921;1108.3128460354633;1123.500042481088;1150.384544268812;1161.2916121166081;1166.597523854269;10705.625303114353;11943.701407464883;12684.556040538537;12709.618711438672;12710.555130570385;293315;295240;295430.5228473844;296664;308908;58085.12872306919;58153.70923145357;58213.70893145507;58470.830583388095;58520.414795852346;1500.129924643704;1532.885033622505;1537.108477083289;1538.169388530181;1551.5733173377412;30039.399212016073;30396.544051839683;30679.233019173807;31106;31483.370332593677;39645.405318919664;39787.80106099451;39820.40269395903;39834.402483962185;39835.60164398319;296479;299054.0094599026;299056;300028;300799;35754.74858379944;35881.1029724259;35976.82011589925;36004;36859.447108293934;47742.04515909732;49895.251571227185;50164;50365.49634503754;50509.49490505048;28972.420551588428;30016.699833002265;30633.693663063084;32534.34931301408;32601.836990814892;26994.325141870824;32695;32782.12446608891;33556.99329020133;33673.49489757606;39095.02262443462;39507.40738888976;39658.2068358637;39698.80150599228;39864.402033970095;28737.712622873503;31663.683363166074;33451.83274083614;34112.65887341095;34245.65754342425;24198.87900560486;24322;25222.243332700047;26080.608790867773;26317.868410657826 05:00:58 INFO - PID 1645 | |2;jquery.html;440.53083466108603;441.7062653335532;446.85604851579956;457.90841831633674;469.95770380665755;21017;21960.341189764313;22694.97872595733;23661;23708;20344.593108137866;23114;23732.525349493;23895.16366927158;23983.640245396335;6087.086936959469;6156.692165391735;6204.13142160098;6269.341719119495;6320.810375688737;5390.245365648812;6173.351798061206;6271.529635277349;6314.6842657867155;6332.715027823736;5835.533157347423;6076.6050206736645;6124.969375153118;6130.816075517741;6138.47822935051;6051.606645568024;6063.18147050147;6081.179040829497;6135;6147.87704245917;5399.676019438807;5409.648372855751;5471.863203419906;5480.205370221295;5483.341998960111;27222.45555088887;27264.45471090587;28036.439271214665;28399.14802555906;28481.430371392664;2217.7116974793335;2245.113180293791;2262.049939025613;2262.694536237603;2264.162259963824;17243.74134387985;17862.821371786376;18304.90170589769;18359.990200538967;18533.166007529693;2115.2490865742748;2167.1656412281386;2181.996281710415;2190.485235969546;2217.922372716947;154108;158033.20983395123;159531;160999.99999999884;161010;11195.776084478428;12545.498180072695;12733.61799146027;12762.489500420064;12863;13359.599212023655;16635.584110397336;16659.833401665826;16677.416290429777;16694.165291735364;8722.171393717586;9008.459492430475;9039.322050846213;9084.227840633488;9189.63241470347;8427.32581393487;8530.104339044436;8532.488050716976;8677.783055423539;8693.087225841322;6707.1616047994;7966.960165199137;8008.199180081945;8056.39577031725;8066.7413124325285;2212.6570381590877;2225.7662945390825;2227.7883601057874;2236.083205885579;2365.018517315295;906.2795077913075;945.8533927241289;950.2445555783169;968.3612156872607;993.572763711611;21003.579928401345;21495.355139345844;21524.677129843065;21572.352829415144;21867.562648746934;993.3692105512907;1004.5328922051282;1025.661531694554;1032.4734385463469;1033.5917312661456;10573.9471302643;10934.507947142398;10950.39772812487;10999.780004399867;11006.284591501688;549503;559751;567909.1604541951;571378;572368;102368;117998;124780;129231;129907.35046324896;1061.4639606998417;1125.8480105185859;1147.9196456247982;1254.736505333872;1270.841144856893;20840.58318833645;22050.669239961735;22190.889045554668;22285.220017299318;22358;46335;56175.31474055785;56200;56773.58066048382;57334.42665573291;55582.72208638931;77574;79136.60431697805;80240.19759802327;85010.57494712487;8896.777580560538;8897.510636915033;8900.154485323885;8928.196462318423;9227.261819054325;14039.894015897697;14227;14334.426622935383;14536.345864435914;14582.4896128635;11781.528738850693;11817.82273265919;11877.762444750884;12143.514259429523;12224.69438264015;11227.775444491228;11245.71885702864;11365.943170284096;11560.190786645191;11646.126540509325;9917.801643967225;12044;12128.514859405524;12346.938265308616;12389.380530973596;9090.909090909006;9126.634934602542;9156.816863662556;9164.450132992042;9219.110082433219;11843.644690659294;11950.581729639422;12067.215630983957;12155.635330940086;12173.69565760863 05:00:58 INFO - PID 1645 | |3;mootools.html;1408.5281430720709;1445.1864931785224;1462.7805829125637;1479.4599971010578;1493.7609982402814;9989.300748947559;10219;11373.545058197673;11864.525418983241;11898.345590992503;11262.662120136409;11624.418779061056;11627.534898604046;11633.883661163385;11730.29618222905;2221.9555608887813;2498.325452127929;2535.6069809179517;2554.118829003991;2554.5657238269446;2004.837194427236;2477.2815883393796;2521.1176088369016;2541.3265484646586;2592.6370308156875;2499.7125330587032;2511.3721569607596;2511.849289042654;2517.1944977607172;2524.924252272435;2243.181238847809;2243.3942835434423;2257.24382331919;2269.6822444857567;2271.0802125139344;2452.8037756979397;2460.7047154341594;2470.1354525915967;2474.8762561871836;2479.219046000504;10099.899001010042;11315.8684131587;11630.767384652345;11631.30212187263;11731.7067073323;5820.243368362086;6518.315576864456;6721.26066132725;6780.627065511395;6791.524593278473;3525.7013972403024;3642.4354225095153;4382.496012958519;4425.291953287491;4459.264221403465;1229.4098832560421;1253.3795771093367;1258.8237646729465;1306.4251729239104;1308.6205000549828;13931.233782141979;14329.068610540386;16367;16711.498655040246;16713.916430417892;5865.765369385177;5929.902967950943;6037.456628903332;6097.268327800603;6197.876042479215;13741.03812733119;13816.93091534536;13835;13845.238511881944;13850.515231966832;6747.291534388916;6818.93181068183;6820.727170913207;6826.24911259761;6832.59004459734;5316.415194328621;6186.876262474815;6226.875462490725;6267.4045965633195;6269.65516896566;4560;4696.81212751493;4724.858254252378;4781.258904869751;4785.856424307276;1345.4618152738983;1452.244832686997;1455.9490417835536;1479.1938393575526;1489.2181604657642;804.6539987805182;810.3395732478011;820.9014918209853;826.8428998490267;853.9530325832014;6352.110704501373;6591.571547849375;6710.563813352116;6804.251532331439;6911.619860907598;602.8515677634026;608.3703367015119;930.916217540411;957.8132264208551;977.9755506112405;4209.684273679486;4245.915081698348;4271.551487093872;4356.847510337187;4361.214981303396;14730.558083257305;15326.23368831554;15328.846711532966;15331.23343832804;15334;14548.636284092983;14902.403903843942;15135.470258540898;15154.242287885561;15243.695126097417;7131.714731410685;8590.613422396007;8600.22597966186;8615.655373785105;8643.135686431433;6523.6738163092605;6720.932790672031;6931.44548436134;6952.652367381509;6964.79105626832;12453.501859925502;13114.950086675573;13236.338183091;13370.465181392636;13438.52176260591;13422.859056980265;13865.306734663025;13951.790723138958;14016.088954217943;14348.856511434751;8577.785555361166;8772.91227087721;9279.211267042378;9314.673986410444;9526.190273826802;11025.393603351893;11049.889501104886;11087.33475991443;11122.165837562377;11137.10903127764;7832.451728378959;8910.37627366104;9169.312301577274;9227.400218985744;9238.630454782002;7280.7815765525;8926.68756593516;8978.506182160045;9126.49804260772;9142.451452912846;7861.724839630586;7897.723579674684;7928.326092282221;7991.720289790062;8013.118556958846;5064.822731204537;5935.643861368159;6105.908411373922;6106.32830388648;6312.936870631235;6086.939130608815;6088.634681919099;6134.202553667995;6206.751729930752;6283.59156654816 05:00:58 INFO - PID 1645 | |4;prototype.html;340.88409940620187;392.8173399369293;397.7514053716427;404.30661415672137;407.9143379890224;4982.9252561211615;5444.373897001841;5856.355800861902;6205.751769929208;6494.383033611805;5540.002799496089;5608.523275521576;6143.863385273717;6225.782097626584;6392.488600911927;3865.845366185349;4145.54399016108;4482.641388688897;4612.238980568202;4633.721976681393;3663.5970043295215;3922.5292964844257;4025.859094931678;4557.794899229542;4628.375169352128;4254.829806807724;4525.275955847065;4579.908401831962;4593.311003349491;4597.678162528624;3788.677962373202;4516.18708632446;4523.547645235483;4589.724616523019;4605.562471565196;3868.845246190149;3887.358585833334;3888.941665875014;3897.2984862724697;3915.530136383624;6237.4698150656795;6248.218972628421;6261.968690156566;6265.404786545317;6284.654344011077;5063.734066483379;5278.894422111574;5424.0236757383655;5450.264214331054;5477.726113694339;5700.914486282709;5929.495992840613;6783;6828.385445309946;6840.623765692885;4245.448091748084;4463.285874260136;4465.665075119379;4476.8880777980485;4478.335390442681;6149.938500614981;7140;7225.89161162583;7317.670704818296;7328.816779580553;3881.320768865494;3983.223271462095;4031.5162180538523;4521.683482156218;4530.275155975094;3916.6083391661177;4082;4467.486239082547;4615.376924115269;4617.792199351037;4244.8514301999285;4372.1692878353015;4893.923336865883;5308.734563271898;5445.98498555537;6841.692123854438;6850.9314906850295;6862.044317369626;6866.725330986705;6901.309869013159;1350.4463170100212;1524.1617110589132;1554.4170935899037;1577.0458872382274;1577.2350410051115;865.8960924689078;1001.1990407673832;1007.4308015970953;1017.2624846986024;1037.232447988483;5850.882982340329;6487.599588152414;6502.869942601122;6511.38141876521;6587.550738837448;6550.2794692583775;6870.213744426485;7128.857422851617;7162.785116446515;7183;5778.855528611818;6122.387761223931;6359.554831161867;6447.903281450782;6451.580647257913;3329.334133173375;3650;3692.372296709566;3747.3442147624055;3759.774413535197;6720.361565651256;7235.359093930782;7293.781186564412;7309.853802923912;7397.26027397256;6474.931636279961;6625.536212465081;6665.666716664147;6711.429528490133;7310.890336644955;7049.647517624201;7271.781846544613;7309.671064802096;7364.3372096511575;7399.667014984231;7122.934349038721;7128.928710712827;7130.679119439534;7136.250693677089;7148.785536433916;5775.653460792366;6698.363655452724;6975.372216500539;7024.367806897199;7052.188998265266;7200.783976480714;7232.7468538603;7287.9635601823775;7380.011095506328;7446.25537446251;4527.275635898241;4543.13680400736;4543.250363689954;4557.567031132037;4559.635229181724;6061.333253342041;6213.5339849512375;6765.8985115224295;7087.645617719197;7198.136223653195;6881.277465866012;6899.310068993061;6900.447964162755;6911.5853048817235;6913.89629155553;5289.973550132225;6094.695265236809;6169.383061693795;6895.965520172367;6901.964705294246;6753.2233793112455;6756;6762.459003279824;6780.016897549926;6786.287439818945;6015.969920150546;6807.795766127024;6843.555168914005;6889.689963951734;6940.7917762467205;6452.935470645233;6766.5263431559315;6768.763093291711;6780.288069752605;6788.287229840796 05:00:58 INFO - PID 1645 | |5;yui.html;832.3008672714918;841.5834162089766;854.7222152800338;866.0646501778081;880.0143838900433;13119.54081607144;17105.82894171058;17126.828731712678;19098.140583673732;19510.21959121637;15548.533543993699;18078.367257146;18445.81554184458;18709.158087886077;18716.06419679014;974.5614473486924;979.6277414582466;982.0572250639359;989.5596459575492;991.9752006199867;993.9254555908336;1000.9349392289514;1003.2776400991274;1006.9244806639495;1018.6078359831445;1050.8371202463593;1063.2025980514613;1065.0840277361463;1066.1577353890418;1077.4774234496263;1047;1047.1831971062584;1060.7242117049545;1064.7338165458675;1073.3935326540518;748.4872862089486;763.091920614467;766.2720415605197;771.7106085218044;776.0803447914184;16979.915100424543;17421.30314787407;17544;17548;17582;17035.57411064721;17481.912590437092;17488.650226995516;17583.12084395775;17641.294348226056;12127.514899404101;14073.085249458854;14122.293885305797;14364.281785910664;14392.712145757027;3105.6428510721103;3458.962311306623;3508.2281897982402;3531.593866705336;3537.2925414916863;133756;134234;134320;136111;138183.99999999898;13128.671783205305;13235;13412.396442160127;13506.864931350758;13652.863471365357;26187.345316367242;26226.606600901003;26294.474110518066;26384.868075659884;26416.0754373596;6677.499187560952;7073.681684324218;7595.6961721531625;7865;7867.488613240121;3853.7302388833073;3905.1213476967455;3910.7849068301516;3926.430667553189;3927.0771368728324;3945.072907866649;3963.1083006323925;3966.6628336591134;3989.4813674222164;4034.3545032794614;929.1219797291494;952.4666186935339;957.1194501059042;957.6791774755395;959.1511512311655;581.0992960910572;647.9967600162063;649.2014821769156;651.5439192565224;687.8280429892527;9098.545072746469;11108.16688748347;11420.828687569694;11947.10396720232;11967.102467314986;645.3127419298432;650.4373716735084;657.1457105762489;665.4410295351928;686.1902954513622;5473.124300111963;5575.553955683536;5626.493615574618;5648.378678345379;6105.908411373833;107326.92673073325;110736;112206;113604;114042;91220.08779912116;92489.53755231181;98988.01011989932;103254.48372758238;103822.48088759658;77916;79856.60071699605;80554.59722701466;81907.18092819233;82653;12355;12471.127021108798;12599.874001260237;12766.872331276569;12790.424430900817;39529.80235098921;41434.58565414428;41994.790026049675;42536.78731606322;42569;53082;53176.73411633072;53586;53586.928261435336;54924.45075549193;16131.032138071754;16561.337546498005;16604.335826567287;16737.91631041837;16744.748828767333;18001.819981800538;18303.816961830213;18311.54221144482;18315.084245787923;18697.719534206724;16311;16861.325546977983;17110.144492775562;17189.484315470556;17201.397951071653;16376;16475.505734827973;16972.830271697127;17020;17072.231749571052;15960.361585536913;15992.520224393287;16316.592085197964;16586.83413165853;16603;11844.230125041844;11881.405929703653;12038.638840834788;12115.091368147601;12135.575254866037;12440.37798110109;12581.433835477608;12910.160839545399;13024.28366439817;13131.080824342205 05:00:58 INFO - PID 1645 | __end_tp_report 05:00:58 INFO - PID 1645 | __start_cc_report 05:00:58 INFO - PID 1645 | _x_x_mozilla_cycle_collect,406 05:00:58 INFO - PID 1645 | __end_cc_report 05:00:58 INFO - PID 1645 | __startTimestamp1494244858590__endTimestamp 05:00:58 INFO - PID 1645 | 05:00:58 INFO - PID 1645 | ------- Summary: start ------- 05:00:58 INFO - PID 1645 | Number of tests: 6 05:00:58 INFO - PID 1645 | 05:00:58 INFO - PID 1645 | [#0] dojo.html Cycles:165 Average:6182.96 Median:6397.30 stddev:751.72 (11.8%) stddev-sans-first:713.40 05:00:58 INFO - PID 1645 | Values: 3075.5 3641.8 3668.8 3668.9 3669.8 6158.5 6264.7 6297.7 6302.1 6329.1 6235.0 6244.8 6269.1 6279.2 6338.3 4661.7 5103.3 5482.2 5495.7 5508.3 5546.8 5579.7 5606.3 5635.2 5657.1 5411.2 5518.6 5538.3 5589.3 5596.7 4419.0 5444.5 5561.9 5574.2 5605.9 5386.6 5481.1 5493.7 5506.9 5511.8 5927.7 5998.6 6274.7 6278.9 6293.9 6480.6 6573.4 6643.0 6708.7 6730.1 6825.0 6827.2 6851.5 6857.5 6874.1 4798.4 6277.4 6334.3 6354.3 6380.5 6767.3 6858.1 6873.1 6916.8 6988.4 6385.6 6480.5 6555.2 6575.8 6700.7 6797.5 6798.5 6808.1 6808.1 6834.1 6614.2 6741.3 6756.5 6757.7 6764.6 6448.4 6448.6 6560.5 6745.9 6771.3 5334.3 5356.9 5377.3 5389.6 5390.9 4722.8 4776.1 4777.0 4779.2 4806.0 6149.4 6277.6 6299.5 6361.7 6371.1 5786.0 6629.5 6731.0 6748.8 6848.0 6309.7 6311.9 6354.8 6365.8 6372.3 5933.7 5986.9 5987.4 5996.7 6000.5 6769.8 6854.6 6918.6 6964.3 7042.5 6343.6 6428.7 6853.9 6864.3 6888.5 6351.2 6586.1 6990.3 6996.9 7091.5 6458.1 6659.4 6689.3 6735.7 6754.5 6699.5 6787.3 6829.6 6841.6 6883.7 6429.5 6642.0 6652.7 6653.2 6662.2 6397.3 6481.4 6627.3 6629.6 6633.7 6258.7 6332.7 6495.7 6509.5 6525.9 5355.6 6459.9 6582.2 6619.5 6664.7 6425.5 6462.1 6485.5 6486.4 6493.2 05:00:58 INFO - PID 1645 | 05:00:58 INFO - PID 1645 | [#1] ext.html Cycles:180 Average:45008.66 Median:34179.16 stddev:75767.00 (221.7%) stddev-sans-first:75906.54 05:00:58 INFO - PID 1645 | Values: 710.0 746.3 819.4 1040.3 1265.7 37593.0 38887.6 38902.6 38937.6 38959.8 32536.0 38631.4 38891.8 38909.4 38930.0 7879.0 8056.7 8322.6 8538.1 8572.7 8397.3 8407.6 8500.4 8513.7 8538.3 8409.0 8483.3 8507.4 8539.7 8545.8 8456.2 8509.3 8518.9 8521.0 8522.8 8342.1 8387.3 8393.0 8401.5 8429.0 37670.6 37754.0 37788.2 37863.1 37942.1 3520.6 3603.9 3642.6 3648.2 3671.9 29251.9 30764.7 30975.6 30988.8 31077.9 3117.7 3172.1 3194.2 3195.8 3227.0 220355.0 255741.0 268436.0 295706.0 305875.5 40408.4 47216.5 47754.3 47943.8 48096.8 49842.0 49854.3 51388.7 54644.0 54726.5 14469.2 14576.5 14592.6 14633.0 14633.9 11569.9 11619.2 11660.8 11664.9 11672.2 13971.7 14017.4 14029.4 14038.2 14052.5 6029.0 6048.5 6053.5 6073.2 6088.8 902.0 1019.6 1027.2 1041.6 1049.3 23233.0 23735.0 24748.5 24914.5 24921.0 1108.3 1123.5 1150.4 1161.3 1166.6 10705.6 11943.7 12684.6 12709.6 12710.6 293315.0 295240.0 295430.5 296664.0 308908.0 58085.1 58153.7 58213.7 58470.8 58520.4 1500.1 1532.9 1537.1 1538.2 1551.6 30039.4 30396.5 30679.2 31106.0 31483.4 39645.4 39787.8 39820.4 39834.4 39835.6 296479.0 299054.0 299056.0 300028.0 300799.0 35754.7 35881.1 35976.8 36004.0 36859.4 47742.0 49895.3 50164.0 50365.5 50509.5 28972.4 30016.7 30633.7 32534.3 32601.8 26994.3 32695.0 32782.1 33557.0 33673.5 39095.0 39507.4 39658.2 39698.8 39864.4 28737.7 31663.7 33451.8 34112.7 34245.7 24198.9 24322.0 25222.2 26080.6 26317.9 05:00:58 INFO - PID 1645 | 05:00:58 INFO - PID 1645 | [#2] jquery.html Cycles:180 Average:35926.11 Median:22904.49 stddev:95365.91 (416.4%) stddev-sans-first:95596.22 05:00:58 INFO - PID 1645 | Values: 440.5 441.7 446.9 457.9 470.0 21017.0 21960.3 22695.0 23661.0 23708.0 20344.6 23114.0 23732.5 23895.2 23983.6 6087.1 6156.7 6204.1 6269.3 6320.8 5390.2 6173.4 6271.5 6314.7 6332.7 5835.5 6076.6 6125.0 6130.8 6138.5 6051.6 6063.2 6081.2 6135.0 6147.9 5399.7 5409.6 5471.9 5480.2 5483.3 27222.5 27264.5 28036.4 28399.1 28481.4 2217.7 2245.1 2262.0 2262.7 2264.2 17243.7 17862.8 18304.9 18360.0 18533.2 2115.2 2167.2 2182.0 2190.5 2217.9 154108.0 158033.2 159531.0 161000.0 161010.0 11195.8 12545.5 12733.6 12762.5 12863.0 13359.6 16635.6 16659.8 16677.4 16694.2 8722.2 9008.5 9039.3 9084.2 9189.6 8427.3 8530.1 8532.5 8677.8 8693.1 6707.2 7967.0 8008.2 8056.4 8066.7 2212.7 2225.8 2227.8 2236.1 2365.0 906.3 945.9 950.2 968.4 993.6 21003.6 21495.4 21524.7 21572.4 21867.6 993.4 1004.5 1025.7 1032.5 1033.6 10573.9 10934.5 10950.4 10999.8 11006.3 549503.0 559751.0 567909.2 571378.0 572368.0 102368.0 117998.0 124780.0 129231.0 129907.4 1061.5 1125.8 1147.9 1254.7 1270.8 20840.6 22050.7 22190.9 22285.2 22358.0 46335.0 56175.3 56200.0 56773.6 57334.4 55582.7 77574.0 79136.6 80240.2 85010.6 8896.8 8897.5 8900.2 8928.2 9227.3 14039.9 14227.0 14334.4 14536.3 14582.5 11781.5 11817.8 11877.8 12143.5 12224.7 11227.8 11245.7 11365.9 11560.2 11646.1 9917.8 12044.0 12128.5 12346.9 12389.4 9090.9 9126.6 9156.8 9164.5 9219.1 11843.6 11950.6 12067.2 12155.6 12173.7 05:00:58 INFO - PID 1645 | 05:00:58 INFO - PID 1645 | [#3] mootools.html Cycles:180 Average:7128.18 Median:3926.06 stddev:4510.23 (114.9%) stddev-sans-first:4502.40 05:00:58 INFO - PID 1645 | Values: 1408.5 1445.2 1462.8 1479.5 1493.8 9989.3 10219.0 11373.5 11864.5 11898.3 11262.7 11624.4 11627.5 11633.9 11730.3 2222.0 2498.3 2535.6 2554.1 2554.6 2004.8 2477.3 2521.1 2541.3 2592.6 2499.7 2511.4 2511.8 2517.2 2524.9 2243.2 2243.4 2257.2 2269.7 2271.1 2452.8 2460.7 2470.1 2474.9 2479.2 10099.9 11315.9 11630.8 11631.3 11731.7 5820.2 6518.3 6721.3 6780.6 6791.5 3525.7 3642.4 4382.5 4425.3 4459.3 1229.4 1253.4 1258.8 1306.4 1308.6 13931.2 14329.1 16367.0 16711.5 16713.9 5865.8 5929.9 6037.5 6097.3 6197.9 13741.0 13816.9 13835.0 13845.2 13850.5 6747.3 6818.9 6820.7 6826.2 6832.6 5316.4 6186.9 6226.9 6267.4 6269.7 4560.0 4696.8 4724.9 4781.3 4785.9 1345.5 1452.2 1455.9 1479.2 1489.2 804.7 810.3 820.9 826.8 854.0 6352.1 6591.6 6710.6 6804.3 6911.6 602.9 608.4 930.9 957.8 978.0 4209.7 4245.9 4271.6 4356.8 4361.2 14730.6 15326.2 15328.8 15331.2 15334.0 14548.6 14902.4 15135.5 15154.2 15243.7 7131.7 8590.6 8600.2 8615.7 8643.1 6523.7 6720.9 6931.4 6952.7 6964.8 12453.5 13115.0 13236.3 13370.5 13438.5 13422.9 13865.3 13951.8 14016.1 14348.9 8577.8 8772.9 9279.2 9314.7 9526.2 11025.4 11049.9 11087.3 11122.2 11137.1 7832.5 8910.4 9169.3 9227.4 9238.6 7280.8 8926.7 8978.5 9126.5 9142.5 7861.7 7897.7 7928.3 7991.7 8013.1 5064.8 5935.6 6105.9 6106.3 6312.9 6086.9 6088.6 6134.2 6206.8 6283.6 05:00:58 INFO - PID 1645 | 05:00:58 INFO - PID 1645 | [#4] prototype.html Cycles:180 Average:5441.05 Median:6159.66 stddev:1792.48 (29.1%) stddev-sans-first:1756.16 05:00:58 INFO - PID 1645 | Values: 340.9 392.8 397.8 404.3 407.9 4982.9 5444.4 5856.4 6205.8 6494.4 5540.0 5608.5 6143.9 6225.8 6392.5 3865.8 4145.5 4482.6 4612.2 4633.7 3663.6 3922.5 4025.9 4557.8 4628.4 4254.8 4525.3 4579.9 4593.3 4597.7 3788.7 4516.2 4523.5 4589.7 4605.6 3868.8 3887.4 3888.9 3897.3 3915.5 6237.5 6248.2 6262.0 6265.4 6284.7 5063.7 5278.9 5424.0 5450.3 5477.7 5700.9 5929.5 6783.0 6828.4 6840.6 4245.4 4463.3 4465.7 4476.9 4478.3 6149.9 7140.0 7225.9 7317.7 7328.8 3881.3 3983.2 4031.5 4521.7 4530.3 3916.6 4082.0 4467.5 4615.4 4617.8 4244.9 4372.2 4893.9 5308.7 5446.0 6841.7 6850.9 6862.0 6866.7 6901.3 1350.4 1524.2 1554.4 1577.0 1577.2 865.9 1001.2 1007.4 1017.3 1037.2 5850.9 6487.6 6502.9 6511.4 6587.6 6550.3 6870.2 7128.9 7162.8 7183.0 5778.9 6122.4 6359.6 6447.9 6451.6 3329.3 3650.0 3692.4 3747.3 3759.8 6720.4 7235.4 7293.8 7309.9 7397.3 6474.9 6625.5 6665.7 6711.4 7310.9 7049.6 7271.8 7309.7 7364.3 7399.7 7122.9 7128.9 7130.7 7136.3 7148.8 5775.7 6698.4 6975.4 7024.4 7052.2 7200.8 7232.7 7288.0 7380.0 7446.3 4527.3 4543.1 4543.3 4557.6 4559.6 6061.3 6213.5 6765.9 7087.6 7198.1 6881.3 6899.3 6900.4 6911.6 6913.9 5290.0 6094.7 6169.4 6896.0 6902.0 6753.2 6756.0 6762.5 6780.0 6786.3 6016.0 6807.8 6843.6 6889.7 6940.8 6452.9 6766.5 6768.8 6780.3 6788.3 05:00:58 INFO - PID 1645 | 05:00:58 INFO - PID 1645 | [#5] yui.html Cycles:180 Average:22499.92 Median:18191.09 stddev:32470.48 (178.5%) stddev-sans-first:32520.81 05:00:58 INFO - PID 1645 | Values: 832.3 841.6 854.7 866.1 880.0 13119.5 17105.8 17126.8 19098.1 19510.2 15548.5 18078.4 18445.8 18709.2 18716.1 974.6 979.6 982.1 989.6 992.0 993.9 1000.9 1003.3 1006.9 1018.6 1050.8 1063.2 1065.1 1066.2 1077.5 1047.0 1047.2 1060.7 1064.7 1073.4 748.5 763.1 766.3 771.7 776.1 16979.9 17421.3 17544.0 17548.0 17582.0 17035.6 17481.9 17488.7 17583.1 17641.3 12127.5 14073.1 14122.3 14364.3 14392.7 3105.6 3459.0 3508.2 3531.6 3537.3 133756.0 134234.0 134320.0 136111.0 138184.0 13128.7 13235.0 13412.4 13506.9 13652.9 26187.3 26226.6 26294.5 26384.9 26416.1 6677.5 7073.7 7595.7 7865.0 7867.5 3853.7 3905.1 3910.8 3926.4 3927.1 3945.1 3963.1 3966.7 3989.5 4034.4 929.1 952.5 957.1 957.7 959.2 581.1 648.0 649.2 651.5 687.8 9098.5 11108.2 11420.8 11947.1 11967.1 645.3 650.4 657.1 665.4 686.2 5473.1 5575.6 5626.5 5648.4 6105.9 107326.9 110736.0 112206.0 113604.0 114042.0 91220.1 92489.5 98988.0 103254.5 103822.5 77916.0 79856.6 80554.6 81907.2 82653.0 12355.0 12471.1 12599.9 12766.9 12790.4 39529.8 41434.6 41994.8 42536.8 42569.0 53082.0 53176.7 53586.0 53586.9 54924.5 16131.0 16561.3 16604.3 16737.9 16744.7 18001.8 18303.8 18311.5 18315.1 18697.7 16311.0 16861.3 17110.1 17189.5 17201.4 16376.0 16475.5 16972.8 17020.0 17072.2 15960.4 15992.5 16316.6 16586.8 16603.0 11844.2 11881.4 12038.6 12115.1 12135.6 12440.4 12581.4 12910.2 13024.3 13131.1 05:00:58 INFO - PID 1645 | -------- Summary: end -------- 05:00:58 INFO - PID 1645 | 05:00:59 INFO - TEST-INFO | 1645: exit 0 05:00:59 INFO - TEST-OK | dromaeo_css | took 1115135ms 05:00:59 INFO - TEST-START | kraken 05:00:59 INFO - operating with platform_type : mac_ 05:00:59 INFO - Initialising browser for kraken test... 05:00:59 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmpkH4Cl8/profile http://localhost:49241/getInfo.html) 05:01:02 INFO - PID 1659 | 2017-05-08 05:01:02.085 plugin-container[1660:10313] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 05:01:02 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:01:02 INFO - PID 1659 | 2017-05-08 05:01:02.086 plugin-container[1660:10313] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471f, name = 'com.apple.CFPasteboardClient' 05:01:02 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:01:02 INFO - PID 1659 | 2017-05-08 05:01:02.086 plugin-container[1660:10313] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:01:02 INFO - PID 1659 | __metrics Screen width/height:1600/1200 05:01:02 INFO - PID 1659 | colorDepth:24 05:01:02 INFO - PID 1659 | Browser inner width/height: 1024/691 05:01:02 INFO - PID 1659 | __metrics 05:01:03 INFO - TEST-INFO | 1659: exit 0 05:01:03 INFO - Browser initialized. 05:01:03 INFO - Running cycle 1/1 for kraken test... 05:01:03 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmpkH4Cl8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:05 INFO - PID 1662 | 2017-05-08 05:01:05.549 plugin-container[1663:10466] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x933b, name = 'com.apple.tsm.portname' 05:01:05 INFO - PID 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:01:05 INFO - PID 1662 | 2017-05-08 05:01:05.550 plugin-container[1663:10466] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970f, name = 'com.apple.CFPasteboardClient' 05:01:05 INFO - PID 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:01:05 INFO - PID 1662 | 2017-05-08 05:01:05.550 plugin-container[1663:10466] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:01:06 INFO - PID 1662 | 2017-05-08 05:01:06.248 plugin-container[1664:10512] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 05:01:06 INFO - PID 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:01:06 INFO - PID 1662 | 2017-05-08 05:01:06.248 plugin-container[1664:10512] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9903, name = 'com.apple.CFPasteboardClient' 05:01:06 INFO - PID 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:01:06 INFO - PID 1662 | 2017-05-08 05:01:06.249 plugin-container[1664:10512] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:01:15 INFO - PID 1662 | RSS: Main: 234950656 05:01:15 INFO - PID 1662 | 05:01:18 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:01:19 INFO - PID 1662 | RSS: Main: 247123968 05:01:19 INFO - PID 1662 | 05:01:22 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:01:22 INFO - PID 1662 | RSS: Main: 255315968 05:01:22 INFO - PID 1662 | 05:01:26 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:01:26 INFO - PID 1662 | RSS: Main: 258105344 05:01:26 INFO - PID 1662 | 05:01:28 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:01:29 INFO - PID 1662 | RSS: Main: 259911680 05:01:29 INFO - PID 1662 | 05:01:31 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:01:32 INFO - PID 1662 | RSS: Main: 260669440 05:01:32 INFO - PID 1662 | 05:01:35 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:01:35 INFO - PID 1662 | RSS: Main: 266006528 05:01:35 INFO - PID 1662 | 05:01:38 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:01:39 INFO - PID 1662 | RSS: Main: 267583488 05:01:39 INFO - PID 1662 | 05:01:42 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:01:43 INFO - PID 1662 | RSS: Main: 267206656 05:01:43 INFO - PID 1662 | 05:01:44 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:01:45 INFO - PID 1662 | RSS: Main: 266805248 05:01:45 INFO - PID 1662 | 05:01:47 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:01:47 INFO - PID 1662 | RSS: Main: 266874880 05:01:47 INFO - PID 1662 | 05:01:49 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:01:50 INFO - PID 1662 | RSS: Main: 266752000 05:01:50 INFO - PID 1662 | 05:01:53 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:01:54 INFO - PID 1662 | RSS: Main: 266772480 05:01:54 INFO - PID 1662 | 05:01:57 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:01:58 INFO - PID 1662 | RSS: Main: 266625024 05:01:58 INFO - PID 1662 | 05:01:59 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:02:00 INFO - PID 1662 | RSS: Main: 268341248 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | __start_tp_report 05:02:00 INFO - PID 1662 | _x_x_mozilla_page_load 05:02:00 INFO - PID 1662 | _x_x_mozilla_page_load_details 05:02:00 INFO - PID 1662 | |i|pagename|runs| 05:02:00 INFO - PID 1662 | |0;ai-astar;102;120;167;103;157;156;109;95;121;120 05:02:00 INFO - PID 1662 | |1;audio-beat-detection;180;104;99;151;164;144;95;146;154;137 05:02:00 INFO - PID 1662 | |2;audio-dft;195;204;215;250;215;278;273;199;199;200 05:02:00 INFO - PID 1662 | |3;audio-fft;81;56;58;82;59;60;62;56;76;70 05:02:00 INFO - PID 1662 | |4;audio-oscillator;95;54;84;93;102;87;103;103;99;95 05:02:00 INFO - PID 1662 | |5;imaging-gaussian-blur;91;91;92;91;90;102;137;88;89;91 05:02:00 INFO - PID 1662 | |6;imaging-darkroom;97;97;97;96;97;114;98;97;96;97 05:02:00 INFO - PID 1662 | |7;imaging-desaturate;90;108;117;90;126;138;91;92;92;93 05:02:00 INFO - PID 1662 | |8;json-parse-financial;51;51;51;52;52;52;51;55;51;49 05:02:00 INFO - PID 1662 | |9;json-stringify-tinderbox;55;63;58;65;65;62;66;81;83;83 05:02:00 INFO - PID 1662 | |10;stanford-crypto-aes;84;82;84;81;85;86;83;82;84;82 05:02:00 INFO - PID 1662 | |11;stanford-crypto-ccm;136;138;154;182;146;156;152;156;187;139 05:02:00 INFO - PID 1662 | |12;stanford-crypto-pbkdf2;199;229;205;177;241;233;186;181;186;186 05:02:00 INFO - PID 1662 | |13;stanford-crypto-sha256-iterative;66;72;69;69;70;66;70;70;69;69 05:02:00 INFO - PID 1662 | __end_tp_report 05:02:00 INFO - PID 1662 | __start_cc_report 05:02:00 INFO - PID 1662 | _x_x_mozilla_cycle_collect,980 05:02:00 INFO - PID 1662 | __end_cc_report 05:02:00 INFO - PID 1662 | __startTimestamp1494244920057__endTimestamp 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | ------- Summary: start ------- 05:02:00 INFO - PID 1662 | Number of tests: 14 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | [#0] ai-astar Cycles:10 Average:125.00 Median:138.50 stddev:25.79 (18.6%) stddev-sans-first:25.97 05:02:00 INFO - PID 1662 | Values: 102.0 120.0 167.0 103.0 157.0 156.0 109.0 95.0 121.0 120.0 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:159.00 stddev:28.85 (18.1%) stddev-sans-first:26.15 05:02:00 INFO - PID 1662 | Values: 180.0 104.0 99.0 151.0 164.0 144.0 95.0 146.0 154.0 137.0 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | [#2] audio-dft Cycles:10 Average:222.80 Median:215.00 stddev:31.99 (14.9%) stddev-sans-first:32.30 05:02:00 INFO - PID 1662 | Values: 195.0 204.0 215.0 250.0 215.0 278.0 273.0 199.0 199.0 200.0 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | [#3] audio-fft Cycles:10 Average:66.00 Median:66.00 stddev:10.34 (15.7%) stddev-sans-first:9.43 05:02:00 INFO - PID 1662 | Values: 81.0 56.0 58.0 82.0 59.0 60.0 62.0 56.0 76.0 70.0 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:90.00 stddev:14.68 (16.3%) stddev-sans-first:15.52 05:02:00 INFO - PID 1662 | Values: 95.0 54.0 84.0 93.0 102.0 87.0 103.0 103.0 99.0 95.0 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:96.20 Median:91.00 stddev:14.84 (16.3%) stddev-sans-first:15.62 05:02:00 INFO - PID 1662 | Values: 91.0 91.0 92.0 91.0 90.0 102.0 137.0 88.0 89.0 91.0 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | [#6] imaging-darkroom Cycles:10 Average:98.60 Median:97.00 stddev:5.44 (5.6%) stddev-sans-first:5.74 05:02:00 INFO - PID 1662 | Values: 97.0 97.0 97.0 96.0 97.0 114.0 98.0 97.0 96.0 97.0 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | [#7] imaging-desaturate Cycles:10 Average:103.70 Median:90.50 stddev:17.62 (19.5%) stddev-sans-first:17.98 05:02:00 INFO - PID 1662 | Values: 90.0 108.0 117.0 90.0 126.0 138.0 91.0 92.0 92.0 93.0 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.50 stddev:1.51 (2.9%) stddev-sans-first:1.59 05:02:00 INFO - PID 1662 | Values: 51.0 51.0 51.0 52.0 52.0 52.0 51.0 55.0 51.0 49.0 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:65.50 stddev:10.39 (15.9%) stddev-sans-first:9.88 05:02:00 INFO - PID 1662 | Values: 55.0 63.0 58.0 65.0 65.0 62.0 66.0 81.0 83.0 83.0 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.00 stddev:1.57 (1.9%) stddev-sans-first:1.64 05:02:00 INFO - PID 1662 | Values: 84.0 82.0 84.0 81.0 85.0 86.0 83.0 82.0 84.0 82.0 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:154.60 Median:155.00 stddev:17.48 (11.3%) stddev-sans-first:17.20 05:02:00 INFO - PID 1662 | Values: 136.0 138.0 154.0 182.0 146.0 156.0 152.0 156.0 187.0 139.0 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.30 Median:202.00 stddev:23.72 (11.7%) stddev-sans-first:25.12 05:02:00 INFO - PID 1662 | Values: 199.0 229.0 205.0 177.0 241.0 233.0 186.0 181.0 186.0 186.0 05:02:00 INFO - PID 1662 | 05:02:00 INFO - PID 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.83 (2.6%) stddev-sans-first:1.58 05:02:00 INFO - PID 1662 | Values: 66.0 72.0 69.0 69.0 70.0 66.0 70.0 70.0 69.0 69.0 05:02:00 INFO - PID 1662 | -------- Summary: end -------- 05:02:00 INFO - PID 1662 | 05:02:01 INFO - TEST-INFO | 1662: exit 0 05:02:01 INFO - TEST-OK | kraken | took 61818ms 05:02:01 INFO - SUITE-END | took 1176s 05:02:01 INFO - Completed test suite (00:19:37) 05:02:01 INFO - javascript benchmark 05:02:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7979.670731549188, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.492543730284, 3641.763285386448, 3668.8349024293902, 3668.926621467571, 3669.7798132112057, 6158.4765294949875, 6264.686765661716, 6297.6536290504, 6302.117703521505, 6329.082283068964, 6235.033569796688, 6244.84387890303, 6269.122322874801, 6279.246490421156, 6338.271098823637, 4661.743604101773, 5103.2855400244, 5482.17767334901, 5495.697736624484, 5508.338999320087, 5546.77812887484, 5579.7489112990015, 5606.299212598426, 5635.154726790973, 5657.0665840136535, 5411.21537377082, 5518.613697041209, 5538.335399752015, 5589.273394458714, 5596.664200148004, 4418.977905110486, 5444.50999410055, 5561.916571251434, 5574.163875418679, 5605.943940560583, 5386.622936394454, 5481.068218402881, 5493.697846618435, 5506.91739623906, 5511.807086751945, 5927.695906900518, 5998.550108741818, 6274.686265686697, 6278.937210627881, 6293.905591416133, 6480.578762380477, 6573.408393244583, 6643.0, 6708.698108585126, 6730.091437655903, 6824.976253561956, 6827.249002609709, 6851.520393572452, 6857.519973601849, 6874.106366172416, 4798.376211092571, 6277.435030847154, 6334.334894836022, 6354.269259035178, 6380.457661098812, 6767.255601883789, 6858.108445902001, 6873.1064961554675, 6916.792496225121, 6988.44092472601, 6385.584936979081, 6480.4815614750705, 6555.246146693191, 6575.769848055295, 6700.698468568926, 6797.52417330792, 6798.5241033128195, 6808.114945057111, 6808.148981377328, 6834.111565496453, 6614.173228346457, 6741.258461569223, 6756.4932630052945, 6757.695903684247, 6764.627945462948, 6448.355164483608, 6448.613083215022, 6560.540762146604, 6745.865082698417, 6771.322867713287, 5334.333208348957, 5356.866078348073, 5377.327834020747, 5389.622726409192, 5390.946090539044, 4722.763861806896, 4776.140294746979, 4777.044591081798, 4779.211430114062, 4806.0, 6149.41580549847, 6277.623342599459, 6299.496040316763, 6361.681915904186, 6371.108044873721, 5785.971070144622, 6629.46964242869, 6730.966345168341, 6748.763793267212, 6848.048668959649, 6309.747610095545, 6311.873762524724, 6354.841128971812, 6365.777197798055, 6372.299047104815, 5933.715519525014, 5986.880262394815, 5987.43119403656, 5996.730147143389, 6000.489958353589, 6769.796906092825, 6854.554453960476, 6918.619475928872, 6964.338387853045, 7042.50702450844, 6343.5876668016435, 6428.678566071584, 6853.862922741617, 6864.313568643096, 6888.51780375389, 6351.237851457855, 6586.1438013059915, 6990.26602206761, 6996.895046574407, 7091.539049961736, 6458.128152699325, 6659.4006539411685, 6689.331066893466, 6735.696893639896, 6754.527183097136, 6699.464042876656, 6787.253402125861, 6829.590224586541, 6841.589504629738, 6883.655817209019, 6429.453496452854, 6641.9667901662115, 6652.7006284716335, 6653.201615806134, 6662.167229096363, 6397.296297407374, 6481.351864813481, 6627.304133066152, 6629.569078009914, 6633.734650613921, 6258.749650013949, 6332.651704156316, 6495.740170393131, 6509.544331896722, 6525.9021114684265, 5355.5983301253345, 6459.935400646122, 6582.243042050225, 6619.470442364503, 6664.66676666155, 6425.453836423956, 6462.127612772216, 6485.54601177913, 6486.383793539606, 6493.22081350241], "value": 6132.937569854486, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.982250443739, 746.3432179681879, 819.369085803931, 1040.2562168049838, 1265.7088869560007, 37593.0, 38887.61112388875, 38902.61097389025, 38937.61062389382, 38959.805200973955, 32536.0, 38631.42052869209, 38891.805540972324, 38909.41635875457, 38930.0, 7879.0151231096115, 8056.677732890677, 8322.583870806466, 8538.103499132594, 8572.657093716243, 8397.286230670401, 8407.62165702545, 8500.404971651988, 8513.659453621847, 8538.274246689009, 8409.0, 8483.278921291698, 8507.447015943944, 8539.701110461136, 8545.786355341135, 8456.154384561525, 8509.319254459628, 8518.892543969276, 8521.020082690446, 8522.786930326729, 8342.124076971892, 8387.287080598157, 8392.958035209846, 8401.495910245343, 8429.030661473947, 37670.62329376726, 37754.0, 37788.24423511514, 37863.05342366435, 37942.051448713726, 3520.5775306963073, 3603.891883243507, 3642.6357364263363, 3648.1791596890753, 3671.889843304705, 29251.853740731374, 30764.692353076407, 30975.606097725657, 30988.76044958199, 31077.91227307056, 3117.703818137273, 3172.12766489215, 3194.185482701896, 3195.760317976161, 3226.951595726066, 220355.0, 255740.99999999814, 268436.0, 295706.0, 305875.47062264546, 40408.39387409191, 47216.5278347219, 47754.28368574474, 47943.760281198374, 48096.7595162022, 49842.0, 49854.252186217236, 51388.74305628448, 54644.0, 54726.452735472136, 14469.204193769443, 14576.489822856362, 14592.63518412027, 14633.0, 14633.902457315744, 11569.88430115688, 11619.186656934102, 11660.766784664429, 11664.94167529157, 11672.241304315192, 13971.720565588632, 14017.369218385196, 14029.438822447191, 14038.227897465533, 14052.508162214477, 6029.0, 6048.4858787003595, 6053.4551890330085, 6073.210482637229, 6088.847778805565, 902.0168016861652, 1019.5615885169449, 1027.198784947742, 1041.6093964763213, 1049.2812423489934, 23233.0, 23735.0, 24748.5050298993, 24914.501709965698, 24921.0, 1108.3128460354633, 1123.500042481088, 1150.384544268812, 1161.2916121166081, 1166.597523854269, 10705.625303114353, 11943.701407464883, 12684.556040538537, 12709.618711438672, 12710.555130570385, 293315.0, 295240.0, 295430.5228473844, 296664.0, 308908.0, 58085.12872306919, 58153.70923145357, 58213.70893145507, 58470.830583388095, 58520.414795852346, 1500.129924643704, 1532.885033622505, 1537.108477083289, 1538.169388530181, 1551.5733173377412, 30039.399212016073, 30396.544051839683, 30679.233019173807, 31106.0, 31483.370332593677, 39645.405318919664, 39787.80106099451, 39820.40269395903, 39834.402483962185, 39835.60164398319, 296479.0, 299054.0094599026, 299056.0, 300028.0, 300799.0, 35754.74858379944, 35881.1029724259, 35976.82011589925, 36004.0, 36859.447108293934, 47742.04515909732, 49895.251571227185, 50164.0, 50365.49634503754, 50509.49490505048, 28972.420551588428, 30016.699833002265, 30633.693663063084, 32534.34931301408, 32601.836990814892, 26994.325141870824, 32695.0, 32782.12446608891, 33556.99329020133, 33673.49489757606, 39095.02262443462, 39507.40738888976, 39658.2068358637, 39698.80150599228, 39864.402033970095, 28737.712622873503, 31663.683363166074, 33451.83274083614, 34112.65887341095, 34245.65754342425, 24198.87900560486, 24322.0, 25222.243332700047, 26080.608790867773, 26317.868410657826], "value": 17930.05833657688, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.53083466108603, 441.7062653335532, 446.85604851579956, 457.90841831633674, 469.95770380665755, 21017.0, 21960.341189764313, 22694.97872595733, 23661.0, 23708.0, 20344.593108137866, 23114.0, 23732.525349493, 23895.16366927158, 23983.640245396335, 6087.086936959469, 6156.692165391735, 6204.13142160098, 6269.341719119495, 6320.810375688737, 5390.245365648812, 6173.351798061206, 6271.529635277349, 6314.6842657867155, 6332.715027823736, 5835.533157347423, 6076.6050206736645, 6124.969375153118, 6130.816075517741, 6138.47822935051, 6051.606645568024, 6063.18147050147, 6081.179040829497, 6135.0, 6147.87704245917, 5399.676019438807, 5409.648372855751, 5471.863203419906, 5480.205370221295, 5483.341998960111, 27222.45555088887, 27264.45471090587, 28036.439271214665, 28399.14802555906, 28481.430371392664, 2217.7116974793335, 2245.113180293791, 2262.049939025613, 2262.694536237603, 2264.162259963824, 17243.74134387985, 17862.821371786376, 18304.90170589769, 18359.990200538967, 18533.166007529693, 2115.2490865742748, 2167.1656412281386, 2181.996281710415, 2190.485235969546, 2217.922372716947, 154108.0, 158033.20983395123, 159531.0, 160999.99999999884, 161010.0, 11195.776084478428, 12545.498180072695, 12733.61799146027, 12762.489500420064, 12863.0, 13359.599212023655, 16635.584110397336, 16659.833401665826, 16677.416290429777, 16694.165291735364, 8722.171393717586, 9008.459492430475, 9039.322050846213, 9084.227840633488, 9189.63241470347, 8427.32581393487, 8530.104339044436, 8532.488050716976, 8677.783055423539, 8693.087225841322, 6707.1616047994, 7966.960165199137, 8008.199180081945, 8056.39577031725, 8066.7413124325285, 2212.6570381590877, 2225.7662945390825, 2227.7883601057874, 2236.083205885579, 2365.018517315295, 906.2795077913075, 945.8533927241289, 950.2445555783169, 968.3612156872607, 993.572763711611, 21003.579928401345, 21495.355139345844, 21524.677129843065, 21572.352829415144, 21867.562648746934, 993.3692105512907, 1004.5328922051282, 1025.661531694554, 1032.4734385463469, 1033.5917312661456, 10573.9471302643, 10934.507947142398, 10950.39772812487, 10999.780004399867, 11006.284591501688, 549503.0, 559751.0, 567909.1604541951, 571378.0, 572368.0, 102368.0, 117998.0, 124780.0, 129231.0, 129907.35046324896, 1061.4639606998417, 1125.8480105185859, 1147.9196456247982, 1254.736505333872, 1270.841144856893, 20840.58318833645, 22050.669239961735, 22190.889045554668, 22285.220017299318, 22358.0, 46335.0, 56175.31474055785, 56200.0, 56773.58066048382, 57334.42665573291, 55582.72208638931, 77574.0, 79136.60431697805, 80240.19759802327, 85010.57494712487, 8896.777580560538, 8897.510636915033, 8900.154485323885, 8928.196462318423, 9227.261819054325, 14039.894015897697, 14227.0, 14334.426622935383, 14536.345864435914, 14582.4896128635, 11781.528738850693, 11817.82273265919, 11877.762444750884, 12143.514259429523, 12224.69438264015, 11227.775444491228, 11245.71885702864, 11365.943170284096, 11560.190786645191, 11646.126540509325, 9917.801643967225, 12044.0, 12128.514859405524, 12346.938265308616, 12389.380530973596, 9090.909090909006, 9126.634934602542, 9156.816863662556, 9164.450132992042, 9219.110082433219, 11843.644690659294, 11950.581729639422, 12067.215630983957, 12155.635330940086, 12173.69565760863], "value": 10557.953811289595, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.5281430720709, 1445.1864931785224, 1462.7805829125637, 1479.4599971010578, 1493.7609982402814, 9989.300748947559, 10219.0, 11373.545058197673, 11864.525418983241, 11898.345590992503, 11262.662120136409, 11624.418779061056, 11627.534898604046, 11633.883661163385, 11730.29618222905, 2221.9555608887813, 2498.325452127929, 2535.6069809179517, 2554.118829003991, 2554.5657238269446, 2004.837194427236, 2477.2815883393796, 2521.1176088369016, 2541.3265484646586, 2592.6370308156875, 2499.7125330587032, 2511.3721569607596, 2511.849289042654, 2517.1944977607172, 2524.924252272435, 2243.181238847809, 2243.3942835434423, 2257.24382331919, 2269.6822444857567, 2271.0802125139344, 2452.8037756979397, 2460.7047154341594, 2470.1354525915967, 2474.8762561871836, 2479.219046000504, 10099.899001010042, 11315.8684131587, 11630.767384652345, 11631.30212187263, 11731.7067073323, 5820.243368362086, 6518.315576864456, 6721.26066132725, 6780.627065511395, 6791.524593278473, 3525.7013972403024, 3642.4354225095153, 4382.496012958519, 4425.291953287491, 4459.264221403465, 1229.4098832560421, 1253.3795771093367, 1258.8237646729465, 1306.4251729239104, 1308.6205000549828, 13931.233782141979, 14329.068610540386, 16367.0, 16711.498655040246, 16713.916430417892, 5865.765369385177, 5929.902967950943, 6037.456628903332, 6097.268327800603, 6197.876042479215, 13741.03812733119, 13816.93091534536, 13835.0, 13845.238511881944, 13850.515231966832, 6747.291534388916, 6818.93181068183, 6820.727170913207, 6826.24911259761, 6832.59004459734, 5316.415194328621, 6186.876262474815, 6226.875462490725, 6267.4045965633195, 6269.65516896566, 4560.0, 4696.81212751493, 4724.858254252378, 4781.258904869751, 4785.856424307276, 1345.4618152738983, 1452.244832686997, 1455.9490417835536, 1479.1938393575526, 1489.2181604657642, 804.6539987805182, 810.3395732478011, 820.9014918209853, 826.8428998490267, 853.9530325832014, 6352.110704501373, 6591.571547849375, 6710.563813352116, 6804.251532331439, 6911.619860907598, 602.8515677634026, 608.3703367015119, 930.916217540411, 957.8132264208551, 977.9755506112405, 4209.684273679486, 4245.915081698348, 4271.551487093872, 4356.847510337187, 4361.214981303396, 14730.558083257305, 15326.23368831554, 15328.846711532966, 15331.23343832804, 15334.0, 14548.636284092983, 14902.403903843942, 15135.470258540898, 15154.242287885561, 15243.695126097417, 7131.714731410685, 8590.613422396007, 8600.22597966186, 8615.655373785105, 8643.135686431433, 6523.6738163092605, 6720.932790672031, 6931.44548436134, 6952.652367381509, 6964.79105626832, 12453.501859925502, 13114.950086675573, 13236.338183091, 13370.465181392636, 13438.52176260591, 13422.859056980265, 13865.306734663025, 13951.790723138958, 14016.088954217943, 14348.856511434751, 8577.785555361166, 8772.91227087721, 9279.211267042378, 9314.673986410444, 9526.190273826802, 11025.393603351893, 11049.889501104886, 11087.33475991443, 11122.165837562377, 11137.10903127764, 7832.451728378959, 8910.37627366104, 9169.312301577274, 9227.400218985744, 9238.630454782002, 7280.7815765525, 8926.68756593516, 8978.506182160045, 9126.49804260772, 9142.451452912846, 7861.724839630586, 7897.723579674684, 7928.326092282221, 7991.720289790062, 8013.118556958846, 5064.822731204537, 5935.643861368159, 6105.908411373922, 6106.32830388648, 6312.936870631235, 6086.939130608815, 6088.634681919099, 6134.202553667995, 6206.751729930752, 6283.59156654816], "value": 5394.443755159406, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.88409940620187, 392.8173399369293, 397.7514053716427, 404.30661415672137, 407.9143379890224, 4982.9252561211615, 5444.373897001841, 5856.355800861902, 6205.751769929208, 6494.383033611805, 5540.002799496089, 5608.523275521576, 6143.863385273717, 6225.782097626584, 6392.488600911927, 3865.845366185349, 4145.54399016108, 4482.641388688897, 4612.238980568202, 4633.721976681393, 3663.5970043295215, 3922.5292964844257, 4025.859094931678, 4557.794899229542, 4628.375169352128, 4254.829806807724, 4525.275955847065, 4579.908401831962, 4593.311003349491, 4597.678162528624, 3788.677962373202, 4516.18708632446, 4523.547645235483, 4589.724616523019, 4605.562471565196, 3868.845246190149, 3887.358585833334, 3888.941665875014, 3897.2984862724697, 3915.530136383624, 6237.4698150656795, 6248.218972628421, 6261.968690156566, 6265.404786545317, 6284.654344011077, 5063.734066483379, 5278.894422111574, 5424.0236757383655, 5450.264214331054, 5477.726113694339, 5700.914486282709, 5929.495992840613, 6783.0, 6828.385445309946, 6840.623765692885, 4245.448091748084, 4463.285874260136, 4465.665075119379, 4476.8880777980485, 4478.335390442681, 6149.938500614981, 7140.0, 7225.89161162583, 7317.670704818296, 7328.816779580553, 3881.320768865494, 3983.223271462095, 4031.5162180538523, 4521.683482156218, 4530.275155975094, 3916.6083391661177, 4082.0, 4467.486239082547, 4615.376924115269, 4617.792199351037, 4244.8514301999285, 4372.1692878353015, 4893.923336865883, 5308.734563271898, 5445.98498555537, 6841.692123854438, 6850.9314906850295, 6862.044317369626, 6866.725330986705, 6901.309869013159, 1350.4463170100212, 1524.1617110589132, 1554.4170935899037, 1577.0458872382274, 1577.2350410051115, 865.8960924689078, 1001.1990407673832, 1007.4308015970953, 1017.2624846986024, 1037.232447988483, 5850.882982340329, 6487.599588152414, 6502.869942601122, 6511.38141876521, 6587.550738837448, 6550.2794692583775, 6870.213744426485, 7128.857422851617, 7162.785116446515, 7183.0, 5778.855528611818, 6122.387761223931, 6359.554831161867, 6447.903281450782, 6451.580647257913, 3329.334133173375, 3650.0, 3692.372296709566, 3747.3442147624055, 3759.774413535197, 6720.361565651256, 7235.359093930782, 7293.781186564412, 7309.853802923912, 7397.26027397256, 6474.931636279961, 6625.536212465081, 6665.666716664147, 6711.429528490133, 7310.890336644955, 7049.647517624201, 7271.781846544613, 7309.671064802096, 7364.3372096511575, 7399.667014984231, 7122.934349038721, 7128.928710712827, 7130.679119439534, 7136.250693677089, 7148.785536433916, 5775.653460792366, 6698.363655452724, 6975.372216500539, 7024.367806897199, 7052.188998265266, 7200.783976480714, 7232.7468538603, 7287.9635601823775, 7380.011095506328, 7446.25537446251, 4527.275635898241, 4543.13680400736, 4543.250363689954, 4557.567031132037, 4559.635229181724, 6061.333253342041, 6213.5339849512375, 6765.8985115224295, 7087.645617719197, 7198.136223653195, 6881.277465866012, 6899.310068993061, 6900.447964162755, 6911.5853048817235, 6913.89629155553, 5289.973550132225, 6094.695265236809, 6169.383061693795, 6895.965520172367, 6901.964705294246, 6753.2233793112455, 6756.0, 6762.459003279824, 6780.016897549926, 6786.287439818945, 6015.969920150546, 6807.795766127024, 6843.555168914005, 6889.689963951734, 6940.7917762467205, 6452.935470645233, 6766.5263431559315, 6768.763093291711, 6780.288069752605, 6788.287229840796], "value": 4871.391789430693, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [832.3008672714918, 841.5834162089766, 854.7222152800338, 866.0646501778081, 880.0143838900433, 13119.54081607144, 17105.82894171058, 17126.828731712678, 19098.140583673732, 19510.21959121637, 15548.533543993699, 18078.367257146, 18445.81554184458, 18709.158087886077, 18716.06419679014, 974.5614473486924, 979.6277414582466, 982.0572250639359, 989.5596459575492, 991.9752006199867, 993.9254555908336, 1000.9349392289514, 1003.2776400991274, 1006.9244806639495, 1018.6078359831445, 1050.8371202463593, 1063.2025980514613, 1065.0840277361463, 1066.1577353890418, 1077.4774234496263, 1047.0, 1047.1831971062584, 1060.7242117049545, 1064.7338165458675, 1073.3935326540518, 748.4872862089486, 763.091920614467, 766.2720415605197, 771.7106085218044, 776.0803447914184, 16979.915100424543, 17421.30314787407, 17544.0, 17548.0, 17582.0, 17035.57411064721, 17481.912590437092, 17488.650226995516, 17583.12084395775, 17641.294348226056, 12127.514899404101, 14073.085249458854, 14122.293885305797, 14364.281785910664, 14392.712145757027, 3105.6428510721103, 3458.962311306623, 3508.2281897982402, 3531.593866705336, 3537.2925414916863, 133756.0, 134234.0, 134320.0, 136111.0, 138183.99999999898, 13128.671783205305, 13235.0, 13412.396442160127, 13506.864931350758, 13652.863471365357, 26187.345316367242, 26226.606600901003, 26294.474110518066, 26384.868075659884, 26416.0754373596, 6677.499187560952, 7073.681684324218, 7595.6961721531625, 7865.0, 7867.488613240121, 3853.7302388833073, 3905.1213476967455, 3910.7849068301516, 3926.430667553189, 3927.0771368728324, 3945.072907866649, 3963.1083006323925, 3966.6628336591134, 3989.4813674222164, 4034.3545032794614, 929.1219797291494, 952.4666186935339, 957.1194501059042, 957.6791774755395, 959.1511512311655, 581.0992960910572, 647.9967600162063, 649.2014821769156, 651.5439192565224, 687.8280429892527, 9098.545072746469, 11108.16688748347, 11420.828687569694, 11947.10396720232, 11967.102467314986, 645.3127419298432, 650.4373716735084, 657.1457105762489, 665.4410295351928, 686.1902954513622, 5473.124300111963, 5575.553955683536, 5626.493615574618, 5648.378678345379, 6105.908411373833, 107326.92673073325, 110736.0, 112206.0, 113604.0, 114042.0, 91220.08779912116, 92489.53755231181, 98988.01011989932, 103254.48372758238, 103822.48088759658, 77916.0, 79856.60071699605, 80554.59722701466, 81907.18092819233, 82653.0, 12355.0, 12471.127021108798, 12599.874001260237, 12766.872331276569, 12790.424430900817, 39529.80235098921, 41434.58565414428, 41994.790026049675, 42536.78731606322, 42569.0, 53082.0, 53176.73411633072, 53586.0, 53586.928261435336, 54924.45075549193, 16131.032138071754, 16561.337546498005, 16604.335826567287, 16737.91631041837, 16744.748828767333, 18001.819981800538, 18303.816961830213, 18311.54221144482, 18315.084245787923, 18697.719534206724, 16311.0, 16861.325546977983, 17110.144492775562, 17189.484315470556, 17201.397951071653, 16376.0, 16475.505734827973, 16972.830271697127, 17020.0, 17072.231749571052, 15960.361585536913, 15992.520224393287, 16316.592085197964, 16586.83413165853, 16603.0, 11844.230125041844, 11881.405929703653, 12038.638840834788, 12115.091368147601, 12135.575254866037, 12440.37798110109, 12581.433835477608, 12910.160839545399, 13024.28366439817, 13131.080824342205], "value": 8461.541672803438, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1570.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 120.0, 167.0, 103.0, 157.0, 156.0, 109.0, 95.0, 121.0, 120.0], "value": 125.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 104.0, 99.0, 151.0, 164.0, 144.0, 95.0, 146.0, 154.0, 137.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 204.0, 215.0, 250.0, 215.0, 278.0, 273.0, 199.0, 199.0, 200.0], "value": 222.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 56.0, 58.0, 82.0, 59.0, 60.0, 62.0, 56.0, 76.0, 70.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 54.0, 84.0, 93.0, 102.0, 87.0, 103.0, 103.0, 99.0, 95.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 92.0, 91.0, 90.0, 102.0, 137.0, 88.0, 89.0, 91.0], "value": 96.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 96.0, 97.0, 114.0, 98.0, 97.0, 96.0, 97.0], "value": 98.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 108.0, 117.0, 90.0, 126.0, 138.0, 91.0, 92.0, 92.0, 93.0], "value": 103.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 52.0, 52.0, 52.0, 51.0, 55.0, 51.0, 49.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 63.0, 58.0, 65.0, 65.0, 62.0, 66.0, 81.0, 83.0, 83.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 84.0, 81.0, 85.0, 86.0, 83.0, 82.0, 84.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 154.0, 182.0, 146.0, 156.0, 152.0, 156.0, 187.0, 139.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 229.0, 205.0, 177.0, 241.0, 233.0, 186.0, 181.0, 186.0, 186.0], "value": 202.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 69.0, 69.0, 70.0, 66.0, 70.0, 70.0, 69.0, 69.0], "value": 69.0, "unit": "score"}]}]} 05:02:01 INFO - Return code: 0 05:02:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:02:01 INFO - # TBPL SUCCESS # 05:02:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:02:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:02:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:02:01 INFO - 2017-05-08 05:02:01.387 screenresolution[1669:10899] starting screenresolution argv=screenresolution get 05:02:01 INFO - 2017-05-08 05:02:01.390 screenresolution[1669:10899] Display 0: 1600x1200x32@60 05:02:01 INFO - 2017-05-08 05:02:01.396 screenresolution[1670:10902] starting screenresolution argv=screenresolution list 05:02:01 INFO - Available Modes on Display 0 05:02:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:02:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:02:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:02:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:02:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:02:01 INFO - Intel Iris: 05:02:01 INFO - Chipset Model: Intel Iris 05:02:01 INFO - Type: GPU 05:02:01 INFO - Bus: Built-In 05:02:01 INFO - VRAM (Dynamic, Max): 1536 MB 05:02:01 INFO - Vendor: Intel (0x8086) 05:02:01 INFO - Device ID: 0x0a2e 05:02:01 INFO - Revision ID: 0x0009 05:02:01 INFO - Displays: 05:02:01 INFO - Display: 05:02:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:02:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:02:01 INFO - Display Serial Number: 1600x1200 60 05:02:01 INFO - Main Display: Yes 05:02:01 INFO - Mirror: Off 05:02:01 INFO - Online: Yes 05:02:01 INFO - Rotation: Supported 05:02:01 INFO - Return code: 0 05:02:01 INFO - Running post-action listener: _resource_record_post_action 05:02:01 INFO - [mozharness: 2017-05-08 12:02:01.649894Z] Finished run-tests step (success) 05:02:01 INFO - Running post-run listener: _resource_record_post_run 05:02:01 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 39655936; Write bytes: 529405952; Read time: 255; Write time: 1643 05:02:01 INFO - TinderboxPrint: CPU usage
54.2% 05:02:01 INFO - TinderboxPrint: I/O read bytes / time
39,655,936 / 255 05:02:01 INFO - TinderboxPrint: I/O write bytes / time
529,405,952 / 1,643 05:02:01 INFO - TinderboxPrint: CPU idle
2,192.9 (45.8%) 05:02:01 INFO - TinderboxPrint: CPU system
966.5 (20.2%) 05:02:01 INFO - TinderboxPrint: CPU user
1,630.3 (34.0%) 05:02:01 INFO - TinderboxPrint: Swap in / out
248,295,424 / 0 05:02:01 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207962624; Write bytes: 207214592; Read time: 16100; Write time: 432 05:02:01 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 37456384; Write bytes: 315052032; Read time: 233; Write time: 1182 05:02:02 INFO - Running post-run listener: _upload_blobber_files 05:02:02 INFO - Blob upload gear active. 05:02:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:02:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:02:02 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'] 05:02:02 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 05:02:02 INFO - (blobuploader) - INFO - Open directory for files ... 05:02:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:02:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:02:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:03 INFO - (blobuploader) - INFO - Done attempting. 05:02:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:02:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:02:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:04 INFO - (blobuploader) - INFO - Done attempting. 05:02:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:02:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:02:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:05 INFO - (blobuploader) - INFO - Done attempting. 05:02:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:02:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:02:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:09 INFO - (blobuploader) - INFO - Done attempting. 05:02:09 INFO - (blobuploader) - INFO - Iteration through files over. 05:02:09 INFO - Return code: 0 05:02:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:02:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:02:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57c87406ca0d2e826e7bb56d477756c34d345e6a409c746c23cca47a3d383fc67e42fa4faa2f00824fff08e8292f55277e8ba4ccfc60eb42c87b9045055be71f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6163ab75e556ee604b320566d8d0a223abb77c47ea2358634e5ddfcaf790b1f398b0ce95cf3fecd43029a0b94dead793f219aefd5b8d9f1931df47652194a21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdc0fbc4d528e6f59e9eb8c59442241577c0cc7692d5a3871fd13e129bcbf1fa964fe65571997e644e9903581eb3514a3b1c0a49e4abc33ab108e4946e6f0cc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab4e988f25f4d9848d7a529c987eefb0eb107dddba2df2f27fec90c1ee4a833c83f759cfbc6dfd2439c9de1df63b71bb4e0e0ec0e3c31caefffc8c4fabd85d62"} 05:02:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:02:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:02:09 INFO - Contents: 05:02:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57c87406ca0d2e826e7bb56d477756c34d345e6a409c746c23cca47a3d383fc67e42fa4faa2f00824fff08e8292f55277e8ba4ccfc60eb42c87b9045055be71f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6163ab75e556ee604b320566d8d0a223abb77c47ea2358634e5ddfcaf790b1f398b0ce95cf3fecd43029a0b94dead793f219aefd5b8d9f1931df47652194a21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdc0fbc4d528e6f59e9eb8c59442241577c0cc7692d5a3871fd13e129bcbf1fa964fe65571997e644e9903581eb3514a3b1c0a49e4abc33ab108e4946e6f0cc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab4e988f25f4d9848d7a529c987eefb0eb107dddba2df2f27fec90c1ee4a833c83f759cfbc6dfd2439c9de1df63b71bb4e0e0ec0e3c31caefffc8c4fabd85d62"} 05:02:09 INFO - Running post-run listener: copy_logs_to_upload_dir 05:02:09 INFO - Copying logs to upload dir... 05:02:09 INFO - mkdir: /builds/slave/test/build/upload/logs 05:02:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.353599 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-05-08 05:02:09.168181) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 05:02:09.171849) ========= 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.okRV1aHr3W/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.IgSq6uH11o/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57c87406ca0d2e826e7bb56d477756c34d345e6a409c746c23cca47a3d383fc67e42fa4faa2f00824fff08e8292f55277e8ba4ccfc60eb42c87b9045055be71f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6163ab75e556ee604b320566d8d0a223abb77c47ea2358634e5ddfcaf790b1f398b0ce95cf3fecd43029a0b94dead793f219aefd5b8d9f1931df47652194a21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdc0fbc4d528e6f59e9eb8c59442241577c0cc7692d5a3871fd13e129bcbf1fa964fe65571997e644e9903581eb3514a3b1c0a49e4abc33ab108e4946e6f0cc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab4e988f25f4d9848d7a529c987eefb0eb107dddba2df2f27fec90c1ee4a833c83f759cfbc6dfd2439c9de1df63b71bb4e0e0ec0e3c31caefffc8c4fabd85d62"} build_url:https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011094 build_url: 'https://queue.taskcluster.net/v1/task/dM_iGP8bT6yhrXnHdPhPLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57c87406ca0d2e826e7bb56d477756c34d345e6a409c746c23cca47a3d383fc67e42fa4faa2f00824fff08e8292f55277e8ba4ccfc60eb42c87b9045055be71f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6163ab75e556ee604b320566d8d0a223abb77c47ea2358634e5ddfcaf790b1f398b0ce95cf3fecd43029a0b94dead793f219aefd5b8d9f1931df47652194a21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdc0fbc4d528e6f59e9eb8c59442241577c0cc7692d5a3871fd13e129bcbf1fa964fe65571997e644e9903581eb3514a3b1c0a49e4abc33ab108e4946e6f0cc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab4e988f25f4d9848d7a529c987eefb0eb107dddba2df2f27fec90c1ee4a833c83f759cfbc6dfd2439c9de1df63b71bb4e0e0ec0e3c31caefffc8c4fabd85d62"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 05:02:09.207608) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 05:02:09.207957) ========= 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.okRV1aHr3W/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.IgSq6uH11o/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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.005183 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 05:02:09.257239) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 05:02:09.257565) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 05:02:09.257920) ========= ========= Total master_lag: 0.19 =========