builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1506638856.52 results: success (0) revision: 307a7a34013060a6a1e87dfbb911f058d0781a2e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 15:47:36.523397) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 15:47:36.523764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 15:47:36.524026) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 15:47:36.562694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 15:47:36.562970) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-28 15:47:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.1M=0s 2017-09-28 15:47:36 (36.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.311887 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 15:47:36.892603) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 15:47:36.892873) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015002 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 15:47:36.944917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 15:47:36.945203) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 307a7a34013060a6a1e87dfbb911f058d0781a2e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 307a7a34013060a6a1e87dfbb911f058d0781a2e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-28 15:47:37,002 truncating revision to first 12 chars 2017-09-28 15:47:37,002 Setting DEBUG logging. 2017-09-28 15:47:37,002 attempt 1/10 2017-09-28 15:47:37,002 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/307a7a340130?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-28 15:47:37,470 unpacking tar archive at: mozilla-central-307a7a340130/testing/mozharness/ program finished with exit code 0 elapsedTime=0.777261 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 15:47:37.742168) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 15:47:37.742466) ========= script_repo_revision: 307a7a34013060a6a1e87dfbb911f058d0781a2e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 15:47:37.745875) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 15:47:37.746138) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 15:47:37.767131) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-28 15:47:37.767393) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:37 INFO - MultiFileLogger online at 20170928 15:47:37 in /builds/slave/test 15:47:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:47:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:47:37 INFO - {'append_to_log': False, 15:47:37 INFO - 'base_work_dir': '/builds/slave/test', 15:47:37 INFO - 'blob_upload_branch': 'Firefox', 15:47:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:47:37 INFO - 'branch': 'Firefox', 15:47:37 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:37 INFO - 'code_coverage': False, 15:47:37 INFO - 'config_files': ('talos/linux_config.py',), 15:47:37 INFO - 'default_actions': ('clobber', 15:47:37 INFO - 'read-buildbot-config', 15:47:37 INFO - 'download-and-extract', 15:47:37 INFO - 'populate-webroot', 15:47:37 INFO - 'create-virtualenv', 15:47:37 INFO - 'install', 15:47:37 INFO - 'setup-mitmproxy', 15:47:37 INFO - 'run-tests'), 15:47:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:37 INFO - 'disable_ccov_upload': False, 15:47:37 INFO - 'disable_stylo': False, 15:47:37 INFO - 'download_minidump_stackwalk': True, 15:47:37 INFO - 'download_symbols': 'ondemand', 15:47:37 INFO - 'enable_stylo': False, 15:47:37 INFO - 'enable_webrender': False, 15:47:37 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:47:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:37 INFO - 'gecko_profile': False, 15:47:37 INFO - 'gecko_profile_interval': 0, 15:47:37 INFO - 'installer_path': 'installer.exe', 15:47:37 INFO - 'log_level': 'info', 15:47:37 INFO - 'log_name': 'talos', 15:47:37 INFO - 'log_to_console': True, 15:47:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:37 INFO - 'opt_config_files': (), 15:47:37 INFO - 'pip_index': False, 15:47:37 INFO - 'suite': 'dromaeojs-e10s', 15:47:37 INFO - 'system_bits': '32', 15:47:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:37 INFO - 'title': 'talos-linux64-ix-027', 15:47:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:37 INFO - 'use_talos_json': True, 15:47:37 INFO - 'verify': 'False', 15:47:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:47:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:37 INFO - 'work_dir': 'build'} 15:47:37 INFO - [mozharness: 2017-09-28 22:47:37.966977Z] Running clobber step. 15:47:37 INFO - Running pre-action listener: _resource_record_pre_action 15:47:37 INFO - Running main action method: clobber 15:47:37 INFO - rmtree: /builds/slave/test/build 15:47:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:47:38 INFO - Running post-action listener: _resource_record_post_action 15:47:38 INFO - [mozharness: 2017-09-28 22:47:38.968932Z] Finished clobber step (success) 15:47:38 INFO - [mozharness: 2017-09-28 22:47:38.969030Z] Running read-buildbot-config step. 15:47:38 INFO - Running pre-action listener: _resource_record_pre_action 15:47:38 INFO - Running main action method: read_buildbot_config 15:47:38 INFO - Using buildbot properties: 15:47:38 INFO - { 15:47:38 INFO - "project": "", 15:47:38 INFO - "product": "firefox", 15:47:38 INFO - "who": "ryanvm@gmail.com", 15:47:38 INFO - "installer_path": "public/build/target.tar.bz2", 15:47:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 15:47:38 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:47:38 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 15:47:38 INFO - "stage_platform": "linux64-qr", 15:47:38 INFO - "basedir": "/builds/slave/test", 15:47:38 INFO - "buildnumber": 104, 15:47:38 INFO - "platform": "ubuntu64_hw_qr", 15:47:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:47:38 INFO - "slavebuilddir": "test", 15:47:38 INFO - "taskId": "C6kxkPy0SaOt__3a2z1fZA", 15:47:38 INFO - "branch": "mozilla-central", 15:47:38 INFO - "script_repo_revision": "production", 15:47:38 INFO - "revision": "307a7a34013060a6a1e87dfbb911f058d0781a2e", 15:47:38 INFO - "slavename": "talos-linux64-ix-027", 15:47:38 INFO - "repo_path": "mozilla-central" 15:47:38 INFO - } 15:47:38 INFO - Finding installer, test and symbols from parent task. 15:47:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C6kxkPy0SaOt__3a2z1fZA'}, attempt #1 15:47:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C6kxkPy0SaOt__3a2z1fZA'}, attempt #1 15:47:39 INFO - Task dependencies: CK_o3hL6TtqucDlJLtKu5Q 15:47:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q'}, attempt #1 15:47:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.tar.bz2 15:47:40 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.test_packages.json 15:47:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.crashreporter-symbols.zip 15:47:40 INFO - Running post-action listener: _resource_record_post_action 15:47:40 INFO - [mozharness: 2017-09-28 22:47:40.464067Z] Finished read-buildbot-config step (success) 15:47:40 INFO - [mozharness: 2017-09-28 22:47:40.464283Z] Running download-and-extract step. 15:47:40 INFO - Running pre-action listener: _resource_record_pre_action 15:47:40 INFO - Running main action method: download_and_extract 15:47:40 INFO - mkdir: /builds/slave/test/build/tests 15:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:47:40 INFO - trying https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.test_packages.json 15:47:40 INFO - Downloading https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:47:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:47:41 INFO - Downloaded 989 bytes. 15:47:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:47:41 INFO - Using the following test package requirements: 15:47:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:47:41 INFO - u'common': [u'target.common.tests.zip'], 15:47:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:47:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:47:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:47:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:47:41 INFO - u'mozbase': [u'target.common.tests.zip'], 15:47:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:47:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:47:41 INFO - u'web-platform': [u'target.common.tests.zip', 15:47:41 INFO - u'target.web-platform.tests.tar.gz'], 15:47:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:47:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:47:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.common.tests.zip 15:47:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:47:41 INFO - Fetch https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.common.tests.zip into memory 15:47:45 INFO - Content-Length response header: 55262926 15:47:45 INFO - Bytes received: 55262926 15:47:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.talos.tests.zip 15:47:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:47:55 INFO - Fetch https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.talos.tests.zip into memory 15:47:57 INFO - Content-Length response header: 14521162 15:47:57 INFO - Bytes received: 14521162 15:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:47:57 INFO - trying https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.tar.bz2 15:47:57 INFO - Downloading https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:47:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:48:01 INFO - Downloaded 61687896 bytes. 15:48:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.tar.bz2 15:48:01 INFO - mkdir: /builds/slave/test/properties 15:48:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:48:01 INFO - Writing to file /builds/slave/test/properties/build_url 15:48:01 INFO - Contents: 15:48:01 INFO - build_url:https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.tar.bz2 15:48:01 INFO - Running post-action listener: _resource_record_post_action 15:48:01 INFO - Running post-action listener: find_tests_for_verification 15:48:01 INFO - Running post-action listener: set_extra_try_arguments 15:48:01 INFO - [mozharness: 2017-09-28 22:48:01.457412Z] Finished download-and-extract step (success) 15:48:01 INFO - [mozharness: 2017-09-28 22:48:01.457715Z] Running populate-webroot step. 15:48:01 INFO - Running pre-action listener: _resource_record_pre_action 15:48:01 INFO - Running main action method: populate_webroot 15:48:01 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:48:01 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:01 INFO - 'tests': ['tresize', 15:48:01 INFO - 'tcanvasmark']}, 15:48:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:48:01 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:01 INFO - 'tests': ['dromaeo_css', 15:48:01 INFO - 'kraken']}, 15:48:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:48:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:01 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:01 INFO - 'talos_options': ['--disable-stylo'], 15:48:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:48:01 INFO - 'tests': ['damp', 'tps']}, 15:48:01 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:01 INFO - 'talos_options': ['--disable-stylo'], 15:48:01 INFO - 'tests': ['damp', 'tps']}, 15:48:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:48:01 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:01 INFO - 'tests': ['dromaeo_dom']}, 15:48:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:48:01 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:01 INFO - 'tests': ['basic_compositor_video', 15:48:01 INFO - 'glvideo']}, 15:48:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:48:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:48:01 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:01 INFO - 'talos_options': ['--disable-stylo'], 15:48:01 INFO - 'tests': ['ts_paint_webext', 15:48:01 INFO - 'tp5o_webext']}, 15:48:01 INFO - 'other-e10s': {'tests': ['a11yr', 15:48:01 INFO - 'ts_paint', 15:48:01 INFO - 'tpaint', 15:48:01 INFO - 'sessionrestore', 15:48:01 INFO - 'sessionrestore_many_windows', 15:48:01 INFO - 'sessionrestore_no_auto_restore', 15:48:01 INFO - 'tabpaint', 15:48:01 INFO - 'cpstartup']}, 15:48:01 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:01 INFO - 'tests': ['a11yr', 15:48:01 INFO - 'ts_paint', 15:48:01 INFO - 'tpaint', 15:48:01 INFO - 'sessionrestore', 15:48:01 INFO - 'sessionrestore_many_windows', 15:48:01 INFO - 'sessionrestore_no_auto_restore', 15:48:01 INFO - 'tabpaint', 15:48:01 INFO - 'cpstartup']}, 15:48:01 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 15:48:01 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:48:01 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:01 INFO - 'tests': ['perf_reftest_singletons']}, 15:48:01 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:01 INFO - 'tests': ['perf_reftest']}, 15:48:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:48:01 INFO - 'tsvgr_opacity', 15:48:01 INFO - 'tart', 15:48:01 INFO - 'tscrollx', 15:48:01 INFO - 'tsvg_static']}, 15:48:01 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:01 INFO - 'tests': ['tsvgx', 15:48:01 INFO - 'tsvgr_opacity', 15:48:01 INFO - 'tart', 15:48:01 INFO - 'tscrollx', 15:48:01 INFO - 'tsvg_static']}, 15:48:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:48:01 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:01 INFO - 'talos_options': ['--disable-stylo'], 15:48:01 INFO - 'tests': ['tp5o']}, 15:48:01 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:48:01 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:48:01 INFO - 'talos_options': ['--mitmproxy', 15:48:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:48:01 INFO - '--firstNonBlankPaint'], 15:48:01 INFO - 'tests': ['tp6_google', 15:48:01 INFO - 'tp6_youtube', 15:48:01 INFO - 'tp6_amazon', 15:48:01 INFO - 'tp6_facebook']}, 15:48:01 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:48:01 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:48:01 INFO - 'talos_options': ['--disable-stylo', 15:48:01 INFO - '--mitmproxy', 15:48:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:48:01 INFO - '--firstNonBlankPaint'], 15:48:01 INFO - 'tests': ['tp6_google', 15:48:01 INFO - 'tp6_youtube', 15:48:01 INFO - 'tp6_amazon', 15:48:01 INFO - 'tp6_facebook']}, 15:48:01 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:48:01 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:48:01 INFO - 'talos_options': ['--stylo-threads=1', 15:48:01 INFO - '--mitmproxy', 15:48:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:48:01 INFO - '--firstNonBlankPaint'], 15:48:01 INFO - 'tests': ['tp6_google', 15:48:01 INFO - 'tp6_youtube', 15:48:01 INFO - 'tp6_amazon', 15:48:01 INFO - 'tp6_facebook']}, 15:48:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:48:01 INFO - 'talos_options': ['--xperf_path', 15:48:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:01 INFO - 'tests': ['tp5n']}, 15:48:01 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:01 INFO - 'talos_options': ['--disable-stylo', 15:48:01 INFO - '--xperf_path', 15:48:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:01 INFO - 'tests': ['tp5n']}}} 15:48:01 INFO - Running post-action listener: _resource_record_post_action 15:48:01 INFO - [mozharness: 2017-09-28 22:48:01.813258Z] Finished populate-webroot step (success) 15:48:01 INFO - [mozharness: 2017-09-28 22:48:01.813480Z] Running create-virtualenv step. 15:48:01 INFO - Running pre-action listener: _resource_record_pre_action 15:48:01 INFO - Running main action method: create_virtualenv 15:48:01 INFO - Creating virtualenv /builds/slave/test/build/venv 15:48:01 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:48:01 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:48:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:48:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:48:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:48:02 INFO - Installing distribute.............................................................................................................................................................................................done. 15:48:02 INFO - Installing pip...............done. 15:48:02 INFO - Return code: 0 15:48:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:48:02 INFO - Reading from file tmpfile_stdout 15:48:02 INFO - Output received: 15:48:02 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:48:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:02 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/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 0x28781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be2d60>, '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 0x2be3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be3ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 15:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:48:02 INFO - Using env: {'DISPLAY': ':0', 15:48:02 INFO - 'HOME': '/home/cltbld', 15:48:02 INFO - 'LANG': 'en_US.UTF-8', 15:48:02 INFO - 'LANGUAGE': 'en_US:en', 15:48:02 INFO - 'LOGNAME': 'cltbld', 15:48:02 INFO - 'MAIL': '/var/mail/cltbld', 15:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:02 INFO - 'MOZ_NO_REMOTE': '1', 15:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:02 INFO - 'NO_EM_RESTART': '1', 15:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:02 INFO - 'PWD': '/builds/slave/test', 15:48:02 INFO - 'SHELL': '/bin/bash', 15:48:02 INFO - 'SHLVL': '1', 15:48:02 INFO - 'TERM': 'linux', 15:48:02 INFO - 'TMOUT': '86400', 15:48:02 INFO - 'USER': 'cltbld', 15:48:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 15:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:02 INFO - '_': '/tools/buildbot/bin/python'} 15:48:04 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:48:04 INFO - Downloading/unpacking pip>=1.5 15:48:04 INFO - Running setup.py egg_info for package pip 15:48:04 INFO - warning: no files found matching 'pip/cacert.pem' 15:48:04 INFO - warning: no files found matching '*.html' under directory 'docs' 15:48:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:48:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:48:04 INFO - Installing collected packages: pip 15:48:04 INFO - Found existing installation: pip 1.1 15:48:04 INFO - Uninstalling pip: 15:48:04 INFO - Successfully uninstalled pip 15:48:04 INFO - Running setup.py install for pip 15:48:04 INFO - warning: no files found matching 'pip/cacert.pem' 15:48:04 INFO - warning: no files found matching '*.html' under directory 'docs' 15:48:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:48:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:48:04 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:48:04 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:48:04 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:48:04 INFO - Successfully installed pip 15:48:04 INFO - Cleaning up... 15:48:04 INFO - Return code: 0 15:48:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x28781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be2d60>, '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 0x2be3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be3ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 15:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:48:04 INFO - Using env: {'DISPLAY': ':0', 15:48:04 INFO - 'HOME': '/home/cltbld', 15:48:04 INFO - 'LANG': 'en_US.UTF-8', 15:48:04 INFO - 'LANGUAGE': 'en_US:en', 15:48:04 INFO - 'LOGNAME': 'cltbld', 15:48:04 INFO - 'MAIL': '/var/mail/cltbld', 15:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:04 INFO - 'MOZ_NO_REMOTE': '1', 15:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:04 INFO - 'NO_EM_RESTART': '1', 15:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:04 INFO - 'PWD': '/builds/slave/test', 15:48:04 INFO - 'SHELL': '/bin/bash', 15:48:04 INFO - 'SHLVL': '1', 15:48:04 INFO - 'TERM': 'linux', 15:48:04 INFO - 'TMOUT': '86400', 15:48:04 INFO - 'USER': 'cltbld', 15:48:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 15:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:04 INFO - '_': '/tools/buildbot/bin/python'} 15:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:04 INFO - Downloading/unpacking psutil>=3.1.1 15:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:48:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:05 INFO - Installing collected packages: psutil 15:48:05 INFO - Running setup.py install for psutil 15:48:05 INFO - building 'psutil._psutil_linux' extension 15:48:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:48:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:48:05 INFO - building 'psutil._psutil_posix' extension 15:48:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:48:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:48:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:05 INFO - Successfully installed psutil 15:48:05 INFO - Cleaning up... 15:48:06 INFO - Return code: 0 15:48:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:06 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/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 0x28781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be2d60>, '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 0x2be3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be3ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 15:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:48:06 INFO - Using env: {'DISPLAY': ':0', 15:48:06 INFO - 'HOME': '/home/cltbld', 15:48:06 INFO - 'LANG': 'en_US.UTF-8', 15:48:06 INFO - 'LANGUAGE': 'en_US:en', 15:48:06 INFO - 'LOGNAME': 'cltbld', 15:48:06 INFO - 'MAIL': '/var/mail/cltbld', 15:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:06 INFO - 'MOZ_NO_REMOTE': '1', 15:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:06 INFO - 'NO_EM_RESTART': '1', 15:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:06 INFO - 'PWD': '/builds/slave/test', 15:48:06 INFO - 'SHELL': '/bin/bash', 15:48:06 INFO - 'SHLVL': '1', 15:48:06 INFO - 'TERM': 'linux', 15:48:06 INFO - 'TMOUT': '86400', 15:48:06 INFO - 'USER': 'cltbld', 15:48:06 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 15:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:06 INFO - '_': '/tools/buildbot/bin/python'} 15:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:48:07 INFO - Installing collected packages: mozsystemmonitor 15:48:07 INFO - Running setup.py install for mozsystemmonitor 15:48:07 INFO - Successfully installed mozsystemmonitor 15:48:07 INFO - Cleaning up... 15:48:08 INFO - Return code: 0 15:48:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:08 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/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 0x28781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be2d60>, '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 0x2be3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be3ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 15:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:48:08 INFO - Using env: {'DISPLAY': ':0', 15:48:08 INFO - 'HOME': '/home/cltbld', 15:48:08 INFO - 'LANG': 'en_US.UTF-8', 15:48:08 INFO - 'LANGUAGE': 'en_US:en', 15:48:08 INFO - 'LOGNAME': 'cltbld', 15:48:08 INFO - 'MAIL': '/var/mail/cltbld', 15:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:08 INFO - 'MOZ_NO_REMOTE': '1', 15:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:08 INFO - 'NO_EM_RESTART': '1', 15:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:08 INFO - 'PWD': '/builds/slave/test', 15:48:08 INFO - 'SHELL': '/bin/bash', 15:48:08 INFO - 'SHLVL': '1', 15:48:08 INFO - 'TERM': 'linux', 15:48:08 INFO - 'TMOUT': '86400', 15:48:08 INFO - 'USER': 'cltbld', 15:48:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 15:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:08 INFO - '_': '/tools/buildbot/bin/python'} 15:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:08 INFO - Downloading/unpacking jsonschema==2.5.1 15:48:08 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 15:48:08 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 15:48:08 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 15:48:08 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 15:48:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:48:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:09 INFO - Downloading functools32-3.2.3-2.tar.gz 15:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:48:09 INFO - warning: no files found matching '*.txt' 15:48:09 INFO - no previously-included directories found matching 'build' 15:48:09 INFO - no previously-included directories found matching 'dist' 15:48:09 INFO - no previously-included directories found matching '.git*' 15:48:09 INFO - Installing collected packages: jsonschema, functools32 15:48:09 INFO - Running setup.py install for functools32 15:48:09 INFO - warning: no files found matching '*.txt' 15:48:09 INFO - no previously-included directories found matching 'build' 15:48:09 INFO - no previously-included directories found matching 'dist' 15:48:09 INFO - no previously-included directories found matching '.git*' 15:48:09 INFO - Successfully installed jsonschema functools32 15:48:09 INFO - Cleaning up... 15:48:09 INFO - Return code: 0 15:48:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x28781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be2d60>, '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 0x2be3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be3ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 15:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:48:09 INFO - Using env: {'DISPLAY': ':0', 15:48:09 INFO - 'HOME': '/home/cltbld', 15:48:09 INFO - 'LANG': 'en_US.UTF-8', 15:48:09 INFO - 'LANGUAGE': 'en_US:en', 15:48:09 INFO - 'LOGNAME': 'cltbld', 15:48:09 INFO - 'MAIL': '/var/mail/cltbld', 15:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:09 INFO - 'MOZ_NO_REMOTE': '1', 15:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:09 INFO - 'NO_EM_RESTART': '1', 15:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:09 INFO - 'PWD': '/builds/slave/test', 15:48:09 INFO - 'SHELL': '/bin/bash', 15:48:09 INFO - 'SHLVL': '1', 15:48:09 INFO - 'TERM': 'linux', 15:48:09 INFO - 'TMOUT': '86400', 15:48:09 INFO - 'USER': 'cltbld', 15:48:09 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 15:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:09 INFO - '_': '/tools/buildbot/bin/python'} 15:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:48:10 INFO - Cleaning up... 15:48:10 INFO - Return code: 0 15:48:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:10 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/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 0x28781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be2d60>, '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 0x2be3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be3ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 15:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:48:10 INFO - Using env: {'DISPLAY': ':0', 15:48:10 INFO - 'HOME': '/home/cltbld', 15:48:10 INFO - 'LANG': 'en_US.UTF-8', 15:48:10 INFO - 'LANGUAGE': 'en_US:en', 15:48:10 INFO - 'LOGNAME': 'cltbld', 15:48:10 INFO - 'MAIL': '/var/mail/cltbld', 15:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:10 INFO - 'MOZ_NO_REMOTE': '1', 15:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:10 INFO - 'NO_EM_RESTART': '1', 15:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:10 INFO - 'PWD': '/builds/slave/test', 15:48:10 INFO - 'SHELL': '/bin/bash', 15:48:10 INFO - 'SHLVL': '1', 15:48:10 INFO - 'TERM': 'linux', 15:48:10 INFO - 'TMOUT': '86400', 15:48:10 INFO - 'USER': 'cltbld', 15:48:10 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 15:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:10 INFO - '_': '/tools/buildbot/bin/python'} 15:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:10 INFO - Downloading/unpacking blobuploader==1.2.4 15:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:11 INFO - Downloading blobuploader-1.2.4.tar.gz 15:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:48:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:48:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 INFO - Downloading docopt-0.6.1.tar.gz 15:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:48:12 INFO - Installing collected packages: blobuploader, requests, docopt 15:48:12 INFO - Running setup.py install for blobuploader 15:48:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:48:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:48:12 INFO - Running setup.py install for requests 15:48:12 INFO - Running setup.py install for docopt 15:48:12 INFO - Successfully installed blobuploader requests docopt 15:48:12 INFO - Cleaning up... 15:48:12 INFO - Return code: 0 15:48:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:12 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/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 0x28781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be2d60>, '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 0x2be3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be3ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:12 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:48:12 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:12 INFO - Using env: {'DISPLAY': ':0', 15:48:12 INFO - 'HOME': '/home/cltbld', 15:48:12 INFO - 'LANG': 'en_US.UTF-8', 15:48:12 INFO - 'LANGUAGE': 'en_US:en', 15:48:12 INFO - 'LOGNAME': 'cltbld', 15:48:12 INFO - 'MAIL': '/var/mail/cltbld', 15:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:12 INFO - 'MOZ_NO_REMOTE': '1', 15:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:12 INFO - 'NO_EM_RESTART': '1', 15:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:12 INFO - 'PWD': '/builds/slave/test', 15:48:12 INFO - 'SHELL': '/bin/bash', 15:48:12 INFO - 'SHLVL': '1', 15:48:12 INFO - 'TERM': 'linux', 15:48:12 INFO - 'TMOUT': '86400', 15:48:12 INFO - 'USER': 'cltbld', 15:48:12 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 15:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:12 INFO - '_': '/tools/buildbot/bin/python'} 15:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:12 INFO - Running setup.py (path:/tmp/pip-7Eb9sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:12 INFO - Running setup.py (path:/tmp/pip-W2_SjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:12 INFO - Running setup.py (path:/tmp/pip-Ui92gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:13 INFO - Running setup.py (path:/tmp/pip-lwqpB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:13 INFO - Running setup.py (path:/tmp/pip-u6PsVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:13 INFO - Running setup.py (path:/tmp/pip-zrGaGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:13 INFO - Running setup.py (path:/tmp/pip-3oU04D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:13 INFO - Running setup.py (path:/tmp/pip-ahOGKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:13 INFO - Running setup.py (path:/tmp/pip-dIGkCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:13 INFO - Running setup.py (path:/tmp/pip-Q1_rrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:13 INFO - Running setup.py (path:/tmp/pip-XEjdFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:13 INFO - Running setup.py (path:/tmp/pip-eYiq7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:13 INFO - Running setup.py (path:/tmp/pip-Jaijaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:13 INFO - Running setup.py (path:/tmp/pip-7K6gF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:13 INFO - Running setup.py (path:/tmp/pip-vJWQfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:13 INFO - Running setup.py (path:/tmp/pip-dtpPft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:13 INFO - Running setup.py (path:/tmp/pip-G4vNJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:48:14 INFO - Running setup.py install for manifestparser 15:48:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:48:14 INFO - Running setup.py install for mozcrash 15:48:14 INFO - Running setup.py install for mozdebug 15:48:14 INFO - Running setup.py install for mozdevice 15:48:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:48:14 INFO - Running setup.py install for mozfile 15:48:14 INFO - Running setup.py install for mozhttpd 15:48:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:48:14 INFO - Running setup.py install for mozinfo 15:48:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:48:14 INFO - Running setup.py install for mozInstall 15:48:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:48:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:48:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:48:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:48:14 INFO - Running setup.py install for mozleak 15:48:14 INFO - Running setup.py install for mozlog 15:48:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:48:15 INFO - Running setup.py install for moznetwork 15:48:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:48:15 INFO - Running setup.py install for mozprocess 15:48:15 INFO - Running setup.py install for mozprofile 15:48:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:48:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:48:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:48:15 INFO - Running setup.py install for mozrunner 15:48:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:48:15 INFO - Running setup.py install for mozscreenshot 15:48:15 INFO - Running setup.py install for moztest 15:48:15 INFO - Running setup.py install for mozversion 15:48:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:48:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:15 INFO - Cleaning up... 15:48:15 INFO - Return code: 0 15:48:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:15 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/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 0x28781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be2d60>, '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 0x2be3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be3ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:15 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:48:15 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:15 INFO - Using env: {'DISPLAY': ':0', 15:48:15 INFO - 'HOME': '/home/cltbld', 15:48:15 INFO - 'LANG': 'en_US.UTF-8', 15:48:15 INFO - 'LANGUAGE': 'en_US:en', 15:48:15 INFO - 'LOGNAME': 'cltbld', 15:48:15 INFO - 'MAIL': '/var/mail/cltbld', 15:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:15 INFO - 'MOZ_NO_REMOTE': '1', 15:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:15 INFO - 'NO_EM_RESTART': '1', 15:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:15 INFO - 'PWD': '/builds/slave/test', 15:48:15 INFO - 'SHELL': '/bin/bash', 15:48:15 INFO - 'SHLVL': '1', 15:48:15 INFO - 'TERM': 'linux', 15:48:15 INFO - 'TMOUT': '86400', 15:48:15 INFO - 'USER': 'cltbld', 15:48:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 15:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:15 INFO - '_': '/tools/buildbot/bin/python'} 15:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:16 INFO - Running setup.py (path:/tmp/pip-Vd2FAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:16 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)) 15:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:16 INFO - Running setup.py (path:/tmp/pip-y56cZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:16 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)) 15:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:16 INFO - Running setup.py (path:/tmp/pip-wd6Lsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:16 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)) 15:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:16 INFO - Running setup.py (path:/tmp/pip-_4_ONP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 15:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:16 INFO - Running setup.py (path:/tmp/pip-mOQpXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:16 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)) 15:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:16 INFO - Running setup.py (path:/tmp/pip-FELXJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:16 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)) 15:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:16 INFO - Running setup.py (path:/tmp/pip-Ya7Sxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 15:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:16 INFO - Running setup.py (path:/tmp/pip-B26q8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 15:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:16 INFO - Running setup.py (path:/tmp/pip-rpc5Cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:16 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)) 15:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:16 INFO - Running setup.py (path:/tmp/pip-7LjmjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 15:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:16 INFO - Running setup.py (path:/tmp/pip-XHKxRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:16 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)) 15:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:16 INFO - Running setup.py (path:/tmp/pip-VtRvP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:16 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)) 15:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:16 INFO - Running setup.py (path:/tmp/pip-Yb6qOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:16 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)) 15:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:16 INFO - Running setup.py (path:/tmp/pip-rd3eg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:17 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)) 15:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:17 INFO - Running setup.py (path:/tmp/pip-dSwtaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:17 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)) 15:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:17 INFO - Running setup.py (path:/tmp/pip-HLQnU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:17 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)) 15:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:17 INFO - Running setup.py (path:/tmp/pip-6TtR3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:17 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)) 15:48:17 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)) 15:48:17 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)) 15:48:17 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)) 15:48:17 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:17 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:48:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:17 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 15:48:17 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 15:48:17 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 15:48:17 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 15:48:18 INFO - Downloading blessings-1.6.tar.gz 15:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:18 INFO - Installing collected packages: blessings 15:48:18 INFO - Running setup.py install for blessings 15:48:18 INFO - Successfully installed blessings 15:48:18 INFO - Cleaning up... 15:48:18 INFO - Return code: 0 15:48:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:48:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:18 INFO - Reading from file tmpfile_stdout 15:48:18 INFO - Current package versions: 15:48:18 INFO - argparse == 1.2.1 15:48:18 INFO - blessings == 1.6 15:48:18 INFO - blobuploader == 1.2.4 15:48:18 INFO - docopt == 0.6.1 15:48:18 INFO - functools32 == 3.2.3-2 15:48:18 INFO - jsonschema == 2.5.1 15:48:18 INFO - manifestparser == 1.1 15:48:18 INFO - mozInstall == 1.13 15:48:18 INFO - mozcrash == 1.0 15:48:18 INFO - mozdebug == 0.1 15:48:18 INFO - mozdevice == 0.51 15:48:18 INFO - mozfile == 1.2 15:48:18 INFO - mozhttpd == 0.7 15:48:18 INFO - mozinfo == 0.10 15:48:18 INFO - mozleak == 0.1 15:48:18 INFO - mozlog == 3.5 15:48:18 INFO - moznetwork == 0.27 15:48:18 INFO - mozprocess == 0.25 15:48:18 INFO - mozprofile == 0.28 15:48:18 INFO - mozrunner == 6.13 15:48:18 INFO - mozscreenshot == 0.1 15:48:18 INFO - mozsystemmonitor == 0.3 15:48:18 INFO - moztest == 0.8 15:48:18 INFO - mozversion == 1.4 15:48:18 INFO - psutil == 3.1.1 15:48:18 INFO - requests == 1.2.3 15:48:18 INFO - wsgiref == 0.1.2 15:48:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:18 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/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 0x28781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be2d60>, '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 0x2be3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be3ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:18 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:48:18 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:18 INFO - Using env: {'DISPLAY': ':0', 15:48:18 INFO - 'HOME': '/home/cltbld', 15:48:18 INFO - 'LANG': 'en_US.UTF-8', 15:48:18 INFO - 'LANGUAGE': 'en_US:en', 15:48:18 INFO - 'LOGNAME': 'cltbld', 15:48:18 INFO - 'MAIL': '/var/mail/cltbld', 15:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:18 INFO - 'MOZ_NO_REMOTE': '1', 15:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:18 INFO - 'NO_EM_RESTART': '1', 15:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:18 INFO - 'PWD': '/builds/slave/test', 15:48:18 INFO - 'SHELL': '/bin/bash', 15:48:18 INFO - 'SHLVL': '1', 15:48:18 INFO - 'TERM': 'linux', 15:48:18 INFO - 'TMOUT': '86400', 15:48:18 INFO - 'USER': 'cltbld', 15:48:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 15:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:18 INFO - '_': '/tools/buildbot/bin/python'} 15:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:18 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)) 15:48:18 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)) 15:48:18 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)) 15:48:18 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)) 15:48:18 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)) 15:48:18 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)) 15:48:18 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)) 15:48:18 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)) 15:48:18 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)) 15:48:19 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:48:20 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)) 15:48:20 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)) 15:48:20 INFO - Installing collected packages: simplejson 15:48:20 INFO - Running setup.py install for simplejson 15:48:20 INFO - building 'simplejson._speedups' extension 15:48:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:48:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:48:21 INFO - Successfully installed simplejson 15:48:21 INFO - Cleaning up... 15:48:21 INFO - Return code: 0 15:48:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:21 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/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 0x28781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be2d60>, '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 0x2be3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be3ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:48:21 INFO - Using env: {'DISPLAY': ':0', 15:48:21 INFO - 'HOME': '/home/cltbld', 15:48:21 INFO - 'LANG': 'en_US.UTF-8', 15:48:21 INFO - 'LANGUAGE': 'en_US:en', 15:48:21 INFO - 'LOGNAME': 'cltbld', 15:48:21 INFO - 'MAIL': '/var/mail/cltbld', 15:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:21 INFO - 'MOZ_NO_REMOTE': '1', 15:48:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:21 INFO - 'NO_EM_RESTART': '1', 15:48:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:21 INFO - 'PWD': '/builds/slave/test', 15:48:21 INFO - 'SHELL': '/bin/bash', 15:48:21 INFO - 'SHLVL': '1', 15:48:21 INFO - 'TERM': 'linux', 15:48:21 INFO - 'TMOUT': '86400', 15:48:21 INFO - 'USER': 'cltbld', 15:48:21 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 15:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:21 INFO - '_': '/tools/buildbot/bin/python'} 15:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:48:21 INFO - Cleaning up... 15:48:21 INFO - Return code: 0 15:48:21 INFO - Running post-action listener: _resource_record_post_action 15:48:21 INFO - Running post-action listener: _start_resource_monitoring 15:48:21 INFO - Starting resource monitoring. 15:48:21 INFO - [mozharness: 2017-09-28 22:48:21.488442Z] Finished create-virtualenv step (success) 15:48:21 INFO - [mozharness: 2017-09-28 22:48:21.488963Z] Running install step. 15:48:21 INFO - Running pre-action listener: _resource_record_pre_action 15:48:21 INFO - Running main action method: install 15:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:21 INFO - Reading from file tmpfile_stdout 15:48:21 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:48:21 INFO - Reading from file tmpfile_stdout 15:48:21 INFO - Output received: 15:48:21 INFO - Usage: mozinstall [options] installer 15:48:21 INFO - Options: 15:48:21 INFO - -h, --help show this help message and exit 15:48:21 INFO - -d DEST, --destination=DEST 15:48:21 INFO - Directory to install application into. [default: 15:48:21 INFO - "/builds/slave/test"] 15:48:21 INFO - --app=APP Application being installed. [default: firefox] 15:48:21 INFO - mkdir: /builds/slave/test/build/application 15:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:48:39 INFO - Reading from file tmpfile_stdout 15:48:39 INFO - Output received: 15:48:39 INFO - /builds/slave/test/build/application/firefox/firefox 15:48:39 INFO - Running post-action listener: _resource_record_post_action 15:48:39 INFO - [mozharness: 2017-09-28 22:48:39.619994Z] Finished install step (success) 15:48:39 INFO - [mozharness: 2017-09-28 22:48:39.620243Z] Running setup-mitmproxy step. 15:48:39 INFO - Running pre-action listener: _resource_record_pre_action 15:48:39 INFO - Running main action method: setup_mitmproxy 15:48:39 INFO - Skipping: mitmproxy is not required 15:48:39 INFO - Running post-action listener: _resource_record_post_action 15:48:39 INFO - [mozharness: 2017-09-28 22:48:39.621365Z] Finished setup-mitmproxy step (success) 15:48:39 INFO - [mozharness: 2017-09-28 22:48:39.621602Z] Running run-tests step. 15:48:39 INFO - Running pre-action listener: _resource_record_pre_action 15:48:39 INFO - Running pre-action listener: _set_gcov_prefix 15:48:39 INFO - Running main action method: run_tests 15:48:39 WARNING - Try message not found. 15:48:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:48:39 INFO - Python 2.7.3 15:48:39 INFO - Return code: 0 15:48:39 INFO - grabbing minidump binary from tooltool 15:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 15:48:39 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/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 0x2be2d60>, '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 0x2be3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be3ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:48:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:48:39 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:48:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:48:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:48:39 INFO - Return code: 0 15:48:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:48:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:48:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:48:39 INFO - ENV: RUST_BACKTRACE is now full 15:48:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:48:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:48:39 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/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 15:48:39 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/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 15:48:39 INFO - Using env: {'DISPLAY': ':0', 15:48:39 INFO - 'HOME': '/home/cltbld', 15:48:39 INFO - 'LANG': 'en_US.UTF-8', 15:48:39 INFO - 'LANGUAGE': 'en_US:en', 15:48:39 INFO - 'LOGNAME': 'cltbld', 15:48:39 INFO - 'MAIL': '/var/mail/cltbld', 15:48:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:48:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:48:39 INFO - 'MOZ_ACCELERATED': '1', 15:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:39 INFO - 'MOZ_NO_REMOTE': '1', 15:48:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:48:39 INFO - 'MOZ_WEBRENDER': '1', 15:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:39 INFO - 'NO_EM_RESTART': '1', 15:48:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:39 INFO - 'PWD': '/builds/slave/test', 15:48:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:48:39 INFO - 'RUST_BACKTRACE': 'full', 15:48:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:48:39 INFO - 'SHELL': '/bin/bash', 15:48:39 INFO - 'SHLVL': '1', 15:48:39 INFO - 'TERM': 'linux', 15:48:39 INFO - 'TMOUT': '86400', 15:48:39 INFO - 'USER': 'cltbld', 15:48:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 15:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:39 INFO - '_': '/tools/buildbot/bin/python'} 15:48:39 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/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 15:48:39 INFO - mozversion application_buildid: 20170928215608 15:48:39 INFO - mozversion application_changeset: 307a7a34013060a6a1e87dfbb911f058d0781a2e 15:48:39 INFO - mozversion application_display_name: Nightly 15:48:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:48:39 INFO - mozversion application_name: Firefox 15:48:39 INFO - mozversion application_remotingname: firefox 15:48:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:48:39 INFO - mozversion application_vendor: Mozilla 15:48:39 INFO - mozversion application_version: 58.0a1 15:48:39 INFO - mozversion platform_buildid: 20170928215608 15:48:39 INFO - mozversion platform_changeset: 307a7a34013060a6a1e87dfbb911f058d0781a2e 15:48:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:48:39 INFO - mozversion platform_version: 58.0a1 15:48:39 INFO - using testdate: 1506638919 15:48:39 INFO - actual date: 1506638919 15:48:39 INFO - starting webserver on 'localhost:39057' 15:48:39 INFO - SUITE-START | Running 2 tests 15:48:39 INFO - TEST-START | dromaeo_css 15:48:39 INFO - Initialising browser for dromaeo_css test... 15:48:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39057/getInfo.html -profile /tmp/tmp0ofB3G/profile 15:48:39 INFO - TEST-INFO | started process 11868 (/builds/slave/test/build/application/firefox/firefox http://localhost:39057/getInfo.html) 15:48:46 INFO - TEST-INFO | 11868: exit 0 15:48:46 INFO - Browser initialized. 15:48:46 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:46 INFO - Using env: {'DISPLAY': ':0', 15:48:46 INFO - 'HOME': '/home/cltbld', 15:48:46 INFO - 'JSGC_DISABLE_POISONING': '1', 15:48:46 INFO - 'LANG': 'en_US.UTF-8', 15:48:46 INFO - 'LANGUAGE': 'en_US:en', 15:48:46 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:48:46 INFO - 'LOGNAME': 'cltbld', 15:48:46 INFO - 'MAIL': '/var/mail/cltbld', 15:48:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:48:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:48:46 INFO - 'MOZ_ACCELERATED': '1', 15:48:46 INFO - 'MOZ_CRASHREPORTER': '1', 15:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:46 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:48:46 INFO - 'MOZ_NO_REMOTE': '1', 15:48:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:48:46 INFO - 'MOZ_WEBRENDER': '1', 15:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:46 INFO - 'NO_EM_RESTART': '1', 15:48:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:46 INFO - 'PWD': '/builds/slave/test', 15:48:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:48:46 INFO - 'RUST_BACKTRACE': 'full', 15:48:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:48:46 INFO - 'SHELL': '/bin/bash', 15:48:46 INFO - 'SHLVL': '1', 15:48:46 INFO - 'TERM': 'linux', 15:48:46 INFO - 'TMOUT': '86400', 15:48:46 INFO - 'USER': 'cltbld', 15:48:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 15:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:46 INFO - '_': '/tools/buildbot/bin/python'} 15:48:46 INFO - TEST-INFO | started process 12111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0ofB3G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:47 INFO - PID 12111 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:48:47 INFO - PID 12111 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:48:47 INFO - PID 12111 | 15:48:47 INFO - PID 12111 | (/builds/slave/test/build/application/firefox/firefox:12169): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:48:47 INFO - PID 12111 | 15:48:58 INFO - PID 12111 | RSS: Main: 195743744 15:48:58 INFO - PID 12111 | 15:51:54 INFO - PID 12111 | Cycle 1(1): loaded http://localhost:39057/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39057/tests/dromaeo/cssquery-ext.html) 15:51:55 INFO - PID 12111 | RSS: Main: 194031616 15:51:55 INFO - PID 12111 | 15:54:58 INFO - PID 12111 | Cycle 1(1): loaded http://localhost:39057/tests/dromaeo/cssquery-ext.html (next: http://localhost:39057/tests/dromaeo/cssquery-jquery.html) 15:54:58 INFO - PID 12111 | RSS: Main: 192741376 15:54:58 INFO - PID 12111 | 15:58:00 INFO - PID 12111 | Cycle 1(1): loaded http://localhost:39057/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39057/tests/dromaeo/cssquery-mootools.html) 15:58:01 INFO - PID 12111 | RSS: Main: 194977792 15:58:01 INFO - PID 12111 | 16:01:03 INFO - PID 12111 | Cycle 1(1): loaded http://localhost:39057/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39057/tests/dromaeo/cssquery-prototype.html) 16:01:04 INFO - PID 12111 | RSS: Main: 194404352 16:01:04 INFO - PID 12111 | 16:04:07 INFO - PID 12111 | Cycle 1(1): loaded http://localhost:39057/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39057/tests/dromaeo/cssquery-yui.html) 16:04:08 INFO - PID 12111 | RSS: Main: 196923392 16:04:08 INFO - PID 12111 | 16:07:10 INFO - PID 12111 | Cycle 1(1): loaded http://localhost:39057/tests/dromaeo/cssquery-yui.html (next: http://localhost:39057/tests/dromaeo/cssquery-dojo.html) 16:07:10 INFO - PID 12111 | RSS: Main: 198737920 16:07:10 INFO - PID 12111 | 16:07:10 INFO - PID 12111 | __start_tp_report 16:07:10 INFO - PID 12111 | _x_x_mozilla_page_load 16:07:10 INFO - PID 12111 | _x_x_mozilla_page_load_details 16:07:10 INFO - PID 12111 | |i|pagename|runs| 16:07:10 INFO - PID 12111 | |0;dojo.html;3174.349258402025;3207.03788863341;3218.4528630132877;3241.5623890774755;3251.349730053989;6053.545984051203;6171.537134714898;6197.256329240487;6204.069389591564;6234.688265586719;6132.110843927628;6147.938520614804;6176.444120029197;6217.37826217378;6264.436200741932;5724.656520608777;5750.166225897253;5819.738111784959;5827.533797296227;5828.737706803183;84.03279505041266;5786.334571524266;5788.18965344852;5867.354590994987;5869.148973398855;5292.179712144623;5622.91565626516;5657.886842263152;5772.740226689809;5810.767569297223;5680.375158732536;5715.142728590703;5774.133879918004;5797.536197104264;5806.88386232273;5590.972045139748;5624.718764061821;5676.148577713335;5754.338251101135;5764.135379693038;6087.452129308339;6182.474489668383;6225.28409232935;6300.369963003709;6301.87396252077;6578.769743059018;6591.571547849375;6621.172353455818;6668.399844014013;6699.899501507482;6432.163818703539;6608.768693095719;6629.635370054645;6680.7327706891665;6682.899756503656;6030.879382412371;6106.969465152646;6130.785422510191;6141.78503752371;6148.047052706837;6779.118714567124;6889.138857642794;6909.309069093151;6912.585244885323;6927.965360173268;6490.8052758417325;6493.285738568754;6544.9672751635935;6568.244651865001;6575.243846957565;6599.835004124935;6626;6731.360520750521;6731.629760363129;6777.356151165632;6468.288488266287;6559.508036897252;6607.900881486781;6609.966950165219;6621.172353455818;6556.934430655728;6593.142891424084;6600.933990660128;6614.107095542136;6642.568233064835;5274.103402421598;5294.232336311214;5296.841094767163;5322.228276899906;5324.121519949243;4565.474970378383;4652.604528615106;4679.906401871944;4680.555347242007;4688.484266730725;5654;5702.230198923092;5717.914231286534;5807.622504537191;5818.6217895836635;6395.936040639534;6570.638614876132;6585.407313341822;6618.7352505899225;6640.468762498988;5674.2623458950075;5701.40135285789;5715.028445164332;5784.479396854304;5836.9124463133085;5770.88458230833;5793.15999180125;5797.565182611321;5803;5811.070228763378;6402.647854368054;6456.289808121103;6507.739690412425;6516.087747715229;6588.077669126326;6475.4819614430735;6534.37923397286;6554.2462616797775;6556.934430655632;6578.868422631616;6415.582987105823;6431.871362572816;6446.4520515756685;6488.837779055561;6502.382273683992;6388.872222555616;6472.320406357265;6509.446697030806;6516.543841931019;6663.333666633298;6683.966580167263;6702.966485167543;6794.456443484411;6799.558028728117;6803.897941530782;6486;6514.446272066927;6567.9014814778775;6577.506686998398;6599.967000164968;6317;6395.136656551306;6441.806745797634;6592.70332835014;6597.5381723280825;6379.234491861006;6409.198850143732;6445.742170313135;6505.41451269388;6510.837229069311;6456.54804163704;6465.288818229897;6468.191476065492;6573;6581.177352830896;6249.34381889895;6324.956382196886;6355.650439225887;6402.199725034371;6429.099926010455 16:07:10 INFO - PID 12111 | |1;ext.html;866.9523176225308;874.4403581707704;874.5146443723735;882.9205371516571;894.3337213775736;36964.815175924115;40497;40839.79580102103;40928.59071409285;40930;37470.43794343087;38294.808525957334;38329.23341533168;38362.99999999993;38523.614763852354;7038.5424947378515;7122.715091396338;7237.71049158033;7243.7102515899305;7245.6377181141;7729.033870766154;7833.647485863121;7952.8409431811615;7958.880616790752;7964;7851.646675899569;7882.80292992674;7909.367250619936;7925.9603701981405;7964.482308649919;7806.4925779824125;7888.60556972152;7910.4067194960035;7915.891775151484;7931.365490760725;7810.531368117931;7825.843483130306;7838.137804841463;7850.136484986647;7863.68545258189;37329;37389.81305093484;37432.81283593565;37458.62541374606;37631.4355284671;3491.877784277538;3524.6122926478324;3542.822858857047;3546.9113272168142;3556.6621170988974;31903.361932761214;32099;32107.357852843044;32207.71169153231;32221.516677249627;4984.3021976923255;5120.667156634807;5130.9230361544605;5160.948390516084;5289.047971365153;188612;189350;190428;190604;192473;48701;48782.75608621934;48852;49172.78722457498;49610;44865;45416.54583454123;45470.31794523085;45610.54389456063;52536.211956820676;14581.562553123424;14790.260486975609;14798.408063677547;14807;14821.92589037048;11755.588554400554;11756.294622322517;11809.763804723858;11810.291382516905;11812.35032073227;14471.348789304506;14473.92763036178;14545.636359090895;14577.781333280009;14627.26863656813;5815.88368232633;5833.82498525045;5868.647881127146;5886.205362276123;5946.940530594638;980.9215262778961;985.6747273399761;1001.3191030099603;1001.9048190421898;1005.8390657494766;24922.750772492407;27740.583891241648;28626.284342891595;29124.563131553045;29272.414551708847;1041.6510468992972;1058.8517607534952;1062.2617280989793;1071.2822408985999;1072.6728347853823;12015;12055.457504412323;12132.5146994121;12254.816177757162;12332.383380830923;244505;246482;246956;247300;247589;51237.48762512402;51291.743541282056;51335.7433212839;51450.228246576335;51612.22581661278;1319.9076064675573;1368.4936573467683;1368.5415385845854;1395.8115654386731;1403.2422491854488;21922;22342;22448.551028979655;22637.88681056584;22762.886185568965;37085.814570926974;37230;37306;37348.6265137356;37366.252674946896;211553;212220;212337;212587;212735;29137;29468.852655736584;31697.524537132424;33011.504827427125;33210.66789332076;40667;41121.58878411177;41799.37300940549;42404.1519169621;42568.57431425646;30038.549421758253;30249.243768905955;30378.69621303847;30633.846830765702;31037.8448107758;29757.702422975493;30257.848710756305;30664.233394164432;30773.692263077082;30895;33893.152671183416;34252.48621270733;34698.47952280667;35221.29557408786;35240.471392928615;29445.852770736008;29878.850605747703;29991;30041.248968775955;30099.79600815943;22041.669374959067;22503.88748056249;22698.773012270325;22836.31491055271;22905.88547057254 16:07:10 INFO - PID 12111 | |2;jquery.html;577.8786454844483;591.7041479260371;596.627108057464;598.6288501129301;598.775459202799;21707.457313567167;22302.88848555757;22700.88649556754;22719.20482783103;22748.31755047351;22900.88549557254;23288.650670239917;23599.05603775847;24399.63400548993;24439.877800611015;6614.140161778962;6781.220159681626;6789.76235831746;6791.76228831991;6801.93198068018;6671.399574038335;6758.952362383839;6760.222574403932;6767.357101075415;6801.591904485722;6410.775622853201;6580.769673061443;6662.4336931360895;6665.700043498055;6678.532502724811;6690.565113267647;6696.59820410777;6753.898691519631;6756.662166891636;6762.560433571802;5931.377205393414;6163.599366041193;6211.47202487789;6242.250929888397;6255.749770009194;29564.408711825858;30013.399732005455;30041.69958300411;30065.398692026254;30122.54816177759;2076.107273872234;2097.968530472044;2109.9050542725613;2113.6618141097506;2115.206797450956;19669.31157409498;20361.796382036136;20626.48433789152;20678.793212067838;20691.379258622266;2424.7575242475787;2467.6668649732414;2497.9750202498108;2515.4717509323063;2516.471540976397;118989.40505297505;123875;146192;151294.9999999989;152875;19849.40451786449;20361;21016.36950891476;22378.664320035212;22408.887955560116;42602;42738.78630606827;42853;43028.13943721108;43442.78278608587;10873.113727917531;11029.61396351124;11093;11106.278091924;11112.333260004425;8851.69019084329;8909.376343655882;8952.14954579314;9002.86495702565;9048.954755226314;11177;11425.885741142649;11514.76970460586;11806.173567850168;12083.275003499819;3597.7661452005536;3625.7643253188457;3914.5693973662874;4068.877933661995;4249.490061192615;926.36081104038;953.0945601678433;960.3613596957945;966.0387914025589;974.5858010345574;19370.322038728576;19885.900570497346;20007.799922000595;20078.498037548885;20489.590208195754;993.2550587059706;1015.1016350529686;1019.2763138171832;1024.8411496218098;1025.7435641089728;10891.891081089088;10937.234393592373;11131.554737810397;11280.702719187399;11539.307641541534;440187;457566;465859;468160;475228;110060.89939100506;110286.44856775664;110437.44781276042;110627;112656.43671781589;1142.2461175624048;1192.8807119288176;1238.5756380162704;1241.2924632959307;1254.8494180698374;20683.689744654144;20846.583068338852;20910;21008.369748907557;21195.046222920315;55962.440375597354;58992.41007590041;59486;59613.40386596078;59979.70010149921;70890.64554677194;71324.64337678278;72314;72906.27093729207;73165.6341718288;14929.402823887358;15129.924350378178;15233;15332.310046048178;15357.539273821356;23579.882100589388;23595.882020589786;23615.29154125379;23719.1698290559;23979.880100599385;18347.724784128517;18366.724499132255;18366.81633183651;18530.907345463187;18776.155073021473;16764.413245536347;16821;17106.65786684284;17270.82729172692;17392.304307827544;19107;19146.329878454188;19312.4206273812;19347.90326048417;19392.030398480303;14784.926075369554;14899.925500372428;14977;15097.54707358781;15125.243737813285;18311.90844045771;18318.90840545789;18587.90706046461;18651.90674046621;18950.715739263647 16:07:10 INFO - PID 12111 | |3;mootools.html;1290.9160904541204;1352.9594112176626;1364.3723887011977;1390.3395886953692;1407.5003373802294;14623.488177913776;15311.69376612467;15367.92424530282;15373.461928832494;15403.999999999985;14704.191269480174;14799.704005919875;14807.55577332679;14888.925555372234;14914.627134321647;2722.060888993294;2737.5893615957666;2770.7090755470686;2780.7358300961378;2807.3964097718986;2718.347596576827;2748.2991837081618;2753.3804893898914;2771.778257739376;2774.4035032468014;2703.9053633122844;2716.891324347034;2731.0441345529102;2739.739724726148;2849.757770589492;2822.633057702506;2822.8729707163225;2828.632277803893;2831.6885142634396;2860.5137126688514;2688.1129227354927;2694.8922043118446;2717.565189569679;2735.411886444404;2735.726427357248;14673.972821902471;15064.096154230781;15498;15729.213539323102;15761.921190393974;7843.4117441191565;8205.343572514184;8211.34309255264;8212.301954333889;8228.971378577678;5328.49379308965;5502.257195278667;5561.582881283879;5601.6358936668985;5612.522935550483;1881.7835948865918;1924.9037548122678;1945.4941715154162;1971.152404466079;1974.7235387045826;27052.188434346805;27439.45121097587;27440.725592744016;27449;27922.581161282596;7056.964715176391;7174.282571742784;7282.563046217244;7409.036825212688;7414.258574142543;20572.177112915615;20574;20582;20584.794152058286;20654.17383304681;7994.880076798852;8135;8140.185981401931;8143.267105960492;8145.918540814516;6814.727410903607;7210.819729506699;7252.528585641917;7277.2358902315555;7341.853162936818;5542.584306177053;5684.34630017545;5688.744006519716;5696.914546281809;5704.1443783432815;1661.7756602858701;1683.0743091299737;1722.9827701723073;1731.2382551677222;1751.089433494601;861.3453775130946;883.1609970528024;892.1925657280171;911.6809116809063;920.9263258939269;7452.813679657944;7515.887261691079;7541.509801862861;7577.848443031108;7717.575533345607;696.4428457234193;735.7902997645753;740.6741033945046;743.3904198557132;746.2052913647057;4791.712497250176;5159.922601160985;5222.529972302511;5379.838604841861;5465.4261302563455;21149.144865443275;21288.148474061174;21819.23632672849;21830.672539911913;22383.664245036336;20479.180832766524;21809.67285490719;21821.454463638536;21928.122875084817;22028.33914982553;11214.719632009102;11289.37908415045;11498.310101393943;11579.942100289445;11739.354335511629;7874.56689882062;7878.960605196938;7891.605419729105;7919.84160316802;8002.479838810459;18265;18546.44360669182;18565.257389704802;18707.438776836716;19376.2249510018;19041.809581904003;19508.122134504265;19550.21799128019;19578;19585.02074896221;12340.753184936431;12398.938005309916;12463.563775267821;12464.688382790502;12491.562795302121;13647.522336718168;13841.653958650712;14000.789988150389;14019.719605608036;14073.859261407664;10982.670519884416;11178.608748693756;11198.21612487118;11483.85161483845;11796.587119450778;10112.191024718151;10384.532696028848;10421.218408619232;10653.307535010199;10719.249652524248;10125.392476451436;10203.285769996326;10258.333208341433;10297.12474439681;10317.27779055489;7273.927260727325;7469.477136600386;7483.550986940801;7508.324250817453;7572.977648017447;7171.964140179266;7323.963380183278;7397.26027397256;7451.962740186264;7470.4023678106705 16:07:10 INFO - PID 12111 | |4;prototype.html;504.0347734089219;534.9724543978322;544.2516539757836;544.9509544141026;548.292702413886;6197.84505387365;6201.813945581628;6221.595596286238;6249.593776404537;6261;6069.878602427949;6077.483413909812;6086.421789929961;6095.634261944287;6162.952298109321;5110.310108135401;5111.08000559899;5137.845864624049;5138.126518491866;5193.1171700810955;5097.260897169908;5141.742912854361;5177.456367081459;5189.714565698885;5192.71440070796;4732.1718699227495;4932.284818701286;4933.679310844784;4947.455779864212;5061.468545802693;4920.704757714549;4925.13810083234;4945.802167913279;4956.826511072113;4960.305557221992;4431.202383570956;4491.416115904912;4496.235639941186;4497.955020449786;4501.819927202908;5932.555058370639;6020.277566692025;6043.214382130295;6088.299845517778;6104.725287362079;5674.921764864663;5677.261955945701;5694.117411801178;5700.97382471155;5722.771089156428;6402.327755585643;6482.675866206718;6501.967490162566;6551.93448065518;6583.275839657634;4866.878328041792;4870.09903167915;4887.437944636376;4919.262110683426;4937.061958227961;6518.837029074263;6568.292244016542;6685.43173830225;6806.863862722717;6826.624535650537;4988.451270360258;4995.150824359795;5008.874778130576;5015.523525265094;5029.698218106925;5061.645684802103;5107;5111.693298402108;5111.897762044812;5121.4878512149235;5648.943510564842;5673.290838645169;5673.971630141823;5689.459501347365;5718.971405142947;6464.321246269168;6568.441682457044;6587.407133357925;6601.86796264072;6608.768693095719;1758.3318339031086;1761.3042848074938;1768.2308195934809;1776.1385727922207;1784.580623553464;1168.9298642081503;1225.7671042501895;1236.4436003798328;1241.6771639373646;1269.435101379877;5456.208849716769;5487.368952570426;5489.533389661844;5501.312335958005;5536.197251398525;6464.547481676237;6491.967540162269;6585.6707164641575;6587.110740050128;6639.838028345021;5409.702466364388;5434.157705555645;5464.207689884945;5498.5876059294915;5581.6371935824045;3353.7987720736833;3361.3613413451853;3454.946241396348;3463.8614455422003;3489.860405583799;6310.368963103653;6401.295857455676;6418.1656384669695;6431.941778630793;6482.1573195485225;6596.736130554724;6651.567648102858;6743.3593808589085;6764.966175169093;6852.657367131723;6293.622382657055;6343.936560634427;6351.71417286214;6364.904526432108;6463.709133089116;6422.293547709654;6514.6416947068365;6554.082428460115;6649.301823308483;6651.235107962646;6596.60420374779;6619.470442364695;6624.503162262946;6643.0035494676185;6668.799936001928;6419.261784894797;6431.646259455588;6434.388733070351;6507.577007494498;6545.545420467325;5449.754761035683;5482.17767334903;5495.340559132929;5529.668219906818;5535.4187810280955;6417.197850268716;6434.646094464662;6594.3071879747495;6689.665516724047;6695.096162018065;6168.907466388097;6276.215473065867;6303.873922521616;6317.526185536011;6379.585326953733;6295.18162638854;6359.5866268694235;6385.393387628354;6418;6440.066190402459;6236.656983865931;6289.905651415141;6305.572354643404;6311.400416960381;6364.504341479841;6379.840503987438;6397.360263973565;6409.807705768834;6474.708638111202;6510.283868774526;6258.368807082817;6278.309385967631;6298.748050077946;6316.494680425647;6337.683115844097 16:07:10 INFO - PID 12111 | |5;yui.html;889;894.3828758156872;923.6490133749174;924.3760461688358;924.9213816825571;18939.242430302787;19770.703439448418;19856.503587410323;19861.304854330083;19930.60138797223;17868.39184473397;18306.267749290048;18501.7224741629;18515;18663;941.1764705882352;952.2049089010684;964.8070385922844;966.4442945306477;968.5060619084283;928.9721308360727;929.1776777551881;929.948852813095;933.383966582056;995.9651412200575;985.3841349156777;995.8705368302146;997.1075887081095;997.421495532593;1010.8028934357803;954.1269738189583;977.7115750853479;982.94102353859;984.0798853072364;984.625842179967;713.105053158283;741.936935360495;743.6356185469135;744.9702011919571;745.5191401545973;20569.69145462819;20638.690419643717;20753.169873205054;20786.37640870776;20871.269505567383;21238.787612123837;21497.67753483699;21945.451363715874;21957.231496897533;22153.778462215334;16342.264598093114;16558.83441165597;16661.91669041659;16679.08265045422;16706.164691765363;3603.0451930238246;3623.275344930998;3650.908727281813;3656.049427148934;3662.1393972416463;137308.31345843305;138372;141843.2907835454;142589;146566.99999999892;16012.759808602881;16317.347306107622;16542.503724888273;16562.58593535171;16850.241739121768;30450.84774576113;31036.689633103833;31503.212419689233;31505.527417088302;31733.04800855978;8652.480851148952;8704.60829262672;8717.520536370434;8724.083971183061;8745.081766414562;4111.239420707178;4132.524759652679;4192.035831758712;4226.302660061056;4240.321548552217;5350.143976963667;5469.945300547023;5514.200440936122;5527.143292789624;5527.226188333637;962.6438217859297;981.4847205217318;985.3201291109111;992.176493510399;997.0876647867266;673.706937482187;676.1142902797351;685.2256949646967;694.3265032918061;705.4744215559339;11167.441627918572;11326.603568875049;11718.531258749554;12193.634190974284;12199.939000304941;635.1076737184263;637.209859773877;658.687123616288;661.5633681770105;662.7945336945562;5590.273264475592;5606.579506537026;5697.515711164515;5702.6293290935955;5800.53595712342;122699;122743;127247.36376318059;127375.36312318564;129245;112202.43898780453;112542;114778;114848.42575787235;116549.41725291319;92401;96473.51763241139;97745.51127244461;97933;99957.50021249993;10340.172786177238;10381.688549343531;10413.84379234297;10544.736381590521;10670.146388288764;44188.337174943044;45167.54832451765;45670.771646141555;46892.53107469018;47527.52472475231;59227.111593327;60325.39674603198;61279.693601531704;61557.384426156954;61559.38440615537;15461.922690386476;15475.226238688245;15524.767128492857;15651.29569169413;15654.765178522104;17206.225719842387;17273.222704978558;17303.3943811966;17321.480355589352;17555.122243887497;14841.480548180762;14850.108993460426;14977.625559360667;14989.175595342362;15203.163825989677;14364.138151710931;14391.784123238369;14640.633984150481;14729.852701472848;14755.55733328002;13923.234222117475;14139.575812725223;14185.077969931921;14275.500357487437;14540.781888271897;11632.825507617561;11804.586839460577;11914.582989595669;12028.037756979245;12043.09676774228;11547.769044618892;11565.016973557005;11716.472758726048;11757.764844702888;11946.581869634521 16:07:10 INFO - PID 12111 | __end_tp_report 16:07:10 INFO - PID 12111 | __start_cc_report 16:07:10 INFO - PID 12111 | _x_x_mozilla_cycle_collect,262 16:07:10 INFO - PID 12111 | __end_cc_report 16:07:10 INFO - PID 12111 | __startTimestamp1506640030597__endTimestamp 16:07:10 INFO - PID 12111 | 16:07:10 INFO - PID 12111 | ------- Summary: start ------- 16:07:10 INFO - PID 12111 | Number of tests: 6 16:07:10 INFO - PID 12111 | 16:07:10 INFO - PID 12111 | [#0] dojo.html Cycles:165 Average:6086.52 Median:6402.20 stddev:848.29 (13.2%) stddev-sans-first:819.55 16:07:10 INFO - PID 12111 | Values: 3174.3 3207.0 3218.5 3241.6 3251.3 6053.5 6171.5 6197.3 6204.1 6234.7 6132.1 6147.9 6176.4 6217.4 6264.4 5724.7 5750.2 5819.7 5827.5 5828.7 84.0 5786.3 5788.2 5867.4 5869.1 5292.2 5622.9 5657.9 5772.7 5810.8 5680.4 5715.1 5774.1 5797.5 5806.9 5591.0 5624.7 5676.1 5754.3 5764.1 6087.5 6182.5 6225.3 6300.4 6301.9 6578.8 6591.6 6621.2 6668.4 6699.9 6432.2 6608.8 6629.6 6680.7 6682.9 6030.9 6107.0 6130.8 6141.8 6148.0 6779.1 6889.1 6909.3 6912.6 6928.0 6490.8 6493.3 6545.0 6568.2 6575.2 6599.8 6626.0 6731.4 6731.6 6777.4 6468.3 6559.5 6607.9 6610.0 6621.2 6556.9 6593.1 6600.9 6614.1 6642.6 5274.1 5294.2 5296.8 5322.2 5324.1 4565.5 4652.6 4679.9 4680.6 4688.5 5654.0 5702.2 5717.9 5807.6 5818.6 6395.9 6570.6 6585.4 6618.7 6640.5 5674.3 5701.4 5715.0 5784.5 5836.9 5770.9 5793.2 5797.6 5803.0 5811.1 6402.6 6456.3 6507.7 6516.1 6588.1 6475.5 6534.4 6554.2 6556.9 6578.9 6415.6 6431.9 6446.5 6488.8 6502.4 6388.9 6472.3 6509.4 6516.5 6663.3 6684.0 6703.0 6794.5 6799.6 6803.9 6486.0 6514.4 6567.9 6577.5 6600.0 6317.0 6395.1 6441.8 6592.7 6597.5 6379.2 6409.2 6445.7 6505.4 6510.8 6456.5 6465.3 6468.2 6573.0 6581.2 6249.3 6325.0 6355.7 6402.2 6429.1 16:07:10 INFO - PID 12111 | 16:07:10 INFO - PID 12111 | [#1] ext.html Cycles:180 Average:37879.00 Median:19095.18 stddev:56458.54 (295.7%) stddev-sans-first:56548.52 16:07:10 INFO - PID 12111 | Values: 867.0 874.4 874.5 882.9 894.3 36964.8 40497.0 40839.8 40928.6 40930.0 37470.4 38294.8 38329.2 38363.0 38523.6 7038.5 7122.7 7237.7 7243.7 7245.6 7729.0 7833.6 7952.8 7958.9 7964.0 7851.6 7882.8 7909.4 7926.0 7964.5 7806.5 7888.6 7910.4 7915.9 7931.4 7810.5 7825.8 7838.1 7850.1 7863.7 37329.0 37389.8 37432.8 37458.6 37631.4 3491.9 3524.6 3542.8 3546.9 3556.7 31903.4 32099.0 32107.4 32207.7 32221.5 4984.3 5120.7 5130.9 5160.9 5289.0 188612.0 189350.0 190428.0 190604.0 192473.0 48701.0 48782.8 48852.0 49172.8 49610.0 44865.0 45416.5 45470.3 45610.5 52536.2 14581.6 14790.3 14798.4 14807.0 14821.9 11755.6 11756.3 11809.8 11810.3 11812.4 14471.3 14473.9 14545.6 14577.8 14627.3 5815.9 5833.8 5868.6 5886.2 5946.9 980.9 985.7 1001.3 1001.9 1005.8 24922.8 27740.6 28626.3 29124.6 29272.4 1041.7 1058.9 1062.3 1071.3 1072.7 12015.0 12055.5 12132.5 12254.8 12332.4 244505.0 246482.0 246956.0 247300.0 247589.0 51237.5 51291.7 51335.7 51450.2 51612.2 1319.9 1368.5 1368.5 1395.8 1403.2 21922.0 22342.0 22448.6 22637.9 22762.9 37085.8 37230.0 37306.0 37348.6 37366.3 211553.0 212220.0 212337.0 212587.0 212735.0 29137.0 29468.9 31697.5 33011.5 33210.7 40667.0 41121.6 41799.4 42404.2 42568.6 30038.5 30249.2 30378.7 30633.8 31037.8 29757.7 30257.8 30664.2 30773.7 30895.0 33893.2 34252.5 34698.5 35221.3 35240.5 29445.9 29878.9 29991.0 30041.2 30099.8 22041.7 22503.9 22698.8 22836.3 22905.9 16:07:10 INFO - PID 12111 | 16:07:10 INFO - PID 12111 | [#2] jquery.html Cycles:180 Average:34961.15 Median:22554.89 stddev:78032.51 (346.0%) stddev-sans-first:78208.71 16:07:10 INFO - PID 12111 | Values: 577.9 591.7 596.6 598.6 598.8 21707.5 22302.9 22700.9 22719.2 22748.3 22900.9 23288.7 23599.1 24399.6 24439.9 6614.1 6781.2 6789.8 6791.8 6801.9 6671.4 6759.0 6760.2 6767.4 6801.6 6410.8 6580.8 6662.4 6665.7 6678.5 6690.6 6696.6 6753.9 6756.7 6762.6 5931.4 6163.6 6211.5 6242.3 6255.7 29564.4 30013.4 30041.7 30065.4 30122.5 2076.1 2098.0 2109.9 2113.7 2115.2 19669.3 20361.8 20626.5 20678.8 20691.4 2424.8 2467.7 2498.0 2515.5 2516.5 118989.4 123875.0 146192.0 151295.0 152875.0 19849.4 20361.0 21016.4 22378.7 22408.9 42602.0 42738.8 42853.0 43028.1 43442.8 10873.1 11029.6 11093.0 11106.3 11112.3 8851.7 8909.4 8952.1 9002.9 9049.0 11177.0 11425.9 11514.8 11806.2 12083.3 3597.8 3625.8 3914.6 4068.9 4249.5 926.4 953.1 960.4 966.0 974.6 19370.3 19885.9 20007.8 20078.5 20489.6 993.3 1015.1 1019.3 1024.8 1025.7 10891.9 10937.2 11131.6 11280.7 11539.3 440187.0 457566.0 465859.0 468160.0 475228.0 110060.9 110286.4 110437.4 110627.0 112656.4 1142.2 1192.9 1238.6 1241.3 1254.8 20683.7 20846.6 20910.0 21008.4 21195.0 55962.4 58992.4 59486.0 59613.4 59979.7 70890.6 71324.6 72314.0 72906.3 73165.6 14929.4 15129.9 15233.0 15332.3 15357.5 23579.9 23595.9 23615.3 23719.2 23979.9 18347.7 18366.7 18366.8 18530.9 18776.2 16764.4 16821.0 17106.7 17270.8 17392.3 19107.0 19146.3 19312.4 19347.9 19392.0 14784.9 14899.9 14977.0 15097.5 15125.2 18311.9 18318.9 18587.9 18651.9 18950.7 16:07:10 INFO - PID 12111 | 16:07:10 INFO - PID 12111 | [#3] mootools.html Cycles:180 Average:9515.76 Median:2717.96 stddev:6887.25 (253.4%) stddev-sans-first:6878.85 16:07:10 INFO - PID 12111 | Values: 1290.9 1353.0 1364.4 1390.3 1407.5 14623.5 15311.7 15367.9 15373.5 15404.0 14704.2 14799.7 14807.6 14888.9 14914.6 2722.1 2737.6 2770.7 2780.7 2807.4 2718.3 2748.3 2753.4 2771.8 2774.4 2703.9 2716.9 2731.0 2739.7 2849.8 2822.6 2822.9 2828.6 2831.7 2860.5 2688.1 2694.9 2717.6 2735.4 2735.7 14674.0 15064.1 15498.0 15729.2 15761.9 7843.4 8205.3 8211.3 8212.3 8229.0 5328.5 5502.3 5561.6 5601.6 5612.5 1881.8 1924.9 1945.5 1971.2 1974.7 27052.2 27439.5 27440.7 27449.0 27922.6 7057.0 7174.3 7282.6 7409.0 7414.3 20572.2 20574.0 20582.0 20584.8 20654.2 7994.9 8135.0 8140.2 8143.3 8145.9 6814.7 7210.8 7252.5 7277.2 7341.9 5542.6 5684.3 5688.7 5696.9 5704.1 1661.8 1683.1 1723.0 1731.2 1751.1 861.3 883.2 892.2 911.7 920.9 7452.8 7515.9 7541.5 7577.8 7717.6 696.4 735.8 740.7 743.4 746.2 4791.7 5159.9 5222.5 5379.8 5465.4 21149.1 21288.1 21819.2 21830.7 22383.7 20479.2 21809.7 21821.5 21928.1 22028.3 11214.7 11289.4 11498.3 11579.9 11739.4 7874.6 7879.0 7891.6 7919.8 8002.5 18265.0 18546.4 18565.3 18707.4 19376.2 19041.8 19508.1 19550.2 19578.0 19585.0 12340.8 12398.9 12463.6 12464.7 12491.6 13647.5 13841.7 14000.8 14019.7 14073.9 10982.7 11178.6 11198.2 11483.9 11796.6 10112.2 10384.5 10421.2 10653.3 10719.2 10125.4 10203.3 10258.3 10297.1 10317.3 7273.9 7469.5 7483.6 7508.3 7573.0 7172.0 7324.0 7397.3 7452.0 7470.4 16:07:10 INFO - PID 12111 | 16:07:10 INFO - PID 12111 | [#4] prototype.html Cycles:180 Average:5459.52 Median:6087.36 stddev:1502.69 (24.7%) stddev-sans-first:1460.15 16:07:10 INFO - PID 12111 | Values: 504.0 535.0 544.3 545.0 548.3 6197.8 6201.8 6221.6 6249.6 6261.0 6069.9 6077.5 6086.4 6095.6 6163.0 5110.3 5111.1 5137.8 5138.1 5193.1 5097.3 5141.7 5177.5 5189.7 5192.7 4732.2 4932.3 4933.7 4947.5 5061.5 4920.7 4925.1 4945.8 4956.8 4960.3 4431.2 4491.4 4496.2 4498.0 4501.8 5932.6 6020.3 6043.2 6088.3 6104.7 5674.9 5677.3 5694.1 5701.0 5722.8 6402.3 6482.7 6502.0 6551.9 6583.3 4866.9 4870.1 4887.4 4919.3 4937.1 6518.8 6568.3 6685.4 6806.9 6826.6 4988.5 4995.2 5008.9 5015.5 5029.7 5061.6 5107.0 5111.7 5111.9 5121.5 5648.9 5673.3 5674.0 5689.5 5719.0 6464.3 6568.4 6587.4 6601.9 6608.8 1758.3 1761.3 1768.2 1776.1 1784.6 1168.9 1225.8 1236.4 1241.7 1269.4 5456.2 5487.4 5489.5 5501.3 5536.2 6464.5 6492.0 6585.7 6587.1 6639.8 5409.7 5434.2 5464.2 5498.6 5581.6 3353.8 3361.4 3454.9 3463.9 3489.9 6310.4 6401.3 6418.2 6431.9 6482.2 6596.7 6651.6 6743.4 6765.0 6852.7 6293.6 6343.9 6351.7 6364.9 6463.7 6422.3 6514.6 6554.1 6649.3 6651.2 6596.6 6619.5 6624.5 6643.0 6668.8 6419.3 6431.6 6434.4 6507.6 6545.5 5449.8 5482.2 5495.3 5529.7 5535.4 6417.2 6434.6 6594.3 6689.7 6695.1 6168.9 6276.2 6303.9 6317.5 6379.6 6295.2 6359.6 6385.4 6418.0 6440.1 6236.7 6289.9 6305.6 6311.4 6364.5 6379.8 6397.4 6409.8 6474.7 6510.3 6258.4 6278.3 6298.7 6316.5 6337.7 16:07:10 INFO - PID 12111 | 16:07:10 INFO - PID 12111 | [#5] yui.html Cycles:180 Average:24659.53 Median:26302.31 stddev:36316.77 (138.1%) stddev-sans-first:36374.79 16:07:10 INFO - PID 12111 | Values: 889.0 894.4 923.6 924.4 924.9 18939.2 19770.7 19856.5 19861.3 19930.6 17868.4 18306.3 18501.7 18515.0 18663.0 941.2 952.2 964.8 966.4 968.5 929.0 929.2 929.9 933.4 996.0 985.4 995.9 997.1 997.4 1010.8 954.1 977.7 982.9 984.1 984.6 713.1 741.9 743.6 745.0 745.5 20569.7 20638.7 20753.2 20786.4 20871.3 21238.8 21497.7 21945.5 21957.2 22153.8 16342.3 16558.8 16661.9 16679.1 16706.2 3603.0 3623.3 3650.9 3656.0 3662.1 137308.3 138372.0 141843.3 142589.0 146567.0 16012.8 16317.3 16542.5 16562.6 16850.2 30450.8 31036.7 31503.2 31505.5 31733.0 8652.5 8704.6 8717.5 8724.1 8745.1 4111.2 4132.5 4192.0 4226.3 4240.3 5350.1 5469.9 5514.2 5527.1 5527.2 962.6 981.5 985.3 992.2 997.1 673.7 676.1 685.2 694.3 705.5 11167.4 11326.6 11718.5 12193.6 12199.9 635.1 637.2 658.7 661.6 662.8 5590.3 5606.6 5697.5 5702.6 5800.5 122699.0 122743.0 127247.4 127375.4 129245.0 112202.4 112542.0 114778.0 114848.4 116549.4 92401.0 96473.5 97745.5 97933.0 99957.5 10340.2 10381.7 10413.8 10544.7 10670.1 44188.3 45167.5 45670.8 46892.5 47527.5 59227.1 60325.4 61279.7 61557.4 61559.4 15461.9 15475.2 15524.8 15651.3 15654.8 17206.2 17273.2 17303.4 17321.5 17555.1 14841.5 14850.1 14977.6 14989.2 15203.2 14364.1 14391.8 14640.6 14729.9 14755.6 13923.2 14139.6 14185.1 14275.5 14540.8 11632.8 11804.6 11914.6 12028.0 12043.1 11547.8 11565.0 11716.5 11757.8 11946.6 16:07:10 INFO - PID 12111 | -------- Summary: end -------- 16:07:10 INFO - PID 12111 | 16:07:11 INFO - TEST-INFO | 12111: exit 0 16:07:11 INFO - TEST-OK | dromaeo_css | took 1111327ms 16:07:11 INFO - TEST-START | kraken 16:07:11 INFO - Initialising browser for kraken test... 16:07:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39057/getInfo.html -profile /tmp/tmpXD335T/profile 16:07:11 INFO - TEST-INFO | started process 12488 (/builds/slave/test/build/application/firefox/firefox http://localhost:39057/getInfo.html) 16:07:16 INFO - TEST-INFO | 12488: exit 0 16:07:16 INFO - Browser initialized. 16:07:16 INFO - Running cycle 1/1 for kraken test... 16:07:16 INFO - Using env: {'DISPLAY': ':0', 16:07:16 INFO - 'HOME': '/home/cltbld', 16:07:16 INFO - 'JSGC_DISABLE_POISONING': '1', 16:07:16 INFO - 'LANG': 'en_US.UTF-8', 16:07:16 INFO - 'LANGUAGE': 'en_US:en', 16:07:16 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:07:16 INFO - 'LOGNAME': 'cltbld', 16:07:16 INFO - 'MAIL': '/var/mail/cltbld', 16:07:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:07:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:07:16 INFO - 'MOZ_ACCELERATED': '1', 16:07:16 INFO - 'MOZ_CRASHREPORTER': '1', 16:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:16 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:07:16 INFO - 'MOZ_NO_REMOTE': '1', 16:07:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:07:16 INFO - 'MOZ_WEBRENDER': '1', 16:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:16 INFO - 'NO_EM_RESTART': '1', 16:07:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:16 INFO - 'PWD': '/builds/slave/test', 16:07:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:07:16 INFO - 'RUST_BACKTRACE': 'full', 16:07:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:07:16 INFO - 'SHELL': '/bin/bash', 16:07:16 INFO - 'SHLVL': '1', 16:07:16 INFO - 'TERM': 'linux', 16:07:16 INFO - 'TMOUT': '86400', 16:07:16 INFO - 'USER': 'cltbld', 16:07:16 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056', 16:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:16 INFO - '_': '/tools/buildbot/bin/python'} 16:07:16 INFO - TEST-INFO | started process 12736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXD335T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:17 INFO - PID 12736 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:07:17 INFO - PID 12736 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:07:17 INFO - PID 12736 | 16:07:17 INFO - PID 12736 | (/builds/slave/test/build/application/firefox/firefox:12794): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:07:17 INFO - PID 12736 | 16:07:28 INFO - PID 12736 | RSS: Main: 199483392 16:07:28 INFO - PID 12736 | 16:07:30 INFO - PID 12736 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39057/tests/kraken/driver.html?testName=audio-beat-detection) 16:07:31 INFO - PID 12736 | RSS: Main: 197177344 16:07:31 INFO - PID 12736 | 16:07:34 INFO - PID 12736 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39057/tests/kraken/driver.html?testName=audio-dft) 16:07:35 INFO - PID 12736 | RSS: Main: 197509120 16:07:35 INFO - PID 12736 | 16:07:38 INFO - PID 12736 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39057/tests/kraken/driver.html?testName=audio-fft) 16:07:38 INFO - PID 12736 | RSS: Main: 193257472 16:07:38 INFO - PID 12736 | 16:07:41 INFO - PID 12736 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39057/tests/kraken/driver.html?testName=audio-oscillator) 16:07:41 INFO - PID 12736 | RSS: Main: 193462272 16:07:41 INFO - PID 12736 | 16:07:43 INFO - PID 12736 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39057/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:07:44 INFO - PID 12736 | RSS: Main: 193728512 16:07:44 INFO - PID 12736 | 16:07:47 INFO - PID 12736 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39057/tests/kraken/driver.html?testName=imaging-darkroom) 16:07:48 INFO - PID 12736 | RSS: Main: 196321280 16:07:48 INFO - PID 12736 | 16:07:52 INFO - PID 12736 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39057/tests/kraken/driver.html?testName=imaging-desaturate) 16:07:52 INFO - PID 12736 | RSS: Main: 195256320 16:07:52 INFO - PID 12736 | 16:07:55 INFO - PID 12736 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39057/tests/kraken/driver.html?testName=json-parse-financial) 16:07:56 INFO - PID 12736 | RSS: Main: 196538368 16:07:56 INFO - PID 12736 | 16:07:57 INFO - PID 12736 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39057/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:07:58 INFO - PID 12736 | RSS: Main: 196788224 16:07:58 INFO - PID 12736 | 16:08:00 INFO - PID 12736 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:08:00 INFO - PID 12736 | RSS: Main: 193556480 16:08:00 INFO - PID 12736 | 16:08:02 INFO - PID 12736 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:08:03 INFO - PID 12736 | RSS: Main: 193613824 16:08:03 INFO - PID 12736 | 16:08:06 INFO - PID 12736 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:08:06 INFO - PID 12736 | RSS: Main: 193982464 16:08:06 INFO - PID 12736 | 16:08:09 INFO - PID 12736 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:08:10 INFO - PID 12736 | RSS: Main: 194134016 16:08:10 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39057/tests/kraken/driver.html?testName=ai-astar) 16:08:12 INFO - PID 12736 | RSS: Main: 195059712 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | __start_tp_report 16:08:12 INFO - PID 12736 | _x_x_mozilla_page_load 16:08:12 INFO - PID 12736 | _x_x_mozilla_page_load_details 16:08:12 INFO - PID 12736 | |i|pagename|runs| 16:08:12 INFO - PID 12736 | |0;ai-astar;113;111;108;109;114;110;118;116;116;113 16:08:12 INFO - PID 12736 | |1;audio-beat-detection;119;123;133;123;115;128;120;146;117;118 16:08:12 INFO - PID 12736 | |2;audio-dft;171;163;165;174;163;173;183;166;164;168 16:08:12 INFO - PID 12736 | |3;audio-fft;79;82;80;74;77;74;82;74;77;78 16:08:12 INFO - PID 12736 | |4;audio-oscillator;84;79;82;78;79;84;84;91;85;79 16:08:12 INFO - PID 12736 | |5;imaging-gaussian-blur;110;114;112;114;114;111;115;113;121;115 16:08:12 INFO - PID 12736 | |6;imaging-darkroom;156;157;147;150;152;156;153;157;148;151 16:08:12 INFO - PID 12736 | |7;imaging-desaturate;93;103;96;93;95;94;95;94;94;93 16:08:12 INFO - PID 12736 | |8;json-parse-financial;61;52;52;52;54;52;51;58;50;51 16:08:12 INFO - PID 12736 | |9;json-stringify-tinderbox;37;42;38;45;37;42;44;55;37;37 16:08:12 INFO - PID 12736 | |10;stanford-crypto-aes;75;72;73;75;76;78;75;76;80;72 16:08:12 INFO - PID 12736 | |11;stanford-crypto-ccm;108;111;110;112;112;122;116;113;112;114 16:08:12 INFO - PID 12736 | |12;stanford-crypto-pbkdf2;160;169;165;161;177;167;169;165;164;167 16:08:12 INFO - PID 12736 | |13;stanford-crypto-sha256-iterative;64;76;63;71;73;66;65;70;67;65 16:08:12 INFO - PID 12736 | __end_tp_report 16:08:12 INFO - PID 12736 | __start_cc_report 16:08:12 INFO - PID 12736 | _x_x_mozilla_cycle_collect,746 16:08:12 INFO - PID 12736 | __end_cc_report 16:08:12 INFO - PID 12736 | __startTimestamp1506640092518__endTimestamp 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | ------- Summary: start ------- 16:08:12 INFO - PID 12736 | Number of tests: 14 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.50 stddev:3.29 (2.9%) stddev-sans-first:3.49 16:08:12 INFO - PID 12736 | Values: 113.0 111.0 108.0 109.0 114.0 110.0 118.0 116.0 116.0 113.0 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:123.00 stddev:9.37 (7.6%) stddev-sans-first:9.74 16:08:12 INFO - PID 12736 | Values: 119.0 123.0 133.0 123.0 115.0 128.0 120.0 146.0 117.0 118.0 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | [#2] audio-dft Cycles:10 Average:169.00 Median:169.50 stddev:6.36 (3.8%) stddev-sans-first:6.70 16:08:12 INFO - PID 12736 | Values: 171.0 163.0 165.0 174.0 163.0 173.0 183.0 166.0 164.0 168.0 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | [#3] audio-fft Cycles:10 Average:77.70 Median:78.50 stddev:3.09 (3.9%) stddev-sans-first:3.24 16:08:12 INFO - PID 12736 | Values: 79.0 82.0 80.0 74.0 77.0 74.0 82.0 74.0 77.0 78.0 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | [#4] audio-oscillator Cycles:10 Average:82.50 Median:84.00 stddev:3.98 (4.7%) stddev-sans-first:4.18 16:08:12 INFO - PID 12736 | Values: 84.0 79.0 82.0 78.0 79.0 84.0 84.0 91.0 85.0 79.0 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:3.00 (2.6%) stddev-sans-first:2.83 16:08:12 INFO - PID 12736 | Values: 110.0 114.0 112.0 114.0 114.0 111.0 115.0 113.0 121.0 115.0 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | [#6] imaging-darkroom Cycles:10 Average:152.70 Median:154.50 stddev:3.71 (2.4%) stddev-sans-first:3.74 16:08:12 INFO - PID 12736 | Values: 156.0 157.0 147.0 150.0 152.0 156.0 153.0 157.0 148.0 151.0 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.00 stddev:2.98 (3.2%) stddev-sans-first:3.07 16:08:12 INFO - PID 12736 | Values: 93.0 103.0 96.0 93.0 95.0 94.0 95.0 94.0 94.0 93.0 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:52.00 stddev:3.50 (6.7%) stddev-sans-first:2.35 16:08:12 INFO - PID 12736 | Values: 61.0 52.0 52.0 52.0 54.0 52.0 51.0 58.0 50.0 51.0 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | [#9] json-stringify-tinderbox Cycles:10 Average:41.40 Median:42.00 stddev:5.72 (13.6%) stddev-sans-first:5.84 16:08:12 INFO - PID 12736 | Values: 37.0 42.0 38.0 45.0 37.0 42.0 44.0 55.0 37.0 37.0 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.50 stddev:2.53 (3.4%) stddev-sans-first:2.68 16:08:12 INFO - PID 12736 | Values: 75.0 72.0 73.0 75.0 76.0 78.0 75.0 76.0 80.0 72.0 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | [#11] stanford-crypto-ccm Cycles:10 Average:113.00 Median:112.50 stddev:3.83 (3.4%) stddev-sans-first:3.61 16:08:12 INFO - PID 12736 | Values: 108.0 111.0 110.0 112.0 112.0 122.0 116.0 113.0 112.0 114.0 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:167.00 stddev:4.79 (2.9%) stddev-sans-first:4.48 16:08:12 INFO - PID 12736 | Values: 160.0 169.0 165.0 161.0 177.0 167.0 169.0 165.0 164.0 167.0 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:4.29 (6.3%) stddev-sans-first:4.30 16:08:12 INFO - PID 12736 | Values: 64.0 76.0 63.0 71.0 73.0 66.0 65.0 70.0 67.0 65.0 16:08:12 INFO - PID 12736 | -------- Summary: end -------- 16:08:12 INFO - PID 12736 | 16:08:12 INFO - PID 12736 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:08:13 INFO - TEST-INFO | 12736: exit 0 16:08:13 INFO - TEST-OK | kraken | took 62118ms 16:08:13 INFO - SUITE-END | took 1173s 16:08:13 INFO - Completed test suite (00:19:33) 16:08:13 INFO - javascript benchmark 16:08:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8538.676938825347, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3174.349258402025, 3207.03788863341, 3218.4528630132877, 3241.5623890774755, 3251.349730053989, 6053.545984051203, 6171.537134714898, 6197.256329240487, 6204.069389591564, 6234.688265586719, 6132.110843927628, 6147.938520614804, 6176.444120029197, 6217.37826217378, 6264.436200741932, 5724.656520608777, 5750.166225897253, 5819.738111784959, 5827.533797296227, 5828.737706803183, 84.03279505041266, 5786.334571524266, 5788.18965344852, 5867.354590994987, 5869.148973398855, 5292.179712144623, 5622.91565626516, 5657.886842263152, 5772.740226689809, 5810.767569297223, 5680.375158732536, 5715.142728590703, 5774.133879918004, 5797.536197104264, 5806.88386232273, 5590.972045139748, 5624.718764061821, 5676.148577713335, 5754.338251101135, 5764.135379693038, 6087.452129308339, 6182.474489668383, 6225.28409232935, 6300.369963003709, 6301.87396252077, 6578.769743059018, 6591.571547849375, 6621.172353455818, 6668.399844014013, 6699.899501507482, 6432.163818703539, 6608.768693095719, 6629.635370054645, 6680.7327706891665, 6682.899756503656, 6030.879382412371, 6106.969465152646, 6130.785422510191, 6141.78503752371, 6148.047052706837, 6779.118714567124, 6889.138857642794, 6909.309069093151, 6912.585244885323, 6927.965360173268, 6490.8052758417325, 6493.285738568754, 6544.9672751635935, 6568.244651865001, 6575.243846957565, 6599.835004124935, 6626.0, 6731.360520750521, 6731.629760363129, 6777.356151165632, 6468.288488266287, 6559.508036897252, 6607.900881486781, 6609.966950165219, 6621.172353455818, 6556.934430655728, 6593.142891424084, 6600.933990660128, 6614.107095542136, 6642.568233064835, 5274.103402421598, 5294.232336311214, 5296.841094767163, 5322.228276899906, 5324.121519949243, 4565.474970378383, 4652.604528615106, 4679.906401871944, 4680.555347242007, 4688.484266730725, 5654.0, 5702.230198923092, 5717.914231286534, 5807.622504537191, 5818.6217895836635, 6395.936040639534, 6570.638614876132, 6585.407313341822, 6618.7352505899225, 6640.468762498988, 5674.2623458950075, 5701.40135285789, 5715.028445164332, 5784.479396854304, 5836.9124463133085, 5770.88458230833, 5793.15999180125, 5797.565182611321, 5803.0, 5811.070228763378, 6402.647854368054, 6456.289808121103, 6507.739690412425, 6516.087747715229, 6588.077669126326, 6475.4819614430735, 6534.37923397286, 6554.2462616797775, 6556.934430655632, 6578.868422631616, 6415.582987105823, 6431.871362572816, 6446.4520515756685, 6488.837779055561, 6502.382273683992, 6388.872222555616, 6472.320406357265, 6509.446697030806, 6516.543841931019, 6663.333666633298, 6683.966580167263, 6702.966485167543, 6794.456443484411, 6799.558028728117, 6803.897941530782, 6486.0, 6514.446272066927, 6567.9014814778775, 6577.506686998398, 6599.967000164968, 6317.0, 6395.136656551306, 6441.806745797634, 6592.70332835014, 6597.5381723280825, 6379.234491861006, 6409.198850143732, 6445.742170313135, 6505.41451269388, 6510.837229069311, 6456.54804163704, 6465.288818229897, 6468.191476065492, 6573.0, 6581.177352830896, 6249.34381889895, 6324.956382196886, 6355.650439225887, 6402.199725034371, 6429.099926010455], "value": 6029.862552162368, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [866.9523176225308, 874.4403581707704, 874.5146443723735, 882.9205371516571, 894.3337213775736, 36964.815175924115, 40497.0, 40839.79580102103, 40928.59071409285, 40930.0, 37470.43794343087, 38294.808525957334, 38329.23341533168, 38362.99999999993, 38523.614763852354, 7038.5424947378515, 7122.715091396338, 7237.71049158033, 7243.7102515899305, 7245.6377181141, 7729.033870766154, 7833.647485863121, 7952.8409431811615, 7958.880616790752, 7964.0, 7851.646675899569, 7882.80292992674, 7909.367250619936, 7925.9603701981405, 7964.482308649919, 7806.4925779824125, 7888.60556972152, 7910.4067194960035, 7915.891775151484, 7931.365490760725, 7810.531368117931, 7825.843483130306, 7838.137804841463, 7850.136484986647, 7863.68545258189, 37329.0, 37389.81305093484, 37432.81283593565, 37458.62541374606, 37631.4355284671, 3491.877784277538, 3524.6122926478324, 3542.822858857047, 3546.9113272168142, 3556.6621170988974, 31903.361932761214, 32099.0, 32107.357852843044, 32207.71169153231, 32221.516677249627, 4984.3021976923255, 5120.667156634807, 5130.9230361544605, 5160.948390516084, 5289.047971365153, 188612.0, 189350.0, 190428.0, 190604.0, 192473.0, 48701.0, 48782.75608621934, 48852.0, 49172.78722457498, 49610.0, 44865.0, 45416.54583454123, 45470.31794523085, 45610.54389456063, 52536.211956820676, 14581.562553123424, 14790.260486975609, 14798.408063677547, 14807.0, 14821.92589037048, 11755.588554400554, 11756.294622322517, 11809.763804723858, 11810.291382516905, 11812.35032073227, 14471.348789304506, 14473.92763036178, 14545.636359090895, 14577.781333280009, 14627.26863656813, 5815.88368232633, 5833.82498525045, 5868.647881127146, 5886.205362276123, 5946.940530594638, 980.9215262778961, 985.6747273399761, 1001.3191030099603, 1001.9048190421898, 1005.8390657494766, 24922.750772492407, 27740.583891241648, 28626.284342891595, 29124.563131553045, 29272.414551708847, 1041.6510468992972, 1058.8517607534952, 1062.2617280989793, 1071.2822408985999, 1072.6728347853823, 12015.0, 12055.457504412323, 12132.5146994121, 12254.816177757162, 12332.383380830923, 244505.0, 246482.0, 246956.0, 247300.0, 247589.0, 51237.48762512402, 51291.743541282056, 51335.7433212839, 51450.228246576335, 51612.22581661278, 1319.9076064675573, 1368.4936573467683, 1368.5415385845854, 1395.8115654386731, 1403.2422491854488, 21922.0, 22342.0, 22448.551028979655, 22637.88681056584, 22762.886185568965, 37085.814570926974, 37230.0, 37306.0, 37348.6265137356, 37366.252674946896, 211553.0, 212220.0, 212337.0, 212587.0, 212735.0, 29137.0, 29468.852655736584, 31697.524537132424, 33011.504827427125, 33210.66789332076, 40667.0, 41121.58878411177, 41799.37300940549, 42404.1519169621, 42568.57431425646, 30038.549421758253, 30249.243768905955, 30378.69621303847, 30633.846830765702, 31037.8448107758, 29757.702422975493, 30257.848710756305, 30664.233394164432, 30773.692263077082, 30895.0, 33893.152671183416, 34252.48621270733, 34698.47952280667, 35221.29557408786, 35240.471392928615, 29445.852770736008, 29878.850605747703, 29991.0, 30041.248968775955, 30099.79600815943, 22041.669374959067, 22503.88748056249, 22698.773012270325, 22836.31491055271, 22905.88547057254], "value": 16916.572105507003, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8786454844483, 591.7041479260371, 596.627108057464, 598.6288501129301, 598.775459202799, 21707.457313567167, 22302.88848555757, 22700.88649556754, 22719.20482783103, 22748.31755047351, 22900.88549557254, 23288.650670239917, 23599.05603775847, 24399.63400548993, 24439.877800611015, 6614.140161778962, 6781.220159681626, 6789.76235831746, 6791.76228831991, 6801.93198068018, 6671.399574038335, 6758.952362383839, 6760.222574403932, 6767.357101075415, 6801.591904485722, 6410.775622853201, 6580.769673061443, 6662.4336931360895, 6665.700043498055, 6678.532502724811, 6690.565113267647, 6696.59820410777, 6753.898691519631, 6756.662166891636, 6762.560433571802, 5931.377205393414, 6163.599366041193, 6211.47202487789, 6242.250929888397, 6255.749770009194, 29564.408711825858, 30013.399732005455, 30041.69958300411, 30065.398692026254, 30122.54816177759, 2076.107273872234, 2097.968530472044, 2109.9050542725613, 2113.6618141097506, 2115.206797450956, 19669.31157409498, 20361.796382036136, 20626.48433789152, 20678.793212067838, 20691.379258622266, 2424.7575242475787, 2467.6668649732414, 2497.9750202498108, 2515.4717509323063, 2516.471540976397, 118989.40505297505, 123875.0, 146192.0, 151294.9999999989, 152875.0, 19849.40451786449, 20361.0, 21016.36950891476, 22378.664320035212, 22408.887955560116, 42602.0, 42738.78630606827, 42853.0, 43028.13943721108, 43442.78278608587, 10873.113727917531, 11029.61396351124, 11093.0, 11106.278091924, 11112.333260004425, 8851.69019084329, 8909.376343655882, 8952.14954579314, 9002.86495702565, 9048.954755226314, 11177.0, 11425.885741142649, 11514.76970460586, 11806.173567850168, 12083.275003499819, 3597.7661452005536, 3625.7643253188457, 3914.5693973662874, 4068.877933661995, 4249.490061192615, 926.36081104038, 953.0945601678433, 960.3613596957945, 966.0387914025589, 974.5858010345574, 19370.322038728576, 19885.900570497346, 20007.799922000595, 20078.498037548885, 20489.590208195754, 993.2550587059706, 1015.1016350529686, 1019.2763138171832, 1024.8411496218098, 1025.7435641089728, 10891.891081089088, 10937.234393592373, 11131.554737810397, 11280.702719187399, 11539.307641541534, 440187.0, 457566.0, 465859.0, 468160.0, 475228.0, 110060.89939100506, 110286.44856775664, 110437.44781276042, 110627.0, 112656.43671781589, 1142.2461175624048, 1192.8807119288176, 1238.5756380162704, 1241.2924632959307, 1254.8494180698374, 20683.689744654144, 20846.583068338852, 20910.0, 21008.369748907557, 21195.046222920315, 55962.440375597354, 58992.41007590041, 59486.0, 59613.40386596078, 59979.70010149921, 70890.64554677194, 71324.64337678278, 72314.0, 72906.27093729207, 73165.6341718288, 14929.402823887358, 15129.924350378178, 15233.0, 15332.310046048178, 15357.539273821356, 23579.882100589388, 23595.882020589786, 23615.29154125379, 23719.1698290559, 23979.880100599385, 18347.724784128517, 18366.724499132255, 18366.81633183651, 18530.907345463187, 18776.155073021473, 16764.413245536347, 16821.0, 17106.65786684284, 17270.82729172692, 17392.304307827544, 19107.0, 19146.329878454188, 19312.4206273812, 19347.90326048417, 19392.030398480303, 14784.926075369554, 14899.925500372428, 14977.0, 15097.54707358781, 15125.243737813285, 18311.90844045771, 18318.90840545789, 18587.90706046461, 18651.90674046621, 18950.715739263647], "value": 12680.43582038358, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.9160904541204, 1352.9594112176626, 1364.3723887011977, 1390.3395886953692, 1407.5003373802294, 14623.488177913776, 15311.69376612467, 15367.92424530282, 15373.461928832494, 15403.999999999985, 14704.191269480174, 14799.704005919875, 14807.55577332679, 14888.925555372234, 14914.627134321647, 2722.060888993294, 2737.5893615957666, 2770.7090755470686, 2780.7358300961378, 2807.3964097718986, 2718.347596576827, 2748.2991837081618, 2753.3804893898914, 2771.778257739376, 2774.4035032468014, 2703.9053633122844, 2716.891324347034, 2731.0441345529102, 2739.739724726148, 2849.757770589492, 2822.633057702506, 2822.8729707163225, 2828.632277803893, 2831.6885142634396, 2860.5137126688514, 2688.1129227354927, 2694.8922043118446, 2717.565189569679, 2735.411886444404, 2735.726427357248, 14673.972821902471, 15064.096154230781, 15498.0, 15729.213539323102, 15761.921190393974, 7843.4117441191565, 8205.343572514184, 8211.34309255264, 8212.301954333889, 8228.971378577678, 5328.49379308965, 5502.257195278667, 5561.582881283879, 5601.6358936668985, 5612.522935550483, 1881.7835948865918, 1924.9037548122678, 1945.4941715154162, 1971.152404466079, 1974.7235387045826, 27052.188434346805, 27439.45121097587, 27440.725592744016, 27449.0, 27922.581161282596, 7056.964715176391, 7174.282571742784, 7282.563046217244, 7409.036825212688, 7414.258574142543, 20572.177112915615, 20574.0, 20582.0, 20584.794152058286, 20654.17383304681, 7994.880076798852, 8135.0, 8140.185981401931, 8143.267105960492, 8145.918540814516, 6814.727410903607, 7210.819729506699, 7252.528585641917, 7277.2358902315555, 7341.853162936818, 5542.584306177053, 5684.34630017545, 5688.744006519716, 5696.914546281809, 5704.1443783432815, 1661.7756602858701, 1683.0743091299737, 1722.9827701723073, 1731.2382551677222, 1751.089433494601, 861.3453775130946, 883.1609970528024, 892.1925657280171, 911.6809116809063, 920.9263258939269, 7452.813679657944, 7515.887261691079, 7541.509801862861, 7577.848443031108, 7717.575533345607, 696.4428457234193, 735.7902997645753, 740.6741033945046, 743.3904198557132, 746.2052913647057, 4791.712497250176, 5159.922601160985, 5222.529972302511, 5379.838604841861, 5465.4261302563455, 21149.144865443275, 21288.148474061174, 21819.23632672849, 21830.672539911913, 22383.664245036336, 20479.180832766524, 21809.67285490719, 21821.454463638536, 21928.122875084817, 22028.33914982553, 11214.719632009102, 11289.37908415045, 11498.310101393943, 11579.942100289445, 11739.354335511629, 7874.56689882062, 7878.960605196938, 7891.605419729105, 7919.84160316802, 8002.479838810459, 18265.0, 18546.44360669182, 18565.257389704802, 18707.438776836716, 19376.2249510018, 19041.809581904003, 19508.122134504265, 19550.21799128019, 19578.0, 19585.02074896221, 12340.753184936431, 12398.938005309916, 12463.563775267821, 12464.688382790502, 12491.562795302121, 13647.522336718168, 13841.653958650712, 14000.789988150389, 14019.719605608036, 14073.859261407664, 10982.670519884416, 11178.608748693756, 11198.21612487118, 11483.85161483845, 11796.587119450778, 10112.191024718151, 10384.532696028848, 10421.218408619232, 10653.307535010199, 10719.249652524248, 10125.392476451436, 10203.285769996326, 10258.333208341433, 10297.12474439681, 10317.27779055489, 7273.927260727325, 7469.477136600386, 7483.550986940801, 7508.324250817453, 7572.977648017447, 7171.964140179266, 7323.963380183278, 7397.26027397256, 7451.962740186264, 7470.4023678106705], "value": 6747.338664999702, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.0347734089219, 534.9724543978322, 544.2516539757836, 544.9509544141026, 548.292702413886, 6197.84505387365, 6201.813945581628, 6221.595596286238, 6249.593776404537, 6261.0, 6069.878602427949, 6077.483413909812, 6086.421789929961, 6095.634261944287, 6162.952298109321, 5110.310108135401, 5111.08000559899, 5137.845864624049, 5138.126518491866, 5193.1171700810955, 5097.260897169908, 5141.742912854361, 5177.456367081459, 5189.714565698885, 5192.71440070796, 4732.1718699227495, 4932.284818701286, 4933.679310844784, 4947.455779864212, 5061.468545802693, 4920.704757714549, 4925.13810083234, 4945.802167913279, 4956.826511072113, 4960.305557221992, 4431.202383570956, 4491.416115904912, 4496.235639941186, 4497.955020449786, 4501.819927202908, 5932.555058370639, 6020.277566692025, 6043.214382130295, 6088.299845517778, 6104.725287362079, 5674.921764864663, 5677.261955945701, 5694.117411801178, 5700.97382471155, 5722.771089156428, 6402.327755585643, 6482.675866206718, 6501.967490162566, 6551.93448065518, 6583.275839657634, 4866.878328041792, 4870.09903167915, 4887.437944636376, 4919.262110683426, 4937.061958227961, 6518.837029074263, 6568.292244016542, 6685.43173830225, 6806.863862722717, 6826.624535650537, 4988.451270360258, 4995.150824359795, 5008.874778130576, 5015.523525265094, 5029.698218106925, 5061.645684802103, 5107.0, 5111.693298402108, 5111.897762044812, 5121.4878512149235, 5648.943510564842, 5673.290838645169, 5673.971630141823, 5689.459501347365, 5718.971405142947, 6464.321246269168, 6568.441682457044, 6587.407133357925, 6601.86796264072, 6608.768693095719, 1758.3318339031086, 1761.3042848074938, 1768.2308195934809, 1776.1385727922207, 1784.580623553464, 1168.9298642081503, 1225.7671042501895, 1236.4436003798328, 1241.6771639373646, 1269.435101379877, 5456.208849716769, 5487.368952570426, 5489.533389661844, 5501.312335958005, 5536.197251398525, 6464.547481676237, 6491.967540162269, 6585.6707164641575, 6587.110740050128, 6639.838028345021, 5409.702466364388, 5434.157705555645, 5464.207689884945, 5498.5876059294915, 5581.6371935824045, 3353.7987720736833, 3361.3613413451853, 3454.946241396348, 3463.8614455422003, 3489.860405583799, 6310.368963103653, 6401.295857455676, 6418.1656384669695, 6431.941778630793, 6482.1573195485225, 6596.736130554724, 6651.567648102858, 6743.3593808589085, 6764.966175169093, 6852.657367131723, 6293.622382657055, 6343.936560634427, 6351.71417286214, 6364.904526432108, 6463.709133089116, 6422.293547709654, 6514.6416947068365, 6554.082428460115, 6649.301823308483, 6651.235107962646, 6596.60420374779, 6619.470442364695, 6624.503162262946, 6643.0035494676185, 6668.799936001928, 6419.261784894797, 6431.646259455588, 6434.388733070351, 6507.577007494498, 6545.545420467325, 5449.754761035683, 5482.17767334903, 5495.340559132929, 5529.668219906818, 5535.4187810280955, 6417.197850268716, 6434.646094464662, 6594.3071879747495, 6689.665516724047, 6695.096162018065, 6168.907466388097, 6276.215473065867, 6303.873922521616, 6317.526185536011, 6379.585326953733, 6295.18162638854, 6359.5866268694235, 6385.393387628354, 6418.0, 6440.066190402459, 6236.656983865931, 6289.905651415141, 6305.572354643404, 6311.400416960381, 6364.504341479841, 6379.840503987438, 6397.360263973565, 6409.807705768834, 6474.708638111202, 6510.283868774526, 6258.368807082817, 6278.309385967631, 6298.748050077946, 6316.494680425647, 6337.683115844097], "value": 5023.2049035231175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.0, 894.3828758156872, 923.6490133749174, 924.3760461688358, 924.9213816825571, 18939.242430302787, 19770.703439448418, 19856.503587410323, 19861.304854330083, 19930.60138797223, 17868.39184473397, 18306.267749290048, 18501.7224741629, 18515.0, 18663.0, 941.1764705882352, 952.2049089010684, 964.8070385922844, 966.4442945306477, 968.5060619084283, 928.9721308360727, 929.1776777551881, 929.948852813095, 933.383966582056, 995.9651412200575, 985.3841349156777, 995.8705368302146, 997.1075887081095, 997.421495532593, 1010.8028934357803, 954.1269738189583, 977.7115750853479, 982.94102353859, 984.0798853072364, 984.625842179967, 713.105053158283, 741.936935360495, 743.6356185469135, 744.9702011919571, 745.5191401545973, 20569.69145462819, 20638.690419643717, 20753.169873205054, 20786.37640870776, 20871.269505567383, 21238.787612123837, 21497.67753483699, 21945.451363715874, 21957.231496897533, 22153.778462215334, 16342.264598093114, 16558.83441165597, 16661.91669041659, 16679.08265045422, 16706.164691765363, 3603.0451930238246, 3623.275344930998, 3650.908727281813, 3656.049427148934, 3662.1393972416463, 137308.31345843305, 138372.0, 141843.2907835454, 142589.0, 146566.99999999892, 16012.759808602881, 16317.347306107622, 16542.503724888273, 16562.58593535171, 16850.241739121768, 30450.84774576113, 31036.689633103833, 31503.212419689233, 31505.527417088302, 31733.04800855978, 8652.480851148952, 8704.60829262672, 8717.520536370434, 8724.083971183061, 8745.081766414562, 4111.239420707178, 4132.524759652679, 4192.035831758712, 4226.302660061056, 4240.321548552217, 5350.143976963667, 5469.945300547023, 5514.200440936122, 5527.143292789624, 5527.226188333637, 962.6438217859297, 981.4847205217318, 985.3201291109111, 992.176493510399, 997.0876647867266, 673.706937482187, 676.1142902797351, 685.2256949646967, 694.3265032918061, 705.4744215559339, 11167.441627918572, 11326.603568875049, 11718.531258749554, 12193.634190974284, 12199.939000304941, 635.1076737184263, 637.209859773877, 658.687123616288, 661.5633681770105, 662.7945336945562, 5590.273264475592, 5606.579506537026, 5697.515711164515, 5702.6293290935955, 5800.53595712342, 122699.0, 122743.0, 127247.36376318059, 127375.36312318564, 129245.0, 112202.43898780453, 112542.0, 114778.0, 114848.42575787235, 116549.41725291319, 92401.0, 96473.51763241139, 97745.51127244461, 97933.0, 99957.50021249993, 10340.172786177238, 10381.688549343531, 10413.84379234297, 10544.736381590521, 10670.146388288764, 44188.337174943044, 45167.54832451765, 45670.771646141555, 46892.53107469018, 47527.52472475231, 59227.111593327, 60325.39674603198, 61279.693601531704, 61557.384426156954, 61559.38440615537, 15461.922690386476, 15475.226238688245, 15524.767128492857, 15651.29569169413, 15654.765178522104, 17206.225719842387, 17273.222704978558, 17303.3943811966, 17321.480355589352, 17555.122243887497, 14841.480548180762, 14850.108993460426, 14977.625559360667, 14989.175595342362, 15203.163825989677, 14364.138151710931, 14391.784123238369, 14640.633984150481, 14729.852701472848, 14755.55733328002, 13923.234222117475, 14139.575812725223, 14185.077969931921, 14275.500357487437, 14540.781888271897, 11632.825507617561, 11804.586839460577, 11914.582989595669, 12028.037756979245, 12043.09676774228, 11547.769044618892, 11565.016973557005, 11716.472758726048, 11757.764844702888, 11946.581869634521], "value": 8839.941984960175, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1445.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 108.0, 109.0, 114.0, 110.0, 118.0, 116.0, 116.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 123.0, 133.0, 123.0, 115.0, 128.0, 120.0, 146.0, 117.0, 118.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 163.0, 165.0, 174.0, 163.0, 173.0, 183.0, 166.0, 164.0, 168.0], "value": 169.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 80.0, 74.0, 77.0, 74.0, 82.0, 74.0, 77.0, 78.0], "value": 77.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 82.0, 78.0, 79.0, 84.0, 84.0, 91.0, 85.0, 79.0], "value": 82.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 112.0, 114.0, 114.0, 111.0, 115.0, 113.0, 121.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 147.0, 150.0, 152.0, 156.0, 153.0, 157.0, 148.0, 151.0], "value": 152.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 103.0, 96.0, 93.0, 95.0, 94.0, 95.0, 94.0, 94.0, 93.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 52.0, 52.0, 52.0, 54.0, 52.0, 51.0, 58.0, 50.0, 51.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 42.0, 38.0, 45.0, 37.0, 42.0, 44.0, 55.0, 37.0, 37.0], "value": 41.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 73.0, 75.0, 76.0, 78.0, 75.0, 76.0, 80.0, 72.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 110.0, 112.0, 112.0, 122.0, 116.0, 113.0, 112.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 169.0, 165.0, 161.0, 177.0, 167.0, 169.0, 165.0, 164.0, 167.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 76.0, 63.0, 71.0, 73.0, 66.0, 65.0, 70.0, 67.0, 65.0], "value": 68.0, "unit": "score"}]}]} 16:08:13 INFO - Return code: 0 16:08:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:08:13 INFO - # TBPL SUCCESS # 16:08:13 INFO - Running post-action listener: _package_coverage_data 16:08:13 INFO - Running post-action listener: _resource_record_post_action 16:08:13 INFO - [mozharness: 2017-09-28 23:08:13.812815Z] Finished run-tests step (success) 16:08:13 INFO - Running post-run listener: _resource_record_post_run 16:08:13 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 3485696; Write bytes: 346333184; Read time: 1620; Write time: 236184 16:08:13 INFO - TinderboxPrint: CPU usage
13.2% 16:08:13 INFO - TinderboxPrint: I/O read bytes / time
3,485,696 / 1,620 16:08:13 INFO - TinderboxPrint: I/O write bytes / time
346,333,184 / 236,184 16:08:13 INFO - TinderboxPrint: CPU idle
8,240.9 (86.8%) 16:08:13 INFO - TinderboxPrint: CPU user
1,197.1 (12.6%) 16:08:13 INFO - TinderboxPrint: Swap in / out
0 / 0 16:08:13 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13090816; Read time: 0; Write time: 1112 16:08:13 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:08:13 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 3481600; Write bytes: 333242368; Read time: 1604; Write time: 235072 16:08:14 INFO - Running post-run listener: _upload_blobber_files 16:08:14 INFO - Blob upload gear active. 16:08:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:08:14 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 16:08:14 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'] 16:08:14 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 16:08:14 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:08:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:08:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:16 INFO - (blobuploader) - INFO - Done attempting. 16:08:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:08:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:08:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:19 INFO - (blobuploader) - INFO - Done attempting. 16:08:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:08:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:08:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:20 INFO - (blobuploader) - INFO - Done attempting. 16:08:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:08:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:08:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:21 INFO - (blobuploader) - INFO - Done attempting. 16:08:21 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:21 INFO - Return code: 0 16:08:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:08:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:21 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c72045085aab7e10799749e59e1a972720aafe37349a0301915f8cac29d2009d326bbea3d381ff4ad20bb5705e3a988b5580b522812d44f2b02446fb7a923105", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/729582941f7c3f9f54e3731117733d2cb887862fc69733476850421a502e95087317a96355fbc6b785b1d28a23505b78b2beab080349c3f2552c54acf7c58483", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/512848af98fc1a0b962e15b8b927174c7c9c60b095faec01e13407f633d7b33ea1e922b4b203b0b926c3cb07d88d4eb89907df468d58d2ff57d5a38edfdb2aa9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84d0e4bfca56e3cc93917c4e9dd904f6bd447fb14ea86a908fc4ee44c1b7a2283647c69ecdf91727228d1e091dd4cbedcc790f1290797efc2da2b7166d73df63"} 16:08:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:08:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:08:21 INFO - Contents: 16:08:21 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c72045085aab7e10799749e59e1a972720aafe37349a0301915f8cac29d2009d326bbea3d381ff4ad20bb5705e3a988b5580b522812d44f2b02446fb7a923105", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/729582941f7c3f9f54e3731117733d2cb887862fc69733476850421a502e95087317a96355fbc6b785b1d28a23505b78b2beab080349c3f2552c54acf7c58483", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/512848af98fc1a0b962e15b8b927174c7c9c60b095faec01e13407f633d7b33ea1e922b4b203b0b926c3cb07d88d4eb89907df468d58d2ff57d5a38edfdb2aa9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84d0e4bfca56e3cc93917c4e9dd904f6bd447fb14ea86a908fc4ee44c1b7a2283647c69ecdf91727228d1e091dd4cbedcc790f1290797efc2da2b7166d73df63"} 16:08:21 INFO - Running post-run listener: copy_logs_to_upload_dir 16:08:21 INFO - Copying logs to upload dir... 16:08:21 INFO - mkdir: /builds/slave/test/build/upload/logs 16:08:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.131695 ========= master_lag: 0.68 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-28 16:08:22.576332) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 16:08:22.580913) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c72045085aab7e10799749e59e1a972720aafe37349a0301915f8cac29d2009d326bbea3d381ff4ad20bb5705e3a988b5580b522812d44f2b02446fb7a923105", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/729582941f7c3f9f54e3731117733d2cb887862fc69733476850421a502e95087317a96355fbc6b785b1d28a23505b78b2beab080349c3f2552c54acf7c58483", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/512848af98fc1a0b962e15b8b927174c7c9c60b095faec01e13407f633d7b33ea1e922b4b203b0b926c3cb07d88d4eb89907df468d58d2ff57d5a38edfdb2aa9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84d0e4bfca56e3cc93917c4e9dd904f6bd447fb14ea86a908fc4ee44c1b7a2283647c69ecdf91727228d1e091dd4cbedcc790f1290797efc2da2b7166d73df63"} build_url:https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.010434 build_url: 'https://queue.taskcluster.net/v1/task/CK_o3hL6TtqucDlJLtKu5Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c72045085aab7e10799749e59e1a972720aafe37349a0301915f8cac29d2009d326bbea3d381ff4ad20bb5705e3a988b5580b522812d44f2b02446fb7a923105", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/729582941f7c3f9f54e3731117733d2cb887862fc69733476850421a502e95087317a96355fbc6b785b1d28a23505b78b2beab080349c3f2552c54acf7c58483", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/512848af98fc1a0b962e15b8b927174c7c9c60b095faec01e13407f633d7b33ea1e922b4b203b0b926c3cb07d88d4eb89907df468d58d2ff57d5a38edfdb2aa9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84d0e4bfca56e3cc93917c4e9dd904f6bd447fb14ea86a908fc4ee44c1b7a2283647c69ecdf91727228d1e091dd4cbedcc790f1290797efc2da2b7166d73df63"}' ========= master_lag: 0.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 16:08:22.703989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 16:08:22.704319) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1506638470.208667-2145543056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.64 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 16:08:23.344165) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 16:08:23.344491) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 16:08:23.345308) ========= ========= Total master_lag: 1.50 =========