builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1506197904.91 results: success (0) revision: 6c495bb9e72c5033cf9584851c10b508655bcf31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 13:18:24.907409) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 13:18:24.907913) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 13:18:24.908208) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 13:18:24.961167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 13:18:24.961523) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 13:18:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2017-09-23 13:18:25 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120345 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 13:18:25.128967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 13:18:25.129300) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014397 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 13:18:25.190597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 13:18:25.190902) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6c495bb9e72c5033cf9584851c10b508655bcf31 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6c495bb9e72c5033cf9584851c10b508655bcf31 --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=74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 13:18:25,233 truncating revision to first 12 chars 2017-09-23 13:18:25,233 Setting DEBUG logging. 2017-09-23 13:18:25,233 attempt 1/10 2017-09-23 13:18:25,233 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6c495bb9e72c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-23 13:18:25,639 unpacking tar archive at: mozilla-beta-6c495bb9e72c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.738177 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 13:18:25.951868) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 13:18:25.952187) ========= script_repo_revision: 6c495bb9e72c5033cf9584851c10b508655bcf31 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 13:18:25.952620) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 13:18:25.952897) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 13:18:25.966725) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-09-23 13:18:25.967078) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] 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=74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:18:26 INFO - MultiFileLogger online at 20170923 13:18:26 in /builds/slave/test 13:18:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 13:18:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:18:26 INFO - {'append_to_log': False, 13:18:26 INFO - 'base_work_dir': '/builds/slave/test', 13:18:26 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 13:18:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:18:26 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 13:18:26 INFO - 'buildbot_json_path': 'buildprops.json', 13:18:26 INFO - 'code_coverage': False, 13:18:26 INFO - 'config_files': ('talos/linux_config.py',), 13:18:26 INFO - 'default_actions': ('clobber', 13:18:26 INFO - 'read-buildbot-config', 13:18:26 INFO - 'download-and-extract', 13:18:26 INFO - 'populate-webroot', 13:18:26 INFO - 'create-virtualenv', 13:18:26 INFO - 'install', 13:18:26 INFO - 'setup-mitmproxy', 13:18:26 INFO - 'run-tests'), 13:18:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:18:26 INFO - 'disable_ccov_upload': False, 13:18:26 INFO - 'disable_stylo': False, 13:18:26 INFO - 'download_minidump_stackwalk': True, 13:18:26 INFO - 'download_symbols': 'ondemand', 13:18:26 INFO - 'enable_stylo': False, 13:18:26 INFO - 'enable_webrender': False, 13:18:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:18:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:18:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:18:26 INFO - 'gecko_profile': False, 13:18:26 INFO - 'gecko_profile_interval': 0, 13:18:26 INFO - 'installer_path': 'installer.exe', 13:18:26 INFO - 'log_level': 'info', 13:18:26 INFO - 'log_name': 'talos', 13:18:26 INFO - 'log_to_console': True, 13:18:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:18:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:18:26 INFO - 'opt_config_files': (), 13:18:26 INFO - 'pip_index': False, 13:18:26 INFO - 'suite': 'dromaeojs-e10s', 13:18:26 INFO - 'system_bits': '32', 13:18:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:18:26 INFO - 'title': 'talos-linux64-ix-042', 13:18:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:18:26 INFO - 'use_talos_json': True, 13:18:26 INFO - 'verify': 'False', 13:18:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:18:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:18:26 INFO - 'work_dir': 'build'} 13:18:26 INFO - [mozharness: 2017-09-23 20:18:26.138218Z] Running clobber step. 13:18:26 INFO - Running pre-action listener: _resource_record_pre_action 13:18:26 INFO - Running main action method: clobber 13:18:26 INFO - rmtree: /builds/slave/test/build 13:18:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:18:27 INFO - Running post-action listener: _resource_record_post_action 13:18:27 INFO - [mozharness: 2017-09-23 20:18:27.112955Z] Finished clobber step (success) 13:18:27 INFO - [mozharness: 2017-09-23 20:18:27.113052Z] Running read-buildbot-config step. 13:18:27 INFO - Running pre-action listener: _resource_record_pre_action 13:18:27 INFO - Running main action method: read_buildbot_config 13:18:27 INFO - Using buildbot properties: 13:18:27 INFO - { 13:18:27 INFO - "project": "", 13:18:27 INFO - "product": "firefox", 13:18:27 INFO - "who": "ffxbld@noreply.mozilla.org", 13:18:27 INFO - "installer_path": "public/build/target.tar.bz2", 13:18:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 13:18:27 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 13:18:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 13:18:27 INFO - "stage_platform": "linux64", 13:18:27 INFO - "basedir": "/builds/slave/test", 13:18:27 INFO - "buildnumber": 114, 13:18:27 INFO - "platform": "ubuntu64_hw", 13:18:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:18:27 INFO - "slavebuilddir": "test", 13:18:27 INFO - "taskId": "BfBuMql-Q4SL9N787RIqQA", 13:18:27 INFO - "branch": "mozilla-beta", 13:18:27 INFO - "script_repo_revision": "production", 13:18:27 INFO - "revision": "6c495bb9e72c5033cf9584851c10b508655bcf31", 13:18:27 INFO - "slavename": "talos-linux64-ix-042", 13:18:27 INFO - "repo_path": "releases/mozilla-beta" 13:18:27 INFO - } 13:18:27 INFO - Finding installer, test and symbols from parent task. 13:18:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BfBuMql-Q4SL9N787RIqQA'}, attempt #1 13:18:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BfBuMql-Q4SL9N787RIqQA'}, attempt #1 13:18:28 INFO - Task dependencies: QpjT2mohRr6eqmfePmJGIg 13:18:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg'}, attempt #1 13:18:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.tar.bz2 13:18:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.test_packages.json 13:18:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.crashreporter-symbols.zip 13:18:28 INFO - Running post-action listener: _resource_record_post_action 13:18:28 INFO - [mozharness: 2017-09-23 20:18:28.765919Z] Finished read-buildbot-config step (success) 13:18:28 INFO - [mozharness: 2017-09-23 20:18:28.766137Z] Running download-and-extract step. 13:18:28 INFO - Running pre-action listener: _resource_record_pre_action 13:18:28 INFO - Running main action method: download_and_extract 13:18:28 INFO - mkdir: /builds/slave/test/build/tests 13:18:28 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')]} 13:18:28 INFO - trying https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.test_packages.json 13:18:28 INFO - Downloading https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:18:29 INFO - Downloaded 989 bytes. 13:18:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:18:29 INFO - Using the following test package requirements: 13:18:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:18:29 INFO - u'common': [u'target.common.tests.zip'], 13:18:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:18:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:18:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:18:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:18:29 INFO - u'mozbase': [u'target.common.tests.zip'], 13:18:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:18:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:18:29 INFO - u'web-platform': [u'target.common.tests.zip', 13:18:29 INFO - u'target.web-platform.tests.tar.gz'], 13:18:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:18:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 13:18:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.common.tests.zip 13:18:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:18:29 INFO - Fetch https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.common.tests.zip into memory 13:18:31 INFO - Content-Length response header: 55178562 13:18:31 INFO - Bytes received: 55178562 13:18:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.talos.tests.zip 13:18:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:18:42 INFO - Fetch https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.talos.tests.zip into memory 13:18:43 INFO - Content-Length response header: 14509184 13:18:43 INFO - Bytes received: 14509184 13:18:44 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')]} 13:18:44 INFO - trying https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.tar.bz2 13:18:44 INFO - Downloading https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:18:46 INFO - Downloaded 53495137 bytes. 13:18:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.tar.bz2 13:18:46 INFO - mkdir: /builds/slave/test/properties 13:18:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:18:46 INFO - Writing to file /builds/slave/test/properties/build_url 13:18:46 INFO - Contents: 13:18:46 INFO - build_url:https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.tar.bz2 13:18:46 INFO - Running post-action listener: _resource_record_post_action 13:18:46 INFO - Running post-action listener: find_tests_for_verification 13:18:46 INFO - Running post-action listener: set_extra_try_arguments 13:18:46 INFO - [mozharness: 2017-09-23 20:18:46.333139Z] Finished download-and-extract step (success) 13:18:46 INFO - [mozharness: 2017-09-23 20:18:46.333238Z] Running populate-webroot step. 13:18:46 INFO - Running pre-action listener: _resource_record_pre_action 13:18:46 INFO - Running main action method: populate_webroot 13:18:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:18:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:46 INFO - 'tests': ['tresize', 13:18:46 INFO - 'tcanvasmark']}, 13:18:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:18:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:46 INFO - 'tests': ['dromaeo_css', 13:18:46 INFO - 'kraken']}, 13:18:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:18:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:18:46 INFO - 'talos_options': ['--disable-stylo'], 13:18:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:18:46 INFO - 'tests': ['damp', 'tps']}, 13:18:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:18:46 INFO - 'talos_options': ['--disable-stylo'], 13:18:46 INFO - 'tests': ['damp', 'tps']}, 13:18:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:18:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:46 INFO - 'tests': ['dromaeo_dom']}, 13:18:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:18:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:46 INFO - 'tests': ['basic_compositor_video', 13:18:46 INFO - 'glvideo']}, 13:18:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:18:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:18:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:18:46 INFO - 'talos_options': ['--disable-stylo'], 13:18:46 INFO - 'tests': ['ts_paint_webext', 13:18:46 INFO - 'tp5o_webext']}, 13:18:46 INFO - 'other-e10s': {'tests': ['a11yr', 13:18:46 INFO - 'ts_paint', 13:18:46 INFO - 'tpaint', 13:18:46 INFO - 'sessionrestore', 13:18:46 INFO - 'sessionrestore_many_windows', 13:18:46 INFO - 'sessionrestore_no_auto_restore', 13:18:46 INFO - 'tabpaint']}, 13:18:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:46 INFO - 'tests': ['a11yr', 13:18:46 INFO - 'ts_paint', 13:18:46 INFO - 'tpaint', 13:18:46 INFO - 'sessionrestore', 13:18:46 INFO - 'sessionrestore_many_windows', 13:18:46 INFO - 'sessionrestore_no_auto_restore', 13:18:46 INFO - 'tabpaint']}, 13:18:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:18:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 13:18:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:46 INFO - 'tests': ['perf_reftest_singletons']}, 13:18:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:46 INFO - 'tests': ['bloom_basic']}, 13:18:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:18:46 INFO - 'tsvgr_opacity', 13:18:46 INFO - 'tart', 13:18:46 INFO - 'tscrollx', 13:18:46 INFO - 'tsvg_static']}, 13:18:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:18:46 INFO - 'tests': ['tsvgx', 13:18:46 INFO - 'tsvgr_opacity', 13:18:46 INFO - 'tart', 13:18:46 INFO - 'tscrollx', 13:18:46 INFO - 'tsvg_static']}, 13:18:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:18:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:18:46 INFO - 'talos_options': ['--disable-stylo'], 13:18:46 INFO - 'tests': ['tp5o']}, 13:18:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:18:46 INFO - 'talos_options': ['--mitmproxy', 13:18:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:18:46 INFO - '--firstNonBlankPaint'], 13:18:46 INFO - 'tests': ['tp6_google', 13:18:46 INFO - 'tp6_youtube', 13:18:46 INFO - 'tp6_amazon', 13:18:46 INFO - 'tp6_facebook']}, 13:18:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:18:46 INFO - 'talos_options': ['--disable-stylo', 13:18:46 INFO - '--mitmproxy', 13:18:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:18:46 INFO - '--firstNonBlankPaint'], 13:18:46 INFO - 'tests': ['tp6_google', 13:18:46 INFO - 'tp6_youtube', 13:18:46 INFO - 'tp6_amazon', 13:18:46 INFO - 'tp6_facebook']}, 13:18:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:18:46 INFO - 'talos_options': ['--stylo-threads=1', 13:18:46 INFO - '--mitmproxy', 13:18:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:18:46 INFO - '--firstNonBlankPaint'], 13:18:46 INFO - 'tests': ['tp6_google', 13:18:46 INFO - 'tp6_youtube', 13:18:46 INFO - 'tp6_amazon', 13:18:46 INFO - 'tp6_facebook']}, 13:18:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:18:46 INFO - 'talos_options': ['--xperf_path', 13:18:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:46 INFO - 'tests': ['tp5n']}, 13:18:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:18:46 INFO - 'talos_options': ['--disable-stylo', 13:18:46 INFO - '--xperf_path', 13:18:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:46 INFO - 'tests': ['tp5n']}}} 13:18:46 INFO - Running post-action listener: _resource_record_post_action 13:18:46 INFO - [mozharness: 2017-09-23 20:18:46.348281Z] Finished populate-webroot step (success) 13:18:46 INFO - [mozharness: 2017-09-23 20:18:46.348371Z] Running create-virtualenv step. 13:18:46 INFO - Running pre-action listener: _resource_record_pre_action 13:18:46 INFO - Running main action method: create_virtualenv 13:18:46 INFO - Creating virtualenv /builds/slave/test/build/venv 13:18:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:18:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:18:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:18:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:18:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:18:47 INFO - Installing distribute.............................................................................................................................................................................................done. 13:18:47 INFO - Installing pip...............done. 13:18:47 INFO - Return code: 0 13:18:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:18:47 INFO - Reading from file tmpfile_stdout 13:18:47 INFO - Output received: 13:18:47 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 13:18:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:18:47 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')]} 13:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:47 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')]} 13:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x180a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79090>, '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 0x1b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b73f90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', '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 13:18:47 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 13:18:47 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 13:18:47 INFO - Using env: {'DISPLAY': ':0', 13:18:47 INFO - 'HOME': '/home/cltbld', 13:18:47 INFO - 'LANG': 'en_US.UTF-8', 13:18:47 INFO - 'LANGUAGE': 'en_US:en', 13:18:47 INFO - 'LOGNAME': 'cltbld', 13:18:47 INFO - 'MAIL': '/var/mail/cltbld', 13:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:47 INFO - 'MOZ_NO_REMOTE': '1', 13:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:47 INFO - 'NO_EM_RESTART': '1', 13:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:47 INFO - 'PWD': '/builds/slave/test', 13:18:47 INFO - 'SHELL': '/bin/bash', 13:18:47 INFO - 'SHLVL': '1', 13:18:47 INFO - 'TERM': 'linux', 13:18:47 INFO - 'TMOUT': '86400', 13:18:47 INFO - 'USER': 'cltbld', 13:18:47 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', 13:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:47 INFO - '_': '/tools/buildbot/bin/python'} 13:18:48 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:18:48 INFO - Downloading/unpacking pip>=1.5 13:18:48 INFO - Running setup.py egg_info for package pip 13:18:48 INFO - warning: no files found matching 'pip/cacert.pem' 13:18:48 INFO - warning: no files found matching '*.html' under directory 'docs' 13:18:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:18:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:18:48 INFO - Installing collected packages: pip 13:18:48 INFO - Found existing installation: pip 1.1 13:18:48 INFO - Uninstalling pip: 13:18:48 INFO - Successfully uninstalled pip 13:18:48 INFO - Running setup.py install for pip 13:18:48 INFO - warning: no files found matching 'pip/cacert.pem' 13:18:48 INFO - warning: no files found matching '*.html' under directory 'docs' 13:18:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:18:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:18:48 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:18:48 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:18:48 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:18:48 INFO - Successfully installed pip 13:18:48 INFO - Cleaning up... 13:18:48 INFO - Return code: 0 13:18:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:18:48 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')]} 13:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:48 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')]} 13:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:48 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 0x180a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79090>, '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 0x1b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b73f90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', '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 13:18:48 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 13:18:48 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 13:18:48 INFO - Using env: {'DISPLAY': ':0', 13:18:48 INFO - 'HOME': '/home/cltbld', 13:18:48 INFO - 'LANG': 'en_US.UTF-8', 13:18:48 INFO - 'LANGUAGE': 'en_US:en', 13:18:48 INFO - 'LOGNAME': 'cltbld', 13:18:48 INFO - 'MAIL': '/var/mail/cltbld', 13:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:48 INFO - 'MOZ_NO_REMOTE': '1', 13:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:48 INFO - 'NO_EM_RESTART': '1', 13:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:48 INFO - 'PWD': '/builds/slave/test', 13:18:48 INFO - 'SHELL': '/bin/bash', 13:18:48 INFO - 'SHLVL': '1', 13:18:48 INFO - 'TERM': 'linux', 13:18:48 INFO - 'TMOUT': '86400', 13:18:48 INFO - 'USER': 'cltbld', 13:18:48 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', 13:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:48 INFO - '_': '/tools/buildbot/bin/python'} 13:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:48 INFO - Downloading/unpacking psutil>=3.1.1 13:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:18:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:18:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:18:50 INFO - Installing collected packages: psutil 13:18:50 INFO - Running setup.py install for psutil 13:18:50 INFO - building 'psutil._psutil_linux' extension 13:18:50 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 13:18:50 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 13:18:50 INFO - building 'psutil._psutil_posix' extension 13:18:50 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 13:18:50 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 13:18:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:18:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:18:50 INFO - Successfully installed psutil 13:18:50 INFO - Cleaning up... 13:18:51 INFO - Return code: 0 13:18:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:18:51 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')]} 13:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:51 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')]} 13:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:51 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 0x180a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79090>, '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 0x1b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b73f90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', '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 13:18:51 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 13:18:51 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 13:18:51 INFO - Using env: {'DISPLAY': ':0', 13:18:51 INFO - 'HOME': '/home/cltbld', 13:18:51 INFO - 'LANG': 'en_US.UTF-8', 13:18:51 INFO - 'LANGUAGE': 'en_US:en', 13:18:51 INFO - 'LOGNAME': 'cltbld', 13:18:51 INFO - 'MAIL': '/var/mail/cltbld', 13:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:51 INFO - 'MOZ_NO_REMOTE': '1', 13:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:51 INFO - 'NO_EM_RESTART': '1', 13:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:51 INFO - 'PWD': '/builds/slave/test', 13:18:51 INFO - 'SHELL': '/bin/bash', 13:18:51 INFO - 'SHLVL': '1', 13:18:51 INFO - 'TERM': 'linux', 13:18:51 INFO - 'TMOUT': '86400', 13:18:51 INFO - 'USER': 'cltbld', 13:18:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', 13:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:51 INFO - '_': '/tools/buildbot/bin/python'} 13:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:18:52 INFO - Installing collected packages: mozsystemmonitor 13:18:52 INFO - Running setup.py install for mozsystemmonitor 13:18:53 INFO - Successfully installed mozsystemmonitor 13:18:53 INFO - Cleaning up... 13:18:53 INFO - Return code: 0 13:18:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:18:53 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')]} 13:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:53 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')]} 13:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x180a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79090>, '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 0x1b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b73f90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', '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 13:18:53 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 13:18:53 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 13:18:53 INFO - Using env: {'DISPLAY': ':0', 13:18:53 INFO - 'HOME': '/home/cltbld', 13:18:53 INFO - 'LANG': 'en_US.UTF-8', 13:18:53 INFO - 'LANGUAGE': 'en_US:en', 13:18:53 INFO - 'LOGNAME': 'cltbld', 13:18:53 INFO - 'MAIL': '/var/mail/cltbld', 13:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:53 INFO - 'MOZ_NO_REMOTE': '1', 13:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:53 INFO - 'NO_EM_RESTART': '1', 13:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:53 INFO - 'PWD': '/builds/slave/test', 13:18:53 INFO - 'SHELL': '/bin/bash', 13:18:53 INFO - 'SHLVL': '1', 13:18:53 INFO - 'TERM': 'linux', 13:18:53 INFO - 'TMOUT': '86400', 13:18:53 INFO - 'USER': 'cltbld', 13:18:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', 13:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:53 INFO - '_': '/tools/buildbot/bin/python'} 13:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:53 INFO - Downloading/unpacking jsonschema==2.5.1 13:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:18:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:54 INFO - Downloading functools32-3.2.3-2.tar.gz 13:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:18:55 INFO - warning: no files found matching '*.txt' 13:18:55 INFO - no previously-included directories found matching 'build' 13:18:55 INFO - no previously-included directories found matching 'dist' 13:18:55 INFO - no previously-included directories found matching '.git*' 13:18:55 INFO - Installing collected packages: jsonschema, functools32 13:18:55 INFO - Running setup.py install for functools32 13:18:55 INFO - warning: no files found matching '*.txt' 13:18:55 INFO - no previously-included directories found matching 'build' 13:18:55 INFO - no previously-included directories found matching 'dist' 13:18:55 INFO - no previously-included directories found matching '.git*' 13:18:55 INFO - Successfully installed jsonschema functools32 13:18:55 INFO - Cleaning up... 13:18:55 INFO - Return code: 0 13:18:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:18:55 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')]} 13:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:55 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')]} 13:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:55 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 0x180a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79090>, '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 0x1b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b73f90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', '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 13:18:55 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 13:18:55 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 13:18:55 INFO - Using env: {'DISPLAY': ':0', 13:18:55 INFO - 'HOME': '/home/cltbld', 13:18:55 INFO - 'LANG': 'en_US.UTF-8', 13:18:55 INFO - 'LANGUAGE': 'en_US:en', 13:18:55 INFO - 'LOGNAME': 'cltbld', 13:18:55 INFO - 'MAIL': '/var/mail/cltbld', 13:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:55 INFO - 'MOZ_NO_REMOTE': '1', 13:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:55 INFO - 'NO_EM_RESTART': '1', 13:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:55 INFO - 'PWD': '/builds/slave/test', 13:18:55 INFO - 'SHELL': '/bin/bash', 13:18:55 INFO - 'SHLVL': '1', 13:18:55 INFO - 'TERM': 'linux', 13:18:55 INFO - 'TMOUT': '86400', 13:18:55 INFO - 'USER': 'cltbld', 13:18:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', 13:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:55 INFO - '_': '/tools/buildbot/bin/python'} 13:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:18:55 INFO - Cleaning up... 13:18:55 INFO - Return code: 0 13:18:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:18:55 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')]} 13:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:55 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')]} 13:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:55 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 0x180a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79090>, '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 0x1b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b73f90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', '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 13:18:55 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 13:18:55 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 13:18:55 INFO - Using env: {'DISPLAY': ':0', 13:18:55 INFO - 'HOME': '/home/cltbld', 13:18:55 INFO - 'LANG': 'en_US.UTF-8', 13:18:55 INFO - 'LANGUAGE': 'en_US:en', 13:18:55 INFO - 'LOGNAME': 'cltbld', 13:18:55 INFO - 'MAIL': '/var/mail/cltbld', 13:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:55 INFO - 'MOZ_NO_REMOTE': '1', 13:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:55 INFO - 'NO_EM_RESTART': '1', 13:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:55 INFO - 'PWD': '/builds/slave/test', 13:18:55 INFO - 'SHELL': '/bin/bash', 13:18:55 INFO - 'SHLVL': '1', 13:18:55 INFO - 'TERM': 'linux', 13:18:55 INFO - 'TMOUT': '86400', 13:18:55 INFO - 'USER': 'cltbld', 13:18:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', 13:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:55 INFO - '_': '/tools/buildbot/bin/python'} 13:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:55 INFO - Downloading/unpacking blobuploader==1.2.4 13:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:18:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:18:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:57 INFO - Downloading docopt-0.6.1.tar.gz 13:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:18:57 INFO - Installing collected packages: blobuploader, requests, docopt 13:18:57 INFO - Running setup.py install for blobuploader 13:18:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:18:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:18:57 INFO - Running setup.py install for requests 13:18:57 INFO - Running setup.py install for docopt 13:18:57 INFO - Successfully installed blobuploader requests docopt 13:18:57 INFO - Cleaning up... 13:18:57 INFO - Return code: 0 13:18:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18: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')]} 13:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18: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')]} 13:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:57 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 0x180a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79090>, '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 0x1b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b73f90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', '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 13:18:57 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 13:18:57 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 13:18:57 INFO - Using env: {'DISPLAY': ':0', 13:18:57 INFO - 'HOME': '/home/cltbld', 13:18:57 INFO - 'LANG': 'en_US.UTF-8', 13:18:57 INFO - 'LANGUAGE': 'en_US:en', 13:18:57 INFO - 'LOGNAME': 'cltbld', 13:18:57 INFO - 'MAIL': '/var/mail/cltbld', 13:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:57 INFO - 'MOZ_NO_REMOTE': '1', 13:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:57 INFO - 'NO_EM_RESTART': '1', 13:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:57 INFO - 'PWD': '/builds/slave/test', 13:18:57 INFO - 'SHELL': '/bin/bash', 13:18:57 INFO - 'SHLVL': '1', 13:18:57 INFO - 'TERM': 'linux', 13:18:57 INFO - 'TMOUT': '86400', 13:18:57 INFO - 'USER': 'cltbld', 13:18:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', 13:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:57 INFO - '_': '/tools/buildbot/bin/python'} 13:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:18:58 INFO - Running setup.py (path:/tmp/pip-lXTCfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:18:58 INFO - Running setup.py (path:/tmp/pip-r47mB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:18:58 INFO - Running setup.py (path:/tmp/pip-XXjIvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:18:58 INFO - Running setup.py (path:/tmp/pip-zcCp2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:18:58 INFO - Running setup.py (path:/tmp/pip-vFX3_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:18:58 INFO - Running setup.py (path:/tmp/pip-JrFQE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:18:58 INFO - Running setup.py (path:/tmp/pip-R0TKrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:18:58 INFO - Running setup.py (path:/tmp/pip-Hu6cXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:18:58 INFO - Running setup.py (path:/tmp/pip-GYdp6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:18:58 INFO - Running setup.py (path:/tmp/pip-9AUBMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:18:58 INFO - Running setup.py (path:/tmp/pip-CISsj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:18:58 INFO - Running setup.py (path:/tmp/pip-dx1gqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:18:59 INFO - Running setup.py (path:/tmp/pip-NDwMY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:18:59 INFO - Running setup.py (path:/tmp/pip-NC0N8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:59 INFO - Running setup.py (path:/tmp/pip-tOe8Q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:18:59 INFO - Running setup.py (path:/tmp/pip-TnjSNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:18:59 INFO - Running setup.py (path:/tmp/pip-_jZQrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:18:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:18:59 INFO - Running setup.py install for manifestparser 13:18:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:18:59 INFO - Running setup.py install for mozcrash 13:18:59 INFO - Running setup.py install for mozdebug 13:18:59 INFO - Running setup.py install for mozdevice 13:18:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:18:59 INFO - Running setup.py install for mozfile 13:18:59 INFO - Running setup.py install for mozhttpd 13:18:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:18:59 INFO - Running setup.py install for mozinfo 13:19:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:19:00 INFO - Running setup.py install for mozInstall 13:19:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:19:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:19:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:19:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:19:00 INFO - Running setup.py install for mozleak 13:19:00 INFO - Running setup.py install for mozlog 13:19:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:19:00 INFO - Running setup.py install for moznetwork 13:19:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:19:00 INFO - Running setup.py install for mozprocess 13:19:00 INFO - Running setup.py install for mozprofile 13:19:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:19:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:19:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:19:00 INFO - Running setup.py install for mozrunner 13:19:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:19:00 INFO - Running setup.py install for mozscreenshot 13:19:00 INFO - Running setup.py install for moztest 13:19:00 INFO - Running setup.py install for mozversion 13:19:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:19:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:19:01 INFO - Cleaning up... 13:19:01 INFO - Return code: 0 13:19:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:01 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')]} 13:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:01 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')]} 13:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:01 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 0x180a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79090>, '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 0x1b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b73f90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', '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 13:19:01 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 13:19:01 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 13:19:01 INFO - Using env: {'DISPLAY': ':0', 13:19:01 INFO - 'HOME': '/home/cltbld', 13:19:01 INFO - 'LANG': 'en_US.UTF-8', 13:19:01 INFO - 'LANGUAGE': 'en_US:en', 13:19:01 INFO - 'LOGNAME': 'cltbld', 13:19:01 INFO - 'MAIL': '/var/mail/cltbld', 13:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:01 INFO - 'MOZ_NO_REMOTE': '1', 13:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:01 INFO - 'NO_EM_RESTART': '1', 13:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:01 INFO - 'PWD': '/builds/slave/test', 13:19:01 INFO - 'SHELL': '/bin/bash', 13:19:01 INFO - 'SHLVL': '1', 13:19:01 INFO - 'TERM': 'linux', 13:19:01 INFO - 'TMOUT': '86400', 13:19:01 INFO - 'USER': 'cltbld', 13:19:01 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', 13:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:01 INFO - '_': '/tools/buildbot/bin/python'} 13:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:01 INFO - Running setup.py (path:/tmp/pip-BnrfKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:01 INFO - Running setup.py (path:/tmp/pip-YS7oaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:01 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)) 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:01 INFO - Running setup.py (path:/tmp/pip-4_jaLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:01 INFO - Running setup.py (path:/tmp/pip-0OPeA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:01 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)) 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:01 INFO - Running setup.py (path:/tmp/pip-NCpAoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:01 INFO - Running setup.py (path:/tmp/pip-SzqaqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:01 INFO - Running setup.py (path:/tmp/pip-9OwLkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:01 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)) 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:01 INFO - Running setup.py (path:/tmp/pip-E8uH5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:01 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)) 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:01 INFO - Running setup.py (path:/tmp/pip-fMXdPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:01 INFO - Running setup.py (path:/tmp/pip-WpdqgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:02 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)) 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:02 INFO - Running setup.py (path:/tmp/pip-i4EiYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:02 INFO - Running setup.py (path:/tmp/pip-_sKaPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:02 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)) 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:02 INFO - Running setup.py (path:/tmp/pip-CNISKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:02 INFO - Running setup.py (path:/tmp/pip-mPLnzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:02 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)) 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:02 INFO - Running setup.py (path:/tmp/pip-gTgZJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:02 INFO - Running setup.py (path:/tmp/pip-4n1vTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:02 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)) 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:02 INFO - Running setup.py (path:/tmp/pip-9P3ARY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:19:02 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)) 13:19:02 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)) 13:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:19:02 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)) 13:19:02 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)) 13:19:02 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)) 13:19:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:03 INFO - Downloading blessings-1.6.tar.gz 13:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:19:03 INFO - Installing collected packages: blessings 13:19:03 INFO - Running setup.py install for blessings 13:19:03 INFO - Successfully installed blessings 13:19:03 INFO - Cleaning up... 13:19:03 INFO - Return code: 0 13:19:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:19:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:04 INFO - Reading from file tmpfile_stdout 13:19:04 INFO - Current package versions: 13:19:04 INFO - argparse == 1.2.1 13:19:04 INFO - blessings == 1.6 13:19:04 INFO - blobuploader == 1.2.4 13:19:04 INFO - docopt == 0.6.1 13:19:04 INFO - functools32 == 3.2.3-2 13:19:04 INFO - jsonschema == 2.5.1 13:19:04 INFO - manifestparser == 1.1 13:19:04 INFO - mozInstall == 1.13 13:19:04 INFO - mozcrash == 1.0 13:19:04 INFO - mozdebug == 0.1 13:19:04 INFO - mozdevice == 0.51 13:19:04 INFO - mozfile == 1.2 13:19:04 INFO - mozhttpd == 0.7 13:19:04 INFO - mozinfo == 0.10 13:19:04 INFO - mozleak == 0.1 13:19:04 INFO - mozlog == 3.5 13:19:04 INFO - moznetwork == 0.27 13:19:04 INFO - mozprocess == 0.25 13:19:04 INFO - mozprofile == 0.28 13:19:04 INFO - mozrunner == 6.13 13:19:04 INFO - mozscreenshot == 0.1 13:19:04 INFO - mozsystemmonitor == 0.3 13:19:04 INFO - moztest == 0.8 13:19:04 INFO - mozversion == 1.4 13:19:04 INFO - psutil == 3.1.1 13:19:04 INFO - requests == 1.2.3 13:19:04 INFO - wsgiref == 0.1.2 13:19:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19: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')]} 13:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:04 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 0x180a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79090>, '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 0x1b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b73f90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', '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 13:19:04 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 13:19:04 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 13:19:04 INFO - Using env: {'DISPLAY': ':0', 13:19:04 INFO - 'HOME': '/home/cltbld', 13:19:04 INFO - 'LANG': 'en_US.UTF-8', 13:19:04 INFO - 'LANGUAGE': 'en_US:en', 13:19:04 INFO - 'LOGNAME': 'cltbld', 13:19:04 INFO - 'MAIL': '/var/mail/cltbld', 13:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:04 INFO - 'MOZ_NO_REMOTE': '1', 13:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:04 INFO - 'NO_EM_RESTART': '1', 13:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:04 INFO - 'PWD': '/builds/slave/test', 13:19:04 INFO - 'SHELL': '/bin/bash', 13:19:04 INFO - 'SHLVL': '1', 13:19:04 INFO - 'TERM': 'linux', 13:19:04 INFO - 'TMOUT': '86400', 13:19:04 INFO - 'USER': 'cltbld', 13:19:04 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', 13:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:04 INFO - '_': '/tools/buildbot/bin/python'} 13:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:19:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:19: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 13:19: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 13:19: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 13:19: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 13:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:19:05 INFO - Installing collected packages: simplejson 13:19:05 INFO - Running setup.py install for simplejson 13:19:05 INFO - building 'simplejson._speedups' extension 13:19:05 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 13:19:06 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 13:19:06 INFO - Successfully installed simplejson 13:19:06 INFO - Cleaning up... 13:19:06 INFO - Return code: 0 13:19:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19: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')]} 13:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79090>, '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 0x1b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b73f90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', '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 13:19: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', 'jsonschema'] in /builds/slave/test/build 13:19: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 jsonschema 13:19:06 INFO - Using env: {'DISPLAY': ':0', 13:19:06 INFO - 'HOME': '/home/cltbld', 13:19:06 INFO - 'LANG': 'en_US.UTF-8', 13:19:06 INFO - 'LANGUAGE': 'en_US:en', 13:19:06 INFO - 'LOGNAME': 'cltbld', 13:19:06 INFO - 'MAIL': '/var/mail/cltbld', 13:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:06 INFO - 'MOZ_NO_REMOTE': '1', 13:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:06 INFO - 'NO_EM_RESTART': '1', 13:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:06 INFO - 'PWD': '/builds/slave/test', 13:19:06 INFO - 'SHELL': '/bin/bash', 13:19:06 INFO - 'SHLVL': '1', 13:19:06 INFO - 'TERM': 'linux', 13:19:06 INFO - 'TMOUT': '86400', 13:19:06 INFO - 'USER': 'cltbld', 13:19:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', 13:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:06 INFO - '_': '/tools/buildbot/bin/python'} 13:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:19:06 INFO - Cleaning up... 13:19:06 INFO - Return code: 0 13:19:06 INFO - Running post-action listener: _resource_record_post_action 13:19:06 INFO - Running post-action listener: _start_resource_monitoring 13:19:06 INFO - Starting resource monitoring. 13:19:06 INFO - [mozharness: 2017-09-23 20:19:06.873205Z] Finished create-virtualenv step (success) 13:19:06 INFO - [mozharness: 2017-09-23 20:19:06.873667Z] Running install step. 13:19:06 INFO - Running pre-action listener: _resource_record_pre_action 13:19:06 INFO - Running main action method: install 13:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:07 INFO - Reading from file tmpfile_stdout 13:19:07 INFO - Detecting whether we're running mozinstall >=1.0... 13:19:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:19:07 INFO - Reading from file tmpfile_stdout 13:19:07 INFO - Output received: 13:19:07 INFO - Usage: mozinstall [options] installer 13:19:07 INFO - Options: 13:19:07 INFO - -h, --help show this help message and exit 13:19:07 INFO - -d DEST, --destination=DEST 13:19:07 INFO - Directory to install application into. [default: 13:19:07 INFO - "/builds/slave/test"] 13:19:07 INFO - --app=APP Application being installed. [default: firefox] 13:19:07 INFO - mkdir: /builds/slave/test/build/application 13:19:07 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'] 13:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:19:21 INFO - Reading from file tmpfile_stdout 13:19:21 INFO - Output received: 13:19:21 INFO - /builds/slave/test/build/application/firefox/firefox 13:19:21 INFO - Running post-action listener: _resource_record_post_action 13:19:21 INFO - [mozharness: 2017-09-23 20:19:21.756063Z] Finished install step (success) 13:19:21 INFO - [mozharness: 2017-09-23 20:19:21.756314Z] Running setup-mitmproxy step. 13:19:21 INFO - Running pre-action listener: _resource_record_pre_action 13:19:21 INFO - Running main action method: setup_mitmproxy 13:19:21 INFO - Skipping: mitmproxy is not required 13:19:21 INFO - Running post-action listener: _resource_record_post_action 13:19:21 INFO - [mozharness: 2017-09-23 20:19:21.757439Z] Finished setup-mitmproxy step (success) 13:19:21 INFO - [mozharness: 2017-09-23 20:19:21.757660Z] Running run-tests step. 13:19:21 INFO - Running pre-action listener: _resource_record_pre_action 13:19:21 INFO - Running pre-action listener: _set_gcov_prefix 13:19:21 INFO - Running main action method: run_tests 13:19:21 WARNING - Try message not found. 13:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:19:21 INFO - Python 2.7.3 13:19:21 INFO - Return code: 0 13:19:21 INFO - grabbing minidump binary from tooltool 13:19: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')]} 13:19:21 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 0x1b79090>, '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 0x1b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b73f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:19:21 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 13:19:21 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 13:19:21 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 13:19:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:19:21 INFO - Return code: 0 13:19:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:19:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:19:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:19:21 INFO - ENV: RUST_BACKTRACE is now full 13:19:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:19:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 13:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 13:19:21 INFO - Using env: {'DISPLAY': ':0', 13:19:21 INFO - 'HOME': '/home/cltbld', 13:19:21 INFO - 'LANG': 'en_US.UTF-8', 13:19:21 INFO - 'LANGUAGE': 'en_US:en', 13:19:21 INFO - 'LOGNAME': 'cltbld', 13:19:21 INFO - 'MAIL': '/var/mail/cltbld', 13:19:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:19:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:21 INFO - 'MOZ_NO_REMOTE': '1', 13:19:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:21 INFO - 'NO_EM_RESTART': '1', 13:19:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:21 INFO - 'PWD': '/builds/slave/test', 13:19:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:19:21 INFO - 'RUST_BACKTRACE': 'full', 13:19:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:19:21 INFO - 'SHELL': '/bin/bash', 13:19:21 INFO - 'SHLVL': '1', 13:19:21 INFO - 'TERM': 'linux', 13:19:21 INFO - 'TMOUT': '86400', 13:19:21 INFO - 'USER': 'cltbld', 13:19:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', 13:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:21 INFO - '_': '/tools/buildbot/bin/python'} 13:19:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 13:19:22 INFO - mozversion application_buildid: 20170923190022 13:19:22 INFO - mozversion application_changeset: 6c495bb9e72c5033cf9584851c10b508655bcf31 13:19:22 INFO - mozversion application_display_name: Firefox 13:19:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:19:22 INFO - mozversion application_name: Firefox 13:19:22 INFO - mozversion application_remotingname: firefox 13:19:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:19:22 INFO - mozversion application_vendor: Mozilla 13:19:22 INFO - mozversion application_version: 57.0 13:19:22 INFO - mozversion platform_buildid: 20170923190022 13:19:22 INFO - mozversion platform_changeset: 6c495bb9e72c5033cf9584851c10b508655bcf31 13:19:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:19:22 INFO - mozversion platform_version: 57.0 13:19:22 INFO - using testdate: 1506197962 13:19:22 INFO - actual date: 1506197962 13:19:22 INFO - starting webserver on 'localhost:55502' 13:19:22 INFO - SUITE-START | Running 2 tests 13:19:22 INFO - TEST-START | dromaeo_css 13:19:22 INFO - Initialising browser for dromaeo_css test... 13:19:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55502/getInfo.html -profile /tmp/tmpOjGs5X/profile 13:19:22 INFO - TEST-INFO | started process 19191 (/builds/slave/test/build/application/firefox/firefox http://localhost:55502/getInfo.html) 13:19:27 INFO - TEST-INFO | 19191: exit 0 13:19:27 INFO - Browser initialized. 13:19:27 INFO - Running cycle 1/1 for dromaeo_css test... 13:19:27 INFO - Using env: {'DISPLAY': ':0', 13:19:27 INFO - 'HOME': '/home/cltbld', 13:19:27 INFO - 'JSGC_DISABLE_POISONING': '1', 13:19:27 INFO - 'LANG': 'en_US.UTF-8', 13:19:27 INFO - 'LANGUAGE': 'en_US:en', 13:19:27 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:19:27 INFO - 'LOGNAME': 'cltbld', 13:19:27 INFO - 'MAIL': '/var/mail/cltbld', 13:19:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:19:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:19:27 INFO - 'MOZ_CRASHREPORTER': '1', 13:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:27 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:19:27 INFO - 'MOZ_NO_REMOTE': '1', 13:19:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:19:27 INFO - 'NO_EM_RESTART': '1', 13:19:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:27 INFO - 'PWD': '/builds/slave/test', 13:19:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:19:27 INFO - 'RUST_BACKTRACE': 'full', 13:19:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:19:27 INFO - 'SHELL': '/bin/bash', 13:19:27 INFO - 'SHLVL': '1', 13:19:27 INFO - 'TERM': 'linux', 13:19:27 INFO - 'TMOUT': '86400', 13:19:27 INFO - 'USER': 'cltbld', 13:19:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', 13:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:27 INFO - '_': '/tools/buildbot/bin/python'} 13:19:27 INFO - TEST-INFO | started process 19379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOjGs5X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:19:38 INFO - PID 19379 | RSS: Main: 144637952 13:19:38 INFO - PID 19379 | 13:22:36 INFO - PID 19379 | Cycle 1(1): loaded http://localhost:55502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55502/tests/dromaeo/cssquery-ext.html) 13:22:37 INFO - PID 19379 | RSS: Main: 147431424 13:22:37 INFO - PID 19379 | 13:25:38 INFO - PID 19379 | Cycle 1(1): loaded http://localhost:55502/tests/dromaeo/cssquery-ext.html (next: http://localhost:55502/tests/dromaeo/cssquery-jquery.html) 13:25:39 INFO - PID 19379 | RSS: Main: 146300928 13:25:39 INFO - PID 19379 | 13:28:40 INFO - PID 19379 | Cycle 1(1): loaded http://localhost:55502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55502/tests/dromaeo/cssquery-mootools.html) 13:28:41 INFO - PID 19379 | RSS: Main: 147128320 13:28:41 INFO - PID 19379 | 13:31:42 INFO - PID 19379 | Cycle 1(1): loaded http://localhost:55502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55502/tests/dromaeo/cssquery-prototype.html) 13:31:43 INFO - PID 19379 | RSS: Main: 147308544 13:31:43 INFO - PID 19379 | 13:34:46 INFO - PID 19379 | Cycle 1(1): loaded http://localhost:55502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55502/tests/dromaeo/cssquery-yui.html) 13:34:47 INFO - PID 19379 | RSS: Main: 148385792 13:34:47 INFO - PID 19379 | 13:37:48 INFO - PID 19379 | Cycle 1(1): loaded http://localhost:55502/tests/dromaeo/cssquery-yui.html (next: http://localhost:55502/tests/dromaeo/cssquery-dojo.html) 13:37:48 INFO - PID 19379 | RSS: Main: 151461888 13:37:48 INFO - PID 19379 | 13:37:48 INFO - PID 19379 | __start_tp_report 13:37:48 INFO - PID 19379 | _x_x_mozilla_page_load 13:37:48 INFO - PID 19379 | _x_x_mozilla_page_load_details 13:37:48 INFO - PID 19379 | |i|pagename|runs| 13:37:48 INFO - PID 19379 | |0;dojo.html;4021.0751527148736;4030.6573941214997;4031.3751368537874;4033.959660403395;4052.250333688268;6512.967435162824;6524.2170939487205;6576.6382848943285;6674.499412544054;6680.832979175517;6595.802125936218;6601.801945941617;6614.735410583571;6679.298673639259;6682.498812589051;5887.793927212549;5957.851053723659;5959.970200149015;5971.731272092767;6023.427774361428;5950.702464876739;5967.313758917737;6002.519798416138;6090.725917333731;6098.908516372258;6005.6997150142315;6044.758209671608;6097.176881121036;6102.725377358008;6106.175666285039;5934.5845790794665;5993.910091348655;6041.154238406582;6070.119832624245;6089.45194932456;5848.67832269225;5860.7948721794955;5864.472197502203;5942.732577034;5953.672548009858;6528.21661400635;6593.307702691196;6596.637184954826;6616.503762217853;6632.303608121126;7198.496105272633;7199.1001124859395;7276.527025743309;7278.818029549304;7309.757341252;7097.645117744144;7209.567425954459;7211.278872112799;7234.96382518084;7290.890636640454;6745.494087943375;6752.628605426699;6758.324167583202;6760.695768690421;6762.628055456948;7294.161171465349;7432.479726419207;7450.552966822008;7481.064866891638;7528.661210245552;6972.198197207386;7088.574685518885;7115.181754098345;7123.038389817412;7203.38771204443;7248.057752492142;7264.23725508814;7292.270772922665;7318.975343451921;7326.597037163007;7090.361867431956;7193.460490463236;7238.239984801626;7277.454190935701;7286.162091359562;7119.323664251888;7142.071530700976;7156.320149585781;7217.2421895701245;7271.309225623558;5308.150695888639;5356.035913535523;5357.973210133924;5358.705271210121;5380.973095134499;4868.391451068616;4921.803127874917;4923.458419573844;4977.40271167455;4991.550760431579;6565.540412171103;6717.966410167918;6745.527813053137;6748.595084294958;6817.625030623363;6983.266756990544;7134.821629459201;7144.3927266182955;7195.7481488148715;7232.529885557422;6675.198976122896;6764.323567643295;6764.763233286812;6771.221309549366;6789;6176.66028368444;6188.4739797116845;6249.468795152463;6256.468200202943;6257.56197066201;7339.082614673166;7367.8894816577795;7463.067116610424;7473.6263186841525;7582.582957937256;7162.462815288978;7202.099737532809;7263.927360726537;7278.890816637861;7289.015982842248;7456.664450099867;7469.477136600386;7545.056867891513;7563.130240022248;7590.240975902366;7001.439884809305;7077.035021355528;7186.748463803742;7198.640067996684;7221.350078492961;7092.113485814273;7181.712731490891;7236.457265704988;7245.710171593288;7263.128424589083;7021.508494405342;7041.225465198926;7092.680829362795;7098.396636285974;7110.253423390676;6929.272426395156;6950.756723514653;6958.7216511341;7037.331453511908;7052.047973523714;6841.110655614738;6863.862722745617;6905.654717264017;6936.237013928565;6986.615736134561;7011.579305241702;7094.6097964612445;7113;7114.324139206767;7118.715251390094;6813.0461735358085;6829.112215412163;6868.931310686829;6898.310168983062;6904.792856214322 13:37:48 INFO - PID 19379 | |1;ext.html;988.9604415823368;1010.2271762101992;1034.4827586206898;1043.332267348897;1045.6078970386104;45996.540034599646;46934.765326173365;47010.529894701045;47060.29409558855;47137.7643111784;44568.77715611417;44613;46474;47112.29331560021;47181;8750.343724220676;8867.645294188256;8870.556472176399;8892.555372231394;8905.510196939165;8527.530985795778;8527.573621318908;8533.146685331449;8572.485650860968;8589.09814469481;8548.957255213747;8648.827023459527;8651.524166170859;8652.48085114892;8677.392582519225;8522.40343175978;8579.656813727475;8612.39713220078;8646.870296945552;8646.956765216197;8588.69939552119;8588.8711669325;8620;8654.00478944923;8660.307175426015;43302.56697433017;43310.78344608288;43416.13167736659;43617.127657446676;43723.78138109289;3708.87018954338;3730.123420996064;3731;3743;3749.6812770914503;34550.136246593785;34715.82642086798;34761.30477390438;34780.478292825625;34829.12927176816;5621.213030175779;5628.971855140739;5641.605087643867;5644.774209031634;5676.205331253628;233880;238369;248879;249480;263547;55961.440385596434;56402;56482;56497;56549.151762723595;58462;58880.705596471744;58997.41002590005;59000.70499647474;59022.40977590169;18454.26182952667;18608.81391186098;18615.348462803737;18628;18790.81209187918;15522.37910483568;15551.844481555267;15583.06501609907;15590.064596124043;15603.687926241639;15122.697546049238;15131.394744210109;15160.772588411182;15212.239388030775;15312.770308445382;5409.486098820606;5526.424968883849;5556.416576259516;5632.295963004624;5643.689597072201;1101.5373543111912;1111.127764704703;1114.0975809594254;1118.7706520163347;1131.9377434241196;26673.915645824127;26847.194584162506;26869.596956045283;26932.326691832863;27111.72888271092;1209.6915286601861;1230.5693007447321;1232;1235.7713822942785;1237.8824011718873;13978.580642580739;14039.50861719835;14039.719205615831;14154.221517816413;14307.642308942151;306562;317735;320428;320695;321490;64158;64169.35830641727;64386.67806660937;64797.676011620584;64814.35185648177;1530.6785575029146;1538.9153596552073;1551.7672349147717;1552.0377366032906;1555.4089446010444;30728.078157655305;31012.379752404373;31196.31321727493;31314;31967;43888;43897.34153987757;43958;43992.56007439885;44065.559344406145;251823;251895;252057;252314;253305;38005.809970949966;38702.80648596739;38892;38916.610833891296;39449.80275098721;47961.760191200214;49853.252201217736;49982.50017499778;50485.242721358474;50760;36085.45871811872;36101.45847812337;36147.27705445929;36369.636303636624;36606.45090323594;35760;35974.640253598176;36263.81868090643;36431.27137457183;36907;41858.58141418547;41916.580834192486;42087.36868946907;42214.57785422107;42374;34807.82596087003;34808.30383392369;35201.29597407986;35248.47127293144;35475.29049418945;25810.483790323713;25854.482910342063;26026.739732602433;26399.472010559297;26577.468450631266 13:37:48 INFO - PID 19379 | |2;jquery.html;626.3611116661006;631.4632562322026;633.2749002392264;633.7116611941564;646.6766616691655;23272.41818954527;23643;23830.880845595748;24420.999999999978;24423.75576244237;25696.74303256967;26163.3459163521;26184.214473565775;26206.344841378974;26213.21360359192;6619.404253617174;6877.243503214642;7063.505554611179;7086.503944723871;7087.291270872897;6704.094947182141;6738.12404387429;6742.662866856637;6743.089682892795;6750;6646.335366463363;6648.634325112117;6680.031395447657;6682.832929176785;6733.797986060426;6670.799876003728;6712.765053223138;6714.966425167867;6743.595384276935;6747.291534388867;6257.624542527463;6276.937230627681;6291.276503202144;6300.054991751228;6303.621782693053;28812.279693007633;29594.556081658793;30130;30360.8481957591;30430.695693043006;2390.6772585700883;2419.4556224849443;2426.4419183587875;2437.171361737018;2437.463757973243;20295.28966486166;20995.475113122142;20998.790012099835;21004.684929726067;21016.789832101636;2550.668413106303;2568.486302739441;2660.9068682596017;2660.9600855987173;2672.038066296132;142630;151053;162324;166263.16868415702;168339;16303.755443668355;16652.75020874688;17147.22837472292;17178.484645460656;17356.91321543384;27083.593746093826;27111;27278.45443091127;27349.179524614294;27397.726022739917;11360.204785664924;11522.884771152349;11628.069754419626;11741.76516469683;11923.224990375598;10414.739631509274;10565.9471702641;10677.359358438518;10687.251892367614;10707.250492465453;10068.496575171359;10135.138513226459;10184.949075254577;10265.178785697126;10583.25917185805;2871.7211355081195;2895.739383455499;2900.2169414258033;2959.7632189424794;3026.2585666511845;1067.514281002142;1074.5648012554927;1082.6427278997912;1100.2628239079836;1106.623747925709;21755.67366489504;22014;22146.778532214794;22221.111155553597;22250.777492225196;1148.3798748675788;1154.2785758900686;1158.1140427572914;1158.5655379232787;1158.9478473468714;11717.76564468723;11811.940940295415;12084.516619335129;12108.515659373703;12163.391830408622;651504;658688;660970;661566;672634;137873.31063344819;140514.2974285122;141806;142382;143537.28231358985;1265.7721610110084;1271.8028705550655;1290.0969321475004;1293.5860524632028;1302.3358087375318;19609.215631374584;19846.01539846004;19921.402357929284;19929;20161.495962601053;64842;66128.66935665291;66458;68154;69433.65283173753;84611.5769421149;84698;85484.57257713671;85487.57256213679;85569.57215213885;15640.92179539095;15796;15808.209589520708;15957.840421595636;16043.278052487432;23897.641535376635;24347.634785477876;24351.878240608683;24384.146554870495;24461.877690611433;19593.412197634094;19795.508380558327;19824.405267841987;20085.598288033867;20099.598008039466;17204.31182752676;17362;17813.109344532983;18100.45698629043;18140.45578632643;18268.36060737868;18702;20177.495562610464;20248.291309804084;20668.379948601567;15451.150186739387;15570.610734731723;15705.528834134995;15740.134292613559;15743.370265189264;18989.43031708996;19307.90346048261;19367.612647746686;19459.51351216231;19474.610507789483 13:37:48 INFO - PID 19379 | |3;mootools.html;1433.9569812905613;1475.107559926244;1488.1220080152707;1497.0269324938788;1504.0374160537258;16976.151192440375;17612.559686007855;17617.82382176178;17676.823231767677;17685.115744212788;17793.199306031227;17845.464636060908;17847.46457606274;17921.731174032368;17929.193186306617;3103.6120484939383;3147.2446612812873;3193.8882139125135;3197.792143510676;3198.6641402652735;3096.040227529473;3097.4269760094344;3132.1386618679817;3132.3578666373337;3134.13811201919;3060.02079334613;3125.484295091307;3224.5808044954124;3227;3229.079712282;3237.7247933925646;3245.5618491503583;3255.625603055655;3269.6893795089427;3284.8357582120916;3024.9243768905953;3063.3107550801114;3078.846057697129;3108.984455077733;3111.595492585949;16976.151192440328;17217.569560760956;17334.306627734877;17376.04431756253;17399.913000435045;9135.223506001998;9488.478133702643;9488.573014214377;9493.620255189784;9538.52307384628;6149.262088549358;6311.842203944938;6388.2334119905445;6500.284968653445;6503.154589903283;2099.6379073542266;2133.5092928626505;2162.98339780303;2189.6496560550236;2198.6482162853868;31641.683583164104;31773.52339714906;31798.682013179805;31918;32028.839855800572;7511.924880751232;7725.381969442431;7979.8404031919035;8007.239312265326;8181.304589109874;20600.38198854037;20646.17415303371;20683.793162068487;20714.275000374913;20723.689144662843;9185.311101667401;9262.444253344685;9265.814683706423;9278.62885484573;9282.211012063915;8264.628091735887;8312.459690120122;8464.661413543512;8540.658373664985;8541.829163416696;6116.29662588808;6159.722812473449;6175.752969881154;6217.036359364306;6299.937000630027;1650.9587260318588;1730.6019615488256;1765.8675599330102;1800.9549761256073;1804.6029873428088;999.0658734083655;1029.9330543514798;1030.4332617060586;1031.7523794289316;1036.1762398892897;10287.22845786569;10389.896101038892;10471.109955653856;10477.423741694127;10539.57841686324;823.4194892600702;832.3840358134937;840.2185967050701;848.9193526614962;883.9790042500922;6252.5935814171935;6499.967500162564;6562.704678289489;6653.833654158685;6670.199576050905;25585;26457.33856653599;26608.60087098695;26644.333891652863;26653.20040398791;25006.37484062913;25994.220173394828;26112.73887261103;26177.73822261753;26224;13032.218066916015;13081.149725267827;13194.472221111047;13302.401391937387;13359.398827052806;10018.499075046073;10130.341527800669;10173.949130254301;10252.231082668979;10268.178545716473;21855.344339669835;22474.550508990054;22586.435339115997;22620.321390358316;22939.96770145314;23190.42023949415;23218.76781232166;23308.76691233134;23564.41088972721;23997.28008159758;12660.683482913;12685.619431417072;12726.300053497147;12818.87181128214;12829.67925801825;16283.755743664091;16409.753853692444;16445.09551974653;16458.42395516151;16460.42388516444;12825.486980520674;12882.871171288167;12887.93556032214;12905.483780648668;13027.08810383264;11929.701757456132;12213.633590992284;12686.873131268938;12943.676408089497;13011.414486347947;10194.286399952229;10353.171746260432;10372.844407334047;10391.948040259751;10444.582216711246;8728.56357182151;8853.203211710977;8870.467771933705;8926.285897128084;8950.418222815497;8337.458065225741;8369.121242269717;8481.982162140583;8547.230749232598;8552.615132319184 13:37:48 INFO - PID 19379 | |4;prototype.html;567.3787203012699;569.8803251317224;570.4894119762812;589.9646021238726;607.1590846677353;6432.742690292389;6474.510862501622;6480.2179400664845;6625.238097618775;6631.900521492169;6419.165508483902;6482.448991835699;6484.087194277688;6489.123968264283;6501.609903405787;5348.518633323;5366.624336296461;5370.355557333106;5400.513953744162;5423.322084739408;5095.3885533736;5181.4300426953005;5190.079670521912;5227.73861306935;5242.659227150242;5166.225066240057;5173.896522069556;5192.818251361203;5195.376554813428;5225.843224703246;5145.459726728677;5168.121419358718;5171.612129090315;5216.087184742655;5244.265802787613;4766.094442055998;4766.976165119152;4772.331873537708;4777.355057067321;4786.449558300805;6303.684815759194;6410.134631824691;6448.484121270334;6458.7093580788505;6530;5928.822135335947;6120.663363515005;6128.846778830521;6153.784617538365;6156.4766994805495;6861.622610756406;6875.48433867462;6967.372936435694;6971.570827980303;6999.040268724765;5109.4379618241965;5299.788008479656;5312.681239125626;5313.38896026958;5336.665833541615;6926.203486599055;7136.607486588236;7142.678604458192;7185.8143406337895;7214.278572142849;5413.729313534308;5429.104197807317;5451.318585176853;5482.5613950883835;5490.615656903979;5454.781808727606;5455.890882182334;5520.1443776214755;5529.917051244234;5550.639208451518;6079.75680972765;6096.542759293071;6144.41628045335;6153.323304362617;6163.3836616338;7014;7037.120359955005;7046.224915259318;7051.153861536648;7086.681099350541;1880.1351378365832;1880.4170707080848;1893.5171531259716;1916.7604049493814;1928.7366774762554;1293.8964882809353;1331.4541038174302;1333.7999300105062;1358.5720498043283;1368.7339211229573;6340;6392.680365981682;6468.8059358219325;6539.607623542603;6542.803715888531;6893.620850853151;6899.17209934801;6915.412189963909;6968.233494315621;7006.4044556212275;6471.644059576674;6538.248101468297;6559.409653131241;6577.704003319862;6589.374009469093;3663.3183650431147;3726.795026273581;3731.3097077040834;3741.8316175772156;3747.306748251582;7160.391366733782;7198.5320954137815;7205.423566114699;7327.413806895435;7378.188399276075;7177.7487787927175;7179.89230161548;7195.316444937723;7242.96378518104;7301.853962920712;7179.78460646171;7219.411729419519;7255.419566434567;7292.8906066409045;7313.670884810196;6888;6902.171739391305;7008.649567521706;7021.508494405342;7036.437085033082;6958.617276049866;6993.3216028151855;7027.754028608974;7042.612656303748;7056.2359410147465;7297.270272972661;7325.230850760593;7330.193678695233;7331.670074846538;7378.926210737824;5445.700486473282;5452.26394436746;5460.3993560707495;5469.972650136724;5476.644018138808;6616.536842420985;6758.290379510081;7024.789256322319;7134.964325178341;7178.605176715122;6802;6813.466969931924;6817.693203805939;6842.213145488333;6907.861842763217;6799.966000169968;6864.622445765531;6885.793426197222;6899.102007365822;6942.166939967236;6773.89839152423;6829.112215411965;6843.726250949906;6871.759488417882;6924.480663950325;6857.965710171417;6908.5509441886115;6975.686094125675;6991.965040174767;7014;6569.80290591283;6691.230508491586;6695.799126026227;6737.663116844236;6743.123393958754 13:37:48 INFO - PID 19379 | |5;yui.html;996.7259003773966;1014.5890914179756;1029.1612335946204;1038.94805259737;1053.7418332508537;19881.3041543546;20600.89699551502;20618.38144855653;20643.17427302906;20649.587008259863;19671.114799834006;19814.306499272527;19851.7096388735;19885.105170267336;19896.90051549744;1036.9844452333202;1062.6493257225097;1071.6517131932114;1072.6942821295913;1074.511097450662;1076.3757020927883;1076.8115579773548;1084.2139448899525;1086.3427626286102;1088.1023155896378;1114.760326529796;1175.97648047039;1179.257068047129;1183.3018519073744;1184.2420850655587;1157.2015309436463;1161.1929708852351;1162.482695200636;1162.4885050577718;1162.9534818607247;829.2578142562434;837.3761547646981;840.0255703384045;840.5839109640706;841.1126261793805;18636.72044919327;21007.159713611436;22004.88997555002;22209.777902221093;22217;22872.7712722874;23276.418089547726;23278.3016509505;23378;23404.18085367021;17019.744703829452;17254.91372543142;17270.13649317529;17292;17292.827071729247;3936.9015774605577;4029.435878976946;4103.4870641169855;4153.709240353177;4157.771322577257;121358;124631.37684311612;155069;155371;159164;18655.253789848255;18892.622147556973;18977.715334269997;19128.52178695516;19158.23367065302;34860;34967;35116.29767404638;35246.11884702903;35274.118147046014;10773.19201059908;10825.945870270756;10833.458327083614;10856.457177141112;10874.45627718611;4832.975835120872;4887.36464259644;4964.553190212898;4966.602671786321;4973.030259099441;6094.116353128771;6247.531435142382;6247.9062814057825;6249.375062493714;6254.874902501924;1260.332024027267;1308.234682710606;1319.6700824793802;1320.0957344219241;1320.3662242123835;771.8456308738275;772.6291380137566;783.8706613408838;792.9841403171904;793.757903839323;13851.445942162401;14205;14983.250837458083;15088.24558772057;15143.242837858063;752.6838727734255;756.3079781999409;758.7496126278315;769.7036640893297;776.0299625468165;6353.428191462791;6512.772052978123;6520.0871877937125;6532.902006469907;6631.900521492182;147991;149242.25378873255;150036.24981875022;151215;153318;122575;123514;133637;134511;135249;113776;115640.42179789215;115710;116157.8384216164;118588;12682.365881705693;13271.734565308447;13372.732545348845;13554.72890542164;13635.181889086687;54704.45295546993;54925.17612235899;55146.72426637841;56107;56507.15239271496;92207.53896230475;93156;94353.5282323584;94549.52725236605;102464;21538.784612154304;21654.24210152637;21724;21772.67340989918;21895.233666821583;24041;24251.878740606186;24296.51406971886;24811.875940620183;25004.37489062788;20818.895905520374;21156.25953091696;21673.133074676836;22157.556848863256;22242.110315587197;17651.735223971395;17724.734128987817;20134.395968120978;20513.38459846207;20910.47723806856;18799.90600046991;18892.811071889104;18933.148008339933;19225.903870480557;21616.567668646854;13391.055691447775;13774;13968.371423285773;14002.229877356844;14182.361793719101;14168.291585420893;14280.357383917957;14295.857041429452;14886.85113148898;14928.626784330045 13:37:48 INFO - PID 19379 | __end_tp_report 13:37:48 INFO - PID 19379 | __start_cc_report 13:37:48 INFO - PID 19379 | _x_x_mozilla_cycle_collect,249 13:37:48 INFO - PID 19379 | __end_cc_report 13:37:48 INFO - PID 19379 | __startTimestamp1506199068776__endTimestamp 13:37:48 INFO - PID 19379 | 13:37:48 INFO - PID 19379 | ------- Summary: start ------- 13:37:48 INFO - PID 19379 | Number of tests: 6 13:37:48 INFO - PID 19379 | 13:37:48 INFO - PID 19379 | [#0] dojo.html Cycles:165 Average:6662.62 Median:6905.65 stddev:772.50 (11.2%) stddev-sans-first:746.56 13:37:48 INFO - PID 19379 | Values: 4021.1 4030.7 4031.4 4034.0 4052.3 6513.0 6524.2 6576.6 6674.5 6680.8 6595.8 6601.8 6614.7 6679.3 6682.5 5887.8 5957.9 5960.0 5971.7 6023.4 5950.7 5967.3 6002.5 6090.7 6098.9 6005.7 6044.8 6097.2 6102.7 6106.2 5934.6 5993.9 6041.2 6070.1 6089.5 5848.7 5860.8 5864.5 5942.7 5953.7 6528.2 6593.3 6596.6 6616.5 6632.3 7198.5 7199.1 7276.5 7278.8 7309.8 7097.6 7209.6 7211.3 7235.0 7290.9 6745.5 6752.6 6758.3 6760.7 6762.6 7294.2 7432.5 7450.6 7481.1 7528.7 6972.2 7088.6 7115.2 7123.0 7203.4 7248.1 7264.2 7292.3 7319.0 7326.6 7090.4 7193.5 7238.2 7277.5 7286.2 7119.3 7142.1 7156.3 7217.2 7271.3 5308.2 5356.0 5358.0 5358.7 5381.0 4868.4 4921.8 4923.5 4977.4 4991.6 6565.5 6718.0 6745.5 6748.6 6817.6 6983.3 7134.8 7144.4 7195.7 7232.5 6675.2 6764.3 6764.8 6771.2 6789.0 6176.7 6188.5 6249.5 6256.5 6257.6 7339.1 7367.9 7463.1 7473.6 7582.6 7162.5 7202.1 7263.9 7278.9 7289.0 7456.7 7469.5 7545.1 7563.1 7590.2 7001.4 7077.0 7186.7 7198.6 7221.4 7092.1 7181.7 7236.5 7245.7 7263.1 7021.5 7041.2 7092.7 7098.4 7110.3 6929.3 6950.8 6958.7 7037.3 7052.0 6841.1 6863.9 6905.7 6936.2 6986.6 7011.6 7094.6 7113.0 7114.3 7118.7 6813.0 6829.1 6868.9 6898.3 6904.8 13:37:48 INFO - PID 19379 | 13:37:48 INFO - PID 19379 | [#1] ext.html Cycles:180 Average:46121.50 Median:3730.56 stddev:71394.37 (1913.8%) stddev-sans-first:71514.23 13:37:48 INFO - PID 19379 | Values: 989.0 1010.2 1034.5 1043.3 1045.6 45996.5 46934.8 47010.5 47060.3 47137.8 44568.8 44613.0 46474.0 47112.3 47181.0 8750.3 8867.6 8870.6 8892.6 8905.5 8527.5 8527.6 8533.1 8572.5 8589.1 8549.0 8648.8 8651.5 8652.5 8677.4 8522.4 8579.7 8612.4 8646.9 8647.0 8588.7 8588.9 8620.0 8654.0 8660.3 43302.6 43310.8 43416.1 43617.1 43723.8 3708.9 3730.1 3731.0 3743.0 3749.7 34550.1 34715.8 34761.3 34780.5 34829.1 5621.2 5629.0 5641.6 5644.8 5676.2 233880.0 238369.0 248879.0 249480.0 263547.0 55961.4 56402.0 56482.0 56497.0 56549.2 58462.0 58880.7 58997.4 59000.7 59022.4 18454.3 18608.8 18615.3 18628.0 18790.8 15522.4 15551.8 15583.1 15590.1 15603.7 15122.7 15131.4 15160.8 15212.2 15312.8 5409.5 5526.4 5556.4 5632.3 5643.7 1101.5 1111.1 1114.1 1118.8 1131.9 26673.9 26847.2 26869.6 26932.3 27111.7 1209.7 1230.6 1232.0 1235.8 1237.9 13978.6 14039.5 14039.7 14154.2 14307.6 306562.0 317735.0 320428.0 320695.0 321490.0 64158.0 64169.4 64386.7 64797.7 64814.4 1530.7 1538.9 1551.8 1552.0 1555.4 30728.1 31012.4 31196.3 31314.0 31967.0 43888.0 43897.3 43958.0 43992.6 44065.6 251823.0 251895.0 252057.0 252314.0 253305.0 38005.8 38702.8 38892.0 38916.6 39449.8 47961.8 49853.3 49982.5 50485.2 50760.0 36085.5 36101.5 36147.3 36369.6 36606.5 35760.0 35974.6 36263.8 36431.3 36907.0 41858.6 41916.6 42087.4 42214.6 42374.0 34807.8 34808.3 35201.3 35248.5 35475.3 25810.5 25854.5 26026.7 26399.5 26577.5 13:37:48 INFO - PID 19379 | 13:37:48 INFO - PID 19379 | [#2] jquery.html Cycles:180 Average:42271.11 Median:21884.84 stddev:110524.52 (505.0%) stddev-sans-first:110790.34 13:37:48 INFO - PID 19379 | Values: 626.4 631.5 633.3 633.7 646.7 23272.4 23643.0 23830.9 24421.0 24423.8 25696.7 26163.3 26184.2 26206.3 26213.2 6619.4 6877.2 7063.5 7086.5 7087.3 6704.1 6738.1 6742.7 6743.1 6750.0 6646.3 6648.6 6680.0 6682.8 6733.8 6670.8 6712.8 6715.0 6743.6 6747.3 6257.6 6276.9 6291.3 6300.1 6303.6 28812.3 29594.6 30130.0 30360.8 30430.7 2390.7 2419.5 2426.4 2437.2 2437.5 20295.3 20995.5 20998.8 21004.7 21016.8 2550.7 2568.5 2660.9 2661.0 2672.0 142630.0 151053.0 162324.0 166263.2 168339.0 16303.8 16652.8 17147.2 17178.5 17356.9 27083.6 27111.0 27278.5 27349.2 27397.7 11360.2 11522.9 11628.1 11741.8 11923.2 10414.7 10565.9 10677.4 10687.3 10707.3 10068.5 10135.1 10184.9 10265.2 10583.3 2871.7 2895.7 2900.2 2959.8 3026.3 1067.5 1074.6 1082.6 1100.3 1106.6 21755.7 22014.0 22146.8 22221.1 22250.8 1148.4 1154.3 1158.1 1158.6 1158.9 11717.8 11811.9 12084.5 12108.5 12163.4 651504.0 658688.0 660970.0 661566.0 672634.0 137873.3 140514.3 141806.0 142382.0 143537.3 1265.8 1271.8 1290.1 1293.6 1302.3 19609.2 19846.0 19921.4 19929.0 20161.5 64842.0 66128.7 66458.0 68154.0 69433.7 84611.6 84698.0 85484.6 85487.6 85569.6 15640.9 15796.0 15808.2 15957.8 16043.3 23897.6 24347.6 24351.9 24384.1 24461.9 19593.4 19795.5 19824.4 20085.6 20099.6 17204.3 17362.0 17813.1 18100.5 18140.5 18268.4 18702.0 20177.5 20248.3 20668.4 15451.2 15570.6 15705.5 15740.1 15743.4 18989.4 19307.9 19367.6 19459.5 19474.6 13:37:48 INFO - PID 19379 | 13:37:48 INFO - PID 19379 | [#3] mootools.html Cycles:180 Average:11017.14 Median:25789.61 stddev:8032.96 (31.1%) stddev-sans-first:8023.23 13:37:48 INFO - PID 19379 | Values: 1434.0 1475.1 1488.1 1497.0 1504.0 16976.2 17612.6 17617.8 17676.8 17685.1 17793.2 17845.5 17847.5 17921.7 17929.2 3103.6 3147.2 3193.9 3197.8 3198.7 3096.0 3097.4 3132.1 3132.4 3134.1 3060.0 3125.5 3224.6 3227.0 3229.1 3237.7 3245.6 3255.6 3269.7 3284.8 3024.9 3063.3 3078.8 3109.0 3111.6 16976.2 17217.6 17334.3 17376.0 17399.9 9135.2 9488.5 9488.6 9493.6 9538.5 6149.3 6311.8 6388.2 6500.3 6503.2 2099.6 2133.5 2163.0 2189.6 2198.6 31641.7 31773.5 31798.7 31918.0 32028.8 7511.9 7725.4 7979.8 8007.2 8181.3 20600.4 20646.2 20683.8 20714.3 20723.7 9185.3 9262.4 9265.8 9278.6 9282.2 8264.6 8312.5 8464.7 8540.7 8541.8 6116.3 6159.7 6175.8 6217.0 6299.9 1651.0 1730.6 1765.9 1801.0 1804.6 999.1 1029.9 1030.4 1031.8 1036.2 10287.2 10389.9 10471.1 10477.4 10539.6 823.4 832.4 840.2 848.9 884.0 6252.6 6500.0 6562.7 6653.8 6670.2 25585.0 26457.3 26608.6 26644.3 26653.2 25006.4 25994.2 26112.7 26177.7 26224.0 13032.2 13081.1 13194.5 13302.4 13359.4 10018.5 10130.3 10173.9 10252.2 10268.2 21855.3 22474.6 22586.4 22620.3 22940.0 23190.4 23218.8 23308.8 23564.4 23997.3 12660.7 12685.6 12726.3 12818.9 12829.7 16283.8 16409.8 16445.1 16458.4 16460.4 12825.5 12882.9 12887.9 12905.5 13027.1 11929.7 12213.6 12686.9 12943.7 13011.4 10194.3 10353.2 10372.8 10391.9 10444.6 8728.6 8853.2 8870.5 8926.3 8950.4 8337.5 8369.1 8482.0 8547.2 8552.6 13:37:48 INFO - PID 19379 | 13:37:48 INFO - PID 19379 | [#4] prototype.html Cycles:180 Average:5884.63 Median:6515.80 stddev:1638.85 (25.2%) stddev-sans-first:1594.11 13:37:48 INFO - PID 19379 | Values: 567.4 569.9 570.5 590.0 607.2 6432.7 6474.5 6480.2 6625.2 6631.9 6419.2 6482.4 6484.1 6489.1 6501.6 5348.5 5366.6 5370.4 5400.5 5423.3 5095.4 5181.4 5190.1 5227.7 5242.7 5166.2 5173.9 5192.8 5195.4 5225.8 5145.5 5168.1 5171.6 5216.1 5244.3 4766.1 4767.0 4772.3 4777.4 4786.4 6303.7 6410.1 6448.5 6458.7 6530.0 5928.8 6120.7 6128.8 6153.8 6156.5 6861.6 6875.5 6967.4 6971.6 6999.0 5109.4 5299.8 5312.7 5313.4 5336.7 6926.2 7136.6 7142.7 7185.8 7214.3 5413.7 5429.1 5451.3 5482.6 5490.6 5454.8 5455.9 5520.1 5529.9 5550.6 6079.8 6096.5 6144.4 6153.3 6163.4 7014.0 7037.1 7046.2 7051.2 7086.7 1880.1 1880.4 1893.5 1916.8 1928.7 1293.9 1331.5 1333.8 1358.6 1368.7 6340.0 6392.7 6468.8 6539.6 6542.8 6893.6 6899.2 6915.4 6968.2 7006.4 6471.6 6538.2 6559.4 6577.7 6589.4 3663.3 3726.8 3731.3 3741.8 3747.3 7160.4 7198.5 7205.4 7327.4 7378.2 7177.7 7179.9 7195.3 7243.0 7301.9 7179.8 7219.4 7255.4 7292.9 7313.7 6888.0 6902.2 7008.6 7021.5 7036.4 6958.6 6993.3 7027.8 7042.6 7056.2 7297.3 7325.2 7330.2 7331.7 7378.9 5445.7 5452.3 5460.4 5470.0 5476.6 6616.5 6758.3 7024.8 7135.0 7178.6 6802.0 6813.5 6817.7 6842.2 6907.9 6800.0 6864.6 6885.8 6899.1 6942.2 6773.9 6829.1 6843.7 6871.8 6924.5 6858.0 6908.6 6975.7 6992.0 7014.0 6569.8 6691.2 6695.8 6737.7 6743.1 13:37:48 INFO - PID 19379 | 13:37:48 INFO - PID 19379 | [#5] yui.html Cycles:180 Average:29194.18 Median:19192.07 stddev:41702.17 (217.3%) stddev-sans-first:41765.41 13:37:48 INFO - PID 19379 | Values: 996.7 1014.6 1029.2 1038.9 1053.7 19881.3 20600.9 20618.4 20643.2 20649.6 19671.1 19814.3 19851.7 19885.1 19896.9 1037.0 1062.6 1071.7 1072.7 1074.5 1076.4 1076.8 1084.2 1086.3 1088.1 1114.8 1176.0 1179.3 1183.3 1184.2 1157.2 1161.2 1162.5 1162.5 1163.0 829.3 837.4 840.0 840.6 841.1 18636.7 21007.2 22004.9 22209.8 22217.0 22872.8 23276.4 23278.3 23378.0 23404.2 17019.7 17254.9 17270.1 17292.0 17292.8 3936.9 4029.4 4103.5 4153.7 4157.8 121358.0 124631.4 155069.0 155371.0 159164.0 18655.3 18892.6 18977.7 19128.5 19158.2 34860.0 34967.0 35116.3 35246.1 35274.1 10773.2 10825.9 10833.5 10856.5 10874.5 4833.0 4887.4 4964.6 4966.6 4973.0 6094.1 6247.5 6247.9 6249.4 6254.9 1260.3 1308.2 1319.7 1320.1 1320.4 771.8 772.6 783.9 793.0 793.8 13851.4 14205.0 14983.3 15088.2 15143.2 752.7 756.3 758.7 769.7 776.0 6353.4 6512.8 6520.1 6532.9 6631.9 147991.0 149242.3 150036.2 151215.0 153318.0 122575.0 123514.0 133637.0 134511.0 135249.0 113776.0 115640.4 115710.0 116157.8 118588.0 12682.4 13271.7 13372.7 13554.7 13635.2 54704.5 54925.2 55146.7 56107.0 56507.2 92207.5 93156.0 94353.5 94549.5 102464.0 21538.8 21654.2 21724.0 21772.7 21895.2 24041.0 24251.9 24296.5 24811.9 25004.4 20818.9 21156.3 21673.1 22157.6 22242.1 17651.7 17724.7 20134.4 20513.4 20910.5 18799.9 18892.8 18933.1 19225.9 21616.6 13391.1 13774.0 13968.4 14002.2 14182.4 14168.3 14280.4 14295.9 14886.9 14928.6 13:37:48 INFO - PID 19379 | -------- Summary: end -------- 13:37:48 INFO - PID 19379 | 13:37:49 INFO - TEST-INFO | 19379: exit 0 13:37:49 INFO - TEST-OK | dromaeo_css | took 1107229ms 13:37:49 INFO - TEST-START | kraken 13:37:49 INFO - Initialising browser for kraken test... 13:37:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55502/getInfo.html -profile /tmp/tmp9O8Yir/profile 13:37:49 INFO - TEST-INFO | started process 19739 (/builds/slave/test/build/application/firefox/firefox http://localhost:55502/getInfo.html) 13:37:54 INFO - TEST-INFO | 19739: exit 0 13:37:54 INFO - Browser initialized. 13:37:54 INFO - Running cycle 1/1 for kraken test... 13:37:54 INFO - Using env: {'DISPLAY': ':0', 13:37:54 INFO - 'HOME': '/home/cltbld', 13:37:54 INFO - 'JSGC_DISABLE_POISONING': '1', 13:37:54 INFO - 'LANG': 'en_US.UTF-8', 13:37:54 INFO - 'LANGUAGE': 'en_US:en', 13:37:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:37:54 INFO - 'LOGNAME': 'cltbld', 13:37:54 INFO - 'MAIL': '/var/mail/cltbld', 13:37:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:37:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:37:54 INFO - 'MOZ_CRASHREPORTER': '1', 13:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:37:54 INFO - 'MOZ_NO_REMOTE': '1', 13:37:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:54 INFO - 'NO_EM_RESTART': '1', 13:37:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:54 INFO - 'PWD': '/builds/slave/test', 13:37:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:37:54 INFO - 'RUST_BACKTRACE': 'full', 13:37:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:37:54 INFO - 'SHELL': '/bin/bash', 13:37:54 INFO - 'SHLVL': '1', 13:37:54 INFO - 'TERM': 'linux', 13:37:54 INFO - 'TMOUT': '86400', 13:37:54 INFO - 'USER': 'cltbld', 13:37:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695', 13:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:54 INFO - '_': '/tools/buildbot/bin/python'} 13:37:54 INFO - TEST-INFO | started process 19931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9O8Yir/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:38:05 INFO - PID 19931 | RSS: Main: 144547840 13:38:05 INFO - PID 19931 | 13:38:08 INFO - PID 19931 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55502/tests/kraken/driver.html?testName=audio-beat-detection) 13:38:09 INFO - PID 19931 | RSS: Main: 150302720 13:38:09 INFO - PID 19931 | 13:38:11 INFO - PID 19931 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55502/tests/kraken/driver.html?testName=audio-dft) 13:38:12 INFO - PID 19931 | RSS: Main: 150360064 13:38:12 INFO - PID 19931 | 13:38:15 INFO - PID 19931 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55502/tests/kraken/driver.html?testName=audio-fft) 13:38:15 INFO - PID 19931 | RSS: Main: 152199168 13:38:15 INFO - PID 19931 | 13:38:17 INFO - PID 19931 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55502/tests/kraken/driver.html?testName=audio-oscillator) 13:38:18 INFO - PID 19931 | RSS: Main: 152051712 13:38:18 INFO - PID 19931 | 13:38:20 INFO - PID 19931 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:38:20 INFO - PID 19931 | RSS: Main: 151810048 13:38:20 INFO - PID 19931 | 13:38:24 INFO - PID 19931 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55502/tests/kraken/driver.html?testName=imaging-darkroom) 13:38:24 INFO - PID 19931 | RSS: Main: 151584768 13:38:24 INFO - PID 19931 | 13:38:28 INFO - PID 19931 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55502/tests/kraken/driver.html?testName=imaging-desaturate) 13:38:28 INFO - PID 19931 | RSS: Main: 154075136 13:38:28 INFO - PID 19931 | 13:38:31 INFO - PID 19931 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55502/tests/kraken/driver.html?testName=json-parse-financial) 13:38:32 INFO - PID 19931 | RSS: Main: 154443776 13:38:32 INFO - PID 19931 | 13:38:33 INFO - PID 19931 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:38:34 INFO - PID 19931 | RSS: Main: 155152384 13:38:34 INFO - PID 19931 | 13:38:35 INFO - PID 19931 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:38:36 INFO - PID 19931 | RSS: Main: 154537984 13:38:36 INFO - PID 19931 | 13:38:38 INFO - PID 19931 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:38:39 INFO - PID 19931 | RSS: Main: 151785472 13:38:39 INFO - PID 19931 | 13:38:41 INFO - PID 19931 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:38:41 INFO - PID 19931 | RSS: Main: 151359488 13:38:41 INFO - PID 19931 | 13:38:44 INFO - PID 19931 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:38:45 INFO - PID 19931 | RSS: Main: 152174592 13:38:45 INFO - PID 19931 | 13:38:46 INFO - PID 19931 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55502/tests/kraken/driver.html?testName=ai-astar) 13:38:47 INFO - PID 19931 | RSS: Main: 153669632 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | __start_tp_report 13:38:47 INFO - PID 19931 | _x_x_mozilla_page_load 13:38:47 INFO - PID 19931 | _x_x_mozilla_page_load_details 13:38:47 INFO - PID 19931 | |i|pagename|runs| 13:38:47 INFO - PID 19931 | |0;ai-astar;104;104;104;104;106;108;106;106;105;105 13:38:47 INFO - PID 19931 | |1;audio-beat-detection;111;112;116;112;114;112;140;109;114;115 13:38:47 INFO - PID 19931 | |2;audio-dft;161;160;160;162;162;163;161;161;161;162 13:38:47 INFO - PID 19931 | |3;audio-fft;73;72;74;73;72;72;72;72;81;73 13:38:47 INFO - PID 19931 | |4;audio-oscillator;77;76;76;78;83;77;77;78;79;77 13:38:47 INFO - PID 19931 | |5;imaging-gaussian-blur;115;114;111;113;114;114;114;114;113;114 13:38:47 INFO - PID 19931 | |6;imaging-darkroom;151;152;148;156;149;150;147;148;149;148 13:38:47 INFO - PID 19931 | |7;imaging-desaturate;93;94;94;94;93;93;94;94;99;94 13:38:47 INFO - PID 19931 | |8;json-parse-financial;44;42;43;42;42;42;43;48;42;42 13:38:47 INFO - PID 19931 | |9;json-stringify-tinderbox;39;38;38;38;38;38;38;39;38;38 13:38:47 INFO - PID 19931 | |10;stanford-crypto-aes;68;69;68;68;74;68;71;71;69;67 13:38:47 INFO - PID 19931 | |11;stanford-crypto-ccm;111;101;111;101;102;107;106;101;104;107 13:38:47 INFO - PID 19931 | |12;stanford-crypto-pbkdf2;154;154;153;143;146;146;148;151;151;145 13:38:47 INFO - PID 19931 | |13;stanford-crypto-sha256-iterative;61;57;57;60;62;57;58;62;56;58 13:38:47 INFO - PID 19931 | __end_tp_report 13:38:47 INFO - PID 19931 | __start_cc_report 13:38:47 INFO - PID 19931 | _x_x_mozilla_cycle_collect,703 13:38:47 INFO - PID 19931 | __end_cc_report 13:38:47 INFO - PID 19931 | __startTimestamp1506199127136__endTimestamp 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | ------- Summary: start ------- 13:38:47 INFO - PID 19931 | Number of tests: 14 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | [#0] ai-astar Cycles:10 Average:105.20 Median:105.50 stddev:1.32 (1.2%) stddev-sans-first:1.32 13:38:47 INFO - PID 19931 | Values: 104.0 104.0 104.0 104.0 106.0 108.0 106.0 106.0 105.0 105.0 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | [#1] audio-beat-detection Cycles:10 Average:115.50 Median:114.00 stddev:8.85 (7.8%) stddev-sans-first:9.23 13:38:47 INFO - PID 19931 | Values: 111.0 112.0 116.0 112.0 114.0 112.0 140.0 109.0 114.0 115.0 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 13:38:47 INFO - PID 19931 | Values: 161.0 160.0 160.0 162.0 162.0 163.0 161.0 161.0 161.0 162.0 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.00 stddev:2.76 (3.8%) stddev-sans-first:2.92 13:38:47 INFO - PID 19931 | Values: 73.0 72.0 74.0 73.0 72.0 72.0 72.0 72.0 81.0 73.0 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:77.50 stddev:2.04 (2.6%) stddev-sans-first:2.15 13:38:47 INFO - PID 19931 | Values: 77.0 76.0 76.0 78.0 83.0 77.0 77.0 78.0 79.0 77.0 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:1.01 13:38:47 INFO - PID 19931 | Values: 115.0 114.0 111.0 113.0 114.0 114.0 114.0 114.0 113.0 114.0 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:149.50 stddev:2.66 (1.8%) stddev-sans-first:2.78 13:38:47 INFO - PID 19931 | Values: 151.0 152.0 148.0 156.0 149.0 150.0 147.0 148.0 149.0 148.0 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:1.75 (1.9%) stddev-sans-first:1.80 13:38:47 INFO - PID 19931 | Values: 93.0 94.0 94.0 94.0 93.0 93.0 94.0 94.0 99.0 94.0 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | [#8] json-parse-financial Cycles:10 Average:43.00 Median:42.50 stddev:1.89 (4.4%) stddev-sans-first:1.96 13:38:47 INFO - PID 19931 | Values: 44.0 42.0 43.0 42.0 42.0 42.0 43.0 48.0 42.0 42.0 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.33 13:38:47 INFO - PID 19931 | Values: 39.0 38.0 38.0 38.0 38.0 38.0 38.0 39.0 38.0 38.0 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | [#10] stanford-crypto-aes Cycles:10 Average:69.30 Median:69.00 stddev:2.11 (3.1%) stddev-sans-first:2.19 13:38:47 INFO - PID 19931 | Values: 68.0 69.0 68.0 68.0 74.0 68.0 71.0 71.0 69.0 67.0 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | [#11] stanford-crypto-ccm Cycles:10 Average:105.10 Median:106.50 stddev:3.93 (3.7%) stddev-sans-first:3.54 13:38:47 INFO - PID 19931 | Values: 111.0 101.0 111.0 101.0 102.0 107.0 106.0 101.0 104.0 107.0 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:151.00 stddev:4.01 (2.7%) stddev-sans-first:3.84 13:38:47 INFO - PID 19931 | Values: 154.0 154.0 153.0 143.0 146.0 146.0 148.0 151.0 151.0 145.0 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.80 Median:59.00 stddev:2.25 (3.8%) stddev-sans-first:2.24 13:38:47 INFO - PID 19931 | Values: 61.0 57.0 57.0 60.0 62.0 57.0 58.0 62.0 56.0 58.0 13:38:47 INFO - PID 19931 | -------- Summary: end -------- 13:38:47 INFO - PID 19931 | 13:38:47 INFO - PID 19931 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:38:47 INFO - TEST-INFO | 19931: exit 0 13:38:47 INFO - TEST-OK | kraken | took 58517ms 13:38:47 INFO - SUITE-END | took 1165s 13:38:48 INFO - Completed test suite (00:19:26) 13:38:48 INFO - javascript benchmark 13:38:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9546.614654628582, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4021.0751527148736, 4030.6573941214997, 4031.3751368537874, 4033.959660403395, 4052.250333688268, 6512.967435162824, 6524.2170939487205, 6576.6382848943285, 6674.499412544054, 6680.832979175517, 6595.802125936218, 6601.801945941617, 6614.735410583571, 6679.298673639259, 6682.498812589051, 5887.793927212549, 5957.851053723659, 5959.970200149015, 5971.731272092767, 6023.427774361428, 5950.702464876739, 5967.313758917737, 6002.519798416138, 6090.725917333731, 6098.908516372258, 6005.6997150142315, 6044.758209671608, 6097.176881121036, 6102.725377358008, 6106.175666285039, 5934.5845790794665, 5993.910091348655, 6041.154238406582, 6070.119832624245, 6089.45194932456, 5848.67832269225, 5860.7948721794955, 5864.472197502203, 5942.732577034, 5953.672548009858, 6528.21661400635, 6593.307702691196, 6596.637184954826, 6616.503762217853, 6632.303608121126, 7198.496105272633, 7199.1001124859395, 7276.527025743309, 7278.818029549304, 7309.757341252, 7097.645117744144, 7209.567425954459, 7211.278872112799, 7234.96382518084, 7290.890636640454, 6745.494087943375, 6752.628605426699, 6758.324167583202, 6760.695768690421, 6762.628055456948, 7294.161171465349, 7432.479726419207, 7450.552966822008, 7481.064866891638, 7528.661210245552, 6972.198197207386, 7088.574685518885, 7115.181754098345, 7123.038389817412, 7203.38771204443, 7248.057752492142, 7264.23725508814, 7292.270772922665, 7318.975343451921, 7326.597037163007, 7090.361867431956, 7193.460490463236, 7238.239984801626, 7277.454190935701, 7286.162091359562, 7119.323664251888, 7142.071530700976, 7156.320149585781, 7217.2421895701245, 7271.309225623558, 5308.150695888639, 5356.035913535523, 5357.973210133924, 5358.705271210121, 5380.973095134499, 4868.391451068616, 4921.803127874917, 4923.458419573844, 4977.40271167455, 4991.550760431579, 6565.540412171103, 6717.966410167918, 6745.527813053137, 6748.595084294958, 6817.625030623363, 6983.266756990544, 7134.821629459201, 7144.3927266182955, 7195.7481488148715, 7232.529885557422, 6675.198976122896, 6764.323567643295, 6764.763233286812, 6771.221309549366, 6789.0, 6176.66028368444, 6188.4739797116845, 6249.468795152463, 6256.468200202943, 6257.56197066201, 7339.082614673166, 7367.8894816577795, 7463.067116610424, 7473.6263186841525, 7582.582957937256, 7162.462815288978, 7202.099737532809, 7263.927360726537, 7278.890816637861, 7289.015982842248, 7456.664450099867, 7469.477136600386, 7545.056867891513, 7563.130240022248, 7590.240975902366, 7001.439884809305, 7077.035021355528, 7186.748463803742, 7198.640067996684, 7221.350078492961, 7092.113485814273, 7181.712731490891, 7236.457265704988, 7245.710171593288, 7263.128424589083, 7021.508494405342, 7041.225465198926, 7092.680829362795, 7098.396636285974, 7110.253423390676, 6929.272426395156, 6950.756723514653, 6958.7216511341, 7037.331453511908, 7052.047973523714, 6841.110655614738, 6863.862722745617, 6905.654717264017, 6936.237013928565, 6986.615736134561, 7011.579305241702, 7094.6097964612445, 7113.0, 7114.324139206767, 7118.715251390094, 6813.0461735358085, 6829.112215412163, 6868.931310686829, 6898.310168983062, 6904.792856214322], "value": 6610.865136903315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [988.9604415823368, 1010.2271762101992, 1034.4827586206898, 1043.332267348897, 1045.6078970386104, 45996.540034599646, 46934.765326173365, 47010.529894701045, 47060.29409558855, 47137.7643111784, 44568.77715611417, 44613.0, 46474.0, 47112.29331560021, 47181.0, 8750.343724220676, 8867.645294188256, 8870.556472176399, 8892.555372231394, 8905.510196939165, 8527.530985795778, 8527.573621318908, 8533.146685331449, 8572.485650860968, 8589.09814469481, 8548.957255213747, 8648.827023459527, 8651.524166170859, 8652.48085114892, 8677.392582519225, 8522.40343175978, 8579.656813727475, 8612.39713220078, 8646.870296945552, 8646.956765216197, 8588.69939552119, 8588.8711669325, 8620.0, 8654.00478944923, 8660.307175426015, 43302.56697433017, 43310.78344608288, 43416.13167736659, 43617.127657446676, 43723.78138109289, 3708.87018954338, 3730.123420996064, 3731.0, 3743.0, 3749.6812770914503, 34550.136246593785, 34715.82642086798, 34761.30477390438, 34780.478292825625, 34829.12927176816, 5621.213030175779, 5628.971855140739, 5641.605087643867, 5644.774209031634, 5676.205331253628, 233880.0, 238369.0, 248879.0, 249480.0, 263547.0, 55961.440385596434, 56402.0, 56482.0, 56497.0, 56549.151762723595, 58462.0, 58880.705596471744, 58997.41002590005, 59000.70499647474, 59022.40977590169, 18454.26182952667, 18608.81391186098, 18615.348462803737, 18628.0, 18790.81209187918, 15522.37910483568, 15551.844481555267, 15583.06501609907, 15590.064596124043, 15603.687926241639, 15122.697546049238, 15131.394744210109, 15160.772588411182, 15212.239388030775, 15312.770308445382, 5409.486098820606, 5526.424968883849, 5556.416576259516, 5632.295963004624, 5643.689597072201, 1101.5373543111912, 1111.127764704703, 1114.0975809594254, 1118.7706520163347, 1131.9377434241196, 26673.915645824127, 26847.194584162506, 26869.596956045283, 26932.326691832863, 27111.72888271092, 1209.6915286601861, 1230.5693007447321, 1232.0, 1235.7713822942785, 1237.8824011718873, 13978.580642580739, 14039.50861719835, 14039.719205615831, 14154.221517816413, 14307.642308942151, 306562.0, 317735.0, 320428.0, 320695.0, 321490.0, 64158.0, 64169.35830641727, 64386.67806660937, 64797.676011620584, 64814.35185648177, 1530.6785575029146, 1538.9153596552073, 1551.7672349147717, 1552.0377366032906, 1555.4089446010444, 30728.078157655305, 31012.379752404373, 31196.31321727493, 31314.0, 31967.0, 43888.0, 43897.34153987757, 43958.0, 43992.56007439885, 44065.559344406145, 251823.0, 251895.0, 252057.0, 252314.0, 253305.0, 38005.809970949966, 38702.80648596739, 38892.0, 38916.610833891296, 39449.80275098721, 47961.760191200214, 49853.252201217736, 49982.50017499778, 50485.242721358474, 50760.0, 36085.45871811872, 36101.45847812337, 36147.27705445929, 36369.636303636624, 36606.45090323594, 35760.0, 35974.640253598176, 36263.81868090643, 36431.27137457183, 36907.0, 41858.58141418547, 41916.580834192486, 42087.36868946907, 42214.57785422107, 42374.0, 34807.82596087003, 34808.30383392369, 35201.29597407986, 35248.47127293144, 35475.29049418945, 25810.483790323713, 25854.482910342063, 26026.739732602433, 26399.472010559297, 26577.468450631266], "value": 19677.141613413987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.3611116661006, 631.4632562322026, 633.2749002392264, 633.7116611941564, 646.6766616691655, 23272.41818954527, 23643.0, 23830.880845595748, 24420.999999999978, 24423.75576244237, 25696.74303256967, 26163.3459163521, 26184.214473565775, 26206.344841378974, 26213.21360359192, 6619.404253617174, 6877.243503214642, 7063.505554611179, 7086.503944723871, 7087.291270872897, 6704.094947182141, 6738.12404387429, 6742.662866856637, 6743.089682892795, 6750.0, 6646.335366463363, 6648.634325112117, 6680.031395447657, 6682.832929176785, 6733.797986060426, 6670.799876003728, 6712.765053223138, 6714.966425167867, 6743.595384276935, 6747.291534388867, 6257.624542527463, 6276.937230627681, 6291.276503202144, 6300.054991751228, 6303.621782693053, 28812.279693007633, 29594.556081658793, 30130.0, 30360.8481957591, 30430.695693043006, 2390.6772585700883, 2419.4556224849443, 2426.4419183587875, 2437.171361737018, 2437.463757973243, 20295.28966486166, 20995.475113122142, 20998.790012099835, 21004.684929726067, 21016.789832101636, 2550.668413106303, 2568.486302739441, 2660.9068682596017, 2660.9600855987173, 2672.038066296132, 142630.0, 151053.0, 162324.0, 166263.16868415702, 168339.0, 16303.755443668355, 16652.75020874688, 17147.22837472292, 17178.484645460656, 17356.91321543384, 27083.593746093826, 27111.0, 27278.45443091127, 27349.179524614294, 27397.726022739917, 11360.204785664924, 11522.884771152349, 11628.069754419626, 11741.76516469683, 11923.224990375598, 10414.739631509274, 10565.9471702641, 10677.359358438518, 10687.251892367614, 10707.250492465453, 10068.496575171359, 10135.138513226459, 10184.949075254577, 10265.178785697126, 10583.25917185805, 2871.7211355081195, 2895.739383455499, 2900.2169414258033, 2959.7632189424794, 3026.2585666511845, 1067.514281002142, 1074.5648012554927, 1082.6427278997912, 1100.2628239079836, 1106.623747925709, 21755.67366489504, 22014.0, 22146.778532214794, 22221.111155553597, 22250.777492225196, 1148.3798748675788, 1154.2785758900686, 1158.1140427572914, 1158.5655379232787, 1158.9478473468714, 11717.76564468723, 11811.940940295415, 12084.516619335129, 12108.515659373703, 12163.391830408622, 651504.0, 658688.0, 660970.0, 661566.0, 672634.0, 137873.31063344819, 140514.2974285122, 141806.0, 142382.0, 143537.28231358985, 1265.7721610110084, 1271.8028705550655, 1290.0969321475004, 1293.5860524632028, 1302.3358087375318, 19609.215631374584, 19846.01539846004, 19921.402357929284, 19929.0, 20161.495962601053, 64842.0, 66128.66935665291, 66458.0, 68154.0, 69433.65283173753, 84611.5769421149, 84698.0, 85484.57257713671, 85487.57256213679, 85569.57215213885, 15640.92179539095, 15796.0, 15808.209589520708, 15957.840421595636, 16043.278052487432, 23897.641535376635, 24347.634785477876, 24351.878240608683, 24384.146554870495, 24461.877690611433, 19593.412197634094, 19795.508380558327, 19824.405267841987, 20085.598288033867, 20099.598008039466, 17204.31182752676, 17362.0, 17813.109344532983, 18100.45698629043, 18140.45578632643, 18268.36060737868, 18702.0, 20177.495562610464, 20248.291309804084, 20668.379948601567, 15451.150186739387, 15570.610734731723, 15705.528834134995, 15740.134292613559, 15743.370265189264, 18989.43031708996, 19307.90346048261, 19367.612647746686, 19459.51351216231, 19474.610507789483], "value": 13173.902420519396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.9569812905613, 1475.107559926244, 1488.1220080152707, 1497.0269324938788, 1504.0374160537258, 16976.151192440375, 17612.559686007855, 17617.82382176178, 17676.823231767677, 17685.115744212788, 17793.199306031227, 17845.464636060908, 17847.46457606274, 17921.731174032368, 17929.193186306617, 3103.6120484939383, 3147.2446612812873, 3193.8882139125135, 3197.792143510676, 3198.6641402652735, 3096.040227529473, 3097.4269760094344, 3132.1386618679817, 3132.3578666373337, 3134.13811201919, 3060.02079334613, 3125.484295091307, 3224.5808044954124, 3227.0, 3229.079712282, 3237.7247933925646, 3245.5618491503583, 3255.625603055655, 3269.6893795089427, 3284.8357582120916, 3024.9243768905953, 3063.3107550801114, 3078.846057697129, 3108.984455077733, 3111.595492585949, 16976.151192440328, 17217.569560760956, 17334.306627734877, 17376.04431756253, 17399.913000435045, 9135.223506001998, 9488.478133702643, 9488.573014214377, 9493.620255189784, 9538.52307384628, 6149.262088549358, 6311.842203944938, 6388.2334119905445, 6500.284968653445, 6503.154589903283, 2099.6379073542266, 2133.5092928626505, 2162.98339780303, 2189.6496560550236, 2198.6482162853868, 31641.683583164104, 31773.52339714906, 31798.682013179805, 31918.0, 32028.839855800572, 7511.924880751232, 7725.381969442431, 7979.8404031919035, 8007.239312265326, 8181.304589109874, 20600.38198854037, 20646.17415303371, 20683.793162068487, 20714.275000374913, 20723.689144662843, 9185.311101667401, 9262.444253344685, 9265.814683706423, 9278.62885484573, 9282.211012063915, 8264.628091735887, 8312.459690120122, 8464.661413543512, 8540.658373664985, 8541.829163416696, 6116.29662588808, 6159.722812473449, 6175.752969881154, 6217.036359364306, 6299.937000630027, 1650.9587260318588, 1730.6019615488256, 1765.8675599330102, 1800.9549761256073, 1804.6029873428088, 999.0658734083655, 1029.9330543514798, 1030.4332617060586, 1031.7523794289316, 1036.1762398892897, 10287.22845786569, 10389.896101038892, 10471.109955653856, 10477.423741694127, 10539.57841686324, 823.4194892600702, 832.3840358134937, 840.2185967050701, 848.9193526614962, 883.9790042500922, 6252.5935814171935, 6499.967500162564, 6562.704678289489, 6653.833654158685, 6670.199576050905, 25585.0, 26457.33856653599, 26608.60087098695, 26644.333891652863, 26653.20040398791, 25006.37484062913, 25994.220173394828, 26112.73887261103, 26177.73822261753, 26224.0, 13032.218066916015, 13081.149725267827, 13194.472221111047, 13302.401391937387, 13359.398827052806, 10018.499075046073, 10130.341527800669, 10173.949130254301, 10252.231082668979, 10268.178545716473, 21855.344339669835, 22474.550508990054, 22586.435339115997, 22620.321390358316, 22939.96770145314, 23190.42023949415, 23218.76781232166, 23308.76691233134, 23564.41088972721, 23997.28008159758, 12660.683482913, 12685.619431417072, 12726.300053497147, 12818.87181128214, 12829.67925801825, 16283.755743664091, 16409.753853692444, 16445.09551974653, 16458.42395516151, 16460.42388516444, 12825.486980520674, 12882.871171288167, 12887.93556032214, 12905.483780648668, 13027.08810383264, 11929.701757456132, 12213.633590992284, 12686.873131268938, 12943.676408089497, 13011.414486347947, 10194.286399952229, 10353.171746260432, 10372.844407334047, 10391.948040259751, 10444.582216711246, 8728.56357182151, 8853.203211710977, 8870.467771933705, 8926.285897128084, 8950.418222815497, 8337.458065225741, 8369.121242269717, 8481.982162140583, 8547.230749232598, 8552.615132319184], "value": 7758.562474007362, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.3787203012699, 569.8803251317224, 570.4894119762812, 589.9646021238726, 607.1590846677353, 6432.742690292389, 6474.510862501622, 6480.2179400664845, 6625.238097618775, 6631.900521492169, 6419.165508483902, 6482.448991835699, 6484.087194277688, 6489.123968264283, 6501.609903405787, 5348.518633323, 5366.624336296461, 5370.355557333106, 5400.513953744162, 5423.322084739408, 5095.3885533736, 5181.4300426953005, 5190.079670521912, 5227.73861306935, 5242.659227150242, 5166.225066240057, 5173.896522069556, 5192.818251361203, 5195.376554813428, 5225.843224703246, 5145.459726728677, 5168.121419358718, 5171.612129090315, 5216.087184742655, 5244.265802787613, 4766.094442055998, 4766.976165119152, 4772.331873537708, 4777.355057067321, 4786.449558300805, 6303.684815759194, 6410.134631824691, 6448.484121270334, 6458.7093580788505, 6530.0, 5928.822135335947, 6120.663363515005, 6128.846778830521, 6153.784617538365, 6156.4766994805495, 6861.622610756406, 6875.48433867462, 6967.372936435694, 6971.570827980303, 6999.040268724765, 5109.4379618241965, 5299.788008479656, 5312.681239125626, 5313.38896026958, 5336.665833541615, 6926.203486599055, 7136.607486588236, 7142.678604458192, 7185.8143406337895, 7214.278572142849, 5413.729313534308, 5429.104197807317, 5451.318585176853, 5482.5613950883835, 5490.615656903979, 5454.781808727606, 5455.890882182334, 5520.1443776214755, 5529.917051244234, 5550.639208451518, 6079.75680972765, 6096.542759293071, 6144.41628045335, 6153.323304362617, 6163.3836616338, 7014.0, 7037.120359955005, 7046.224915259318, 7051.153861536648, 7086.681099350541, 1880.1351378365832, 1880.4170707080848, 1893.5171531259716, 1916.7604049493814, 1928.7366774762554, 1293.8964882809353, 1331.4541038174302, 1333.7999300105062, 1358.5720498043283, 1368.7339211229573, 6340.0, 6392.680365981682, 6468.8059358219325, 6539.607623542603, 6542.803715888531, 6893.620850853151, 6899.17209934801, 6915.412189963909, 6968.233494315621, 7006.4044556212275, 6471.644059576674, 6538.248101468297, 6559.409653131241, 6577.704003319862, 6589.374009469093, 3663.3183650431147, 3726.795026273581, 3731.3097077040834, 3741.8316175772156, 3747.306748251582, 7160.391366733782, 7198.5320954137815, 7205.423566114699, 7327.413806895435, 7378.188399276075, 7177.7487787927175, 7179.89230161548, 7195.316444937723, 7242.96378518104, 7301.853962920712, 7179.78460646171, 7219.411729419519, 7255.419566434567, 7292.8906066409045, 7313.670884810196, 6888.0, 6902.171739391305, 7008.649567521706, 7021.508494405342, 7036.437085033082, 6958.617276049866, 6993.3216028151855, 7027.754028608974, 7042.612656303748, 7056.2359410147465, 7297.270272972661, 7325.230850760593, 7330.193678695233, 7331.670074846538, 7378.926210737824, 5445.700486473282, 5452.26394436746, 5460.3993560707495, 5469.972650136724, 5476.644018138808, 6616.536842420985, 6758.290379510081, 7024.789256322319, 7134.964325178341, 7178.605176715122, 6802.0, 6813.466969931924, 6817.693203805939, 6842.213145488333, 6907.861842763217, 6799.966000169968, 6864.622445765531, 6885.793426197222, 6899.102007365822, 6942.166939967236, 6773.89839152423, 6829.112215411965, 6843.726250949906, 6871.759488417882, 6924.480663950325, 6857.965710171417, 6908.5509441886115, 6975.686094125675, 6991.965040174767, 7014.0, 6569.80290591283, 6691.230508491586, 6695.799126026227, 6737.663116844236, 6743.123393958754], "value": 5411.306457139004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [996.7259003773966, 1014.5890914179756, 1029.1612335946204, 1038.94805259737, 1053.7418332508537, 19881.3041543546, 20600.89699551502, 20618.38144855653, 20643.17427302906, 20649.587008259863, 19671.114799834006, 19814.306499272527, 19851.7096388735, 19885.105170267336, 19896.90051549744, 1036.9844452333202, 1062.6493257225097, 1071.6517131932114, 1072.6942821295913, 1074.511097450662, 1076.3757020927883, 1076.8115579773548, 1084.2139448899525, 1086.3427626286102, 1088.1023155896378, 1114.760326529796, 1175.97648047039, 1179.257068047129, 1183.3018519073744, 1184.2420850655587, 1157.2015309436463, 1161.1929708852351, 1162.482695200636, 1162.4885050577718, 1162.9534818607247, 829.2578142562434, 837.3761547646981, 840.0255703384045, 840.5839109640706, 841.1126261793805, 18636.72044919327, 21007.159713611436, 22004.88997555002, 22209.777902221093, 22217.0, 22872.7712722874, 23276.418089547726, 23278.3016509505, 23378.0, 23404.18085367021, 17019.744703829452, 17254.91372543142, 17270.13649317529, 17292.0, 17292.827071729247, 3936.9015774605577, 4029.435878976946, 4103.4870641169855, 4153.709240353177, 4157.771322577257, 121358.0, 124631.37684311612, 155069.0, 155371.0, 159164.0, 18655.253789848255, 18892.622147556973, 18977.715334269997, 19128.52178695516, 19158.23367065302, 34860.0, 34967.0, 35116.29767404638, 35246.11884702903, 35274.118147046014, 10773.19201059908, 10825.945870270756, 10833.458327083614, 10856.457177141112, 10874.45627718611, 4832.975835120872, 4887.36464259644, 4964.553190212898, 4966.602671786321, 4973.030259099441, 6094.116353128771, 6247.531435142382, 6247.9062814057825, 6249.375062493714, 6254.874902501924, 1260.332024027267, 1308.234682710606, 1319.6700824793802, 1320.0957344219241, 1320.3662242123835, 771.8456308738275, 772.6291380137566, 783.8706613408838, 792.9841403171904, 793.757903839323, 13851.445942162401, 14205.0, 14983.250837458083, 15088.24558772057, 15143.242837858063, 752.6838727734255, 756.3079781999409, 758.7496126278315, 769.7036640893297, 776.0299625468165, 6353.428191462791, 6512.772052978123, 6520.0871877937125, 6532.902006469907, 6631.900521492182, 147991.0, 149242.25378873255, 150036.24981875022, 151215.0, 153318.0, 122575.0, 123514.0, 133637.0, 134511.0, 135249.0, 113776.0, 115640.42179789215, 115710.0, 116157.8384216164, 118588.0, 12682.365881705693, 13271.734565308447, 13372.732545348845, 13554.72890542164, 13635.181889086687, 54704.45295546993, 54925.17612235899, 55146.72426637841, 56107.0, 56507.15239271496, 92207.53896230475, 93156.0, 94353.5282323584, 94549.52725236605, 102464.0, 21538.784612154304, 21654.24210152637, 21724.0, 21772.67340989918, 21895.233666821583, 24041.0, 24251.878740606186, 24296.51406971886, 24811.875940620183, 25004.37489062788, 20818.895905520374, 21156.25953091696, 21673.133074676836, 22157.556848863256, 22242.110315587197, 17651.735223971395, 17724.734128987817, 20134.395968120978, 20513.38459846207, 20910.47723806856, 18799.90600046991, 18892.811071889104, 18933.148008339933, 19225.903870480557, 21616.567668646854, 13391.055691447775, 13774.0, 13968.371423285773, 14002.229877356844, 14182.361793719101, 14168.291585420893, 14280.357383917957, 14295.857041429452, 14886.85113148898, 14928.626784330045], "value": 10520.900857880073, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1354.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 104.0, 104.0, 104.0, 106.0, 108.0, 106.0, 106.0, 105.0, 105.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 116.0, 112.0, 114.0, 112.0, 140.0, 109.0, 114.0, 115.0], "value": 115.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 162.0, 162.0, 163.0, 161.0, 161.0, 161.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 74.0, 73.0, 72.0, 72.0, 72.0, 72.0, 81.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 78.0, 83.0, 77.0, 77.0, 78.0, 79.0, 77.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 111.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 148.0, 156.0, 149.0, 150.0, 147.0, 148.0, 149.0, 148.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 99.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 42.0, 43.0, 42.0, 42.0, 42.0, 43.0, 48.0, 42.0, 42.0], "value": 43.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 68.0, 74.0, 68.0, 71.0, 71.0, 69.0, 67.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 101.0, 111.0, 101.0, 102.0, 107.0, 106.0, 101.0, 104.0, 107.0], "value": 105.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 153.0, 143.0, 146.0, 146.0, 148.0, 151.0, 151.0, 145.0], "value": 149.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 57.0, 57.0, 60.0, 62.0, 57.0, 58.0, 62.0, 56.0, 58.0], "value": 58.8, "unit": "score"}]}]} 13:38:48 INFO - Return code: 0 13:38:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:38:48 INFO - # TBPL SUCCESS # 13:38:48 INFO - Running post-action listener: _package_coverage_data 13:38:48 INFO - Running post-action listener: _resource_record_post_action 13:38:48 INFO - [mozharness: 2017-09-23 20:38:48.437209Z] Finished run-tests step (success) 13:38:48 INFO - Running post-run listener: _resource_record_post_run 13:38:48 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 12288; Write bytes: 339001344; Read time: 156; Write time: 178948 13:38:48 INFO - TinderboxPrint: CPU usage
13.0% 13:38:48 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 156 13:38:48 INFO - TinderboxPrint: I/O write bytes / time
339,001,344 / 178,948 13:38:48 INFO - TinderboxPrint: CPU idle
8,188.2 (86.9%) 13:38:48 INFO - TinderboxPrint: CPU user
1,179.2 (12.5%) 13:38:48 INFO - TinderboxPrint: Swap in / out
0 / 0 13:38:48 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 64466944; Read time: 0; Write time: 38800 13:38:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:38:48 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 12288; Write bytes: 274534400; Read time: 156; Write time: 140148 13:38:49 INFO - Running post-run listener: _upload_blobber_files 13:38:49 INFO - Blob upload gear active. 13:38:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:38:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:38:49 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:38:49 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:38:49 INFO - (blobuploader) - INFO - Open directory for files ... 13:38:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:38:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:38:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:50 INFO - (blobuploader) - INFO - Done attempting. 13:38:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:38:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:52 INFO - (blobuploader) - INFO - Done attempting. 13:38:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:38:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:52 INFO - (blobuploader) - INFO - Done attempting. 13:38:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:38:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:39:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:00 INFO - (blobuploader) - INFO - Done attempting. 13:39:00 INFO - (blobuploader) - INFO - Iteration through files over. 13:39:00 INFO - Return code: 0 13:39:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:39:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:39:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bc72dae1cfa1bbc351a8b6c05039f16d156d74940d13398d51ce5b5679877c1a882c570df6f6f4fd6aa91716f3bc3f92edeb7e1658ea8362bd710cf9ed89515c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f601fd5553f20e2dee9a2892cf673b9755753ef25484077611180feba43d23d87cb1f062c483a2273117de2948a71def7fc61b2d90089c9b8d5cec01cae4e44f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/80b69044138d77d860965abd0b170199b9161f467c9086bb801f4f42c933fdc5813224a261b366e8f09598927326335ddd37b51be4188b348c32c674abb526e0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/030304b2998128c635351ca37c031100f6b20cbc7f4fc87861141f2986a6288bd19d031f5cfa0652d1c62286270470bb73a0508d0a485f7ba406784b4a9f5463"} 13:39:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:39:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:39:00 INFO - Contents: 13:39:00 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bc72dae1cfa1bbc351a8b6c05039f16d156d74940d13398d51ce5b5679877c1a882c570df6f6f4fd6aa91716f3bc3f92edeb7e1658ea8362bd710cf9ed89515c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f601fd5553f20e2dee9a2892cf673b9755753ef25484077611180feba43d23d87cb1f062c483a2273117de2948a71def7fc61b2d90089c9b8d5cec01cae4e44f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/80b69044138d77d860965abd0b170199b9161f467c9086bb801f4f42c933fdc5813224a261b366e8f09598927326335ddd37b51be4188b348c32c674abb526e0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/030304b2998128c635351ca37c031100f6b20cbc7f4fc87861141f2986a6288bd19d031f5cfa0652d1c62286270470bb73a0508d0a485f7ba406784b4a9f5463"} 13:39:00 INFO - Running post-run listener: copy_logs_to_upload_dir 13:39:00 INFO - Copying logs to upload dir... 13:39:00 INFO - mkdir: /builds/slave/test/build/upload/logs 13:39:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.435702 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-09-23 13:39:00.453010) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 13:39:00.458034) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bc72dae1cfa1bbc351a8b6c05039f16d156d74940d13398d51ce5b5679877c1a882c570df6f6f4fd6aa91716f3bc3f92edeb7e1658ea8362bd710cf9ed89515c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f601fd5553f20e2dee9a2892cf673b9755753ef25484077611180feba43d23d87cb1f062c483a2273117de2948a71def7fc61b2d90089c9b8d5cec01cae4e44f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/80b69044138d77d860965abd0b170199b9161f467c9086bb801f4f42c933fdc5813224a261b366e8f09598927326335ddd37b51be4188b348c32c674abb526e0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/030304b2998128c635351ca37c031100f6b20cbc7f4fc87861141f2986a6288bd19d031f5cfa0652d1c62286270470bb73a0508d0a485f7ba406784b4a9f5463"} build_url:https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011756 build_url: 'https://queue.taskcluster.net/v1/task/QpjT2mohRr6eqmfePmJGIg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bc72dae1cfa1bbc351a8b6c05039f16d156d74940d13398d51ce5b5679877c1a882c570df6f6f4fd6aa91716f3bc3f92edeb7e1658ea8362bd710cf9ed89515c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f601fd5553f20e2dee9a2892cf673b9755753ef25484077611180feba43d23d87cb1f062c483a2273117de2948a71def7fc61b2d90089c9b8d5cec01cae4e44f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/80b69044138d77d860965abd0b170199b9161f467c9086bb801f4f42c933fdc5813224a261b366e8f09598927326335ddd37b51be4188b348c32c674abb526e0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/030304b2998128c635351ca37c031100f6b20cbc7f4fc87861141f2986a6288bd19d031f5cfa0652d1c62286270470bb73a0508d0a485f7ba406784b4a9f5463"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 13:39:00.489048) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 13:39:00.489349) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1506195422.675671-185012695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 13:39:00.570502) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 13:39:00.573824) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 13:39:00.574134) ========= ========= Total master_lag: 0.26 =========