builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0322 starttime: 1492042484.23 results: success (0) buildid: 20170412151409 builduid: 20573bb6aca24a37a6a7e95f3d027eb9 revision: ff7729561efd16e7c3140d40337a84318730ab9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 17:14:44.227440) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 17:14:44.227992) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 17:14:44.228307) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 17:14:44.254485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 17:14:44.255254) ========= 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.wkwb2zNABy/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.h7XoykGAv6/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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-04-12 17:14:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.6M=0.001s 2017-04-12 17:14:44 (14.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.190082 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 17:14:44.474813) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 17:14:44.475683) ========= 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.wkwb2zNABy/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.h7XoykGAv6/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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.021340 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 17:14:44.525322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-12 17:14:44.525697) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ff7729561efd16e7c3140d40337a84318730ab9c --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 ff7729561efd16e7c3140d40337a84318730ab9c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wkwb2zNABy/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.h7XoykGAv6/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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-04-12 17:14:44,642 truncating revision to first 12 chars 2017-04-12 17:14:44,642 Setting DEBUG logging. 2017-04-12 17:14:44,643 attempt 1/10 2017-04-12 17:14:44,643 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ff7729561efd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-12 17:14:45,653 unpacking tar archive at: mozilla-central-ff7729561efd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.277287 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-12 17:14:45.832456) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 17:14:45.833425) ========= script_repo_revision: ff7729561efd16e7c3140d40337a84318730ab9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 17:14:45.834545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 17:14:45.835398) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 17:14:45.857144) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-12 17:14:45.857873) ========= /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.wkwb2zNABy/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.h7XoykGAv6/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 17:14:46 INFO - MultiFileLogger online at 20170412 17:14:46 in /builds/slave/test 17:14:46 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 17:14:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:14:46 INFO - {'append_to_log': False, 17:14:46 INFO - 'base_work_dir': '/builds/slave/test', 17:14:46 INFO - 'blob_upload_branch': 'Firefox', 17:14:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:14:46 INFO - 'branch': 'Firefox', 17:14:46 INFO - 'buildbot_json_path': 'buildprops.json', 17:14:46 INFO - 'config_files': ('talos/mac_config.py',), 17:14:46 INFO - 'default_actions': ('clobber', 17:14:46 INFO - 'read-buildbot-config', 17:14:46 INFO - 'download-and-extract', 17:14:46 INFO - 'populate-webroot', 17:14:46 INFO - 'create-virtualenv', 17:14:46 INFO - 'install', 17:14:46 INFO - 'run-tests'), 17:14:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:14:46 INFO - 'download_minidump_stackwalk': True, 17:14:46 INFO - 'download_symbols': 'ondemand', 17:14:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:14:46 INFO - 'tooltool.py': '/tools/tooltool.py', 17:14:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:14:46 INFO - '/tools/misc-python/virtualenv.py')}, 17:14:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:14:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:14:46 INFO - 'gecko_profile': False, 17:14:46 INFO - 'gecko_profile_interval': 0, 17:14:46 INFO - 'installer_path': 'installer.exe', 17:14:46 INFO - 'log_level': 'info', 17:14:46 INFO - 'log_name': 'talos', 17:14:46 INFO - 'log_to_console': True, 17:14:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:14:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:14:46 INFO - 'opt_config_files': (), 17:14:46 INFO - 'pip_index': False, 17:14:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:14:46 INFO - 'cmd': ('bash', 17:14:46 INFO - '-c', 17:14:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:14:46 INFO - 'enabled': True, 17:14:46 INFO - 'halt_on_failure': False, 17:14:46 INFO - 'name': 'check_screen_resolution'},), 17:14:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:14:46 INFO - 'cmd': ('bash', 17:14:46 INFO - '-c', 17:14:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:14:46 INFO - 'enabled': True, 17:14:46 INFO - 'halt_on_failure': False, 17:14:46 INFO - 'name': 'check_screen_resolution'},), 17:14:46 INFO - 'run_cmd_checks_enabled': True, 17:14:46 INFO - 'suite': 'dromaeojs-e10s', 17:14:46 INFO - 'system_bits': '32', 17:14:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:14:46 INFO - 'title': 't-yosemite-r7-0322', 17:14:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:14:46 INFO - 'use_talos_json': True, 17:14:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:14:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:14:46 INFO - 'work_dir': 'build'} 17:14:46 INFO - [mozharness: 2017-04-13 00:14:46.091456Z] Running clobber step. 17:14:46 INFO - Running pre-action listener: _resource_record_pre_action 17:14:46 INFO - Running main action method: clobber 17:14:46 INFO - rmtree: /builds/slave/test/build 17:14:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:14:46 INFO - Running post-action listener: _resource_record_post_action 17:14:46 INFO - [mozharness: 2017-04-13 00:14:46.252725Z] Finished clobber step (success) 17:14:46 INFO - [mozharness: 2017-04-13 00:14:46.252848Z] Running read-buildbot-config step. 17:14:46 INFO - Running pre-action listener: _resource_record_pre_action 17:14:46 INFO - Running main action method: read_buildbot_config 17:14:46 INFO - Using buildbot properties: 17:14:46 INFO - { 17:14:46 INFO - "project": "", 17:14:46 INFO - "product": "firefox", 17:14:46 INFO - "script_repo_revision": "production", 17:14:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:14:46 INFO - "repository": "", 17:14:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:14:46 INFO - "buildid": "20170412151409", 17:14:46 INFO - "pgo_build": "False", 17:14:46 INFO - "basedir": "/builds/slave/test", 17:14:46 INFO - "buildnumber": 11, 17:14:46 INFO - "slavename": "t-yosemite-r7-0322", 17:14:46 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:14:46 INFO - "platform": "yosemite_r7", 17:14:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:14:46 INFO - "branch": "mozilla-central", 17:14:46 INFO - "repo_path": "mozilla-central", 17:14:46 INFO - "revision": "ff7729561efd16e7c3140d40337a84318730ab9c", 17:14:46 INFO - "stage_platform": "macosx64", 17:14:46 INFO - "builduid": "20573bb6aca24a37a6a7e95f3d027eb9", 17:14:46 INFO - "slavebuilddir": "test" 17:14:46 INFO - } 17:14:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 17:14:46 INFO - Running post-action listener: _resource_record_post_action 17:14:46 INFO - [mozharness: 2017-04-13 00:14:46.256252Z] Finished read-buildbot-config step (success) 17:14:46 INFO - [mozharness: 2017-04-13 00:14:46.256363Z] Running download-and-extract step. 17:14:46 INFO - Running pre-action listener: _resource_record_pre_action 17:14:46 INFO - Running main action method: download_and_extract 17:14:46 INFO - mkdir: /builds/slave/test/build/tests 17:14: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')]} 17:14:46 INFO - trying https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 17:14:46 INFO - Downloading https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/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 17:14:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/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 17:14:47 INFO - Downloaded 1325 bytes. 17:14:47 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:14:47 INFO - Using the following test package requirements: 17:14:47 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:14:47 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:14:47 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:14:47 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:14:47 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:14:47 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:14:47 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:14:47 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:14:47 INFO - u'jsshell-mac.zip'], 17:14:47 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:14:47 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:14:47 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:14:47 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:14:47 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:14:47 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:14:47 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:14:47 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:14:47 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:14:47 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:14:47 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:14:47 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:14:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:14:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:14:47 INFO - Fetch https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:14:49 INFO - Expected file size: 52593939 17:14:49 INFO - Obtained file size: 52593939 17:15:05 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 17:15:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:15:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:15:05 INFO - Fetch https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:15:07 INFO - Expected file size: 52593939 17:15:07 INFO - Obtained file size: 52593939 17:15:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 17:15:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:15:22 INFO - Fetch https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:15:24 INFO - Expected file size: 14407739 17:15:24 INFO - Obtained file size: 14407739 17:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:24 INFO - trying https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:15:24 INFO - Downloading https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:15:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/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 17:15:26 INFO - Downloaded 71051283 bytes. 17:15:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:15:26 INFO - mkdir: /builds/slave/test/properties 17:15:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:15:26 INFO - Writing to file /builds/slave/test/properties/build_url 17:15:26 INFO - Contents: 17:15:26 INFO - build_url:https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:15:27 INFO - Running post-action listener: _resource_record_post_action 17:15:27 INFO - Running post-action listener: set_extra_try_arguments 17:15:27 INFO - [mozharness: 2017-04-13 00:15:27.332427Z] Finished download-and-extract step (success) 17:15:27 INFO - [mozharness: 2017-04-13 00:15:27.332549Z] Running populate-webroot step. 17:15:27 INFO - Running pre-action listener: _resource_record_pre_action 17:15:27 INFO - Running main action method: populate_webroot 17:15:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:27 INFO - '--tppagecycles', 17:15:27 INFO - '7'], 17:15:27 INFO - 'tests': ['tsvgm']}}, 17:15:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:15:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:15:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:15:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:15:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:15:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:15:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:15:27 INFO - 'talos_options': ['--disable-e10s'], 17:15:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:15:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:15:27 INFO - 'talos_options': ['--disable-e10s'], 17:15:27 INFO - 'tests': ['damp', 'tps']}, 17:15:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:15:27 INFO - 'tests': ['damp', 'tps']}, 17:15:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:15:27 INFO - 'tests': ['dromaeo_dom']}, 17:15:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:15:27 INFO - 'tests': ['basic_compositor_video']}, 17:15:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:15:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:15:27 INFO - 'tests': ['a11yr', 17:15:27 INFO - 'ts_paint', 17:15:27 INFO - 'tpaint', 17:15:27 INFO - 'sessionrestore', 17:15:27 INFO - 'sessionrestore_no_auto_restore', 17:15:27 INFO - 'tabpaint']}, 17:15:27 INFO - 'other-e10s': {'tests': ['a11yr', 17:15:27 INFO - 'ts_paint', 17:15:27 INFO - 'tpaint', 17:15:27 INFO - 'sessionrestore', 17:15:27 INFO - 'sessionrestore_no_auto_restore', 17:15:27 INFO - 'tabpaint']}, 17:15:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:15:27 INFO - 'ts_paint', 17:15:27 INFO - 'tpaint', 17:15:27 INFO - 'sessionrestore', 17:15:27 INFO - 'sessionrestore_no_auto_restore', 17:15:27 INFO - 'tabpaint']}, 17:15:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:15:27 INFO - 'ts_paint', 17:15:27 INFO - 'tpaint', 17:15:27 INFO - 'sessionrestore', 17:15:27 INFO - 'sessionrestore_no_auto_restore', 17:15:27 INFO - 'tabpaint']}, 17:15:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:15:27 INFO - 'tests': ['a11yr', 17:15:27 INFO - 'ts_paint', 17:15:27 INFO - 'tpaint', 17:15:27 INFO - 'sessionrestore', 17:15:27 INFO - 'sessionrestore_no_auto_restore', 17:15:27 INFO - 'tabpaint']}, 17:15:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:15:27 INFO - 'tests': ['a11yr', 17:15:27 INFO - 'ts_paint', 17:15:27 INFO - 'tpaint', 17:15:27 INFO - 'sessionrestore', 17:15:27 INFO - 'sessionrestore_no_auto_restore', 17:15:27 INFO - 'tabpaint']}, 17:15:27 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:15:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:15:27 INFO - 'bloom_basic_ref']}, 17:15:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:15:27 INFO - 'tests': ['tsvgx', 17:15:27 INFO - 'tsvgr_opacity', 17:15:27 INFO - 'tart', 17:15:27 INFO - 'tscrollx', 17:15:27 INFO - 'cart', 17:15:27 INFO - 'tsvg_static']}, 17:15:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:15:27 INFO - 'tsvgr_opacity', 17:15:27 INFO - 'tart', 17:15:27 INFO - 'tscrollx', 17:15:27 INFO - 'cart', 17:15:27 INFO - 'tsvg_static']}, 17:15:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:15:27 INFO - 'talos_options': ['--disable-e10s'], 17:15:27 INFO - 'tests': ['tp5o']}, 17:15:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:15:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:15:27 INFO - 'talos_options': ['--disable-e10s', 17:15:27 INFO - '--xperf_path', 17:15:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:27 INFO - 'tests': ['tp5n']}, 17:15:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:15:27 INFO - 'talos_options': ['--xperf_path', 17:15:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:27 INFO - 'tests': ['tp5n']}}, 17:15:27 INFO - 'talos.zip': {'path': '', 17:15:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:27 INFO - Running post-action listener: _resource_record_post_action 17:15:27 INFO - [mozharness: 2017-04-13 00:15:27.351635Z] Finished populate-webroot step (success) 17:15:27 INFO - [mozharness: 2017-04-13 00:15:27.351735Z] Running create-virtualenv step. 17:15:27 INFO - Running pre-action listener: _resource_record_pre_action 17:15:27 INFO - Running main action method: create_virtualenv 17:15:27 INFO - Creating virtualenv /builds/slave/test/build/venv 17:15:27 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 17:15:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:15:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:27 INFO - Using real prefix '/tools/python27' 17:15:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:15:28 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:31 INFO - Installing pip.................done. 17:15:31 INFO - Return code: 0 17:15:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:15:31 INFO - Reading from file tmpfile_stdout 17:15:31 INFO - Output received: 17:15:31 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) 17:15:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:15:31 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')]} 17:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:31 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')]} 17:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:31 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 0x10a3efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bc3499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1cdd30>, '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 0x10a0f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c2be8>, '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.wkwb2zNABy/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.h7XoykGAv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 17:15:31 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 17:15:31 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 17:15:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkwb2zNABy/Render', 17:15:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:15:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:15:31 INFO - 'HOME': '/Users/cltbld', 17:15:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:15:31 INFO - 'LOGNAME': 'cltbld', 17:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:31 INFO - 'MOZ_NO_REMOTE': '1', 17:15:31 INFO - 'NO_EM_RESTART': '1', 17:15:31 INFO - 'PAGER': '/bin/cat', 17:15:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:31 INFO - 'PWD': '/builds/slave/test', 17:15:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:15:31 INFO - 'SHELL': '/bin/bash', 17:15:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7XoykGAv6/Listeners', 17:15:31 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 17:15:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:15:31 INFO - 'USER': 'cltbld', 17:15:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:15:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:31 INFO - 'XPC_FLAGS': '0x0', 17:15:31 INFO - 'XPC_SERVICE_NAME': '0', 17:15:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:31 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 17:15:31 INFO - Cleaning up... 17:15:31 INFO - Return code: 0 17:15:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:15:31 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')]} 17:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:31 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')]} 17:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:31 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 0x10a3efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bc3499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1cdd30>, '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 0x10a0f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c2be8>, '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.wkwb2zNABy/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.h7XoykGAv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 17:15:31 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 17:15:31 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 17:15:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkwb2zNABy/Render', 17:15:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:15:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:15:31 INFO - 'HOME': '/Users/cltbld', 17:15:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:15:31 INFO - 'LOGNAME': 'cltbld', 17:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:31 INFO - 'MOZ_NO_REMOTE': '1', 17:15:31 INFO - 'NO_EM_RESTART': '1', 17:15:31 INFO - 'PAGER': '/bin/cat', 17:15:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:31 INFO - 'PWD': '/builds/slave/test', 17:15:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:15:31 INFO - 'SHELL': '/bin/bash', 17:15:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7XoykGAv6/Listeners', 17:15:31 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 17:15:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:15:31 INFO - 'USER': 'cltbld', 17:15:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:15:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:31 INFO - 'XPC_FLAGS': '0x0', 17:15:31 INFO - 'XPC_SERVICE_NAME': '0', 17:15:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:31 INFO - Downloading/unpacking psutil>=3.1.1 17:15:31 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 17:15:31 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 17:15:31 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 17:15:31 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 17:15:31 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 17:15:31 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 17:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:15:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:35 INFO - Installing collected packages: psutil 17:15:35 INFO - Running setup.py install for psutil 17:15:35 INFO - building 'psutil._psutil_osx' extension 17:15:35 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 17:15:35 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 17:15:35 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 17:15:35 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 17:15:36 INFO - building 'psutil._psutil_posix' extension 17:15:36 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 17:15:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:15:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:15:36 INFO - ^ 17:15:36 INFO - 1 warning generated. 17:15:36 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 17:15:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:36 INFO - Successfully installed psutil 17:15:36 INFO - Cleaning up... 17:15:36 INFO - Return code: 0 17:15:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:15:36 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')]} 17:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:36 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')]} 17:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:36 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 0x10a3efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bc3499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1cdd30>, '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 0x10a0f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c2be8>, '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.wkwb2zNABy/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.h7XoykGAv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 17:15:36 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 17:15:36 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 17:15:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkwb2zNABy/Render', 17:15:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:15:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:15:36 INFO - 'HOME': '/Users/cltbld', 17:15:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:15:36 INFO - 'LOGNAME': 'cltbld', 17:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:36 INFO - 'MOZ_NO_REMOTE': '1', 17:15:36 INFO - 'NO_EM_RESTART': '1', 17:15:36 INFO - 'PAGER': '/bin/cat', 17:15:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:36 INFO - 'PWD': '/builds/slave/test', 17:15:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:15:36 INFO - 'SHELL': '/bin/bash', 17:15:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7XoykGAv6/Listeners', 17:15:36 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 17:15:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:15:36 INFO - 'USER': 'cltbld', 17:15:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:15:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:36 INFO - 'XPC_FLAGS': '0x0', 17:15:36 INFO - 'XPC_SERVICE_NAME': '0', 17:15:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:15:36 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 17:15:36 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 17:15:36 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 17:15:36 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 17:15:36 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 17:15:36 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 17:15:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:15:39 INFO - Installing collected packages: mozsystemmonitor 17:15:39 INFO - Running setup.py install for mozsystemmonitor 17:15:39 INFO - Successfully installed mozsystemmonitor 17:15:39 INFO - Cleaning up... 17:15:39 INFO - Return code: 0 17:15:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a3efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bc3499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1cdd30>, '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 0x10a0f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c2be8>, '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.wkwb2zNABy/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.h7XoykGAv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 17:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:15:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkwb2zNABy/Render', 17:15:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:15:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:15:40 INFO - 'HOME': '/Users/cltbld', 17:15:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:15:40 INFO - 'LOGNAME': 'cltbld', 17:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:40 INFO - 'MOZ_NO_REMOTE': '1', 17:15:40 INFO - 'NO_EM_RESTART': '1', 17:15:40 INFO - 'PAGER': '/bin/cat', 17:15:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:40 INFO - 'PWD': '/builds/slave/test', 17:15:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:15:40 INFO - 'SHELL': '/bin/bash', 17:15:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7XoykGAv6/Listeners', 17:15:40 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 17:15:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:15:40 INFO - 'USER': 'cltbld', 17:15:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:15:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:40 INFO - 'XPC_FLAGS': '0x0', 17:15:40 INFO - 'XPC_SERVICE_NAME': '0', 17:15:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:40 INFO - Downloading/unpacking jsonschema==2.5.1 17:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:15:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:43 INFO - Downloading functools32-3.2.3-2.tar.gz 17:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:15:43 INFO - warning: no files found matching '*.txt' 17:15:43 INFO - no previously-included directories found matching 'build' 17:15:43 INFO - no previously-included directories found matching 'dist' 17:15:43 INFO - no previously-included directories found matching '.git*' 17:15:43 INFO - Installing collected packages: jsonschema, functools32 17:15:44 INFO - Running setup.py install for functools32 17:15:44 INFO - warning: no files found matching '*.txt' 17:15:44 INFO - no previously-included directories found matching 'build' 17:15:44 INFO - no previously-included directories found matching 'dist' 17:15:44 INFO - no previously-included directories found matching '.git*' 17:15:44 INFO - Successfully installed jsonschema functools32 17:15:44 INFO - Cleaning up... 17:15:44 INFO - Return code: 0 17:15:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:15: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')]} 17:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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', '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 0x10a3efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bc3499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1cdd30>, '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 0x10a0f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c2be8>, '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.wkwb2zNABy/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.h7XoykGAv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 17:15: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:15: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 functools32==3.2.3-2 17:15:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkwb2zNABy/Render', 17:15:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:15:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:15:44 INFO - 'HOME': '/Users/cltbld', 17:15:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:15:44 INFO - 'LOGNAME': 'cltbld', 17:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:44 INFO - 'MOZ_NO_REMOTE': '1', 17:15:44 INFO - 'NO_EM_RESTART': '1', 17:15:44 INFO - 'PAGER': '/bin/cat', 17:15:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:44 INFO - 'PWD': '/builds/slave/test', 17:15:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:15:44 INFO - 'SHELL': '/bin/bash', 17:15:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7XoykGAv6/Listeners', 17:15:44 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 17:15:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:15:44 INFO - 'USER': 'cltbld', 17:15:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:15:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:44 INFO - 'XPC_FLAGS': '0x0', 17:15:44 INFO - 'XPC_SERVICE_NAME': '0', 17:15:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:15:44 INFO - Cleaning up... 17:15:44 INFO - Return code: 0 17:15:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:15: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')]} 17:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a3efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bc3499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1cdd30>, '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 0x10a0f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c2be8>, '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.wkwb2zNABy/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.h7XoykGAv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 17:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:15:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkwb2zNABy/Render', 17:15:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:15:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:15:44 INFO - 'HOME': '/Users/cltbld', 17:15:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:15:44 INFO - 'LOGNAME': 'cltbld', 17:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:44 INFO - 'MOZ_NO_REMOTE': '1', 17:15:44 INFO - 'NO_EM_RESTART': '1', 17:15:44 INFO - 'PAGER': '/bin/cat', 17:15:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:44 INFO - 'PWD': '/builds/slave/test', 17:15:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:15:44 INFO - 'SHELL': '/bin/bash', 17:15:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7XoykGAv6/Listeners', 17:15:44 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 17:15:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:15:44 INFO - 'USER': 'cltbld', 17:15:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:15:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:44 INFO - 'XPC_FLAGS': '0x0', 17:15:44 INFO - 'XPC_SERVICE_NAME': '0', 17:15:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:45 INFO - Downloading/unpacking blobuploader==1.2.4 17:15:45 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 17:15:45 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 17:15:45 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 17:15:45 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 17:15:45 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 17:15:45 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 17:15:47 INFO - Downloading blobuploader-1.2.4.tar.gz 17:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:15:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:15:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:15:48 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 17:15:48 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 17:15:48 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 17:15:48 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 17:15:48 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 17:15:48 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 17:15:48 INFO - Downloading docopt-0.6.1.tar.gz 17:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:15:49 INFO - Installing collected packages: blobuploader, requests, docopt 17:15:49 INFO - Running setup.py install for blobuploader 17:15:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:15:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:15:49 INFO - Running setup.py install for requests 17:15:49 INFO - Running setup.py install for docopt 17:15:49 INFO - Successfully installed blobuploader requests docopt 17:15:49 INFO - Cleaning up... 17:15:50 INFO - Return code: 0 17:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15: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')]} 17:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:50 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 0x10a3efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bc3499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1cdd30>, '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 0x10a0f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c2be8>, '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.wkwb2zNABy/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.h7XoykGAv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 17:15:50 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 17:15:50 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 17:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkwb2zNABy/Render', 17:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:15:50 INFO - 'HOME': '/Users/cltbld', 17:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:15:50 INFO - 'LOGNAME': 'cltbld', 17:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:50 INFO - 'MOZ_NO_REMOTE': '1', 17:15:50 INFO - 'NO_EM_RESTART': '1', 17:15:50 INFO - 'PAGER': '/bin/cat', 17:15:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:50 INFO - 'PWD': '/builds/slave/test', 17:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:15:50 INFO - 'SHELL': '/bin/bash', 17:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7XoykGAv6/Listeners', 17:15:50 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 17:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:15:50 INFO - 'USER': 'cltbld', 17:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:50 INFO - 'XPC_FLAGS': '0x0', 17:15:50 INFO - 'XPC_SERVICE_NAME': '0', 17:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:50 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-RgOMRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:50 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-Mdo3x7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:50 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-_yYBT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:50 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-w8xv2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:50 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-qAfKK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:50 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-i0UcHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:50 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-mvtvBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:51 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-GVQI6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:51 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-8IlO6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:51 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-uoEBSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:51 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-SOf9Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:51 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-nbiToD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:51 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-hdSrGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:51 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-Jau10X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:51 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-RU3DF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:51 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-6W4O5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:51 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-wazJZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:15:52 INFO - Running setup.py install for manifestparser 17:15:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:15:52 INFO - Running setup.py install for mozcrash 17:15:52 INFO - Running setup.py install for mozdebug 17:15:52 INFO - Running setup.py install for mozdevice 17:15:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:15:52 INFO - Running setup.py install for mozfile 17:15:52 INFO - Running setup.py install for mozhttpd 17:15:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:15:52 INFO - Running setup.py install for mozinfo 17:15:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Running setup.py install for mozInstall 17:15:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Running setup.py install for mozleak 17:15:53 INFO - Running setup.py install for mozlog 17:15:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Running setup.py install for moznetwork 17:15:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Running setup.py install for mozprocess 17:15:53 INFO - Running setup.py install for mozprofile 17:15:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:15:53 INFO - Running setup.py install for mozrunner 17:15:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:15:54 INFO - Running setup.py install for mozscreenshot 17:15:54 INFO - Running setup.py install for moztest 17:15:54 INFO - Running setup.py install for mozversion 17:15:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:15:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:15:54 INFO - Cleaning up... 17:15:54 INFO - Return code: 0 17:15:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15: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')]} 17:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:54 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 0x10a3efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bc3499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1cdd30>, '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 0x10a0f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c2be8>, '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.wkwb2zNABy/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.h7XoykGAv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 17:15:54 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 17:15:54 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 17:15:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkwb2zNABy/Render', 17:15:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:15:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:15:54 INFO - 'HOME': '/Users/cltbld', 17:15:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:15:54 INFO - 'LOGNAME': 'cltbld', 17:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:54 INFO - 'MOZ_NO_REMOTE': '1', 17:15:54 INFO - 'NO_EM_RESTART': '1', 17:15:54 INFO - 'PAGER': '/bin/cat', 17:15:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:54 INFO - 'PWD': '/builds/slave/test', 17:15:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:15:54 INFO - 'SHELL': '/bin/bash', 17:15:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7XoykGAv6/Listeners', 17:15:54 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 17:15:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:15:54 INFO - 'USER': 'cltbld', 17:15:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:15:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:54 INFO - 'XPC_FLAGS': '0x0', 17:15:54 INFO - 'XPC_SERVICE_NAME': '0', 17:15:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:54 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-2OpYiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:55 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)) 17:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:55 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-JqFR5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:55 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)) 17:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:55 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-OK5jiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:55 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)) 17:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:55 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-t7DSxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:55 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)) 17:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:55 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-pBj_O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:55 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)) 17:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:55 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-azm2FE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:55 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)) 17:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:55 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-Bh3OET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:55 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)) 17:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:55 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-hkrRpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:55 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)) 17:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:55 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-tdW8eZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:55 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)) 17:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:55 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-AmdBEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:55 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)) 17:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:55 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-4a8O24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:56 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)) 17:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:56 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-hXPcVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:56 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)) 17:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:56 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-K56ven-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:56 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)) 17:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:56 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-I9HdNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:56 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)) 17:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:56 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-gOD9oE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:56 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)) 17:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:56 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-erd2lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:56 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)) 17:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:56 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-tJ9S5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:56 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)) 17:15:56 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)) 17:15:56 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)) 17:15:56 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)) 17:15:56 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)) 17:15:56 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)) 17:15:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:59 INFO - Downloading blessings-1.6.tar.gz 17:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:15:59 INFO - Installing collected packages: blessings 17:15:59 INFO - Running setup.py install for blessings 17:15:59 INFO - Successfully installed blessings 17:15:59 INFO - Cleaning up... 17:15:59 INFO - Return code: 0 17:15:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:15:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:59 INFO - Reading from file tmpfile_stdout 17:15:59 INFO - Current package versions: 17:15:59 INFO - blessings == 1.6 17:15:59 INFO - blobuploader == 1.2.4 17:15:59 INFO - docopt == 0.6.1 17:15:59 INFO - functools32 == 3.2.3-2 17:15:59 INFO - jsonschema == 2.5.1 17:15:59 INFO - manifestparser == 1.1 17:15:59 INFO - mozInstall == 1.12 17:15:59 INFO - mozcrash == 1.0 17:15:59 INFO - mozdebug == 0.1 17:15:59 INFO - mozdevice == 0.50 17:15:59 INFO - mozfile == 1.2 17:15:59 INFO - mozhttpd == 0.7 17:15:59 INFO - mozinfo == 0.9 17:15:59 INFO - mozleak == 0.1 17:15:59 INFO - mozlog == 3.4 17:15:59 INFO - moznetwork == 0.27 17:15:59 INFO - mozprocess == 0.25 17:15:59 INFO - mozprofile == 0.28 17:15:59 INFO - mozrunner == 6.13 17:15:59 INFO - mozscreenshot == 0.1 17:15:59 INFO - mozsystemmonitor == 0.3 17:15:59 INFO - moztest == 0.8 17:15:59 INFO - mozversion == 1.4 17:15:59 INFO - psutil == 3.1.1 17:15:59 INFO - requests == 1.2.3 17:15:59 INFO - wsgiref == 0.1.2 17:15:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:59 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 0x10a3efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bc3499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1cdd30>, '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 0x10a0f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c2be8>, '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.wkwb2zNABy/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.h7XoykGAv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 17:15:59 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 17:15:59 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 17:15:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkwb2zNABy/Render', 17:15:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:15:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:15:59 INFO - 'HOME': '/Users/cltbld', 17:15:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:15:59 INFO - 'LOGNAME': 'cltbld', 17:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:59 INFO - 'MOZ_NO_REMOTE': '1', 17:15:59 INFO - 'NO_EM_RESTART': '1', 17:15:59 INFO - 'PAGER': '/bin/cat', 17:15:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:59 INFO - 'PWD': '/builds/slave/test', 17:15:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:15:59 INFO - 'SHELL': '/bin/bash', 17:15:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7XoykGAv6/Listeners', 17:15:59 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 17:15:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:15:59 INFO - 'USER': 'cltbld', 17:15:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:15:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:59 INFO - 'XPC_FLAGS': '0x0', 17:15:59 INFO - 'XPC_SERVICE_NAME': '0', 17:15:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:00 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)) 17:16:00 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)) 17:16:00 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)) 17:16:00 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)) 17:16:00 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)) 17:16:00 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)) 17:16:00 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)) 17:16:00 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)) 17:16:00 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)) 17:16:00 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)) 17:16:00 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)) 17:16:00 INFO - Cleaning up... 17:16:00 INFO - Return code: 0 17:16:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a3efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bc3499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1cdd30>, '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 0x10a0f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c2be8>, '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.wkwb2zNABy/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.h7XoykGAv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 17:16:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:16:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkwb2zNABy/Render', 17:16:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:00 INFO - 'HOME': '/Users/cltbld', 17:16:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:00 INFO - 'LOGNAME': 'cltbld', 17:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:00 INFO - 'MOZ_NO_REMOTE': '1', 17:16:00 INFO - 'NO_EM_RESTART': '1', 17:16:00 INFO - 'PAGER': '/bin/cat', 17:16:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:00 INFO - 'PWD': '/builds/slave/test', 17:16:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:00 INFO - 'SHELL': '/bin/bash', 17:16:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7XoykGAv6/Listeners', 17:16:00 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 17:16:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:00 INFO - 'USER': 'cltbld', 17:16:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:00 INFO - 'XPC_FLAGS': '0x0', 17:16:00 INFO - 'XPC_SERVICE_NAME': '0', 17:16:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:16:00 INFO - Cleaning up... 17:16:00 INFO - Return code: 0 17:16:00 INFO - Running post-action listener: _resource_record_post_action 17:16:00 INFO - Running post-action listener: _start_resource_monitoring 17:16:00 INFO - Starting resource monitoring. 17:16:00 INFO - [mozharness: 2017-04-13 00:16:00.524589Z] Finished create-virtualenv step (success) 17:16:00 INFO - [mozharness: 2017-04-13 00:16:00.525501Z] Running install step. 17:16:00 INFO - Running pre-action listener: _resource_record_pre_action 17:16:00 INFO - Running main action method: install 17:16:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:00 INFO - Reading from file tmpfile_stdout 17:16:00 INFO - Detecting whether we're running mozinstall >=1.0... 17:16:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:16:00 INFO - Reading from file tmpfile_stdout 17:16:00 INFO - Output received: 17:16:00 INFO - Usage: mozinstall [options] installer 17:16:00 INFO - Options: 17:16:00 INFO - -h, --help show this help message and exit 17:16:00 INFO - -d DEST, --destination=DEST 17:16:00 INFO - Directory to install application into. [default: 17:16:00 INFO - "/builds/slave/test"] 17:16:00 INFO - --app=APP Application being installed. [default: firefox] 17:16:00 INFO - mkdir: /builds/slave/test/build/application 17:16:00 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'] 17:16:00 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 17:16:20 INFO - Reading from file tmpfile_stdout 17:16:20 INFO - Output received: 17:16:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:16:20 INFO - Running post-action listener: _resource_record_post_action 17:16:20 INFO - [mozharness: 2017-04-13 00:16:20.672778Z] Finished install step (success) 17:16:20 INFO - [mozharness: 2017-04-13 00:16:20.672912Z] Running run-tests step. 17:16:20 INFO - Running pre-action listener: _resource_record_pre_action 17:16:20 INFO - Running main action method: run_tests 17:16:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:16:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:16:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:16:20 INFO - 2017-04-12 17:16:20.687 screenresolution[2207:11123] starting screenresolution argv=screenresolution get 17:16:20 INFO - 2017-04-12 17:16:20.690 screenresolution[2207:11123] Display 0: 1600x1200x32@60 17:16:20 INFO - 2017-04-12 17:16:20.696 screenresolution[2208:11126] starting screenresolution argv=screenresolution list 17:16:20 INFO - Available Modes on Display 0 17:16:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:16:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:16:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:16:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:16:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:16:20 INFO - Intel Iris: 17:16:20 INFO - Chipset Model: Intel Iris 17:16:20 INFO - Type: GPU 17:16:20 INFO - Bus: Built-In 17:16:20 INFO - VRAM (Dynamic, Max): 1536 MB 17:16:20 INFO - Vendor: Intel (0x8086) 17:16:20 INFO - Device ID: 0x0a2e 17:16:20 INFO - Revision ID: 0x0009 17:16:20 INFO - Displays: 17:16:20 INFO - Display: 17:16:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:16:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:16:20 INFO - Display Serial Number: 1600x1200 60 17:16:20 INFO - Main Display: Yes 17:16:20 INFO - Mirror: Off 17:16:20 INFO - Online: Yes 17:16:20 INFO - Rotation: Supported 17:16:20 INFO - Return code: 0 17:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:16:20 INFO - Python 2.7.3 17:16:20 INFO - Return code: 0 17:16:20 INFO - grabbing minidump binary from tooltool 17:16:20 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')]} 17:16:20 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 0x10a1cdd30>, '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 0x10a0f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:16:20 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 17:16:20 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 17:16:20 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 17:16:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:16:21 INFO - Return code: 0 17:16:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:16:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:16:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:16:21 INFO - ENV: RUST_BACKTRACE is now 1 17:16:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:16:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:16:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0322', '--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 17:16:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0322 --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 17:16:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkwb2zNABy/Render', 17:16:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:21 INFO - 'HOME': '/Users/cltbld', 17:16:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:21 INFO - 'LOGNAME': 'cltbld', 17:16:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:16:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:21 INFO - 'MOZ_NO_REMOTE': '1', 17:16:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:16:21 INFO - 'NO_EM_RESTART': '1', 17:16:21 INFO - 'PAGER': '/bin/cat', 17:16:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:21 INFO - 'PWD': '/builds/slave/test', 17:16:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:16:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:21 INFO - 'RUST_BACKTRACE': '1', 17:16:21 INFO - 'SHELL': '/bin/bash', 17:16:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7XoykGAv6/Listeners', 17:16:21 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 17:16:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:21 INFO - 'USER': 'cltbld', 17:16:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:21 INFO - 'XPC_FLAGS': '0x0', 17:16:21 INFO - 'XPC_SERVICE_NAME': '0', 17:16:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0322', '--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 17:16:21 INFO - mozversion application_buildid: 20170412151409 17:16:21 INFO - mozversion application_changeset: ff7729561efd16e7c3140d40337a84318730ab9c 17:16:21 INFO - mozversion application_display_name: Nightly 17:16:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:16:21 INFO - mozversion application_name: Firefox 17:16:21 INFO - mozversion application_remotingname: firefox 17:16:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:16:21 INFO - mozversion application_vendor: Mozilla 17:16:21 INFO - mozversion application_version: 55.0a1 17:16:21 INFO - mozversion platform_buildid: 20170412151409 17:16:21 INFO - mozversion platform_changeset: ff7729561efd16e7c3140d40337a84318730ab9c 17:16:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:16:21 INFO - mozversion platform_version: 55.0a1 17:16:21 INFO - using testdate: 1492042581 17:16:21 INFO - actual date: 1492042581 17:16:21 INFO - starting webserver on 'localhost:49494' 17:16:21 INFO - SUITE-START | Running 2 tests 17:16:21 INFO - TEST-START | dromaeo_css 17:16:21 INFO - operating with platform_type : mac_ 17:16:21 INFO - Initialising browser for dromaeo_css test... 17:16:21 INFO - TEST-INFO | started process 2218 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpClYdTG/profile http://localhost:49494/getInfo.html) 17:16:24 INFO - PID 2218 | 2017-04-12 17:16:24.111 plugin-container[2219:11284] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c3b, name = 'com.apple.tsm.portname' 17:16:24 INFO - PID 2218 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:16:24 INFO - PID 2218 | 2017-04-12 17:16:24.113 plugin-container[2219:11284] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9317, name = 'com.apple.CFPasteboardClient' 17:16:24 INFO - PID 2218 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:16:24 INFO - PID 2218 | 2017-04-12 17:16:24.114 plugin-container[2219:11284] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:16:24 INFO - PID 2218 | __metrics Screen width/height:1600/1200 17:16:24 INFO - PID 2218 | colorDepth:24 17:16:24 INFO - PID 2218 | Browser inner width/height: 1024/689 17:16:24 INFO - PID 2218 | __metrics 17:16:24 ERROR - PID 2218 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 17:16:25 INFO - TEST-INFO | 2218: exit 0 17:16:25 INFO - Browser initialized. 17:16:25 INFO - Running cycle 1/1 for dromaeo_css test... 17:16:25 INFO - TEST-INFO | started process 2221 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpClYdTG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:27 INFO - PID 2221 | 2017-04-12 17:16:27.678 plugin-container[2222:11427] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 17:16:27 INFO - PID 2221 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:16:27 INFO - PID 2221 | 2017-04-12 17:16:27.679 plugin-container[2222:11427] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 17:16:27 INFO - PID 2221 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:16:27 INFO - PID 2221 | 2017-04-12 17:16:27.679 plugin-container[2222:11427] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:16:37 INFO - PID 2221 | RSS: Main: 235311104 17:16:37 INFO - PID 2221 | 17:19:40 INFO - PID 2221 | Cycle 1(1): loaded http://localhost:49494/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49494/tests/dromaeo/cssquery-ext.html) 17:19:42 INFO - PID 2221 | RSS: Main: 257208320 17:19:42 INFO - PID 2221 | 17:21:25 INFO - PID 2221 | ************************* 17:21:25 INFO - PID 2221 | A coding exception was thrown and uncaught in a Task. 17:21:25 INFO - PID 2221 | 17:21:25 ERROR - PID 2221 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:21:25 INFO - PID 2221 | Full stack: 17:21:25 INFO - PID 2221 | ************************* 17:21:25 INFO - PID 2221 | ************************* 17:21:25 INFO - PID 2221 | A coding exception was thrown and uncaught in a Task. 17:21:25 INFO - PID 2221 | 17:21:25 ERROR - PID 2221 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:21:25 INFO - PID 2221 | Full stack: 17:21:25 INFO - PID 2221 | ************************* 17:21:25 INFO - PID 2221 | ************************* 17:21:25 INFO - PID 2221 | A coding exception was thrown and uncaught in a Task. 17:21:25 INFO - PID 2221 | 17:21:25 ERROR - PID 2221 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:21:25 INFO - PID 2221 | Full stack: 17:21:25 INFO - PID 2221 | ************************* 17:21:25 INFO - PID 2221 | ************************* 17:21:25 INFO - PID 2221 | A coding exception was thrown and uncaught in a Task. 17:21:25 INFO - PID 2221 | 17:21:25 ERROR - PID 2221 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:21:25 INFO - PID 2221 | Full stack: 17:21:25 INFO - PID 2221 | ************************* 17:22:44 INFO - PID 2221 | Cycle 1(1): loaded http://localhost:49494/tests/dromaeo/cssquery-ext.html (next: http://localhost:49494/tests/dromaeo/cssquery-jquery.html) 17:22:45 INFO - PID 2221 | RSS: Main: 262369280 17:22:45 INFO - PID 2221 | 17:25:46 INFO - PID 2221 | Cycle 1(1): loaded http://localhost:49494/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49494/tests/dromaeo/cssquery-mootools.html) 17:25:47 INFO - PID 2221 | RSS: Main: 273477632 17:25:47 INFO - PID 2221 | 17:28:49 INFO - PID 2221 | Cycle 1(1): loaded http://localhost:49494/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49494/tests/dromaeo/cssquery-prototype.html) 17:28:49 INFO - PID 2221 | RSS: Main: 266186752 17:28:49 INFO - PID 2221 | 17:31:52 INFO - PID 2221 | Cycle 1(1): loaded http://localhost:49494/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49494/tests/dromaeo/cssquery-yui.html) 17:31:53 INFO - PID 2221 | RSS: Main: 275869696 17:31:53 INFO - PID 2221 | 17:34:55 INFO - PID 2221 | Cycle 1(1): loaded http://localhost:49494/tests/dromaeo/cssquery-yui.html (next: http://localhost:49494/tests/dromaeo/cssquery-dojo.html) 17:34:55 INFO - PID 2221 | RSS: Main: 269709312 17:34:55 INFO - PID 2221 | 17:34:55 INFO - PID 2221 | __start_tp_report 17:34:55 INFO - PID 2221 | _x_x_mozilla_page_load 17:34:55 INFO - PID 2221 | _x_x_mozilla_page_load_details 17:34:55 INFO - PID 2221 | |i|pagename|runs| 17:34:55 INFO - PID 2221 | |0;dojo.html;2973.9553906691403;3495.4931534927437;3510.157562185076;3545.734069944755;3557.3952428087223;5848.736806843692;6052.273727152742;6063;6070;6113.083037544359;5865.5014323782425;5895.616784908978;5906.970465147669;6048.697565121748;6158.507319414436;5246.317978662769;5296.17909224069;5310.15037593985;5322.4411436799155;5325.254464374991;5241.633085684004;5310.495502927235;5381.704006279653;5384.542313903323;5394.946050539504;5328.067588172074;5330.520253177194;5335.1997200419855;5351.304330437038;5418.729063546826;4714.976425117852;5049.444561098277;5139.203423469368;5204.531592156724;5277.12927366984;5233.633645644806;5253.159494480865;5271.578273738091;5309.592957866169;5317.760700768436;4902.8774280643265;5862.296524417097;6063.605865618765;6064.514838812928;6072.939270607281;6279.654618995954;6357.237131544244;6379.585326953733;6393;6396.776112836075;6505.4795616350575;6520.706568204395;6533.673316334211;6542.378474044958;6556.27880933097;6191.133241346215;6215.316315205324;6236;6239.656818874914;6252.155958945529;6228.875422491616;6376.171097757355;6513.609183448913;6681.365270299314;6708.966455167693;5690.260266165455;5736.967345877699;6154.7230374633245;6329.841753956188;6363;6325.430711236011;6349.365063493614;6354.809355719336;6397.712102955378;6500.187476565429;6301.14934483848;6382.0745991831855;6385.48916086712;6388.105665206875;6436.967815160894;6316.684165791692;6417.775377861846;6429.871402571923;6435.131257280301;6450.193725784277;5110.591152707849;5205.609579281569;5215.765290561933;5245.659032162897;5274.103402421598;4624.075184963021;4630.305454181899;4637.1421287062;4645.210314246586;4695.178343789823;6047.576669633171;6253.78111766086;6261.686915654199;6282.717277722513;6291.779787707408;6282.811515654537;6353.714082866282;6457.5479716419395;6478.935210647927;6516.185476815398;6234.5635805494085;6258.43674069336;6280.811575652738;6298.905516417258;6316.684165791692;4818.975905120452;5722.799702010409;5742.54059675225;5744.770209191669;5763.682997435181;6364.522660800459;6421.8715625688155;6549.901751473636;6603;6668.633225172662;6481.805545833632;6502.219733631805;6503.707333169924;6516.446102081187;6527.5757075789925;6626.171728533934;6662.333766623299;6676.499262555425;6691.330866913269;6702.966485167543;5529.198266251291;6253.155823963707;6347.873042539216;6389.616623002635;6425.485961123192;6410.743570257137;6444.806655800334;6513.381228783258;6517.478601711757;6527.249366322743;5886.852828679317;6304.401081897213;6317.399847014526;6321.778737744157;6338.239411270677;5145.768440420115;5973.761049557969;6275.435210831047;6310.432061114522;6311.621302721851;5343.385510666323;5585.916211256916;6301.369863013845;6322.936770632235;6343.111964324906;5233.581313494835;6269.153664255267;6320.241571011508;6337.8732425352155;6361.236651601837;5072.51811077947;6129.633877546871;6143.941779503737;6200.844978875564;6282.717277722422 17:34:55 INFO - PID 2221 | |1;ext.html;741.0292516802989;794.5669610062515;826.0417915218346;1288.7680217560835;1296.449009171102;30695.69304306956;38150.80924595373;38201;38229.235415291674;38361.99999999996;37861;38298.617013829855;38323.425148622795;38326.808365958204;38376;7996.600169991491;8166.591670416485;8442.915570844305;8626.525541095238;8749;6741.393274605284;8641.697540586081;8724.8691269631;8733.257673097794;8741.650333986632;8675.566221688921;8748.387612867102;8753.737387878375;8753.781155471132;8756.255718263923;8707;8733.825323493526;8734.694285700034;8746.606402711894;8758.167974042455;7461.328480436732;8164.918350816475;8392.286655634278;8414.074451810297;8451.57742112898;38089.80955095235;38193.23613527742;38222.42666359979;38299.85100446963;38379;3591.1381268495375;3622.6920711739535;3640.8361623726996;3646.6535679110443;3662.121090938182;31248.687513124805;31335.37329253425;31466.21334466634;31494;31505.36989260202;3142.120206342228;3168.714815666601;3179.3959147761852;3181.586393768818;3185.3310804730804;219387;224205;237606;272246.63876680686;274264;47540.573782786574;47605.523944760804;47699.52300476951;47755.04489910182;47926.56220313396;48948.510514895104;49143.754281228365;49176.75411622919;49187.75406122946;49244.753776231606;12894.29081400532;13365.131266467648;14435.85564144366;14436.494722684656;14607.342669579682;12021.218620789621;12070.939645301893;12094.395280235953;12095.818562721566;12098.334591597371;13461.932690336485;13476.989225808104;13495.932520337336;13529.66175845592;13575.185488870698;5976.551758618034;6002;6003;6039.78860739872;6057.848553786191;1011.3931641015479;1021.1881554164457;1029.6910926721953;1056.1497994114657;1071.3678929431674;23211.53576928452;24367.26898193057;24368.75631243665;24381.376627397796;24478.265652030466;1072.4155335342257;1106.9114470842314;1116.1628778416189;1146.5356530605118;1155.5435602936961;12431;12521.561745339051;12529.498820047096;12543;12588.748225035448;333252;351037;351315;351897;352196.2390188033;55988.88022239614;56353.43646563564;56438.71780641153;56561.43438565644;56625.867482650116;1329.7938819482995;1365.378752667534;1552.8757699384248;1566.7023265579503;1568.4510421352663;23717.881410592836;23781.167659131846;23860.403489912893;23935.880320598983;24050;38922.61077389303;39124;39156.99999999886;39220.80389598034;39333.606663932995;313307;314143;314266;314485;315341;35343.99576036066;35570;36019;36042;36210.913672589864;36038.8198059008;46952.82617934579;46980.53019469762;47000.29499557441;47125.764371177924;24163.879180603984;31165;31525.369492610476;31550.211244719067;31630.683693162773;25299;31188.844055779577;31327.06018819439;31664.050078497683;32327.676723233406;37179.814100929325;37258.62741372552;37268.06829829168;37346.626533734314;37393.439098413;28442.57336140001;30524;31974;32144.874929377358;32936.176595585304;24501.754982449947;24644.630330544696;24675;24741.50516989686;24820.875895620407 17:34:55 INFO - PID 2221 | |2;jquery.html;420.1974229222186;429.09735951520906;437.56680885922935;438.6140196626969;447.42059033551527;20101.396958091264;21451;22172.55654886901;22392.21627243047;22441.99011044503;21629.45926351838;22459.438514037156;23050.19324323649;23198.768012319873;23261.767382326216;6117;6140.232470941132;6319.241690997087;6324.7470101195895;6361.650109243989;6026.3672314406795;6214.906776398335;6234.0337247726675;6247.625142491443;6255.280642726077;4994.700317980933;5981.312149102843;6184.969075154618;6212.471939885115;6229.034499652561;6149.13912052313;6214.440700336946;6220.066989951498;6223.25320961483;6246.812595622138;5390.921815636849;5454.699991500466;5522.171674248854;5548.223248745179;5558.277423934903;27069.593956090674;27170.864145679145;27316.45367092647;27392.726072739417;27627.447451050866;2193;2235.295881797245;2259.3786708655252;2260.626996545568;2264.0490993782487;17926.462206133707;18034.639307213783;18339.174737136862;18342.08289585529;18510.814891851045;2152.989235053815;2182.1162429216192;2226.087304205268;2230.721159855018;2235.1506427557424;116939;119251;129631;145368;147824.260878696;10546.789064218827;12505.624831255076;12708.173968692005;12861.485540578458;12918.22490650564;16910;16916.577085572713;16931.068791216356;16933.068681222405;17023.659526809395;8930.062343453843;9044.773880652905;9169.72490825263;9219.585118669676;9300.11648893354;7805.399893021917;8216.383771217063;8754.56227188638;8780.253678437277;8880.73357799267;6736.8989465158065;8054.275115239539;8126.268635822805;8165.183481651788;8190.918090819016;1837.6324735053042;2143.549854530535;2180.0952604668882;2184.1154332495366;2200.8899555022185;980.5930538826307;999.980000399988;1004.5228516454625;1032.2825636182781;1036.212478516333;20811.58376832485;21489.247876324254;21684.45788855291;21736.239231626816;21775.911204439715;977.941323520591;1002.659095907395;1012.4937531234383;1050.9369437833755;1057.413135709673;10726.785464290671;11273.436328183721;11274.323540587591;11340.943295283636;11378.943105284421;615352;678315;689946;691408;712034;119633;145250;146647;146991;151244;1204.1811568133578;1205.541894080244;1230.2434003088035;1233.660743295601;1234.7592219517107;15043.097414155185;16672.583185420463;18658.813411865707;21765.347039588836;23450.882745586165;59341;60341.094883575905;61718.69140654268;62031.37968620256;62171;71647;83130;83417;84647.73028404702;89543;8729.956350218208;8856.335774817044;8965.910340896507;9112.589933452879;9198.632054717737;13659;13771.380287886868;13851.445942162201;13998.950078743932;14207.431702732189;11713.472893719632;12013.038956883254;12106.641609020922;12144.939275303566;12164.026877849928;8904.065073167483;11154.888451115385;11228.66314010581;11242.887571124184;11576.742535205554;11995.280283183038;12086.45610947527;12143.210691305037;12187.817182742443;12223.633291001284;8960.342336667738;9002.324825638234;9012.954935225544;9096.909030909606;9124.31567632417;9898.554565044446;11672.358020308964;12002.459889304828;12048.397580121135;12148.635540933787 17:34:55 INFO - PID 2221 | |3;mootools.html;1241.8758124187589;1379.255202190817;1398.811010640956;1437.2957250947038;1466.5013895275604;11368.545258189673;11713.941430292836;11891.464884080226;11988.880111198885;12043.458044388002;10137.834149072858;11501.309921404722;11741.70645733857;11761.588344407948;11781;2419.733829278782;2468.568000599888;2469.370310570802;2475.4677744284977;2476.7647073527987;2401.855888646678;2433.5376278507115;2486.01802288097;2494.650748895156;2495.338735235164;2445.620928756037;2445.951080978379;2469.2098528470897;2479.962800557993;2480.2435257246534;2427.526632306701;2429.016248419393;2452.2030340139436;2461.064795377745;2463.470353873917;1891.7162425636266;2171.610169491527;2444.1934161726767;2487.751224877516;2488.9128880489097;10384;11723.296602203895;11784.882151178464;11797.351145686984;11833.526658933632;6429.8392540186405;6630.303818099127;6672.266050734415;6683.598984060972;6707.6981535831;4119.588041195886;4320.891977700583;4348.152110338485;4400.229959757062;4408.757518336491;1235.5922545560034;1255.1653150654804;1295.7084655952335;1303.69363199648;1303.8891694206004;14851.183184924825;15337.079775213635;16349.836501635069;16490.58773530659;16582.08798516081;5471.781128754806;5550.417206193291;5723.856903577361;5731.856703582361;5733.426657334233;12209.450574724158;12326.81509777354;12327.198732082386;12373.443195056245;12700.539437964753;6463.935360646427;6503.869922601616;6539.378759017885;6540.738370465128;6571.080048793173;6032.487238584682;6109.358517355702;6148.784792532329;6201.96899015502;6208.4722798562625;3892.824822882977;4367.5414081520985;4388.648908087345;4434.201843668171;4462.9107417851465;1114.5151858941385;1274.8278982337451;1283.7625039367747;1302.9966925467338;1303.48512337628;687.9724811007603;761.6610608279262;778.2489897249181;779.2713812585138;787.456654908123;6003.429674180946;6023.247094113236;6096.329403765582;6217.347178546278;6351.428371446592;500.4970005144806;579.7014537513184;590.6249531547498;592.2271435776267;598.0431309904205;3676.209614932749;3976.0855003349393;4029.2674150115145;4169.374593810892;4186.974191323085;14453.638659033399;15213.61965950838;15375.61560960985;15377.384904603914;15386.384544618313;14627.488037918622;14677.339519721638;15262.007969481949;15270.16014119234;15287.235638218044;9151.63393464254;10899.727506812234;11021.889781102247;11082.16883733707;11121.110311175087;6272.968635156795;6808.217055038734;6833.145856767904;6918.757843475454;7072.151341839012;11539.480723367637;12801.29592872401;12892.033097517537;12926.96584273237;13636.045476816527;11476.770464590494;12603.117781755556;13887.791683124964;14114.576562703136;14159.858401416266;9444.811103778024;9573.712788616353;9733.221342292742;9762.072603102693;9764.609415623296;11021.338719676845;11036.392998385167;11154.553817847196;11167.218294719292;11171.273867198606;7524.811879703051;9217.861732074158;9284.02517735628;9298.628054877729;9422.811543768948;8823.514706691194;8957.417767845069;9021.503817290111;9039.68361107358;9141.222996045411;7976.122626511195;7989;8071.394645401736;8074.434789564674;8130.67477300925;5737;5939.970300148471;5977.6114552553945;6076.270847498328;6094.54290928191;6030.849228769316;6111.54163437735;6130.356312587114;6153.84615384619;6168.907466388097 17:34:55 INFO - PID 2221 | |4;prototype.html;400.2655127840413;404.9952733966863;410.2779108768567;410.9054917369005;414.67240879705037;5854.180414741934;5882.941170588293;6036.486898613618;6061.636301821888;6088.878222435548;5789.797357092502;5848.912266316009;5922.2597175353085;5935.228420305354;5935.554833387491;4250.404943307939;4384.605385515295;4401.6478681705385;4438.223310920592;4446.7554284514335;4384.49578298495;4389.078293558357;4418.204723149832;4425.901868691913;4433.556644335573;4379.4963579188325;4379.583939525756;4402.779861006953;4406.647468202536;4410.889727756799;4136.31750761124;4226.985523474344;4305.246581848164;4412.845550405753;4428.3800267962515;3353.96646033539;3761.322961866863;3769.5288088988877;3777.414500752388;3806.638369354907;5593.636413633101;5630.943690563124;5633.295838020247;5635.6055076144685;5644.350899646511;5028.220625803006;5112.897742045176;5155.896882062338;5170;5211.635185537014;5236.764345604457;6225.252969643627;6248.718807653667;6251.874962500725;6255.562110652256;4268.975445892995;4272.850450234227;4275.91448171038;4277.123189746095;4288.228118938589;5233.659812112201;6402.679866006681;6619.966900165517;6628.602283862935;6703.396694297488;3555.306715190513;3858.884233473;4096.279562583722;4327.853118923488;4363.912721745547;3617.7467577269863;3694.833732482045;3938.665213456888;3987.6809855211513;4001.8199181036925;4030.153667729751;4037.4953130858644;5005.799768009311;5171.224316352577;5176.482351764794;6339.809805705836;6347.698721762028;6348.492120630339;6358.77744278948;6365.8726825464155;1346.5825594065675;1388.9791653125212;1493.1936754152853;1516.651170230831;1525.893187476866;835.1648351648352;857.9442336248123;891.796075298355;1005.6832097889288;1015.5582321690089;5817.854553636108;6017.518598512109;6050.062240352752;6062.333143354227;6066.66633335162;6231.688415579203;6491.480681545465;6551.344865513506;6559.672016399161;6590.80227593173;5000.399952005782;5715.628484148517;5763.2857720754855;5940.31686356066;6038.052518269501;2674.8127631066027;3427.1774774054047;3436.7078798301923;3436.9828150859084;3448.896533104011;6164.938350616437;6397.264314603787;6694.698738556776;6800.741862755406;6842.178938527409;5376.704281264568;6238.438540531374;6463.935360646427;6518.44593209573;6791.72833086671;5663.518600918968;6758.493113016543;6769.1876974763345;6839.487038472035;6869.210040845267;5533.7786488540005;5831.154482599914;6186.628802271878;6607;6664.966675166593;6463.15978922737;6487.772927947499;6489.805305840832;6516.73933042673;6555.2133743949125;4987.411581345244;5314.202869569595;5621.325440947113;6765.763198288037;6825.781620973303;4243.915121697487;4333.458317710286;4353.869383918487;4378.43080399546;4393.824247030211;6510.372406898276;6574.967125164535;6575.638339891352;6588.308227636029;6602.029086911005;5479.643823151482;5514.558835293086;6048.153258543895;6205.968970155301;6409.615423074631;4868.440129385166;6312.589681670676;6339.732053589393;6366.108744775643;6371.5221358397375;5454.754536045967;5965.806838632204;6214.285357183981;6240.469560087262;6290.779822706367;5019.899602007867;5999.52003839683;6170.259568851587;6325.841853953688;6379.202599675041;6142.969285153546;6179.28938172116;6184.783532576338;6187.288461826767;6205.503559715302 17:34:55 INFO - PID 2221 | |5;yui.html;770.6262462705589;776.7786180938434;821.5686764448666;832.263446849538;879.9956000219998;12100.81848772269;13960.860391396083;16154.353825846967;16719.578835798973;16747.665046699072;13365.532206372778;13786.034977551575;17290.654186916254;17298.48104556862;17303.13484325785;934.6681927915577;976.243411356201;976.7655762616956;982.965596204133;986.3982970388057;1001.5643195210071;1015.9644412445566;1018.0379541333443;1019.9596411660102;1019.9749252001765;1010.954507047181;1043.2592859070069;1050.14937900301;1052.0741747262437;1055.176961969661;1042.8696412948382;1043.9373637581732;1044.613493007592;1048.6749107776614;1048.8688913885803;779.0729032451421;779.158508810489;780.8555417247827;784.3489903380181;785.4776573578563;14041.71916561663;16251.51245462638;16727.247273872585;16858.072805995664;17050.14749262544;17115.486535403958;17147.74278385825;17549.94700317985;17569.824301757075;17647.294108235656;11708.356040417773;14027.43890244389;14053.227072511008;14139.85860141406;14155.787663185061;3499.07274572236;3500.4574290984683;3532.540769699948;3535.416656251741;3537.646235376442;87265.56367218123;92449;119527.4023629885;121605.39197303957;122386;13213.867861321263;13240.20558766477;13286.53497127596;13485.730285394236;13494.52769153075;22017.119315227534;23268.534629307658;24466.633000505008;24829.25512234636;25541;7610.238976102345;8968.68609598661;9054.5020023898;9129.589168487433;9130.634774608941;4821.445533763592;4906.607471402351;4908.337374454403;4909.0672772173175;4911.754412279443;4313.158934007901;4350.564943505624;4409;4442.289233722653;4453.087117140978;884.2086332732168;938.7983381271982;942.3450701762347;973.6494861849728;977.8875429325576;633.9587926784744;671.5332843673698;681.2097966358999;682.3210905149408;689.7516893918286;11079.889201108046;11523.423828808694;11684;11754.06600544629;11769.117316201318;599.4814485470037;652;659.8090446743673;664.9667516624149;669.581511555278;4617.238155704271;5233.973830130825;5255.054090263713;5319.255304257407;5325.547328477045;92707.53646231725;93910;100494.99505005003;103136;105263.89472210513;79271.60364198142;80184;80346;82062.76905846417;84806.15193848105;61797.69101154465;71735.92396114062;71909.6404517974;73763.63118184482;75952.86070708944;9250.676226332045;11986.101042422028;12006.699832504257;12092.60934992452;12110.818337725117;35712;37078.07304817401;37477.875663730134;37682.246355073294;37725.811370944066;64200.03699944598;64342.67828661014;64687.35312646813;65113.674431627536;66151.66924165348;15718.764218536502;15878.841211587736;15917.124558149413;15948.122853243183;16025.919870400574;13943.790843137158;13986.230757308038;14174.362153703314;14196.148231105753;17117.05856177922;15754.842451575338;16045.67908641844;16195.190240487693;16295.51113466598;16393.34426622922;15195.240237988277;15473.690526189639;15695;16166.030038197745;16200.918995404947;15049.54851354461;15078.924605376902;15157;15273.847261527242;15333.846661533242;9703.466309353053;11206.271592346471;11207.831882521932;11219.326840389604;11418.942905285421;12330.75338493243;12395.814062788884;12402.19385739924;12453.813192802296;12625.558105466265 17:34:55 INFO - PID 2221 | __end_tp_report 17:34:55 INFO - PID 2221 | __start_cc_report 17:34:55 INFO - PID 2221 | _x_x_mozilla_cycle_collect,435 17:34:55 INFO - PID 2221 | __end_cc_report 17:34:55 INFO - PID 2221 | __startTimestamp1492043695410__endTimestamp 17:34:55 INFO - PID 2221 | 17:34:55 INFO - PID 2221 | ------- Summary: start ------- 17:34:55 INFO - PID 2221 | Number of tests: 6 17:34:55 INFO - PID 2221 | 17:34:55 INFO - PID 2221 | [#0] dojo.html Cycles:165 Average:5921.57 Median:6253.16 stddev:703.17 (11.2%) stddev-sans-first:666.22 17:34:55 INFO - PID 2221 | Values: 2974.0 3495.5 3510.2 3545.7 3557.4 5848.7 6052.3 6063.0 6070.0 6113.1 5865.5 5895.6 5907.0 6048.7 6158.5 5246.3 5296.2 5310.2 5322.4 5325.3 5241.6 5310.5 5381.7 5384.5 5394.9 5328.1 5330.5 5335.2 5351.3 5418.7 4715.0 5049.4 5139.2 5204.5 5277.1 5233.6 5253.2 5271.6 5309.6 5317.8 4902.9 5862.3 6063.6 6064.5 6072.9 6279.7 6357.2 6379.6 6393.0 6396.8 6505.5 6520.7 6533.7 6542.4 6556.3 6191.1 6215.3 6236.0 6239.7 6252.2 6228.9 6376.2 6513.6 6681.4 6709.0 5690.3 5737.0 6154.7 6329.8 6363.0 6325.4 6349.4 6354.8 6397.7 6500.2 6301.1 6382.1 6385.5 6388.1 6437.0 6316.7 6417.8 6429.9 6435.1 6450.2 5110.6 5205.6 5215.8 5245.7 5274.1 4624.1 4630.3 4637.1 4645.2 4695.2 6047.6 6253.8 6261.7 6282.7 6291.8 6282.8 6353.7 6457.5 6478.9 6516.2 6234.6 6258.4 6280.8 6298.9 6316.7 4819.0 5722.8 5742.5 5744.8 5763.7 6364.5 6421.9 6549.9 6603.0 6668.6 6481.8 6502.2 6503.7 6516.4 6527.6 6626.2 6662.3 6676.5 6691.3 6703.0 5529.2 6253.2 6347.9 6389.6 6425.5 6410.7 6444.8 6513.4 6517.5 6527.2 5886.9 6304.4 6317.4 6321.8 6338.2 5145.8 5973.8 6275.4 6310.4 6311.6 5343.4 5585.9 6301.4 6322.9 6343.1 5233.6 6269.2 6320.2 6337.9 6361.2 5072.5 6129.6 6143.9 6200.8 6282.7 17:34:55 INFO - PID 2221 | 17:34:55 INFO - PID 2221 | [#1] ext.html Cycles:180 Average:45524.44 Median:351606.00 stddev:80361.08 (22.9%) stddev-sans-first:80516.16 17:34:55 INFO - PID 2221 | Values: 741.0 794.6 826.0 1288.8 1296.4 30695.7 38150.8 38201.0 38229.2 38362.0 37861.0 38298.6 38323.4 38326.8 38376.0 7996.6 8166.6 8442.9 8626.5 8749.0 6741.4 8641.7 8724.9 8733.3 8741.7 8675.6 8748.4 8753.7 8753.8 8756.3 8707.0 8733.8 8734.7 8746.6 8758.2 7461.3 8164.9 8392.3 8414.1 8451.6 38089.8 38193.2 38222.4 38299.9 38379.0 3591.1 3622.7 3640.8 3646.7 3662.1 31248.7 31335.4 31466.2 31494.0 31505.4 3142.1 3168.7 3179.4 3181.6 3185.3 219387.0 224205.0 237606.0 272246.6 274264.0 47540.6 47605.5 47699.5 47755.0 47926.6 48948.5 49143.8 49176.8 49187.8 49244.8 12894.3 13365.1 14435.9 14436.5 14607.3 12021.2 12070.9 12094.4 12095.8 12098.3 13461.9 13477.0 13495.9 13529.7 13575.2 5976.6 6002.0 6003.0 6039.8 6057.8 1011.4 1021.2 1029.7 1056.1 1071.4 23211.5 24367.3 24368.8 24381.4 24478.3 1072.4 1106.9 1116.2 1146.5 1155.5 12431.0 12521.6 12529.5 12543.0 12588.7 333252.0 351037.0 351315.0 351897.0 352196.2 55988.9 56353.4 56438.7 56561.4 56625.9 1329.8 1365.4 1552.9 1566.7 1568.5 23717.9 23781.2 23860.4 23935.9 24050.0 38922.6 39124.0 39157.0 39220.8 39333.6 313307.0 314143.0 314266.0 314485.0 315341.0 35344.0 35570.0 36019.0 36042.0 36210.9 36038.8 46952.8 46980.5 47000.3 47125.8 24163.9 31165.0 31525.4 31550.2 31630.7 25299.0 31188.8 31327.1 31664.1 32327.7 37179.8 37258.6 37268.1 37346.6 37393.4 28442.6 30524.0 31974.0 32144.9 32936.2 24501.8 24644.6 24675.0 24741.5 24820.9 17:34:55 INFO - PID 2221 | 17:34:55 INFO - PID 2221 | [#2] jquery.html Cycles:180 Average:39167.89 Median:22417.10 stddev:113096.89 (504.5%) stddev-sans-first:113376.73 17:34:55 INFO - PID 2221 | Values: 420.2 429.1 437.6 438.6 447.4 20101.4 21451.0 22172.6 22392.2 22442.0 21629.5 22459.4 23050.2 23198.8 23261.8 6117.0 6140.2 6319.2 6324.7 6361.7 6026.4 6214.9 6234.0 6247.6 6255.3 4994.7 5981.3 6185.0 6212.5 6229.0 6149.1 6214.4 6220.1 6223.3 6246.8 5390.9 5454.7 5522.2 5548.2 5558.3 27069.6 27170.9 27316.5 27392.7 27627.4 2193.0 2235.3 2259.4 2260.6 2264.0 17926.5 18034.6 18339.2 18342.1 18510.8 2153.0 2182.1 2226.1 2230.7 2235.2 116939.0 119251.0 129631.0 145368.0 147824.3 10546.8 12505.6 12708.2 12861.5 12918.2 16910.0 16916.6 16931.1 16933.1 17023.7 8930.1 9044.8 9169.7 9219.6 9300.1 7805.4 8216.4 8754.6 8780.3 8880.7 6736.9 8054.3 8126.3 8165.2 8190.9 1837.6 2143.5 2180.1 2184.1 2200.9 980.6 1000.0 1004.5 1032.3 1036.2 20811.6 21489.2 21684.5 21736.2 21775.9 977.9 1002.7 1012.5 1050.9 1057.4 10726.8 11273.4 11274.3 11340.9 11378.9 615352.0 678315.0 689946.0 691408.0 712034.0 119633.0 145250.0 146647.0 146991.0 151244.0 1204.2 1205.5 1230.2 1233.7 1234.8 15043.1 16672.6 18658.8 21765.3 23450.9 59341.0 60341.1 61718.7 62031.4 62171.0 71647.0 83130.0 83417.0 84647.7 89543.0 8730.0 8856.3 8965.9 9112.6 9198.6 13659.0 13771.4 13851.4 13999.0 14207.4 11713.5 12013.0 12106.6 12144.9 12164.0 8904.1 11154.9 11228.7 11242.9 11576.7 11995.3 12086.5 12143.2 12187.8 12223.6 8960.3 9002.3 9013.0 9096.9 9124.3 9898.6 11672.4 12002.5 12048.4 12148.6 17:34:55 INFO - PID 2221 | 17:34:55 INFO - PID 2221 | [#3] mootools.html Cycles:180 Average:7126.76 Median:2488.33 stddev:4533.02 (182.2%) stddev-sans-first:4524.17 17:34:55 INFO - PID 2221 | Values: 1241.9 1379.3 1398.8 1437.3 1466.5 11368.5 11713.9 11891.5 11988.9 12043.5 10137.8 11501.3 11741.7 11761.6 11781.0 2419.7 2468.6 2469.4 2475.5 2476.8 2401.9 2433.5 2486.0 2494.7 2495.3 2445.6 2446.0 2469.2 2480.0 2480.2 2427.5 2429.0 2452.2 2461.1 2463.5 1891.7 2171.6 2444.2 2487.8 2488.9 10384.0 11723.3 11784.9 11797.4 11833.5 6429.8 6630.3 6672.3 6683.6 6707.7 4119.6 4320.9 4348.2 4400.2 4408.8 1235.6 1255.2 1295.7 1303.7 1303.9 14851.2 15337.1 16349.8 16490.6 16582.1 5471.8 5550.4 5723.9 5731.9 5733.4 12209.5 12326.8 12327.2 12373.4 12700.5 6463.9 6503.9 6539.4 6540.7 6571.1 6032.5 6109.4 6148.8 6202.0 6208.5 3892.8 4367.5 4388.6 4434.2 4462.9 1114.5 1274.8 1283.8 1303.0 1303.5 688.0 761.7 778.2 779.3 787.5 6003.4 6023.2 6096.3 6217.3 6351.4 500.5 579.7 590.6 592.2 598.0 3676.2 3976.1 4029.3 4169.4 4187.0 14453.6 15213.6 15375.6 15377.4 15386.4 14627.5 14677.3 15262.0 15270.2 15287.2 9151.6 10899.7 11021.9 11082.2 11121.1 6273.0 6808.2 6833.1 6918.8 7072.2 11539.5 12801.3 12892.0 12927.0 13636.0 11476.8 12603.1 13887.8 14114.6 14159.9 9444.8 9573.7 9733.2 9762.1 9764.6 11021.3 11036.4 11154.6 11167.2 11171.3 7524.8 9217.9 9284.0 9298.6 9422.8 8823.5 8957.4 9021.5 9039.7 9141.2 7976.1 7989.0 8071.4 8074.4 8130.7 5737.0 5940.0 5977.6 6076.3 6094.5 6030.8 6111.5 6130.4 6153.8 6168.9 17:34:55 INFO - PID 2221 | 17:34:55 INFO - PID 2221 | [#4] prototype.html Cycles:180 Average:5075.72 Median:5689.57 stddev:1606.15 (28.2%) stddev-sans-first:1571.85 17:34:55 INFO - PID 2221 | Values: 400.3 405.0 410.3 410.9 414.7 5854.2 5882.9 6036.5 6061.6 6088.9 5789.8 5848.9 5922.3 5935.2 5935.6 4250.4 4384.6 4401.6 4438.2 4446.8 4384.5 4389.1 4418.2 4425.9 4433.6 4379.5 4379.6 4402.8 4406.6 4410.9 4136.3 4227.0 4305.2 4412.8 4428.4 3354.0 3761.3 3769.5 3777.4 3806.6 5593.6 5630.9 5633.3 5635.6 5644.4 5028.2 5112.9 5155.9 5170.0 5211.6 5236.8 6225.3 6248.7 6251.9 6255.6 4269.0 4272.9 4275.9 4277.1 4288.2 5233.7 6402.7 6620.0 6628.6 6703.4 3555.3 3858.9 4096.3 4327.9 4363.9 3617.7 3694.8 3938.7 3987.7 4001.8 4030.2 4037.5 5005.8 5171.2 5176.5 6339.8 6347.7 6348.5 6358.8 6365.9 1346.6 1389.0 1493.2 1516.7 1525.9 835.2 857.9 891.8 1005.7 1015.6 5817.9 6017.5 6050.1 6062.3 6066.7 6231.7 6491.5 6551.3 6559.7 6590.8 5000.4 5715.6 5763.3 5940.3 6038.1 2674.8 3427.2 3436.7 3437.0 3448.9 6164.9 6397.3 6694.7 6800.7 6842.2 5376.7 6238.4 6463.9 6518.4 6791.7 5663.5 6758.5 6769.2 6839.5 6869.2 5533.8 5831.2 6186.6 6607.0 6665.0 6463.2 6487.8 6489.8 6516.7 6555.2 4987.4 5314.2 5621.3 6765.8 6825.8 4243.9 4333.5 4353.9 4378.4 4393.8 6510.4 6575.0 6575.6 6588.3 6602.0 5479.6 5514.6 6048.2 6206.0 6409.6 4868.4 6312.6 6339.7 6366.1 6371.5 5454.8 5965.8 6214.3 6240.5 6290.8 5019.9 5999.5 6170.3 6325.8 6379.2 6143.0 6179.3 6184.8 6187.3 6205.5 17:34:55 INFO - PID 2221 | 17:34:55 INFO - PID 2221 | [#5] yui.html Cycles:180 Average:20456.43 Median:17426.54 stddev:27975.16 (160.5%) stddev-sans-first:28014.59 17:34:55 INFO - PID 2221 | Values: 770.6 776.8 821.6 832.3 880.0 12100.8 13960.9 16154.4 16719.6 16747.7 13365.5 13786.0 17290.7 17298.5 17303.1 934.7 976.2 976.8 983.0 986.4 1001.6 1016.0 1018.0 1020.0 1020.0 1011.0 1043.3 1050.1 1052.1 1055.2 1042.9 1043.9 1044.6 1048.7 1048.9 779.1 779.2 780.9 784.3 785.5 14041.7 16251.5 16727.2 16858.1 17050.1 17115.5 17147.7 17549.9 17569.8 17647.3 11708.4 14027.4 14053.2 14139.9 14155.8 3499.1 3500.5 3532.5 3535.4 3537.6 87265.6 92449.0 119527.4 121605.4 122386.0 13213.9 13240.2 13286.5 13485.7 13494.5 22017.1 23268.5 24466.6 24829.3 25541.0 7610.2 8968.7 9054.5 9129.6 9130.6 4821.4 4906.6 4908.3 4909.1 4911.8 4313.2 4350.6 4409.0 4442.3 4453.1 884.2 938.8 942.3 973.6 977.9 634.0 671.5 681.2 682.3 689.8 11079.9 11523.4 11684.0 11754.1 11769.1 599.5 652.0 659.8 665.0 669.6 4617.2 5234.0 5255.1 5319.3 5325.5 92707.5 93910.0 100495.0 103136.0 105263.9 79271.6 80184.0 80346.0 82062.8 84806.2 61797.7 71735.9 71909.6 73763.6 75952.9 9250.7 11986.1 12006.7 12092.6 12110.8 35712.0 37078.1 37477.9 37682.2 37725.8 64200.0 64342.7 64687.4 65113.7 66151.7 15718.8 15878.8 15917.1 15948.1 16025.9 13943.8 13986.2 14174.4 14196.1 17117.1 15754.8 16045.7 16195.2 16295.5 16393.3 15195.2 15473.7 15695.0 16166.0 16200.9 15049.5 15078.9 15157.0 15273.8 15333.8 9703.5 11206.3 11207.8 11219.3 11418.9 12330.8 12395.8 12402.2 12453.8 12625.6 17:34:55 INFO - PID 2221 | -------- Summary: end -------- 17:34:55 INFO - PID 2221 | 17:34:56 INFO - TEST-INFO | 2221: exit 0 17:34:56 INFO - TEST-OK | dromaeo_css | took 1114776ms 17:34:56 INFO - TEST-START | kraken 17:34:56 INFO - operating with platform_type : mac_ 17:34:56 INFO - Initialising browser for kraken test... 17:34:56 INFO - TEST-INFO | started process 2227 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpTfH8gK/profile http://localhost:49494/getInfo.html) 17:34:58 INFO - PID 2227 | 2017-04-12 17:34:58.907 plugin-container[2228:13562] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 17:34:58 INFO - PID 2227 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:34:58 INFO - PID 2227 | 2017-04-12 17:34:58.911 plugin-container[2228:13562] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.CFPasteboardClient' 17:34:58 INFO - PID 2227 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:34:58 INFO - PID 2227 | 2017-04-12 17:34:58.911 plugin-container[2228:13562] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:34:59 INFO - PID 2227 | __metrics Screen width/height:1600/1200 17:34:59 INFO - PID 2227 | colorDepth:24 17:34:59 INFO - PID 2227 | Browser inner width/height: 1024/689 17:34:59 INFO - PID 2227 | __metrics 17:34:59 ERROR - PID 2227 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 17:35:00 INFO - TEST-INFO | 2227: exit 0 17:35:00 INFO - Browser initialized. 17:35:00 INFO - Running cycle 1/1 for kraken test... 17:35:00 INFO - TEST-INFO | started process 2229 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpTfH8gK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:02 INFO - PID 2229 | 2017-04-12 17:35:02.575 plugin-container[2230:13685] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x464b, name = 'com.apple.tsm.portname' 17:35:02 INFO - PID 2229 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:35:02 INFO - PID 2229 | 2017-04-12 17:35:02.575 plugin-container[2230:13685] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 17:35:02 INFO - PID 2229 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:35:02 INFO - PID 2229 | 2017-04-12 17:35:02.575 plugin-container[2230:13685] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:35:12 INFO - PID 2229 | RSS: Main: 234811392 17:35:12 INFO - PID 2229 | 17:35:15 INFO - PID 2229 | Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49494/tests/kraken/driver.html?testName=audio-beat-detection) 17:35:16 INFO - PID 2229 | RSS: Main: 248762368 17:35:16 INFO - PID 2229 | 17:35:18 INFO - PID 2229 | Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49494/tests/kraken/driver.html?testName=audio-dft) 17:35:19 INFO - PID 2229 | RSS: Main: 257290240 17:35:19 INFO - PID 2229 | 17:35:23 INFO - PID 2229 | Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49494/tests/kraken/driver.html?testName=audio-fft) 17:35:23 INFO - PID 2229 | RSS: Main: 260001792 17:35:23 INFO - PID 2229 | 17:35:25 INFO - PID 2229 | Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49494/tests/kraken/driver.html?testName=audio-oscillator) 17:35:26 INFO - PID 2229 | RSS: Main: 262418432 17:35:26 INFO - PID 2229 | 17:35:28 INFO - PID 2229 | Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49494/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:35:28 INFO - PID 2229 | RSS: Main: 262647808 17:35:28 INFO - PID 2229 | 17:35:32 INFO - PID 2229 | Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49494/tests/kraken/driver.html?testName=imaging-darkroom) 17:35:32 INFO - PID 2229 | RSS: Main: 268369920 17:35:32 INFO - PID 2229 | 17:35:36 INFO - PID 2229 | Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49494/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:36 INFO - PID 2229 | RSS: Main: 269127680 17:35:36 INFO - PID 2229 | 17:35:39 INFO - PID 2229 | Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49494/tests/kraken/driver.html?testName=json-parse-financial) 17:35:40 INFO - PID 2229 | RSS: Main: 268996608 17:35:40 INFO - PID 2229 | 17:35:41 INFO - PID 2229 | Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49494/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:42 INFO - PID 2229 | RSS: Main: 268713984 17:35:42 INFO - PID 2229 | 17:35:44 INFO - PID 2229 | Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:35:44 INFO - PID 2229 | RSS: Main: 268836864 17:35:44 INFO - PID 2229 | 17:35:47 INFO - PID 2229 | Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:35:47 INFO - PID 2229 | RSS: Main: 268832768 17:35:47 INFO - PID 2229 | 17:35:50 INFO - PID 2229 | Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:35:51 INFO - PID 2229 | RSS: Main: 269148160 17:35:51 INFO - PID 2229 | 17:35:54 INFO - PID 2229 | Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:35:54 INFO - PID 2229 | RSS: Main: 268988416 17:35:54 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | Cycle 1(1): loaded http://localhost:49494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49494/tests/kraken/driver.html?testName=ai-astar) 17:35:56 INFO - PID 2229 | RSS: Main: 270532608 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | __start_tp_report 17:35:56 INFO - PID 2229 | _x_x_mozilla_page_load 17:35:56 INFO - PID 2229 | _x_x_mozilla_page_load_details 17:35:56 INFO - PID 2229 | |i|pagename|runs| 17:35:56 INFO - PID 2229 | |0;ai-astar;105;118;116;116;118;117;116;117;116;115 17:35:56 INFO - PID 2229 | |1;audio-beat-detection;146;112;111;149;111;112;111;102;154;143 17:35:56 INFO - PID 2229 | |2;audio-dft;197;199;206;230;279;275;244;194;253;280 17:35:56 INFO - PID 2229 | |3;audio-fft;73;50;78;108;86;87;87;74;71;57 17:35:56 INFO - PID 2229 | |4;audio-oscillator;87;72;83;71;73;107;124;81;69;82 17:35:56 INFO - PID 2229 | |5;imaging-gaussian-blur;91;90;91;90;125;134;135;92;93;118 17:35:56 INFO - PID 2229 | |6;imaging-darkroom;131;114;154;136;105;139;97;96;95;98 17:35:56 INFO - PID 2229 | |7;imaging-desaturate;88;92;89;90;90;91;90;91;97;92 17:35:56 INFO - PID 2229 | |8;json-parse-financial;53;49;60;51;52;54;51;54;52;54 17:35:56 INFO - PID 2229 | |9;json-stringify-tinderbox;58;66;58;63;75;68;72;61;58;62 17:35:56 INFO - PID 2229 | |10;stanford-crypto-aes;98;86;84;84;87;85;82;84;83;85 17:35:56 INFO - PID 2229 | |11;stanford-crypto-ccm;137;143;138;140;139;142;141;145;184;140 17:35:56 INFO - PID 2229 | |12;stanford-crypto-pbkdf2;205;201;171;197;190;188;192;190;188;189 17:35:56 INFO - PID 2229 | |13;stanford-crypto-sha256-iterative;70;70;72;68;68;70;68;71;69;69 17:35:56 INFO - PID 2229 | __end_tp_report 17:35:56 INFO - PID 2229 | __start_cc_report 17:35:56 INFO - PID 2229 | _x_x_mozilla_cycle_collect,1011 17:35:56 INFO - PID 2229 | __end_cc_report 17:35:56 INFO - PID 2229 | __startTimestamp1492043756956__endTimestamp 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | ------- Summary: start ------- 17:35:56 INFO - PID 2229 | Number of tests: 14 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.50 stddev:3.78 (3.2%) stddev-sans-first:1.01 17:35:56 INFO - PID 2229 | Values: 105.0 118.0 116.0 116.0 118.0 117.0 116.0 117.0 116.0 115.0 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:127.50 stddev:20.10 (15.8%) stddev-sans-first:19.85 17:35:56 INFO - PID 2229 | Values: 146.0 112.0 111.0 149.0 111.0 112.0 111.0 102.0 154.0 143.0 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | [#2] audio-dft Cycles:10 Average:235.70 Median:248.50 stddev:35.35 (14.2%) stddev-sans-first:34.61 17:35:56 INFO - PID 2229 | Values: 197.0 199.0 206.0 230.0 279.0 275.0 244.0 194.0 253.0 280.0 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | [#3] audio-fft Cycles:10 Average:77.10 Median:76.00 stddev:16.44 (21.6%) stddev-sans-first:17.37 17:35:56 INFO - PID 2229 | Values: 73.0 50.0 78.0 108.0 86.0 87.0 87.0 74.0 71.0 57.0 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | [#4] audio-oscillator Cycles:10 Average:84.90 Median:77.00 stddev:17.65 (22.9%) stddev-sans-first:18.70 17:35:56 INFO - PID 2229 | Values: 87.0 72.0 83.0 71.0 73.0 107.0 124.0 81.0 69.0 82.0 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | [#5] imaging-gaussian-blur Cycles:10 Average:105.90 Median:90.50 stddev:19.60 (21.7%) stddev-sans-first:20.03 17:35:56 INFO - PID 2229 | Values: 91.0 90.0 91.0 90.0 125.0 134.0 135.0 92.0 93.0 118.0 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | [#6] imaging-darkroom Cycles:10 Average:116.50 Median:124.50 stddev:21.72 (17.4%) stddev-sans-first:22.40 17:35:56 INFO - PID 2229 | Values: 131.0 114.0 154.0 136.0 105.0 139.0 97.0 96.0 95.0 98.0 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | [#7] imaging-desaturate Cycles:10 Average:91.00 Median:91.00 stddev:2.45 (2.7%) stddev-sans-first:2.35 17:35:56 INFO - PID 2229 | Values: 88.0 92.0 89.0 90.0 90.0 91.0 90.0 91.0 97.0 92.0 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.50 stddev:2.94 (5.5%) stddev-sans-first:3.12 17:35:56 INFO - PID 2229 | Values: 53.0 49.0 60.0 51.0 52.0 54.0 51.0 54.0 52.0 54.0 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.50 stddev:6.03 (9.3%) stddev-sans-first:5.97 17:35:56 INFO - PID 2229 | Values: 58.0 66.0 58.0 63.0 75.0 68.0 72.0 61.0 58.0 62.0 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.00 stddev:4.52 (5.3%) stddev-sans-first:1.51 17:35:56 INFO - PID 2229 | Values: 98.0 86.0 84.0 84.0 87.0 85.0 82.0 84.0 83.0 85.0 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:141.50 stddev:13.94 (9.9%) stddev-sans-first:14.49 17:35:56 INFO - PID 2229 | Values: 137.0 143.0 138.0 140.0 139.0 142.0 141.0 145.0 184.0 140.0 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.10 Median:191.00 stddev:9.17 (4.8%) stddev-sans-first:8.23 17:35:56 INFO - PID 2229 | Values: 205.0 201.0 171.0 197.0 190.0 188.0 192.0 190.0 188.0 189.0 17:35:56 INFO - PID 2229 | 17:35:56 INFO - PID 2229 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.35 (1.9%) stddev-sans-first:1.42 17:35:56 INFO - PID 2229 | Values: 70.0 70.0 72.0 68.0 68.0 70.0 68.0 71.0 69.0 69.0 17:35:56 INFO - PID 2229 | -------- Summary: end -------- 17:35:56 INFO - PID 2229 | 17:35:58 INFO - TEST-INFO | 2229: exit 0 17:35:58 INFO - TEST-OK | kraken | took 61994ms 17:35:58 INFO - SUITE-END | took 1176s 17:35:58 INFO - Completed test suite (00:19:36) 17:35:58 INFO - javascript benchmark 17:35:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7763.11940489635, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2973.9553906691403, 3495.4931534927437, 3510.157562185076, 3545.734069944755, 3557.3952428087223, 5848.736806843692, 6052.273727152742, 6063.0, 6070.0, 6113.083037544359, 5865.5014323782425, 5895.616784908978, 5906.970465147669, 6048.697565121748, 6158.507319414436, 5246.317978662769, 5296.17909224069, 5310.15037593985, 5322.4411436799155, 5325.254464374991, 5241.633085684004, 5310.495502927235, 5381.704006279653, 5384.542313903323, 5394.946050539504, 5328.067588172074, 5330.520253177194, 5335.1997200419855, 5351.304330437038, 5418.729063546826, 4714.976425117852, 5049.444561098277, 5139.203423469368, 5204.531592156724, 5277.12927366984, 5233.633645644806, 5253.159494480865, 5271.578273738091, 5309.592957866169, 5317.760700768436, 4902.8774280643265, 5862.296524417097, 6063.605865618765, 6064.514838812928, 6072.939270607281, 6279.654618995954, 6357.237131544244, 6379.585326953733, 6393.0, 6396.776112836075, 6505.4795616350575, 6520.706568204395, 6533.673316334211, 6542.378474044958, 6556.27880933097, 6191.133241346215, 6215.316315205324, 6236.0, 6239.656818874914, 6252.155958945529, 6228.875422491616, 6376.171097757355, 6513.609183448913, 6681.365270299314, 6708.966455167693, 5690.260266165455, 5736.967345877699, 6154.7230374633245, 6329.841753956188, 6363.0, 6325.430711236011, 6349.365063493614, 6354.809355719336, 6397.712102955378, 6500.187476565429, 6301.14934483848, 6382.0745991831855, 6385.48916086712, 6388.105665206875, 6436.967815160894, 6316.684165791692, 6417.775377861846, 6429.871402571923, 6435.131257280301, 6450.193725784277, 5110.591152707849, 5205.609579281569, 5215.765290561933, 5245.659032162897, 5274.103402421598, 4624.075184963021, 4630.305454181899, 4637.1421287062, 4645.210314246586, 4695.178343789823, 6047.576669633171, 6253.78111766086, 6261.686915654199, 6282.717277722513, 6291.779787707408, 6282.811515654537, 6353.714082866282, 6457.5479716419395, 6478.935210647927, 6516.185476815398, 6234.5635805494085, 6258.43674069336, 6280.811575652738, 6298.905516417258, 6316.684165791692, 4818.975905120452, 5722.799702010409, 5742.54059675225, 5744.770209191669, 5763.682997435181, 6364.522660800459, 6421.8715625688155, 6549.901751473636, 6603.0, 6668.633225172662, 6481.805545833632, 6502.219733631805, 6503.707333169924, 6516.446102081187, 6527.5757075789925, 6626.171728533934, 6662.333766623299, 6676.499262555425, 6691.330866913269, 6702.966485167543, 5529.198266251291, 6253.155823963707, 6347.873042539216, 6389.616623002635, 6425.485961123192, 6410.743570257137, 6444.806655800334, 6513.381228783258, 6517.478601711757, 6527.249366322743, 5886.852828679317, 6304.401081897213, 6317.399847014526, 6321.778737744157, 6338.239411270677, 5145.768440420115, 5973.761049557969, 6275.435210831047, 6310.432061114522, 6311.621302721851, 5343.385510666323, 5585.916211256916, 6301.369863013845, 6322.936770632235, 6343.111964324906, 5233.581313494835, 6269.153664255267, 6320.241571011508, 6337.8732425352155, 6361.236651601837, 5072.51811077947, 6129.633877546871, 6143.941779503737, 6200.844978875564, 6282.717277722422], "value": 5876.71679340064, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.0292516802989, 794.5669610062515, 826.0417915218346, 1288.7680217560835, 1296.449009171102, 30695.69304306956, 38150.80924595373, 38201.0, 38229.235415291674, 38361.99999999996, 37861.0, 38298.617013829855, 38323.425148622795, 38326.808365958204, 38376.0, 7996.600169991491, 8166.591670416485, 8442.915570844305, 8626.525541095238, 8749.0, 6741.393274605284, 8641.697540586081, 8724.8691269631, 8733.257673097794, 8741.650333986632, 8675.566221688921, 8748.387612867102, 8753.737387878375, 8753.781155471132, 8756.255718263923, 8707.0, 8733.825323493526, 8734.694285700034, 8746.606402711894, 8758.167974042455, 7461.328480436732, 8164.918350816475, 8392.286655634278, 8414.074451810297, 8451.57742112898, 38089.80955095235, 38193.23613527742, 38222.42666359979, 38299.85100446963, 38379.0, 3591.1381268495375, 3622.6920711739535, 3640.8361623726996, 3646.6535679110443, 3662.121090938182, 31248.687513124805, 31335.37329253425, 31466.21334466634, 31494.0, 31505.36989260202, 3142.120206342228, 3168.714815666601, 3179.3959147761852, 3181.586393768818, 3185.3310804730804, 219387.0, 224205.0, 237606.0, 272246.63876680686, 274264.0, 47540.573782786574, 47605.523944760804, 47699.52300476951, 47755.04489910182, 47926.56220313396, 48948.510514895104, 49143.754281228365, 49176.75411622919, 49187.75406122946, 49244.753776231606, 12894.29081400532, 13365.131266467648, 14435.85564144366, 14436.494722684656, 14607.342669579682, 12021.218620789621, 12070.939645301893, 12094.395280235953, 12095.818562721566, 12098.334591597371, 13461.932690336485, 13476.989225808104, 13495.932520337336, 13529.66175845592, 13575.185488870698, 5976.551758618034, 6002.0, 6003.0, 6039.78860739872, 6057.848553786191, 1011.3931641015479, 1021.1881554164457, 1029.6910926721953, 1056.1497994114657, 1071.3678929431674, 23211.53576928452, 24367.26898193057, 24368.75631243665, 24381.376627397796, 24478.265652030466, 1072.4155335342257, 1106.9114470842314, 1116.1628778416189, 1146.5356530605118, 1155.5435602936961, 12431.0, 12521.561745339051, 12529.498820047096, 12543.0, 12588.748225035448, 333252.0, 351037.0, 351315.0, 351897.0, 352196.2390188033, 55988.88022239614, 56353.43646563564, 56438.71780641153, 56561.43438565644, 56625.867482650116, 1329.7938819482995, 1365.378752667534, 1552.8757699384248, 1566.7023265579503, 1568.4510421352663, 23717.881410592836, 23781.167659131846, 23860.403489912893, 23935.880320598983, 24050.0, 38922.61077389303, 39124.0, 39156.99999999886, 39220.80389598034, 39333.606663932995, 313307.0, 314143.0, 314266.0, 314485.0, 315341.0, 35343.99576036066, 35570.0, 36019.0, 36042.0, 36210.913672589864, 36038.8198059008, 46952.82617934579, 46980.53019469762, 47000.29499557441, 47125.764371177924, 24163.879180603984, 31165.0, 31525.369492610476, 31550.211244719067, 31630.683693162773, 25299.0, 31188.844055779577, 31327.06018819439, 31664.050078497683, 32327.676723233406, 37179.814100929325, 37258.62741372552, 37268.06829829168, 37346.626533734314, 37393.439098413, 28442.57336140001, 30524.0, 31974.0, 32144.874929377358, 32936.176595585304, 24501.754982449947, 24644.630330544696, 24675.0, 24741.50516989686, 24820.875895620407], "value": 17692.776176417676, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.1974229222186, 429.09735951520906, 437.56680885922935, 438.6140196626969, 447.42059033551527, 20101.396958091264, 21451.0, 22172.55654886901, 22392.21627243047, 22441.99011044503, 21629.45926351838, 22459.438514037156, 23050.19324323649, 23198.768012319873, 23261.767382326216, 6117.0, 6140.232470941132, 6319.241690997087, 6324.7470101195895, 6361.650109243989, 6026.3672314406795, 6214.906776398335, 6234.0337247726675, 6247.625142491443, 6255.280642726077, 4994.700317980933, 5981.312149102843, 6184.969075154618, 6212.471939885115, 6229.034499652561, 6149.13912052313, 6214.440700336946, 6220.066989951498, 6223.25320961483, 6246.812595622138, 5390.921815636849, 5454.699991500466, 5522.171674248854, 5548.223248745179, 5558.277423934903, 27069.593956090674, 27170.864145679145, 27316.45367092647, 27392.726072739417, 27627.447451050866, 2193.0, 2235.295881797245, 2259.3786708655252, 2260.626996545568, 2264.0490993782487, 17926.462206133707, 18034.639307213783, 18339.174737136862, 18342.08289585529, 18510.814891851045, 2152.989235053815, 2182.1162429216192, 2226.087304205268, 2230.721159855018, 2235.1506427557424, 116939.0, 119251.0, 129631.0, 145368.0, 147824.260878696, 10546.789064218827, 12505.624831255076, 12708.173968692005, 12861.485540578458, 12918.22490650564, 16910.0, 16916.577085572713, 16931.068791216356, 16933.068681222405, 17023.659526809395, 8930.062343453843, 9044.773880652905, 9169.72490825263, 9219.585118669676, 9300.11648893354, 7805.399893021917, 8216.383771217063, 8754.56227188638, 8780.253678437277, 8880.73357799267, 6736.8989465158065, 8054.275115239539, 8126.268635822805, 8165.183481651788, 8190.918090819016, 1837.6324735053042, 2143.549854530535, 2180.0952604668882, 2184.1154332495366, 2200.8899555022185, 980.5930538826307, 999.980000399988, 1004.5228516454625, 1032.2825636182781, 1036.212478516333, 20811.58376832485, 21489.247876324254, 21684.45788855291, 21736.239231626816, 21775.911204439715, 977.941323520591, 1002.659095907395, 1012.4937531234383, 1050.9369437833755, 1057.413135709673, 10726.785464290671, 11273.436328183721, 11274.323540587591, 11340.943295283636, 11378.943105284421, 615352.0, 678315.0, 689946.0, 691408.0, 712034.0, 119633.0, 145250.0, 146647.0, 146991.0, 151244.0, 1204.1811568133578, 1205.541894080244, 1230.2434003088035, 1233.660743295601, 1234.7592219517107, 15043.097414155185, 16672.583185420463, 18658.813411865707, 21765.347039588836, 23450.882745586165, 59341.0, 60341.094883575905, 61718.69140654268, 62031.37968620256, 62171.0, 71647.0, 83130.0, 83417.0, 84647.73028404702, 89543.0, 8729.956350218208, 8856.335774817044, 8965.910340896507, 9112.589933452879, 9198.632054717737, 13659.0, 13771.380287886868, 13851.445942162201, 13998.950078743932, 14207.431702732189, 11713.472893719632, 12013.038956883254, 12106.641609020922, 12144.939275303566, 12164.026877849928, 8904.065073167483, 11154.888451115385, 11228.66314010581, 11242.887571124184, 11576.742535205554, 11995.280283183038, 12086.45610947527, 12143.210691305037, 12187.817182742443, 12223.633291001284, 8960.342336667738, 9002.324825638234, 9012.954935225544, 9096.909030909606, 9124.31567632417, 9898.554565044446, 11672.358020308964, 12002.459889304828, 12048.397580121135, 12148.635540933787], "value": 10611.64843877972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.8758124187589, 1379.255202190817, 1398.811010640956, 1437.2957250947038, 1466.5013895275604, 11368.545258189673, 11713.941430292836, 11891.464884080226, 11988.880111198885, 12043.458044388002, 10137.834149072858, 11501.309921404722, 11741.70645733857, 11761.588344407948, 11781.0, 2419.733829278782, 2468.568000599888, 2469.370310570802, 2475.4677744284977, 2476.7647073527987, 2401.855888646678, 2433.5376278507115, 2486.01802288097, 2494.650748895156, 2495.338735235164, 2445.620928756037, 2445.951080978379, 2469.2098528470897, 2479.962800557993, 2480.2435257246534, 2427.526632306701, 2429.016248419393, 2452.2030340139436, 2461.064795377745, 2463.470353873917, 1891.7162425636266, 2171.610169491527, 2444.1934161726767, 2487.751224877516, 2488.9128880489097, 10384.0, 11723.296602203895, 11784.882151178464, 11797.351145686984, 11833.526658933632, 6429.8392540186405, 6630.303818099127, 6672.266050734415, 6683.598984060972, 6707.6981535831, 4119.588041195886, 4320.891977700583, 4348.152110338485, 4400.229959757062, 4408.757518336491, 1235.5922545560034, 1255.1653150654804, 1295.7084655952335, 1303.69363199648, 1303.8891694206004, 14851.183184924825, 15337.079775213635, 16349.836501635069, 16490.58773530659, 16582.08798516081, 5471.781128754806, 5550.417206193291, 5723.856903577361, 5731.856703582361, 5733.426657334233, 12209.450574724158, 12326.81509777354, 12327.198732082386, 12373.443195056245, 12700.539437964753, 6463.935360646427, 6503.869922601616, 6539.378759017885, 6540.738370465128, 6571.080048793173, 6032.487238584682, 6109.358517355702, 6148.784792532329, 6201.96899015502, 6208.4722798562625, 3892.824822882977, 4367.5414081520985, 4388.648908087345, 4434.201843668171, 4462.9107417851465, 1114.5151858941385, 1274.8278982337451, 1283.7625039367747, 1302.9966925467338, 1303.48512337628, 687.9724811007603, 761.6610608279262, 778.2489897249181, 779.2713812585138, 787.456654908123, 6003.429674180946, 6023.247094113236, 6096.329403765582, 6217.347178546278, 6351.428371446592, 500.4970005144806, 579.7014537513184, 590.6249531547498, 592.2271435776267, 598.0431309904205, 3676.209614932749, 3976.0855003349393, 4029.2674150115145, 4169.374593810892, 4186.974191323085, 14453.638659033399, 15213.61965950838, 15375.61560960985, 15377.384904603914, 15386.384544618313, 14627.488037918622, 14677.339519721638, 15262.007969481949, 15270.16014119234, 15287.235638218044, 9151.63393464254, 10899.727506812234, 11021.889781102247, 11082.16883733707, 11121.110311175087, 6272.968635156795, 6808.217055038734, 6833.145856767904, 6918.757843475454, 7072.151341839012, 11539.480723367637, 12801.29592872401, 12892.033097517537, 12926.96584273237, 13636.045476816527, 11476.770464590494, 12603.117781755556, 13887.791683124964, 14114.576562703136, 14159.858401416266, 9444.811103778024, 9573.712788616353, 9733.221342292742, 9762.072603102693, 9764.609415623296, 11021.338719676845, 11036.392998385167, 11154.553817847196, 11167.218294719292, 11171.273867198606, 7524.811879703051, 9217.861732074158, 9284.02517735628, 9298.628054877729, 9422.811543768948, 8823.514706691194, 8957.417767845069, 9021.503817290111, 9039.68361107358, 9141.222996045411, 7976.122626511195, 7989.0, 8071.394645401736, 8074.434789564674, 8130.67477300925, 5737.0, 5939.970300148471, 5977.6114552553945, 6076.270847498328, 6094.54290928191, 6030.849228769316, 6111.54163437735, 6130.356312587114, 6153.84615384619, 6168.907466388097], "value": 5301.920343019992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.2655127840413, 404.9952733966863, 410.2779108768567, 410.9054917369005, 414.67240879705037, 5854.180414741934, 5882.941170588293, 6036.486898613618, 6061.636301821888, 6088.878222435548, 5789.797357092502, 5848.912266316009, 5922.2597175353085, 5935.228420305354, 5935.554833387491, 4250.404943307939, 4384.605385515295, 4401.6478681705385, 4438.223310920592, 4446.7554284514335, 4384.49578298495, 4389.078293558357, 4418.204723149832, 4425.901868691913, 4433.556644335573, 4379.4963579188325, 4379.583939525756, 4402.779861006953, 4406.647468202536, 4410.889727756799, 4136.31750761124, 4226.985523474344, 4305.246581848164, 4412.845550405753, 4428.3800267962515, 3353.96646033539, 3761.322961866863, 3769.5288088988877, 3777.414500752388, 3806.638369354907, 5593.636413633101, 5630.943690563124, 5633.295838020247, 5635.6055076144685, 5644.350899646511, 5028.220625803006, 5112.897742045176, 5155.896882062338, 5170.0, 5211.635185537014, 5236.764345604457, 6225.252969643627, 6248.718807653667, 6251.874962500725, 6255.562110652256, 4268.975445892995, 4272.850450234227, 4275.91448171038, 4277.123189746095, 4288.228118938589, 5233.659812112201, 6402.679866006681, 6619.966900165517, 6628.602283862935, 6703.396694297488, 3555.306715190513, 3858.884233473, 4096.279562583722, 4327.853118923488, 4363.912721745547, 3617.7467577269863, 3694.833732482045, 3938.665213456888, 3987.6809855211513, 4001.8199181036925, 4030.153667729751, 4037.4953130858644, 5005.799768009311, 5171.224316352577, 5176.482351764794, 6339.809805705836, 6347.698721762028, 6348.492120630339, 6358.77744278948, 6365.8726825464155, 1346.5825594065675, 1388.9791653125212, 1493.1936754152853, 1516.651170230831, 1525.893187476866, 835.1648351648352, 857.9442336248123, 891.796075298355, 1005.6832097889288, 1015.5582321690089, 5817.854553636108, 6017.518598512109, 6050.062240352752, 6062.333143354227, 6066.66633335162, 6231.688415579203, 6491.480681545465, 6551.344865513506, 6559.672016399161, 6590.80227593173, 5000.399952005782, 5715.628484148517, 5763.2857720754855, 5940.31686356066, 6038.052518269501, 2674.8127631066027, 3427.1774774054047, 3436.7078798301923, 3436.9828150859084, 3448.896533104011, 6164.938350616437, 6397.264314603787, 6694.698738556776, 6800.741862755406, 6842.178938527409, 5376.704281264568, 6238.438540531374, 6463.935360646427, 6518.44593209573, 6791.72833086671, 5663.518600918968, 6758.493113016543, 6769.1876974763345, 6839.487038472035, 6869.210040845267, 5533.7786488540005, 5831.154482599914, 6186.628802271878, 6607.0, 6664.966675166593, 6463.15978922737, 6487.772927947499, 6489.805305840832, 6516.73933042673, 6555.2133743949125, 4987.411581345244, 5314.202869569595, 5621.325440947113, 6765.763198288037, 6825.781620973303, 4243.915121697487, 4333.458317710286, 4353.869383918487, 4378.43080399546, 4393.824247030211, 6510.372406898276, 6574.967125164535, 6575.638339891352, 6588.308227636029, 6602.029086911005, 5479.643823151482, 5514.558835293086, 6048.153258543895, 6205.968970155301, 6409.615423074631, 4868.440129385166, 6312.589681670676, 6339.732053589393, 6366.108744775643, 6371.5221358397375, 5454.754536045967, 5965.806838632204, 6214.285357183981, 6240.469560087262, 6290.779822706367, 5019.899602007867, 5999.52003839683, 6170.259568851587, 6325.841853953688, 6379.202599675041, 6142.969285153546, 6179.28938172116, 6184.783532576338, 6187.288461826767, 6205.503559715302], "value": 4577.99517577858, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.6262462705589, 776.7786180938434, 821.5686764448666, 832.263446849538, 879.9956000219998, 12100.81848772269, 13960.860391396083, 16154.353825846967, 16719.578835798973, 16747.665046699072, 13365.532206372778, 13786.034977551575, 17290.654186916254, 17298.48104556862, 17303.13484325785, 934.6681927915577, 976.243411356201, 976.7655762616956, 982.965596204133, 986.3982970388057, 1001.5643195210071, 1015.9644412445566, 1018.0379541333443, 1019.9596411660102, 1019.9749252001765, 1010.954507047181, 1043.2592859070069, 1050.14937900301, 1052.0741747262437, 1055.176961969661, 1042.8696412948382, 1043.9373637581732, 1044.613493007592, 1048.6749107776614, 1048.8688913885803, 779.0729032451421, 779.158508810489, 780.8555417247827, 784.3489903380181, 785.4776573578563, 14041.71916561663, 16251.51245462638, 16727.247273872585, 16858.072805995664, 17050.14749262544, 17115.486535403958, 17147.74278385825, 17549.94700317985, 17569.824301757075, 17647.294108235656, 11708.356040417773, 14027.43890244389, 14053.227072511008, 14139.85860141406, 14155.787663185061, 3499.07274572236, 3500.4574290984683, 3532.540769699948, 3535.416656251741, 3537.646235376442, 87265.56367218123, 92449.0, 119527.4023629885, 121605.39197303957, 122386.0, 13213.867861321263, 13240.20558766477, 13286.53497127596, 13485.730285394236, 13494.52769153075, 22017.119315227534, 23268.534629307658, 24466.633000505008, 24829.25512234636, 25541.0, 7610.238976102345, 8968.68609598661, 9054.5020023898, 9129.589168487433, 9130.634774608941, 4821.445533763592, 4906.607471402351, 4908.337374454403, 4909.0672772173175, 4911.754412279443, 4313.158934007901, 4350.564943505624, 4409.0, 4442.289233722653, 4453.087117140978, 884.2086332732168, 938.7983381271982, 942.3450701762347, 973.6494861849728, 977.8875429325576, 633.9587926784744, 671.5332843673698, 681.2097966358999, 682.3210905149408, 689.7516893918286, 11079.889201108046, 11523.423828808694, 11684.0, 11754.06600544629, 11769.117316201318, 599.4814485470037, 652.0, 659.8090446743673, 664.9667516624149, 669.581511555278, 4617.238155704271, 5233.973830130825, 5255.054090263713, 5319.255304257407, 5325.547328477045, 92707.53646231725, 93910.0, 100494.99505005003, 103136.0, 105263.89472210513, 79271.60364198142, 80184.0, 80346.0, 82062.76905846417, 84806.15193848105, 61797.69101154465, 71735.92396114062, 71909.6404517974, 73763.63118184482, 75952.86070708944, 9250.676226332045, 11986.101042422028, 12006.699832504257, 12092.60934992452, 12110.818337725117, 35712.0, 37078.07304817401, 37477.875663730134, 37682.246355073294, 37725.811370944066, 64200.03699944598, 64342.67828661014, 64687.35312646813, 65113.674431627536, 66151.66924165348, 15718.764218536502, 15878.841211587736, 15917.124558149413, 15948.122853243183, 16025.919870400574, 13943.790843137158, 13986.230757308038, 14174.362153703314, 14196.148231105753, 17117.05856177922, 15754.842451575338, 16045.67908641844, 16195.190240487693, 16295.51113466598, 16393.34426622922, 15195.240237988277, 15473.690526189639, 15695.0, 16166.030038197745, 16200.918995404947, 15049.54851354461, 15078.924605376902, 15157.0, 15273.847261527242, 15333.846661533242, 9703.466309353053, 11206.271592346471, 11207.831882521932, 11219.326840389604, 11418.942905285421, 12330.75338493243, 12395.814062788884, 12402.19385739924, 12453.813192802296, 12625.558105466265], "value": 8172.630140537828, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 116.0, 116.0, 118.0, 117.0, 116.0, 117.0, 116.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 112.0, 111.0, 149.0, 111.0, 112.0, 111.0, 102.0, 154.0, 143.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 199.0, 206.0, 230.0, 279.0, 275.0, 244.0, 194.0, 253.0, 280.0], "value": 235.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 50.0, 78.0, 108.0, 86.0, 87.0, 87.0, 74.0, 71.0, 57.0], "value": 77.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 83.0, 71.0, 73.0, 107.0, 124.0, 81.0, 69.0, 82.0], "value": 84.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 91.0, 90.0, 125.0, 134.0, 135.0, 92.0, 93.0, 118.0], "value": 105.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 114.0, 154.0, 136.0, 105.0, 139.0, 97.0, 96.0, 95.0, 98.0], "value": 116.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 92.0, 89.0, 90.0, 90.0, 91.0, 90.0, 91.0, 97.0, 92.0], "value": 91.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 49.0, 60.0, 51.0, 52.0, 54.0, 51.0, 54.0, 52.0, 54.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 66.0, 58.0, 63.0, 75.0, 68.0, 72.0, 61.0, 58.0, 62.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 86.0, 84.0, 84.0, 87.0, 85.0, 82.0, 84.0, 83.0, 85.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 143.0, 138.0, 140.0, 139.0, 142.0, 141.0, 145.0, 184.0, 140.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 201.0, 171.0, 197.0, 190.0, 188.0, 192.0, 190.0, 188.0, 189.0], "value": 191.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 72.0, 68.0, 68.0, 70.0, 68.0, 71.0, 69.0, 69.0], "value": 69.5, "unit": "score"}]}]} 17:35:58 INFO - Return code: 0 17:35:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:35:58 ERROR - # TBPL SUCCESS # 17:35:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:35:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:35:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:35:58 INFO - 2017-04-12 17:35:58.278 screenresolution[2234:14074] starting screenresolution argv=screenresolution get 17:35:58 INFO - 2017-04-12 17:35:58.281 screenresolution[2234:14074] Display 0: 1600x1200x32@60 17:35:58 INFO - 2017-04-12 17:35:58.287 screenresolution[2235:14077] starting screenresolution argv=screenresolution list 17:35:58 INFO - Available Modes on Display 0 17:35:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:35:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:35:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:35:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:35:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:35:58 INFO - Intel Iris: 17:35:58 INFO - Chipset Model: Intel Iris 17:35:58 INFO - Type: GPU 17:35:58 INFO - Bus: Built-In 17:35:58 INFO - VRAM (Dynamic, Max): 1536 MB 17:35:58 INFO - Vendor: Intel (0x8086) 17:35:58 INFO - Device ID: 0x0a2e 17:35:58 INFO - Revision ID: 0x0009 17:35:58 INFO - Displays: 17:35:58 INFO - Display: 17:35:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:35:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:35:58 INFO - Display Serial Number: 1600x1200 60 17:35:58 INFO - Main Display: Yes 17:35:58 INFO - Mirror: Off 17:35:58 INFO - Online: Yes 17:35:58 INFO - Rotation: Supported 17:35:58 INFO - Return code: 0 17:35:58 INFO - Running post-action listener: _resource_record_post_action 17:35:58 INFO - [mozharness: 2017-04-13 00:35:58.532965Z] Finished run-tests step (success) 17:35:58 INFO - Running post-run listener: _resource_record_post_run 17:35:58 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 1308160; Write bytes: 514499072; Read time: 12; Write time: 1680 17:35:58 INFO - TinderboxPrint: CPU usage
54.0% 17:35:58 INFO - TinderboxPrint: I/O read bytes / time
1,308,160 / 12 17:35:58 INFO - TinderboxPrint: I/O write bytes / time
514,499,072 / 1,680 17:35:58 INFO - TinderboxPrint: CPU idle
2,202.0 (46.0%) 17:35:58 INFO - TinderboxPrint: CPU system
961.5 (20.1%) 17:35:58 INFO - TinderboxPrint: CPU user
1,626.2 (34.0%) 17:35:58 INFO - TinderboxPrint: Swap in / out
209,485,824 / 0 17:35:58 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207264256; Write bytes: 202997760; Read time: 15951; Write time: 475 17:35:58 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 1271296; Write bytes: 304394752; Read time: 12; Write time: 1170 17:35:59 INFO - Running post-run listener: _upload_blobber_files 17:35:59 INFO - Blob upload gear active. 17:35:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:35:59 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 17:35:59 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'] 17:35:59 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 17:35:59 INFO - (blobuploader) - INFO - Open directory for files ... 17:35:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:35:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:00 INFO - (blobuploader) - INFO - Done attempting. 17:36:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:36:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:36:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:01 INFO - (blobuploader) - INFO - Done attempting. 17:36:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:36:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:36:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:02 INFO - (blobuploader) - INFO - Done attempting. 17:36:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:36:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:36:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:04 INFO - (blobuploader) - INFO - Done attempting. 17:36:04 INFO - (blobuploader) - INFO - Iteration through files over. 17:36:04 INFO - Return code: 0 17:36:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:36:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:36:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/405e837e4d5b3119cccbeb25185985401e22bea7de1dbd075d47586aca9b3f84e6e9da9b0f03c6a576892fd91182241d9a1abac25d2214a97935a01b101d46d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d500803fa915290be6d9be3ee8e0bc8dc08ede7bfad649af605e3e7fee3a5f13f58a730f6ecb9540df512acfabc6da51583e7695ae1afdb3756bc22cea945247", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9a28fac0fa72184e4fa6e1f0ba5b0a815e160b3dd812121f36d9d6ec5aa58566f9ed4ba9f631d118291ffae40213befc81b645705fdc74001b9ca969023faf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/314d52fdc84c89f1f1516a1260d4c9af755466fe614a5adaef3c3e49c90520e3444320cb9e5a455c03548ef1c8a4def35c68a30cf63a758928b35243f8a0fa52"} 17:36:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:36:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:36:04 INFO - Contents: 17:36:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/405e837e4d5b3119cccbeb25185985401e22bea7de1dbd075d47586aca9b3f84e6e9da9b0f03c6a576892fd91182241d9a1abac25d2214a97935a01b101d46d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d500803fa915290be6d9be3ee8e0bc8dc08ede7bfad649af605e3e7fee3a5f13f58a730f6ecb9540df512acfabc6da51583e7695ae1afdb3756bc22cea945247", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9a28fac0fa72184e4fa6e1f0ba5b0a815e160b3dd812121f36d9d6ec5aa58566f9ed4ba9f631d118291ffae40213befc81b645705fdc74001b9ca969023faf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/314d52fdc84c89f1f1516a1260d4c9af755466fe614a5adaef3c3e49c90520e3444320cb9e5a455c03548ef1c8a4def35c68a30cf63a758928b35243f8a0fa52"} 17:36:04 INFO - Running post-run listener: copy_logs_to_upload_dir 17:36:04 INFO - Copying logs to upload dir... 17:36:04 INFO - mkdir: /builds/slave/test/build/upload/logs 17:36:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.065822 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-12 17:36:04.949101) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 17:36:04.952919) ========= 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.wkwb2zNABy/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.h7XoykGAv6/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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/405e837e4d5b3119cccbeb25185985401e22bea7de1dbd075d47586aca9b3f84e6e9da9b0f03c6a576892fd91182241d9a1abac25d2214a97935a01b101d46d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d500803fa915290be6d9be3ee8e0bc8dc08ede7bfad649af605e3e7fee3a5f13f58a730f6ecb9540df512acfabc6da51583e7695ae1afdb3756bc22cea945247", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9a28fac0fa72184e4fa6e1f0ba5b0a815e160b3dd812121f36d9d6ec5aa58566f9ed4ba9f631d118291ffae40213befc81b645705fdc74001b9ca969023faf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/314d52fdc84c89f1f1516a1260d4c9af755466fe614a5adaef3c3e49c90520e3444320cb9e5a455c03548ef1c8a4def35c68a30cf63a758928b35243f8a0fa52"} build_url:https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011147 build_url: 'https://queue.taskcluster.net/v1/task/RBd3U0jpTK2TY1-IPu28bQ/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/405e837e4d5b3119cccbeb25185985401e22bea7de1dbd075d47586aca9b3f84e6e9da9b0f03c6a576892fd91182241d9a1abac25d2214a97935a01b101d46d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d500803fa915290be6d9be3ee8e0bc8dc08ede7bfad649af605e3e7fee3a5f13f58a730f6ecb9540df512acfabc6da51583e7695ae1afdb3756bc22cea945247", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9a28fac0fa72184e4fa6e1f0ba5b0a815e160b3dd812121f36d9d6ec5aa58566f9ed4ba9f631d118291ffae40213befc81b645705fdc74001b9ca969023faf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/314d52fdc84c89f1f1516a1260d4c9af755466fe614a5adaef3c3e49c90520e3444320cb9e5a455c03548ef1c8a4def35c68a30cf63a758928b35243f8a0fa52"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 17:36:04.988063) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 17:36:04.988403) ========= 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.wkwb2zNABy/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.h7XoykGAv6/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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.005278 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 17:36:05.037648) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 17:36:05.038016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 17:36:05.038362) ========= ========= Total master_lag: 0.18 =========