builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1507841369.0 results: success (0) revision: 2504eb322881ac4bb8e05bf04b6011c598ca6b9d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-12 13:49:29.000044) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-12 13:49:29.000460) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-12 13:49:29.000749) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-12 13:49:29.077819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 13:49:29.078159) ========= 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=db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-12 13:49:29-- 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% 229M=0s 2017-10-12 13:49:29 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.203551 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 13:49:29.311959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 13:49:29.312259) ========= 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=db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019744 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 13:49:29.362294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 13:49:29.362627) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2504eb322881ac4bb8e05bf04b6011c598ca6b9d --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 2504eb322881ac4bb8e05bf04b6011c598ca6b9d --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=db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-12 13:49:29,421 truncating revision to first 12 chars 2017-10-12 13:49:29,421 Setting DEBUG logging. 2017-10-12 13:49:29,421 attempt 1/10 2017-10-12 13:49:29,421 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2504eb322881?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-12 13:49:29,895 unpacking tar archive at: mozilla-beta-2504eb322881/testing/mozharness/ program finished with exit code 0 elapsedTime=0.792112 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 13:49:30.171797) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-12 13:49:30.172126) ========= script_repo_revision: 2504eb322881ac4bb8e05bf04b6011c598ca6b9d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-12 13:49:30.172521) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-12 13:49:30.172807) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-12 13:49:30.188002) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-10-12 13:49:30.188400) ========= /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=db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:49:30 INFO - MultiFileLogger online at 20171012 13:49:30 in /builds/slave/test 13:49:30 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:49:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:49:30 INFO - {'append_to_log': False, 13:49:30 INFO - 'base_work_dir': '/builds/slave/test', 13:49:30 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 13:49:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:49:30 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 13:49:30 INFO - 'buildbot_json_path': 'buildprops.json', 13:49:30 INFO - 'code_coverage': False, 13:49:30 INFO - 'config_files': ('talos/linux_config.py',), 13:49:30 INFO - 'default_actions': ('clobber', 13:49:30 INFO - 'read-buildbot-config', 13:49:30 INFO - 'download-and-extract', 13:49:30 INFO - 'populate-webroot', 13:49:30 INFO - 'create-virtualenv', 13:49:30 INFO - 'install', 13:49:30 INFO - 'setup-mitmproxy', 13:49:30 INFO - 'run-tests'), 13:49:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:49:30 INFO - 'disable_ccov_upload': False, 13:49:30 INFO - 'disable_stylo': False, 13:49:30 INFO - 'download_minidump_stackwalk': True, 13:49:30 INFO - 'download_symbols': 'ondemand', 13:49:30 INFO - 'enable_stylo': False, 13:49:30 INFO - 'enable_webrender': False, 13:49:30 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:49:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:49:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:49:30 INFO - 'gecko_profile': False, 13:49:30 INFO - 'gecko_profile_interval': 0, 13:49:30 INFO - 'installer_path': 'installer.exe', 13:49:30 INFO - 'log_level': 'info', 13:49:30 INFO - 'log_name': 'talos', 13:49:30 INFO - 'log_to_console': True, 13:49:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:49:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:49:30 INFO - 'opt_config_files': (), 13:49:30 INFO - 'pip_index': False, 13:49:30 INFO - 'suite': 'dromaeojs-e10s', 13:49:30 INFO - 'system_bits': '32', 13:49:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:49:30 INFO - 'title': 'talos-linux64-ix-031', 13:49:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:49:30 INFO - 'use_talos_json': True, 13:49:30 INFO - 'verify': 'False', 13:49:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:49:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:49:30 INFO - 'work_dir': 'build'} 13:49:30 INFO - [mozharness: 2017-10-12 20:49:30.514570Z] Running clobber step. 13:49:30 INFO - Running pre-action listener: _resource_record_pre_action 13:49:30 INFO - Running main action method: clobber 13:49:30 INFO - rmtree: /builds/slave/test/build 13:49:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:49:31 INFO - Running post-action listener: _resource_record_post_action 13:49:31 INFO - [mozharness: 2017-10-12 20:49:31.513845Z] Finished clobber step (success) 13:49:31 INFO - [mozharness: 2017-10-12 20:49:31.513941Z] Running read-buildbot-config step. 13:49:31 INFO - Running pre-action listener: _resource_record_pre_action 13:49:31 INFO - Running main action method: read_buildbot_config 13:49:31 INFO - Using buildbot properties: 13:49:31 INFO - { 13:49:31 INFO - "project": "", 13:49:31 INFO - "product": "firefox", 13:49:31 INFO - "who": "ryanvm@gmail.com", 13:49:31 INFO - "installer_path": "public/build/target.tar.bz2", 13:49:31 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 13:49:31 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 13:49:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 13:49:31 INFO - "stage_platform": "linux64", 13:49:31 INFO - "basedir": "/builds/slave/test", 13:49:31 INFO - "buildnumber": 137, 13:49:31 INFO - "platform": "ubuntu64_hw", 13:49:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:49:31 INFO - "slavebuilddir": "test", 13:49:31 INFO - "taskId": "A8Js0tbJS3Gg7khUWaOspQ", 13:49:31 INFO - "branch": "mozilla-beta", 13:49:31 INFO - "script_repo_revision": "production", 13:49:31 INFO - "revision": "2504eb322881ac4bb8e05bf04b6011c598ca6b9d", 13:49:31 INFO - "slavename": "talos-linux64-ix-031", 13:49:31 INFO - "repo_path": "releases/mozilla-beta" 13:49:31 INFO - } 13:49:31 INFO - Finding installer, test and symbols from parent task. 13:49:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A8Js0tbJS3Gg7khUWaOspQ'}, attempt #1 13:49:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A8Js0tbJS3Gg7khUWaOspQ'}, attempt #1 13:49:32 INFO - Task dependencies: D5fiF01zSRyQbyL5pn7uaA 13:49:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA'}, attempt #1 13:49:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.tar.bz2 13:49:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.test_packages.json 13:49:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.crashreporter-symbols.zip 13:49:32 INFO - Running post-action listener: _resource_record_post_action 13:49:32 INFO - [mozharness: 2017-10-12 20:49:32.988833Z] Finished read-buildbot-config step (success) 13:49:32 INFO - [mozharness: 2017-10-12 20:49:32.989049Z] Running download-and-extract step. 13:49:32 INFO - Running pre-action listener: _resource_record_pre_action 13:49:32 INFO - Running main action method: download_and_extract 13:49:32 INFO - mkdir: /builds/slave/test/build/tests 13:49:32 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:49:32 INFO - trying https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.test_packages.json 13:49:32 INFO - Downloading https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:49:33 INFO - Downloaded 989 bytes. 13:49:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:49:33 INFO - Using the following test package requirements: 13:49:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:49:33 INFO - u'common': [u'target.common.tests.zip'], 13:49:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:49:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:49:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:49:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:49:33 INFO - u'mozbase': [u'target.common.tests.zip'], 13:49:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:49:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:49:33 INFO - u'web-platform': [u'target.common.tests.zip', 13:49:33 INFO - u'target.web-platform.tests.tar.gz'], 13:49:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:49:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 13:49:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.common.tests.zip 13:49:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:49:33 INFO - Fetch https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.common.tests.zip into memory 13:49:35 INFO - Content-Length response header: 55180657 13:49:35 INFO - Bytes received: 55180657 13:49:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.talos.tests.zip 13:49:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:49:46 INFO - Fetch https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.talos.tests.zip into memory 13:49:48 INFO - Content-Length response header: 14509251 13:49:48 INFO - Bytes received: 14509251 13:49:49 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:49:49 INFO - trying https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.tar.bz2 13:49:49 INFO - Downloading https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:49:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:49:51 INFO - Downloaded 53521970 bytes. 13:49:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.tar.bz2 13:49:51 INFO - mkdir: /builds/slave/test/properties 13:49:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:49:51 INFO - Writing to file /builds/slave/test/properties/build_url 13:49:51 INFO - Contents: 13:49:51 INFO - build_url:https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.tar.bz2 13:49:51 INFO - Running post-action listener: _resource_record_post_action 13:49:51 INFO - Running post-action listener: find_tests_for_verification 13:49:51 INFO - Running post-action listener: set_extra_try_arguments 13:49:51 INFO - [mozharness: 2017-10-12 20:49:51.807127Z] Finished download-and-extract step (success) 13:49:51 INFO - [mozharness: 2017-10-12 20:49:51.807301Z] Running populate-webroot step. 13:49:51 INFO - Running pre-action listener: _resource_record_pre_action 13:49:51 INFO - Running main action method: populate_webroot 13:49:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:49:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:51 INFO - 'tests': ['tresize', 13:49:51 INFO - 'tcanvasmark']}, 13:49:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:49:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:51 INFO - 'tests': ['dromaeo_css', 13:49:51 INFO - 'kraken']}, 13:49:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:49:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:51 INFO - 'talos_options': ['--disable-stylo'], 13:49:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:49:51 INFO - 'tests': ['damp', 'tps']}, 13:49:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:51 INFO - 'talos_options': ['--disable-stylo'], 13:49:51 INFO - 'tests': ['damp', 'tps']}, 13:49:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:49:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:51 INFO - 'tests': ['dromaeo_dom']}, 13:49:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:49:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:51 INFO - 'tests': ['basic_compositor_video', 13:49:51 INFO - 'glvideo']}, 13:49:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:49:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:49:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:51 INFO - 'talos_options': ['--disable-stylo'], 13:49:51 INFO - 'tests': ['ts_paint_webext', 13:49:51 INFO - 'tp5o_webext']}, 13:49:51 INFO - 'other-e10s': {'tests': ['a11yr', 13:49:51 INFO - 'ts_paint', 13:49:51 INFO - 'tpaint', 13:49:51 INFO - 'sessionrestore', 13:49:51 INFO - 'sessionrestore_many_windows', 13:49:51 INFO - 'sessionrestore_no_auto_restore', 13:49:51 INFO - 'tabpaint']}, 13:49:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:51 INFO - 'tests': ['a11yr', 13:49:51 INFO - 'ts_paint', 13:49:51 INFO - 'tpaint', 13:49:51 INFO - 'sessionrestore', 13:49:51 INFO - 'sessionrestore_many_windows', 13:49:51 INFO - 'sessionrestore_no_auto_restore', 13:49:51 INFO - 'tabpaint']}, 13:49:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:49:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 13:49:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:51 INFO - 'tests': ['perf_reftest_singletons']}, 13:49:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:51 INFO - 'tests': ['bloom_basic']}, 13:49:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:49:51 INFO - 'tsvgr_opacity', 13:49:51 INFO - 'tart', 13:49:51 INFO - 'tscrollx', 13:49:51 INFO - 'tsvg_static']}, 13:49:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:49:51 INFO - 'tests': ['tsvgx', 13:49:51 INFO - 'tsvgr_opacity', 13:49:51 INFO - 'tart', 13:49:51 INFO - 'tscrollx', 13:49:51 INFO - 'tsvg_static']}, 13:49:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:49:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:51 INFO - 'talos_options': ['--disable-stylo'], 13:49:51 INFO - 'tests': ['tp5o']}, 13:49:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:49:51 INFO - 'talos_options': ['--mitmproxy', 13:49:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:49:51 INFO - '--firstNonBlankPaint'], 13:49:51 INFO - 'tests': ['tp6_google', 13:49:51 INFO - 'tp6_youtube', 13:49:51 INFO - 'tp6_amazon', 13:49:51 INFO - 'tp6_facebook']}, 13:49:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:49:51 INFO - 'talos_options': ['--disable-stylo', 13:49:51 INFO - '--mitmproxy', 13:49:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:49:51 INFO - '--firstNonBlankPaint'], 13:49:51 INFO - 'tests': ['tp6_google', 13:49:51 INFO - 'tp6_youtube', 13:49:51 INFO - 'tp6_amazon', 13:49:51 INFO - 'tp6_facebook']}, 13:49:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:49:51 INFO - 'talos_options': ['--stylo-threads=1', 13:49:51 INFO - '--mitmproxy', 13:49:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:49:51 INFO - '--firstNonBlankPaint'], 13:49:51 INFO - 'tests': ['tp6_google', 13:49:51 INFO - 'tp6_youtube', 13:49:51 INFO - 'tp6_amazon', 13:49:51 INFO - 'tp6_facebook']}, 13:49:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:49:51 INFO - 'talos_options': ['--xperf_path', 13:49:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:51 INFO - 'tests': ['tp5n']}, 13:49:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:49:51 INFO - 'talos_options': ['--disable-stylo', 13:49:51 INFO - '--xperf_path', 13:49:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:51 INFO - 'tests': ['tp5n']}}} 13:49:51 INFO - Running post-action listener: _resource_record_post_action 13:49:51 INFO - [mozharness: 2017-10-12 20:49:51.825208Z] Finished populate-webroot step (success) 13:49:51 INFO - [mozharness: 2017-10-12 20:49:51.825315Z] Running create-virtualenv step. 13:49:51 INFO - Running pre-action listener: _resource_record_pre_action 13:49:51 INFO - Running main action method: create_virtualenv 13:49:51 INFO - Creating virtualenv /builds/slave/test/build/venv 13:49:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:49:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:49:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:49:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:49:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:49:52 INFO - Installing distribute.............................................................................................................................................................................................done. 13:49:52 INFO - Installing pip...............done. 13:49:52 INFO - Return code: 0 13:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:49:53 INFO - Reading from file tmpfile_stdout 13:49:53 INFO - Output received: 13:49:53 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:49:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:49: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:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49: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:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6090>, '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 0x28a6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a0f90>, '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': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', '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:49: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', 'pip>=1.5'] in /builds/slave/test/build 13:49: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 pip>=1.5 13:49:53 INFO - Using env: {'DISPLAY': ':0', 13:49:53 INFO - 'HOME': '/home/cltbld', 13:49:53 INFO - 'LANG': 'en_US.UTF-8', 13:49:53 INFO - 'LANGUAGE': 'en_US:en', 13:49:53 INFO - 'LOGNAME': 'cltbld', 13:49:53 INFO - 'MAIL': '/var/mail/cltbld', 13:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:53 INFO - 'MOZ_NO_REMOTE': '1', 13:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:53 INFO - 'NO_EM_RESTART': '1', 13:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:53 INFO - 'PWD': '/builds/slave/test', 13:49:53 INFO - 'SHELL': '/bin/bash', 13:49:53 INFO - 'SHLVL': '1', 13:49:53 INFO - 'TERM': 'linux', 13:49:53 INFO - 'TMOUT': '86400', 13:49:53 INFO - 'USER': 'cltbld', 13:49:53 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', 13:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:53 INFO - '_': '/tools/buildbot/bin/python'} 13:49:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:49:54 INFO - Downloading/unpacking pip>=1.5 13:49:54 INFO - Running setup.py egg_info for package pip 13:49:54 INFO - warning: no files found matching 'pip/cacert.pem' 13:49:54 INFO - warning: no files found matching '*.html' under directory 'docs' 13:49:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:49:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:49:54 INFO - Installing collected packages: pip 13:49:54 INFO - Found existing installation: pip 1.1 13:49:54 INFO - Uninstalling pip: 13:49:54 INFO - Successfully uninstalled pip 13:49:54 INFO - Running setup.py install for pip 13:49:54 INFO - warning: no files found matching 'pip/cacert.pem' 13:49:54 INFO - warning: no files found matching '*.html' under directory 'docs' 13:49:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:49:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:49:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:49:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:49:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:49:54 INFO - Successfully installed pip 13:49:54 INFO - Cleaning up... 13:49:54 INFO - Return code: 0 13:49:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:49:54 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:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:54 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:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:54 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 0x25371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6090>, '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 0x28a6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a0f90>, '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': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', '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:49:54 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:49:54 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:49:54 INFO - Using env: {'DISPLAY': ':0', 13:49:54 INFO - 'HOME': '/home/cltbld', 13:49:54 INFO - 'LANG': 'en_US.UTF-8', 13:49:54 INFO - 'LANGUAGE': 'en_US:en', 13:49:54 INFO - 'LOGNAME': 'cltbld', 13:49:54 INFO - 'MAIL': '/var/mail/cltbld', 13:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:54 INFO - 'MOZ_NO_REMOTE': '1', 13:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:54 INFO - 'NO_EM_RESTART': '1', 13:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:54 INFO - 'PWD': '/builds/slave/test', 13:49:54 INFO - 'SHELL': '/bin/bash', 13:49:54 INFO - 'SHLVL': '1', 13:49:54 INFO - 'TERM': 'linux', 13:49:54 INFO - 'TMOUT': '86400', 13:49:54 INFO - 'USER': 'cltbld', 13:49:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', 13:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:54 INFO - '_': '/tools/buildbot/bin/python'} 13:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:54 INFO - Downloading/unpacking psutil>=3.1.1 13:49: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:49: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:49: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:49: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:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:49:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:56 INFO - Installing collected packages: psutil 13:49:56 INFO - Running setup.py install for psutil 13:49:56 INFO - building 'psutil._psutil_linux' extension 13:49:56 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:49:57 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:49:57 INFO - building 'psutil._psutil_posix' extension 13:49:57 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:49:57 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:49:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:57 INFO - Successfully installed psutil 13:49:57 INFO - Cleaning up... 13:49:57 INFO - Return code: 0 13:49:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:49: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:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49: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:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:57 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 0x25371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6090>, '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 0x28a6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a0f90>, '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': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', '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:49:57 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:49:57 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:49:57 INFO - Using env: {'DISPLAY': ':0', 13:49:57 INFO - 'HOME': '/home/cltbld', 13:49:57 INFO - 'LANG': 'en_US.UTF-8', 13:49:57 INFO - 'LANGUAGE': 'en_US:en', 13:49:57 INFO - 'LOGNAME': 'cltbld', 13:49:57 INFO - 'MAIL': '/var/mail/cltbld', 13:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:57 INFO - 'MOZ_NO_REMOTE': '1', 13:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:57 INFO - 'NO_EM_RESTART': '1', 13:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:57 INFO - 'PWD': '/builds/slave/test', 13:49:57 INFO - 'SHELL': '/bin/bash', 13:49:57 INFO - 'SHLVL': '1', 13:49:57 INFO - 'TERM': 'linux', 13:49:57 INFO - 'TMOUT': '86400', 13:49:57 INFO - 'USER': 'cltbld', 13:49:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', 13:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:57 INFO - '_': '/tools/buildbot/bin/python'} 13:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:49: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:49: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:49: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:49: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:49:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:49:58 INFO - Installing collected packages: mozsystemmonitor 13:49:58 INFO - Running setup.py install for mozsystemmonitor 13:49:58 INFO - Successfully installed mozsystemmonitor 13:49:58 INFO - Cleaning up... 13:49:58 INFO - Return code: 0 13:49:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:49:58 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:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:58 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:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:58 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 0x25371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6090>, '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 0x28a6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a0f90>, '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': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', '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:49:58 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:49:58 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:49:58 INFO - Using env: {'DISPLAY': ':0', 13:49:58 INFO - 'HOME': '/home/cltbld', 13:49:58 INFO - 'LANG': 'en_US.UTF-8', 13:49:58 INFO - 'LANGUAGE': 'en_US:en', 13:49:58 INFO - 'LOGNAME': 'cltbld', 13:49:58 INFO - 'MAIL': '/var/mail/cltbld', 13:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:58 INFO - 'MOZ_NO_REMOTE': '1', 13:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:58 INFO - 'NO_EM_RESTART': '1', 13:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:58 INFO - 'PWD': '/builds/slave/test', 13:49:58 INFO - 'SHELL': '/bin/bash', 13:49:58 INFO - 'SHLVL': '1', 13:49:58 INFO - 'TERM': 'linux', 13:49:58 INFO - 'TMOUT': '86400', 13:49:58 INFO - 'USER': 'cltbld', 13:49:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', 13:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:58 INFO - '_': '/tools/buildbot/bin/python'} 13:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:59 INFO - Downloading/unpacking jsonschema==2.5.1 13:49:59 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:49:59 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:49:59 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:49:59 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:50:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:50:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:00 INFO - Downloading functools32-3.2.3-2.tar.gz 13:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:50:00 INFO - warning: no files found matching '*.txt' 13:50:00 INFO - no previously-included directories found matching 'build' 13:50:00 INFO - no previously-included directories found matching 'dist' 13:50:00 INFO - no previously-included directories found matching '.git*' 13:50:00 INFO - Installing collected packages: jsonschema, functools32 13:50:00 INFO - Running setup.py install for functools32 13:50:00 INFO - warning: no files found matching '*.txt' 13:50:00 INFO - no previously-included directories found matching 'build' 13:50:00 INFO - no previously-included directories found matching 'dist' 13:50:00 INFO - no previously-included directories found matching '.git*' 13:50:00 INFO - Successfully installed jsonschema functools32 13:50:00 INFO - Cleaning up... 13:50:00 INFO - Return code: 0 13:50:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:50:00 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:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:00 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:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x25371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6090>, '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 0x28a6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a0f90>, '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': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', '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:50:00 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:50:00 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:50:00 INFO - Using env: {'DISPLAY': ':0', 13:50:00 INFO - 'HOME': '/home/cltbld', 13:50:00 INFO - 'LANG': 'en_US.UTF-8', 13:50:00 INFO - 'LANGUAGE': 'en_US:en', 13:50:00 INFO - 'LOGNAME': 'cltbld', 13:50:00 INFO - 'MAIL': '/var/mail/cltbld', 13:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:00 INFO - 'MOZ_NO_REMOTE': '1', 13:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:00 INFO - 'NO_EM_RESTART': '1', 13:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:00 INFO - 'PWD': '/builds/slave/test', 13:50:00 INFO - 'SHELL': '/bin/bash', 13:50:00 INFO - 'SHLVL': '1', 13:50:00 INFO - 'TERM': 'linux', 13:50:00 INFO - 'TMOUT': '86400', 13:50:00 INFO - 'USER': 'cltbld', 13:50:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', 13:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:00 INFO - '_': '/tools/buildbot/bin/python'} 13:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:50:00 INFO - Cleaning up... 13:50:00 INFO - Return code: 0 13:50:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:50:00 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:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:00 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:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x25371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6090>, '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 0x28a6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a0f90>, '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': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', '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:50:00 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:50:00 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:50:00 INFO - Using env: {'DISPLAY': ':0', 13:50:00 INFO - 'HOME': '/home/cltbld', 13:50:00 INFO - 'LANG': 'en_US.UTF-8', 13:50:00 INFO - 'LANGUAGE': 'en_US:en', 13:50:00 INFO - 'LOGNAME': 'cltbld', 13:50:00 INFO - 'MAIL': '/var/mail/cltbld', 13:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:00 INFO - 'MOZ_NO_REMOTE': '1', 13:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:00 INFO - 'NO_EM_RESTART': '1', 13:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:00 INFO - 'PWD': '/builds/slave/test', 13:50:00 INFO - 'SHELL': '/bin/bash', 13:50:00 INFO - 'SHLVL': '1', 13:50:00 INFO - 'TERM': 'linux', 13:50:00 INFO - 'TMOUT': '86400', 13:50:00 INFO - 'USER': 'cltbld', 13:50:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', 13:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:00 INFO - '_': '/tools/buildbot/bin/python'} 13:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:01 INFO - Downloading/unpacking blobuploader==1.2.4 13:50:01 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:50:01 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:50:01 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:50:01 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:50:02 INFO - Downloading blobuploader-1.2.4.tar.gz 13:50:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:50:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:50: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:50: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:50: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:50: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:50:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:50:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:50: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:50: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:50: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:50: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:50:02 INFO - Downloading docopt-0.6.1.tar.gz 13:50:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:50:02 INFO - Installing collected packages: blobuploader, requests, docopt 13:50:02 INFO - Running setup.py install for blobuploader 13:50:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:50:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:50:02 INFO - Running setup.py install for requests 13:50:03 INFO - Running setup.py install for docopt 13:50:03 INFO - Successfully installed blobuploader requests docopt 13:50:03 INFO - Cleaning up... 13:50:03 INFO - Return code: 0 13:50:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50:03 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:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:03 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:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:03 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 0x25371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6090>, '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 0x28a6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a0f90>, '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': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', '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:50:03 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:50:03 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:50:03 INFO - Using env: {'DISPLAY': ':0', 13:50:03 INFO - 'HOME': '/home/cltbld', 13:50:03 INFO - 'LANG': 'en_US.UTF-8', 13:50:03 INFO - 'LANGUAGE': 'en_US:en', 13:50:03 INFO - 'LOGNAME': 'cltbld', 13:50:03 INFO - 'MAIL': '/var/mail/cltbld', 13:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:03 INFO - 'MOZ_NO_REMOTE': '1', 13:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:03 INFO - 'NO_EM_RESTART': '1', 13:50:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:03 INFO - 'PWD': '/builds/slave/test', 13:50:03 INFO - 'SHELL': '/bin/bash', 13:50:03 INFO - 'SHLVL': '1', 13:50:03 INFO - 'TERM': 'linux', 13:50:03 INFO - 'TMOUT': '86400', 13:50:03 INFO - 'USER': 'cltbld', 13:50:03 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', 13:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:03 INFO - '_': '/tools/buildbot/bin/python'} 13:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:50:03 INFO - Running setup.py (path:/tmp/pip-hOpEAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:50:03 INFO - Running setup.py (path:/tmp/pip-0qqp8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:50:03 INFO - Running setup.py (path:/tmp/pip-6kuiFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:50:03 INFO - Running setup.py (path:/tmp/pip-KqO9Bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:50:03 INFO - Running setup.py (path:/tmp/pip-cAFdrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:50:03 INFO - Running setup.py (path:/tmp/pip-xfhUs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:50:04 INFO - Running setup.py (path:/tmp/pip-WTOGGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:50:04 INFO - Running setup.py (path:/tmp/pip-TmzFlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:50:04 INFO - Running setup.py (path:/tmp/pip-6ac_Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:50:04 INFO - Running setup.py (path:/tmp/pip-lT4aEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:50:04 INFO - Running setup.py (path:/tmp/pip-m18Rrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:50:04 INFO - Running setup.py (path:/tmp/pip-56TMtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:50:04 INFO - Running setup.py (path:/tmp/pip-iwqMYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:50:04 INFO - Running setup.py (path:/tmp/pip-MM0SJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:04 INFO - Running setup.py (path:/tmp/pip-1MqoOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:50:04 INFO - Running setup.py (path:/tmp/pip-bH1K2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:50:04 INFO - Running setup.py (path:/tmp/pip-DcIEU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:50:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:50:04 INFO - Running setup.py install for manifestparser 13:50:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:50:04 INFO - Running setup.py install for mozcrash 13:50:05 INFO - Running setup.py install for mozdebug 13:50:05 INFO - Running setup.py install for mozdevice 13:50:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:50:05 INFO - Running setup.py install for mozfile 13:50:05 INFO - Running setup.py install for mozhttpd 13:50:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:50:05 INFO - Running setup.py install for mozinfo 13:50:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:50:05 INFO - Running setup.py install for mozInstall 13:50:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:50:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:50:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:50:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:50:05 INFO - Running setup.py install for mozleak 13:50:05 INFO - Running setup.py install for mozlog 13:50:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:50:05 INFO - Running setup.py install for moznetwork 13:50:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:50:05 INFO - Running setup.py install for mozprocess 13:50:06 INFO - Running setup.py install for mozprofile 13:50:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:50:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:50:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:50:06 INFO - Running setup.py install for mozrunner 13:50:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:50:06 INFO - Running setup.py install for mozscreenshot 13:50:06 INFO - Running setup.py install for moztest 13:50:06 INFO - Running setup.py install for mozversion 13:50:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:50:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:50:06 INFO - Cleaning up... 13:50:06 INFO - Return code: 0 13:50:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50: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:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50: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:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:06 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 0x25371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6090>, '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 0x28a6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a0f90>, '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': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', '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:50:06 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:50:06 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:50:06 INFO - Using env: {'DISPLAY': ':0', 13:50:06 INFO - 'HOME': '/home/cltbld', 13:50:06 INFO - 'LANG': 'en_US.UTF-8', 13:50:06 INFO - 'LANGUAGE': 'en_US:en', 13:50:06 INFO - 'LOGNAME': 'cltbld', 13:50:06 INFO - 'MAIL': '/var/mail/cltbld', 13:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:06 INFO - 'MOZ_NO_REMOTE': '1', 13:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:06 INFO - 'NO_EM_RESTART': '1', 13:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:06 INFO - 'PWD': '/builds/slave/test', 13:50:06 INFO - 'SHELL': '/bin/bash', 13:50:06 INFO - 'SHLVL': '1', 13:50:06 INFO - 'TERM': 'linux', 13:50:06 INFO - 'TMOUT': '86400', 13:50:06 INFO - 'USER': 'cltbld', 13:50:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', 13:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:06 INFO - '_': '/tools/buildbot/bin/python'} 13:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:50:06 INFO - Running setup.py (path:/tmp/pip-J1A_Y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:50:06 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:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:50:06 INFO - Running setup.py (path:/tmp/pip-7_3LAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:50:06 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:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:50:06 INFO - Running setup.py (path:/tmp/pip-vSn8Hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:50:07 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:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:50:07 INFO - Running setup.py (path:/tmp/pip-iiQgpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:50:07 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:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:50:07 INFO - Running setup.py (path:/tmp/pip-pdWMTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:50:07 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:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:50:07 INFO - Running setup.py (path:/tmp/pip-Sg0OMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:50:07 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:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:50:07 INFO - Running setup.py (path:/tmp/pip-sPRfd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:50:07 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:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:50:07 INFO - Running setup.py (path:/tmp/pip-LGlsie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:50:07 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:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:50:07 INFO - Running setup.py (path:/tmp/pip-AjGh_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:50:07 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:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:50:07 INFO - Running setup.py (path:/tmp/pip-1z9iNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:50:07 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:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:50:07 INFO - Running setup.py (path:/tmp/pip-8PHMf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:50:07 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:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:50:07 INFO - Running setup.py (path:/tmp/pip-4e7R9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:50:07 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:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:50:07 INFO - Running setup.py (path:/tmp/pip-t4HHDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:50:07 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:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:50:07 INFO - Running setup.py (path:/tmp/pip-g7wzYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:50:07 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:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:07 INFO - Running setup.py (path:/tmp/pip-xjw1Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:07 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:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:50:07 INFO - Running setup.py (path:/tmp/pip-I2Czra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:50:07 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:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:50:07 INFO - Running setup.py (path:/tmp/pip-kObLi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:50:08 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:50:08 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:50:08 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:50:08 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:50:08 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:50:08 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:50:08 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:50:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:09 INFO - Downloading blessings-1.6.tar.gz 13:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:50:09 INFO - Installing collected packages: blessings 13:50:09 INFO - Running setup.py install for blessings 13:50:09 INFO - Successfully installed blessings 13:50:09 INFO - Cleaning up... 13:50:09 INFO - Return code: 0 13:50:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:50:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:50:09 INFO - Reading from file tmpfile_stdout 13:50:09 INFO - Current package versions: 13:50:09 INFO - argparse == 1.2.1 13:50:09 INFO - blessings == 1.6 13:50:09 INFO - blobuploader == 1.2.4 13:50:09 INFO - docopt == 0.6.1 13:50:09 INFO - functools32 == 3.2.3-2 13:50:09 INFO - jsonschema == 2.5.1 13:50:09 INFO - manifestparser == 1.1 13:50:09 INFO - mozInstall == 1.13 13:50:09 INFO - mozcrash == 1.0 13:50:09 INFO - mozdebug == 0.1 13:50:09 INFO - mozdevice == 0.51 13:50:09 INFO - mozfile == 1.2 13:50:09 INFO - mozhttpd == 0.7 13:50:09 INFO - mozinfo == 0.10 13:50:09 INFO - mozleak == 0.1 13:50:09 INFO - mozlog == 3.5 13:50:09 INFO - moznetwork == 0.27 13:50:09 INFO - mozprocess == 0.25 13:50:09 INFO - mozprofile == 0.28 13:50:09 INFO - mozrunner == 6.13 13:50:09 INFO - mozscreenshot == 0.1 13:50:09 INFO - mozsystemmonitor == 0.3 13:50:09 INFO - moztest == 0.8 13:50:09 INFO - mozversion == 1.4 13:50:09 INFO - psutil == 3.1.1 13:50:09 INFO - requests == 1.2.3 13:50:09 INFO - wsgiref == 0.1.2 13:50:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:09 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 0x25371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6090>, '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 0x28a6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a0f90>, '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': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', '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:50:09 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:50:09 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:50:09 INFO - Using env: {'DISPLAY': ':0', 13:50:09 INFO - 'HOME': '/home/cltbld', 13:50:09 INFO - 'LANG': 'en_US.UTF-8', 13:50:09 INFO - 'LANGUAGE': 'en_US:en', 13:50:09 INFO - 'LOGNAME': 'cltbld', 13:50:09 INFO - 'MAIL': '/var/mail/cltbld', 13:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:09 INFO - 'MOZ_NO_REMOTE': '1', 13:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:09 INFO - 'NO_EM_RESTART': '1', 13:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:09 INFO - 'PWD': '/builds/slave/test', 13:50:09 INFO - 'SHELL': '/bin/bash', 13:50:09 INFO - 'SHLVL': '1', 13:50:09 INFO - 'TERM': 'linux', 13:50:09 INFO - 'TMOUT': '86400', 13:50:09 INFO - 'USER': 'cltbld', 13:50:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', 13:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:09 INFO - '_': '/tools/buildbot/bin/python'} 13:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:09 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:50:09 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:50:09 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:50:09 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:50:09 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:50:09 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:50:09 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:50:09 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:50:09 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:50:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:50:11 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:50:11 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:50:11 INFO - Installing collected packages: simplejson 13:50:11 INFO - Running setup.py install for simplejson 13:50:11 INFO - building 'simplejson._speedups' extension 13:50:11 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:50:11 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:50:12 INFO - Successfully installed simplejson 13:50:12 INFO - Cleaning up... 13:50:12 INFO - Return code: 0 13:50:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:12 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 0x25371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6090>, '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 0x28a6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a0f90>, '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': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', '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:50:12 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:50:12 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:50:12 INFO - Using env: {'DISPLAY': ':0', 13:50:12 INFO - 'HOME': '/home/cltbld', 13:50:12 INFO - 'LANG': 'en_US.UTF-8', 13:50:12 INFO - 'LANGUAGE': 'en_US:en', 13:50:12 INFO - 'LOGNAME': 'cltbld', 13:50:12 INFO - 'MAIL': '/var/mail/cltbld', 13:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:12 INFO - 'MOZ_NO_REMOTE': '1', 13:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:12 INFO - 'NO_EM_RESTART': '1', 13:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:12 INFO - 'PWD': '/builds/slave/test', 13:50:12 INFO - 'SHELL': '/bin/bash', 13:50:12 INFO - 'SHLVL': '1', 13:50:12 INFO - 'TERM': 'linux', 13:50:12 INFO - 'TMOUT': '86400', 13:50:12 INFO - 'USER': 'cltbld', 13:50:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', 13:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:12 INFO - '_': '/tools/buildbot/bin/python'} 13:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:50:12 INFO - Cleaning up... 13:50:12 INFO - Return code: 0 13:50:12 INFO - Running post-action listener: _resource_record_post_action 13:50:12 INFO - Running post-action listener: _start_resource_monitoring 13:50:12 INFO - Starting resource monitoring. 13:50:12 INFO - [mozharness: 2017-10-12 20:50:12.316774Z] Finished create-virtualenv step (success) 13:50:12 INFO - [mozharness: 2017-10-12 20:50:12.317865Z] Running install step. 13:50:12 INFO - Running pre-action listener: _resource_record_pre_action 13:50:12 INFO - Running main action method: install 13:50:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:50:12 INFO - Reading from file tmpfile_stdout 13:50:12 INFO - Detecting whether we're running mozinstall >=1.0... 13:50:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:50:12 INFO - Reading from file tmpfile_stdout 13:50:12 INFO - Output received: 13:50:12 INFO - Usage: mozinstall [options] installer 13:50:12 INFO - Options: 13:50:12 INFO - -h, --help show this help message and exit 13:50:12 INFO - -d DEST, --destination=DEST 13:50:12 INFO - Directory to install application into. [default: 13:50:12 INFO - "/builds/slave/test"] 13:50:12 INFO - --app=APP Application being installed. [default: firefox] 13:50:12 INFO - mkdir: /builds/slave/test/build/application 13:50:12 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:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:50:27 INFO - Reading from file tmpfile_stdout 13:50:27 INFO - Output received: 13:50:27 INFO - /builds/slave/test/build/application/firefox/firefox 13:50:27 INFO - Running post-action listener: _resource_record_post_action 13:50:27 INFO - [mozharness: 2017-10-12 20:50:27.187394Z] Finished install step (success) 13:50:27 INFO - [mozharness: 2017-10-12 20:50:27.187643Z] Running setup-mitmproxy step. 13:50:27 INFO - Running pre-action listener: _resource_record_pre_action 13:50:27 INFO - Running main action method: setup_mitmproxy 13:50:27 INFO - Skipping: mitmproxy is not required 13:50:27 INFO - Running post-action listener: _resource_record_post_action 13:50:27 INFO - [mozharness: 2017-10-12 20:50:27.188772Z] Finished setup-mitmproxy step (success) 13:50:27 INFO - [mozharness: 2017-10-12 20:50:27.188992Z] Running run-tests step. 13:50:27 INFO - Running pre-action listener: _resource_record_pre_action 13:50:27 INFO - Running pre-action listener: _set_gcov_prefix 13:50:27 INFO - Running main action method: run_tests 13:50:27 WARNING - Try message not found. 13:50:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:50:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:50:27 INFO - Python 2.7.3 13:50:27 INFO - Return code: 0 13:50:27 INFO - grabbing minidump binary from tooltool 13:50:27 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:50:27 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 0x28a6090>, '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 0x28a6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a0f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:50:27 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:50:27 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:50:27 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:50:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:50:27 INFO - Return code: 0 13:50:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:50:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:50:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:50:27 INFO - ENV: RUST_BACKTRACE is now full 13:50:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:50:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:50:27 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/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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:50:27 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/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-031 --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:50:27 INFO - Using env: {'DISPLAY': ':0', 13:50:27 INFO - 'HOME': '/home/cltbld', 13:50:27 INFO - 'LANG': 'en_US.UTF-8', 13:50:27 INFO - 'LANGUAGE': 'en_US:en', 13:50:27 INFO - 'LOGNAME': 'cltbld', 13:50:27 INFO - 'MAIL': '/var/mail/cltbld', 13:50:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:50:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:27 INFO - 'MOZ_NO_REMOTE': '1', 13:50:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:50:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:27 INFO - 'NO_EM_RESTART': '1', 13:50:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:27 INFO - 'PWD': '/builds/slave/test', 13:50:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:50:27 INFO - 'RUST_BACKTRACE': 'full', 13:50:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:50:27 INFO - 'SHELL': '/bin/bash', 13:50:27 INFO - 'SHLVL': '1', 13:50:27 INFO - 'TERM': 'linux', 13:50:27 INFO - 'TMOUT': '86400', 13:50:27 INFO - 'USER': 'cltbld', 13:50:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', 13:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:27 INFO - '_': '/tools/buildbot/bin/python'} 13:50:27 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/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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:50:27 INFO - mozversion application_buildid: 20171012192926 13:50:27 INFO - mozversion application_changeset: 2504eb322881ac4bb8e05bf04b6011c598ca6b9d 13:50:27 INFO - mozversion application_display_name: Firefox 13:50:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:50:27 INFO - mozversion application_name: Firefox 13:50:27 INFO - mozversion application_remotingname: firefox 13:50:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:50:27 INFO - mozversion application_vendor: Mozilla 13:50:27 INFO - mozversion application_version: 57.0 13:50:27 INFO - mozversion platform_buildid: 20171012192926 13:50:27 INFO - mozversion platform_changeset: 2504eb322881ac4bb8e05bf04b6011c598ca6b9d 13:50:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:50:27 INFO - mozversion platform_version: 57.0 13:50:27 INFO - using testdate: 1507841427 13:50:27 INFO - actual date: 1507841427 13:50:27 INFO - starting webserver on 'localhost:59172' 13:50:27 INFO - SUITE-START | Running 2 tests 13:50:27 INFO - TEST-START | dromaeo_css 13:50:27 INFO - Initialising browser for dromaeo_css test... 13:50:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59172/getInfo.html -profile /tmp/tmpoeT5uY/profile 13:50:27 INFO - TEST-INFO | started process 3742 (/builds/slave/test/build/application/firefox/firefox http://localhost:59172/getInfo.html) 13:50:34 INFO - TEST-INFO | 3742: exit 0 13:50:34 INFO - Browser initialized. 13:50:34 INFO - Running cycle 1/1 for dromaeo_css test... 13:50:34 INFO - Using env: {'DISPLAY': ':0', 13:50:34 INFO - 'HOME': '/home/cltbld', 13:50:34 INFO - 'JSGC_DISABLE_POISONING': '1', 13:50:34 INFO - 'LANG': 'en_US.UTF-8', 13:50:34 INFO - 'LANGUAGE': 'en_US:en', 13:50:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:50:34 INFO - 'LOGNAME': 'cltbld', 13:50:34 INFO - 'MAIL': '/var/mail/cltbld', 13:50:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:50:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:50:34 INFO - 'MOZ_CRASHREPORTER': '1', 13:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:50:34 INFO - 'MOZ_NO_REMOTE': '1', 13:50:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:34 INFO - 'NO_EM_RESTART': '1', 13:50:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:34 INFO - 'PWD': '/builds/slave/test', 13:50:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:50:34 INFO - 'RUST_BACKTRACE': 'full', 13:50:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:50:34 INFO - 'SHELL': '/bin/bash', 13:50:34 INFO - 'SHLVL': '1', 13:50:34 INFO - 'TERM': 'linux', 13:50:34 INFO - 'TMOUT': '86400', 13:50:34 INFO - 'USER': 'cltbld', 13:50:34 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', 13:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:34 INFO - '_': '/tools/buildbot/bin/python'} 13:50:34 INFO - TEST-INFO | started process 3985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoeT5uY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:50:34 INFO - PID 3985 | 13:50:34 INFO - PID 3985 | (/builds/slave/test/build/application/firefox/firefox:4033): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:50:34 INFO - PID 3985 | 13:50:45 INFO - PID 3985 | RSS: Main: 142196736 13:50:45 INFO - PID 3985 | 13:53:42 INFO - PID 3985 | Cycle 1(1): loaded http://localhost:59172/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59172/tests/dromaeo/cssquery-ext.html) 13:53:43 INFO - PID 3985 | RSS: Main: 145874944 13:53:43 INFO - PID 3985 | 13:56:45 INFO - PID 3985 | Cycle 1(1): loaded http://localhost:59172/tests/dromaeo/cssquery-ext.html (next: http://localhost:59172/tests/dromaeo/cssquery-jquery.html) 13:56:45 INFO - PID 3985 | RSS: Main: 144367616 13:56:45 INFO - PID 3985 | 13:59:47 INFO - PID 3985 | Cycle 1(1): loaded http://localhost:59172/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59172/tests/dromaeo/cssquery-mootools.html) 13:59:47 INFO - PID 3985 | RSS: Main: 145711104 13:59:47 INFO - PID 3985 | 14:02:49 INFO - PID 3985 | Cycle 1(1): loaded http://localhost:59172/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59172/tests/dromaeo/cssquery-prototype.html) 14:02:50 INFO - PID 3985 | RSS: Main: 144916480 14:02:50 INFO - PID 3985 | 14:05:52 INFO - PID 3985 | Cycle 1(1): loaded http://localhost:59172/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59172/tests/dromaeo/cssquery-yui.html) 14:05:53 INFO - PID 3985 | RSS: Main: 144736256 14:05:53 INFO - PID 3985 | 14:08:54 INFO - PID 3985 | Cycle 1(1): loaded http://localhost:59172/tests/dromaeo/cssquery-yui.html (next: http://localhost:59172/tests/dromaeo/cssquery-dojo.html) 14:08:55 INFO - PID 3985 | RSS: Main: 149233664 14:08:55 INFO - PID 3985 | 14:08:55 INFO - PID 3985 | __start_tp_report 14:08:55 INFO - PID 3985 | _x_x_mozilla_page_load 14:08:55 INFO - PID 3985 | _x_x_mozilla_page_load_details 14:08:55 INFO - PID 3985 | |i|pagename|runs| 14:08:55 INFO - PID 3985 | |0;dojo.html;3936.173403585247;3960.3663413853787;3971.9007024824377;3982.542007669119;3988.9601103988953;6570.704318305676;6659.001149827523;6681.265060843303;6698;6718.227403848553;6659.533832631718;6672.666366681671;6673.332666733324;6754.560953538029;6757.864842703143;5972.552058595601;5975.984082705929;6023.789167379143;6030.125631783389;6054.424829641177;6008.1888944992525;6040.516758659319;6041.4562689357945;6102.938970610281;6111.511079113682;6005.3093894202075;6089.6955152242435;6118.174046503732;6120.785772497963;6133.570650054498;5986;6072.149899014142;6137.324894261627;6167.506599472032;6174.043023331391;5868.178455016301;5941.494972927307;5981.312149102865;6033.78881739137;6167.352427995085;6468.159139311906;6597.93402065978;6620.536562440631;6656.700448479782;6673.46612271022;7160.964195179043;7169.24722904098;7246.673899674474;7252.70989160433;7293.380062694678;7137.464690148259;7222.711091556332;7226.132864056294;7340.045794046793;7348.485606007582;6641.236257830363;6648.301928297507;6711.597304161766;6779.457643388468;6797.456203503708;7414.518056326321;7419.480636355512;7497.1753107158165;7505.362044226302;7527.021487206737;7081.858362832818;7111.715531378791;7162.498625096193;7171.247019062923;7228.494005419675;7165.713371465187;7219.422446204396;7277.381422579034;7289.416846652255;7291.744788932362;7174.1032370953635;7193;7223.024891639667;7296.051513303237;7296.087989001375;7195.604241766649;7211.783646490614;7281.672324745399;7288.08898887639;7311.634418279064;5273.604479664041;5278.129108697099;5328.786848526093;5342.652727572696;5358.089124848707;4814.687045342112;4836.951630483721;4847.709137451764;4849.054434385332;4927.482614325444;6778.932210677929;6784.559003664746;6791.830204244933;6859;6869.313068693091;7109.146902371748;7113.0753002109395;7226.963865180641;7229.132504099436;7340.596267205355;6798.592084474947;6832.965835170892;6851.177858656993;6855.451563874878;6870.519063665495;5994.280686317583;5999.4900433463645;6078.75684972605;6092.75628974836;6098.0852872069545;7290.307420795016;7456.1798202197715;7458.888116678254;7477.925220747832;7519.135299440525;7193.856122877409;7223.819404514824;7228.855422891618;7288.161861386008;7318.268173182639;7520.398368130427;7544.132424771222;7609.6575654096805;7620.276073772982;7663.27198916102;7111.253318401494;7157.7136914522835;7227.9638601806655;7252.129744430702;7269.527480713737;7090.432765378654;7173.210946795744;7207.603581803051;7229.204787473269;7350.669219885225;6895.931040689729;6897.41371983387;6919.584824910521;6920.861582768417;6940.444764418935;6824.590524568542;6907.067545881242;6910.308969103049;6912.930870691229;6940.652967351713;6779.93220067793;6794.184697836291;6803.455723542006;6874.931250687429;6892.965535172292;6833.453323734188;6916.757913473004;7013.719451222098;7035.718571257297;7139.21468638439;6824.93175068243;6839.076724642109;6842.760503382557;6867.965660171867;6874.518783685094 14:08:55 INFO - PID 3985 | |1;ext.html;1007.4660429972115;1035.7203555040137;1036.9533370998304;1037.533110100455;1041.8072656558538;43397.78301108494;47121.29318060223;47151;47204.76397618011;47301.52698473014;44265.55734442655;44486.33270500945;44607;44653;44657.330140047925;8156.184381561826;8306.29396501295;8691.739697743824;8904.465732056065;8966;8793.164649358332;8898.733038008837;8914.42056266344;8925.73222803317;8935.508547029911;8857.557122143868;8899;8907.331950103735;8967;9006;8862.291016718647;8890.110988901091;8956.910430895738;8958.148975847284;8975.102489751038;8790.384673072887;8811.427257228259;8819.338549608741;8826.470411775314;8851.247643950272;42012.789936050125;42273;42405;42443.7877810609;42480.78759606213;3857.6528112470014;3874.8643797466952;3904.941425878614;3910.276598829226;3922.4312474691296;35117.12207194815;35302.11744706377;35388.469172962425;35434.64565354365;35454;5478.753456094485;5549.694766787825;5553.666779993213;5597.636153650041;5611.2144299798065;230989;231748;232229;232408;232484;50888.23667644988;51379.74310128426;55336.72331638316;55484.16773748397;55690.16464753032;61101.08348374778;61153;61379;61593;61673.383266167664;19273.807261927483;19327.90336048339;19342.903285483484;19470.8052919469;19535;15892.920535397248;15907.0455772654;16005.759913601305;16061.518154455385;16065.518034458984;16188;16253.431129910396;16337.18314084291;16447.437493438105;16449.917750411172;6140.723667434976;6216.347283535254;6237.438630523275;6345.96827015862;6392.073149393312;1131.6831287239586;1134.7049767060623;1143.4968613809897;1145.0839328537138;1149.9712507187387;27135.592966105523;27392;27702.307442314104;27740.167794966183;27804.72195278062;1253.0602048463652;1266.6136828267283;1266.9239845609293;1269.0925987918683;1274.7577960187534;14173.645658858404;14521.927390363191;14616.561503154922;14645.853541464661;14762.261886905611;304772;305175;306520;306775;308631;64816.351836481976;64937.35062649407;64941.350586494475;65157;65212;1550.093195480634;1574.7716581095676;1607.5016744809147;1608.3888122513604;1619.3198856480071;26811;26813.329666758487;26860.05989790348;27183.59224611672;27363;42884.35673464963;42890;42919.7854010728;43047;43048;263799;263951;264966;265591;265614;37401.81299093487;38790.80604596959;38889.805550972065;38943.221135577696;38966.6103338963;51143.23285150652;51259.23111153261;51277.230841538156;51375.743121284155;51690.22464663108;37842.81078594589;37933.430998534495;38035.42946855744;38165.809170953966;38942.41586376263;37986.2402751949;38166.2366752669;38238.6176138235;38684.41973370458;38815.80592097021;42620;42945.785271073444;43111.56888431076;43405.782971086206;43436.78281608572;36252.81873590615;36265.81867090753;36485.81757091304;36602.8169859149;36989.815050924575;26144.346391339608;26886.731132688423;26910.730892691605;27061.45877082408;27280.72719272782 14:08:55 INFO - PID 3985 | |2;jquery.html;637.7927983754873;641.929299975123;648.5282449820373;651.6144069267503;655.8293446198534;23230.30309090728;24174.87912560437;24223.273301800975;24235.75764242357;24255.75744242557;27106.593401099;27604.309892252702;27632.309192270204;27639.447211055765;27686.584701229447;6236.781712640059;6474.611523308593;6640.169978752656;6686.933130668704;6689.93310066898;6646.966765166191;6666.9333306666795;6735.427488663445;6736.05695202672;6736.8315792105095;6603.273639899608;6687.866242675143;6705.631190284533;6826.624535650537;6839.9316006840045;6780.8304792380095;6808.012838138467;6826.897596536056;6834.384905358516;6835.829104272383;6380.266269378988;6399.232092148972;6402.48780097591;6416.262129855033;6419.422251997296;29193.70806291931;29421;29747.256318591993;30126.397472050656;30167;2399.4601214726545;2456.545539075259;2458.139651122111;2458.2870967419426;2459.163884279336;20361.592768144554;20936.267230646856;20989.68515472269;21042.47393815167;21182.894085529628;2571.8842652080702;2587.0945169190823;2634.6838379394403;2671.5591927331966;2679.6784385873625;147269;154428;168682;175200.49599007948;175818;15927.840721592867;16609.50171494833;16797.664046718997;17146.971181729135;17505.912470437823;27456.313592159957;27459.588106178424;27554.071215014756;27607.171784846487;27703.722962770516;10661.680149595524;10965.725856853483;11055.613053543088;11125.666230013112;11209.383483908463;9802.852957205647;9810.65662701802;9887.406755594688;9924.652637157666;9985;9872.753181170528;10100.191984641211;10183.592656293666;10229.488525573692;10277.486125693686;2844.325570486892;2887.0238606085622;3009.9247518812203;3011.5633233181065;3063.1270088024808;1080.5785743560018;1091.1216470740972;1093.436880006797;1093.781243751253;1104.0725790336155;22167.556648866932;22229;22246.332610021724;22251.44371390696;22580.774192257868;1137.4995002199005;1151.8099513580332;1153.5674122204173;1156.8669602995594;1165.1319766773809;12147.331896745587;12231.449584768707;12348.259104453762;12386.938065309616;12574.119811613282;628568;670856;671151;699495;705158;139128.3043584796;142061.28969355088;142432;145034;146066;1137.294877176156;1187.39442884128;1304.2630913533824;1306.2162702378687;1338.076727058346;22431.77568224297;22730.43173920665;22827.657585136567;22827.771722282563;22991.77008229963;66122;66134;66825.66587167032;66875.66562167158;67323.32676673171;83599;85366.57316713624;86239.13760862562;86307.56846215729;86713.56643216744;16343.264553095378;16397.672046558764;16532.83467165313;16576.419825306057;16591.087490187674;24088.638670420307;24227.273181804576;24700.876495618126;24938.37654058663;25189.370265743502;20180.495487612927;20245.898770506054;20372.59254814866;20594.38216853497;20734.481637959172;17811.46565602982;18003.639927201646;18270.177841996876;18342.633147337245;18443.07784610791;20581;20949.89525052365;20961.89519052395;20996.47508812292;21035.474113147295;16071.67856642884;16075.839241607435;16229.918850405673;16270.674586507967;16303.836961630706;19719.507012324233;19787.30744423938;19903.900480497505;20069.39791806248;20198.091085901462 14:08:55 INFO - PID 3985 | |3;mootools.html;1451.4484495891563;1483.4140514496773;1517.795097661816;1524.8017757691498;1529.082550469719;17390.478285651436;18112.91322520648;18124.184411701488;18141.90929045353;18143.364982225623;17640.294388224487;17728.911355443204;17756.378526751567;17767.46697599071;17785.7332140018;3113.5018397056474;3119.0954623159255;3157.052884134762;3158.415693096773;3160.936781264373;3109.144985129085;3116.781825272232;3117.890873819417;3124.1564777510057;3126.359096385247;3047.939041219174;3154.1483799374155;3155.2427417419885;3156.684331566848;3159.3681263747226;3110.8444577771133;3118.329559144795;3119.111053349807;3121.5629811826475;3126.015305178873;3092.087834088949;3104.798188117765;3106.409782141386;3113.797603155788;3116.1274843043984;17338.13309334528;17456.47630571085;17563.912180439016;17613.471595852145;17624.295028198856;8560.743177704679;8936.195742383217;8949.105089491064;8963.955180224122;8980.371374003822;5398.163284690879;5660.179274005246;5777.59556831022;5802.100674395476;5810.3899090595305;2181.4437318483683;2200.8129309008755;2225.554889022202;2253.853499522526;2277.35095497784;31197.532037019464;31415.057548273588;31554;31599.21001974969;31606.683933160602;7262.854742905112;7427.665755041036;7459.962700186465;7636.427267954815;7669.38644908406;20734;20796.688049679266;20811.68782468264;20939.267125650527;20971.8951405242;8441.788955276168;8736.170063843925;8745.650173993095;8776.122387761301;8786.121387861163;7926.841463170819;7956.403269754792;7959.403044771665;8099.554524501209;8114.837703245902;5831.825045248649;6031.185789918305;6042.425969532887;6088.4215999479975;6119.5104391648565;1547.829738728739;1565.24085818378;1696.5928177237622;1741.277369891481;1777.5644966982914;1026.8716410448694;1032.1123833503182;1039.7972395382978;1044.2429238801808;1062.792755412687;10087.142592879687;10182.287239893285;10254.436006019741;10373.896261037444;10377.792444151075;1101.4712937789907;1116.3023110555903;1129.0910816792398;1129.1136457880525;1133.3962443143025;5693.886122277614;6268.153799237136;6306.590071645328;6358.650274234869;6473.449756770728;25848.74151258501;26478.73521264801;26679.733202668114;26686.46627067448;26850.32874178161;25444.74555254424;26328.736712632628;27042.729572704415;27116.457670846867;27120.32199195036;12820.35898205086;13211.075224734368;13344.132631379123;13401.128926619738;13404.463821447229;9214.677486287948;9826.656067037906;9880;10024.699259022242;10129.898701012895;22205.88897055569;22258.66612000789;22277.10891564319;22400.88799555992;22400.88799555992;22880.656790147827;22959;22992.655110173026;23149.3055208344;23322.76677233206;12700.618981430573;12708.618741437771;12766.744665106831;12827.230366178059;12914.483420663068;14570.198639074953;14718;14722.852771472148;14723.263836808332;14758;11346.659600212008;11534;11560.6531804046;11618.186726929034;11670.416479176178;11440.256383335056;11467.483963221508;11718.23831450953;11747.941260293645;11861.76276474483;10721.142308615448;10738.14094872424;10862;10864.130869530261;10907.945460272647;8029.5583742894705;8283.461574997606;8284.130166332448;8308.792280193044;8408.621612027351;8489.830203395773;8640.697575584825;8671.696490622799;8676;8728.039915609404 14:08:55 INFO - PID 3985 | |4;prototype.html;565.4091474409245;577.9537636989041;585.6925114314987;602.6354055796243;606.854354954811;6358.395952384516;6399.392057754518;6407.839804004902;6412.454941329993;6493.740250389985;6258.342873998222;6353.650549219791;6386.64873431961;6415.166028416299;6497.18785151856;5303.7348132593315;5311.521963023327;5362.249285100089;5365.302510673607;5368.3021207243;5254.343207099113;5300.284461597674;5327.094393953018;5338.412774594792;5347.679139251657;4979.228219625946;5117.257997590347;5121.923171152435;5123.257127716479;5129.487051294859;5129.25625784263;5135.460776618476;5142.074426603229;5147.7683504242395;5152.613553983466;4616.976915115437;4645.698029628097;4680.812767489297;4682.274247491644;4722.574968252874;6313.706679457967;6324.778632747878;6334.366563343675;6340.461060809836;6409.679516024226;5978.910316345258;6032.612499125182;6042.728077236535;6047.546434017467;6067.848303792396;6759.526833121683;6794.592324460499;6804.421624161952;6813.591184528944;6813.897791533131;5020.272060551236;5133.66311897266;5190.455002224788;5221.216817477371;5258.0535503609335;6967.198772141218;6967.54710943787;7057.329553692391;7127.928720712778;7189.496735228536;5316.255724198615;5333.359996800331;5375.19372094189;5395;5428.647137936022;5467.808626698126;5474.7810087596845;5476.616636835463;5510.201020851954;5512.145617429305;6020.909686354708;6043.909341359883;6090.50782558276;6095.323785958808;6116.633002019893;6877.552959057745;6896.344847239504;6903.75836845708;6922.342377474132;6949.652517374111;1867.3090956345968;1873.147717788403;1876.934307299238;1884.7738271407518;1887.37716553537;1304.9608511744664;1320.4388135042761;1339.484298545067;1361.1764882246098;1367.5828872194077;6370.426661600385;6389.840253993687;6412.935870641327;6434.356564343529;6507.772227971998;6761.3238676132;6799.830004249933;6870.31296870319;6876.931230687729;6945.756898508528;6365.681715914186;6369.522285828489;6389.904151437732;6462.192225971754;6518.771842985473;3634.9636503634624;3639.9080275917117;3653.2510835278704;3669.559652841676;3686.889393318205;7105.786826395217;7147.499675022698;7161;7234.457415693844;7254.746083887038;6950.165980082423;6972.686229119702;7005.649717514104;7034.472414568825;7101.680424380916;7136.892946605805;7224.349808517259;7253.419726421874;7279.235680253497;7314;6804.455643548603;6843.452523798183;6942.791716248521;7016.859662806817;7032.12098487689;6719.832004199934;6791.592504449749;6838.281980391987;6839;6858.965705171442;7179.928200718135;7215.963920180366;7222.313880181375;7225.855482890418;7287.708491660274;5348.117560602457;5366.195070739421;5386.299781028441;5405.486478784509;5421.2139239810795;6700.229473610597;6817.0456136141975;6827;6843.110395648733;6962.582245065312;6328.7152078157515;6645.169353830771;6678.666066696743;6686.69909854048;6737.124173857367;6571.145751052332;6656.903075531192;6699.9665001674675;6714;6752.831179220559;6602.8679426410245;6614.470842332698;6626.370494802986;6636;6665.767102954966;6613.338666133348;6659.5671281368495;6660.167479065117;6746.460283177236;6790.660466976533;6341.460975816923;6551.198420434419;6573.704183311858;6586.70359833799;6706.6981985811735 14:08:55 INFO - PID 3985 | |5;yui.html;1006.195043964828;1017.0439786600595;1024.9590016399345;1038.029442471289;1049.8635177426936;17512.562185945357;17555.473335799914;17701.20344584492;19611;19991.300304489345;18239.452816415494;18545.536361590966;18599.53501162468;18657.813421865776;18663.3467828626;1039.454286499588;1060.7560261139943;1065.0255016659746;1068.60995736556;1071.196602548089;1078.008232426166;1091.263397206886;1091.2688498705886;1094.3816743539874;1096.4079397125543;1122.354646078504;1173.624440179143;1175.8882906123904;1179.887910648487;1180.8819118088165;1140.8288756686482;1150.1603829204728;1152.5044230980716;1154.6824623228595;1156.7570810129882;822.1367564057715;830.3772170871846;831.1024093978489;831.6673330667721;833.1918039501734;19408.514787130294;19749.21003159872;19987.10058047377;20064.69902951457;20088.49778755543;23699.170529031402;24114.517709645883;24115;24152.879235603887;24153.637695434583;18858.245670173175;19648.607027859507;19663.115159817844;19832.90083549573;19837.80162198374;3930.0764320384687;3975.940360894589;3979.303621866162;3994.0613955720382;3994.3009973254857;129268;147814.26092869573;167061;167131.16434417872;173342;18499.352522661644;18784.81215187858;18824.905875470537;19148.425547233604;19351.90324048399;35215;35421.64578354235;35671.28657426837;35690.28619427649;36117.555297787796;10339.224558158017;10389.168866490814;10423.94788026055;10438.582456701646;10456.058954694114;4750.14497390473;4812.542808433193;4825.855224343275;4844.2007068833955;4847.830325938575;6122.816315510542;6191.690415479208;6229.7508099676415;6237.656928868865;6243.469305109116;1291.4834066373526;1304.419533307688;1321.966950826237;1323.9801402978962;1326.4826717580152;707.4305184326666;731.2285538756663;733.3949491669395;737.6385571070138;751.2374939436477;11800.586979455678;11978.52085916571;12044.277343359427;12048.819267710991;12389.62831115068;716.989245161323;740.4742632730714;743.2493181886334;743.910730712318;750.951188172767;5592.7762889484775;5682.374938756733;5752.769889204469;5801.6519008859605;5802;160173;160216;162271;162900.1854990741;163636;139841;143434.28282858728;145687.2715636415;146062.269688653;150842.24578877256;123603;124636.99999999818;132722;134226;135009;12512.624621261377;12863.163894346837;13083.672908177372;13236.205827650372;13272.402741876445;57030;57357.42642573521;57477.13784293155;57636.71181644065;58111.418885812294;74774;74891;75782.62108689421;76506.61746691454;77827.6108619476;18321.083945802922;18411.53971150732;18532.1660525274;18561.35035273759;18566.721499177795;22759.658605120607;23329.3001209964;23332.416689582897;23347;23417;18567.350142744937;18608.5347866299;18652.81347186511;18668.253269869052;18769.812301876806;19360.225590976203;19532;19702.901485492483;19756.901215493832;19881.204751809764;17567.385141519986;17570.82429175692;17599.384021559184;17749.822501774815;17758.37845675395;14054.156750594997;14284.57146285613;14582.125072495684;14630.561083167522;14703.55889323322;13280.800787987995;13300.334983250605;13434.328283585977;13469.797953030908;13538.187708737507 14:08:55 INFO - PID 3985 | __end_tp_report 14:08:55 INFO - PID 3985 | __start_cc_report 14:08:55 INFO - PID 3985 | _x_x_mozilla_cycle_collect,246 14:08:55 INFO - PID 3985 | __end_cc_report 14:08:55 INFO - PID 3985 | __startTimestamp1507842535203__endTimestamp 14:08:55 INFO - PID 3985 | 14:08:55 INFO - PID 3985 | ------- Summary: start ------- 14:08:55 INFO - PID 3985 | Number of tests: 6 14:08:55 INFO - PID 3985 | 14:08:55 INFO - PID 3985 | [#0] dojo.html Cycles:165 Average:6667.81 Median:6869.31 stddev:787.03 (11.5%) stddev-sans-first:759.71 14:08:55 INFO - PID 3985 | Values: 3936.2 3960.4 3971.9 3982.5 3989.0 6570.7 6659.0 6681.3 6698.0 6718.2 6659.5 6672.7 6673.3 6754.6 6757.9 5972.6 5976.0 6023.8 6030.1 6054.4 6008.2 6040.5 6041.5 6102.9 6111.5 6005.3 6089.7 6118.2 6120.8 6133.6 5986.0 6072.1 6137.3 6167.5 6174.0 5868.2 5941.5 5981.3 6033.8 6167.4 6468.2 6597.9 6620.5 6656.7 6673.5 7161.0 7169.2 7246.7 7252.7 7293.4 7137.5 7222.7 7226.1 7340.0 7348.5 6641.2 6648.3 6711.6 6779.5 6797.5 7414.5 7419.5 7497.2 7505.4 7527.0 7081.9 7111.7 7162.5 7171.2 7228.5 7165.7 7219.4 7277.4 7289.4 7291.7 7174.1 7193.0 7223.0 7296.1 7296.1 7195.6 7211.8 7281.7 7288.1 7311.6 5273.6 5278.1 5328.8 5342.7 5358.1 4814.7 4837.0 4847.7 4849.1 4927.5 6778.9 6784.6 6791.8 6859.0 6869.3 7109.1 7113.1 7227.0 7229.1 7340.6 6798.6 6833.0 6851.2 6855.5 6870.5 5994.3 5999.5 6078.8 6092.8 6098.1 7290.3 7456.2 7458.9 7477.9 7519.1 7193.9 7223.8 7228.9 7288.2 7318.3 7520.4 7544.1 7609.7 7620.3 7663.3 7111.3 7157.7 7228.0 7252.1 7269.5 7090.4 7173.2 7207.6 7229.2 7350.7 6895.9 6897.4 6919.6 6920.9 6940.4 6824.6 6907.1 6910.3 6912.9 6940.7 6779.9 6794.2 6803.5 6874.9 6893.0 6833.5 6916.8 7013.7 7035.7 7139.2 6824.9 6839.1 6842.8 6868.0 6874.5 14:08:55 INFO - PID 3985 | 14:08:55 INFO - PID 3985 | [#1] ext.html Cycles:180 Average:45933.31 Median:21332.84 stddev:70076.30 (328.5%) stddev-sans-first:70191.70 14:08:55 INFO - PID 3985 | Values: 1007.5 1035.7 1037.0 1037.5 1041.8 43397.8 47121.3 47151.0 47204.8 47301.5 44265.6 44486.3 44607.0 44653.0 44657.3 8156.2 8306.3 8691.7 8904.5 8966.0 8793.2 8898.7 8914.4 8925.7 8935.5 8857.6 8899.0 8907.3 8967.0 9006.0 8862.3 8890.1 8956.9 8958.1 8975.1 8790.4 8811.4 8819.3 8826.5 8851.2 42012.8 42273.0 42405.0 42443.8 42480.8 3857.7 3874.9 3904.9 3910.3 3922.4 35117.1 35302.1 35388.5 35434.6 35454.0 5478.8 5549.7 5553.7 5597.6 5611.2 230989.0 231748.0 232229.0 232408.0 232484.0 50888.2 51379.7 55336.7 55484.2 55690.2 61101.1 61153.0 61379.0 61593.0 61673.4 19273.8 19327.9 19342.9 19470.8 19535.0 15892.9 15907.0 16005.8 16061.5 16065.5 16188.0 16253.4 16337.2 16447.4 16449.9 6140.7 6216.3 6237.4 6346.0 6392.1 1131.7 1134.7 1143.5 1145.1 1150.0 27135.6 27392.0 27702.3 27740.2 27804.7 1253.1 1266.6 1266.9 1269.1 1274.8 14173.6 14521.9 14616.6 14645.9 14762.3 304772.0 305175.0 306520.0 306775.0 308631.0 64816.4 64937.4 64941.4 65157.0 65212.0 1550.1 1574.8 1607.5 1608.4 1619.3 26811.0 26813.3 26860.1 27183.6 27363.0 42884.4 42890.0 42919.8 43047.0 43048.0 263799.0 263951.0 264966.0 265591.0 265614.0 37401.8 38790.8 38889.8 38943.2 38966.6 51143.2 51259.2 51277.2 51375.7 51690.2 37842.8 37933.4 38035.4 38165.8 38942.4 37986.2 38166.2 38238.6 38684.4 38815.8 42620.0 42945.8 43111.6 43405.8 43436.8 36252.8 36265.8 36485.8 36602.8 36989.8 26144.3 26886.7 26910.7 27061.5 27280.7 14:08:55 INFO - PID 3985 | 14:08:55 INFO - PID 3985 | [#2] jquery.html Cycles:180 Average:43101.84 Median:13244.05 stddev:112989.02 (853.1%) stddev-sans-first:113261.00 14:08:55 INFO - PID 3985 | Values: 637.8 641.9 648.5 651.6 655.8 23230.3 24174.9 24223.3 24235.8 24255.8 27106.6 27604.3 27632.3 27639.4 27686.6 6236.8 6474.6 6640.2 6686.9 6689.9 6647.0 6666.9 6735.4 6736.1 6736.8 6603.3 6687.9 6705.6 6826.6 6839.9 6780.8 6808.0 6826.9 6834.4 6835.8 6380.3 6399.2 6402.5 6416.3 6419.4 29193.7 29421.0 29747.3 30126.4 30167.0 2399.5 2456.5 2458.1 2458.3 2459.2 20361.6 20936.3 20989.7 21042.5 21182.9 2571.9 2587.1 2634.7 2671.6 2679.7 147269.0 154428.0 168682.0 175200.5 175818.0 15927.8 16609.5 16797.7 17147.0 17505.9 27456.3 27459.6 27554.1 27607.2 27703.7 10661.7 10965.7 11055.6 11125.7 11209.4 9802.9 9810.7 9887.4 9924.7 9985.0 9872.8 10100.2 10183.6 10229.5 10277.5 2844.3 2887.0 3009.9 3011.6 3063.1 1080.6 1091.1 1093.4 1093.8 1104.1 22167.6 22229.0 22246.3 22251.4 22580.8 1137.5 1151.8 1153.6 1156.9 1165.1 12147.3 12231.4 12348.3 12386.9 12574.1 628568.0 670856.0 671151.0 699495.0 705158.0 139128.3 142061.3 142432.0 145034.0 146066.0 1137.3 1187.4 1304.3 1306.2 1338.1 22431.8 22730.4 22827.7 22827.8 22991.8 66122.0 66134.0 66825.7 66875.7 67323.3 83599.0 85366.6 86239.1 86307.6 86713.6 16343.3 16397.7 16532.8 16576.4 16591.1 24088.6 24227.3 24700.9 24938.4 25189.4 20180.5 20245.9 20372.6 20594.4 20734.5 17811.5 18003.6 18270.2 18342.6 18443.1 20581.0 20949.9 20961.9 20996.5 21035.5 16071.7 16075.8 16229.9 16270.7 16303.8 19719.5 19787.3 19903.9 20069.4 20198.1 14:08:55 INFO - PID 3985 | 14:08:55 INFO - PID 3985 | [#3] mootools.html Cycles:180 Average:10831.82 Median:23236.04 stddev:8043.63 (34.6%) stddev-sans-first:8035.32 14:08:55 INFO - PID 3985 | Values: 1451.4 1483.4 1517.8 1524.8 1529.1 17390.5 18112.9 18124.2 18141.9 18143.4 17640.3 17728.9 17756.4 17767.5 17785.7 3113.5 3119.1 3157.1 3158.4 3160.9 3109.1 3116.8 3117.9 3124.2 3126.4 3047.9 3154.1 3155.2 3156.7 3159.4 3110.8 3118.3 3119.1 3121.6 3126.0 3092.1 3104.8 3106.4 3113.8 3116.1 17338.1 17456.5 17563.9 17613.5 17624.3 8560.7 8936.2 8949.1 8964.0 8980.4 5398.2 5660.2 5777.6 5802.1 5810.4 2181.4 2200.8 2225.6 2253.9 2277.4 31197.5 31415.1 31554.0 31599.2 31606.7 7262.9 7427.7 7460.0 7636.4 7669.4 20734.0 20796.7 20811.7 20939.3 20971.9 8441.8 8736.2 8745.7 8776.1 8786.1 7926.8 7956.4 7959.4 8099.6 8114.8 5831.8 6031.2 6042.4 6088.4 6119.5 1547.8 1565.2 1696.6 1741.3 1777.6 1026.9 1032.1 1039.8 1044.2 1062.8 10087.1 10182.3 10254.4 10373.9 10377.8 1101.5 1116.3 1129.1 1129.1 1133.4 5693.9 6268.2 6306.6 6358.7 6473.4 25848.7 26478.7 26679.7 26686.5 26850.3 25444.7 26328.7 27042.7 27116.5 27120.3 12820.4 13211.1 13344.1 13401.1 13404.5 9214.7 9826.7 9880.0 10024.7 10129.9 22205.9 22258.7 22277.1 22400.9 22400.9 22880.7 22959.0 22992.7 23149.3 23322.8 12700.6 12708.6 12766.7 12827.2 12914.5 14570.2 14718.0 14722.9 14723.3 14758.0 11346.7 11534.0 11560.7 11618.2 11670.4 11440.3 11467.5 11718.2 11747.9 11861.8 10721.1 10738.1 10862.0 10864.1 10907.9 8029.6 8283.5 8284.1 8308.8 8408.6 8489.8 8640.7 8671.7 8676.0 8728.0 14:08:55 INFO - PID 3985 | 14:08:55 INFO - PID 3985 | [#4] prototype.html Cycles:180 Average:5792.82 Median:6403.62 stddev:1601.76 (25.0%) stddev-sans-first:1557.45 14:08:55 INFO - PID 3985 | Values: 565.4 578.0 585.7 602.6 606.9 6358.4 6399.4 6407.8 6412.5 6493.7 6258.3 6353.7 6386.6 6415.2 6497.2 5303.7 5311.5 5362.2 5365.3 5368.3 5254.3 5300.3 5327.1 5338.4 5347.7 4979.2 5117.3 5121.9 5123.3 5129.5 5129.3 5135.5 5142.1 5147.8 5152.6 4617.0 4645.7 4680.8 4682.3 4722.6 6313.7 6324.8 6334.4 6340.5 6409.7 5978.9 6032.6 6042.7 6047.5 6067.8 6759.5 6794.6 6804.4 6813.6 6813.9 5020.3 5133.7 5190.5 5221.2 5258.1 6967.2 6967.5 7057.3 7127.9 7189.5 5316.3 5333.4 5375.2 5395.0 5428.6 5467.8 5474.8 5476.6 5510.2 5512.1 6020.9 6043.9 6090.5 6095.3 6116.6 6877.6 6896.3 6903.8 6922.3 6949.7 1867.3 1873.1 1876.9 1884.8 1887.4 1305.0 1320.4 1339.5 1361.2 1367.6 6370.4 6389.8 6412.9 6434.4 6507.8 6761.3 6799.8 6870.3 6876.9 6945.8 6365.7 6369.5 6389.9 6462.2 6518.8 3635.0 3639.9 3653.3 3669.6 3686.9 7105.8 7147.5 7161.0 7234.5 7254.7 6950.2 6972.7 7005.6 7034.5 7101.7 7136.9 7224.3 7253.4 7279.2 7314.0 6804.5 6843.5 6942.8 7016.9 7032.1 6719.8 6791.6 6838.3 6839.0 6859.0 7179.9 7216.0 7222.3 7225.9 7287.7 5348.1 5366.2 5386.3 5405.5 5421.2 6700.2 6817.0 6827.0 6843.1 6962.6 6328.7 6645.2 6678.7 6686.7 6737.1 6571.1 6656.9 6700.0 6714.0 6752.8 6602.9 6614.5 6626.4 6636.0 6665.8 6613.3 6659.6 6660.2 6746.5 6790.7 6341.5 6551.2 6573.7 6586.7 6706.7 14:08:55 INFO - PID 3985 | 14:08:55 INFO - PID 3985 | [#5] yui.html Cycles:180 Average:29813.84 Median:18567.04 stddev:45067.91 (242.7%) stddev-sans-first:45142.43 14:08:55 INFO - PID 3985 | Values: 1006.2 1017.0 1025.0 1038.0 1049.9 17512.6 17555.5 17701.2 19611.0 19991.3 18239.5 18545.5 18599.5 18657.8 18663.3 1039.5 1060.8 1065.0 1068.6 1071.2 1078.0 1091.3 1091.3 1094.4 1096.4 1122.4 1173.6 1175.9 1179.9 1180.9 1140.8 1150.2 1152.5 1154.7 1156.8 822.1 830.4 831.1 831.7 833.2 19408.5 19749.2 19987.1 20064.7 20088.5 23699.2 24114.5 24115.0 24152.9 24153.6 18858.2 19648.6 19663.1 19832.9 19837.8 3930.1 3975.9 3979.3 3994.1 3994.3 129268.0 147814.3 167061.0 167131.2 173342.0 18499.4 18784.8 18824.9 19148.4 19351.9 35215.0 35421.6 35671.3 35690.3 36117.6 10339.2 10389.2 10423.9 10438.6 10456.1 4750.1 4812.5 4825.9 4844.2 4847.8 6122.8 6191.7 6229.8 6237.7 6243.5 1291.5 1304.4 1322.0 1324.0 1326.5 707.4 731.2 733.4 737.6 751.2 11800.6 11978.5 12044.3 12048.8 12389.6 717.0 740.5 743.2 743.9 751.0 5592.8 5682.4 5752.8 5801.7 5802.0 160173.0 160216.0 162271.0 162900.2 163636.0 139841.0 143434.3 145687.3 146062.3 150842.2 123603.0 124637.0 132722.0 134226.0 135009.0 12512.6 12863.2 13083.7 13236.2 13272.4 57030.0 57357.4 57477.1 57636.7 58111.4 74774.0 74891.0 75782.6 76506.6 77827.6 18321.1 18411.5 18532.2 18561.4 18566.7 22759.7 23329.3 23332.4 23347.0 23417.0 18567.4 18608.5 18652.8 18668.3 18769.8 19360.2 19532.0 19702.9 19756.9 19881.2 17567.4 17570.8 17599.4 17749.8 17758.4 14054.2 14284.6 14582.1 14630.6 14703.6 13280.8 13300.3 13434.3 13469.8 13538.2 14:08:55 INFO - PID 3985 | -------- Summary: end -------- 14:08:55 INFO - PID 3985 | 14:08:55 INFO - TEST-INFO | 3985: exit 0 14:08:55 INFO - TEST-OK | dromaeo_css | took 1108142ms 14:08:55 INFO - TEST-START | kraken 14:08:55 INFO - Initialising browser for kraken test... 14:08:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59172/getInfo.html -profile /tmp/tmpy3OQuv/profile 14:08:55 INFO - TEST-INFO | started process 4364 (/builds/slave/test/build/application/firefox/firefox http://localhost:59172/getInfo.html) 14:09:00 INFO - TEST-INFO | 4364: exit 0 14:09:00 INFO - Browser initialized. 14:09:00 INFO - Running cycle 1/1 for kraken test... 14:09:00 INFO - Using env: {'DISPLAY': ':0', 14:09:00 INFO - 'HOME': '/home/cltbld', 14:09:00 INFO - 'JSGC_DISABLE_POISONING': '1', 14:09:00 INFO - 'LANG': 'en_US.UTF-8', 14:09:00 INFO - 'LANGUAGE': 'en_US:en', 14:09:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:09:00 INFO - 'LOGNAME': 'cltbld', 14:09:00 INFO - 'MAIL': '/var/mail/cltbld', 14:09:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:09:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:09:00 INFO - 'MOZ_CRASHREPORTER': '1', 14:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:09:00 INFO - 'MOZ_NO_REMOTE': '1', 14:09:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:00 INFO - 'NO_EM_RESTART': '1', 14:09:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:00 INFO - 'PWD': '/builds/slave/test', 14:09:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:09:00 INFO - 'RUST_BACKTRACE': 'full', 14:09:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:09:00 INFO - 'SHELL': '/bin/bash', 14:09:00 INFO - 'SHLVL': '1', 14:09:00 INFO - 'TERM': 'linux', 14:09:00 INFO - 'TMOUT': '86400', 14:09:00 INFO - 'USER': 'cltbld', 14:09:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130', 14:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:00 INFO - '_': '/tools/buildbot/bin/python'} 14:09:00 INFO - TEST-INFO | started process 4604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy3OQuv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:01 INFO - PID 4604 | 14:09:01 INFO - PID 4604 | (/builds/slave/test/build/application/firefox/firefox:4652): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:09:01 INFO - PID 4604 | 14:09:12 INFO - PID 4604 | RSS: Main: 138235904 14:09:12 INFO - PID 4604 | 14:09:14 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:59172/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59172/tests/kraken/driver.html?testName=audio-beat-detection) 14:09:15 INFO - PID 4604 | RSS: Main: 145174528 14:09:15 INFO - PID 4604 | 14:09:17 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:59172/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59172/tests/kraken/driver.html?testName=audio-dft) 14:09:18 INFO - PID 4604 | RSS: Main: 145326080 14:09:18 INFO - PID 4604 | 14:09:21 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:59172/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59172/tests/kraken/driver.html?testName=audio-fft) 14:09:21 INFO - PID 4604 | RSS: Main: 146952192 14:09:21 INFO - PID 4604 | 14:09:24 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:59172/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59172/tests/kraken/driver.html?testName=audio-oscillator) 14:09:24 INFO - PID 4604 | RSS: Main: 147169280 14:09:24 INFO - PID 4604 | 14:09:26 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:59172/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59172/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:09:27 INFO - PID 4604 | RSS: Main: 146907136 14:09:27 INFO - PID 4604 | 14:09:30 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:59172/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59172/tests/kraken/driver.html?testName=imaging-darkroom) 14:09:30 INFO - PID 4604 | RSS: Main: 146763776 14:09:30 INFO - PID 4604 | 14:09:34 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:59172/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59172/tests/kraken/driver.html?testName=imaging-desaturate) 14:09:35 INFO - PID 4604 | RSS: Main: 146980864 14:09:35 INFO - PID 4604 | 14:09:37 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:59172/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59172/tests/kraken/driver.html?testName=json-parse-financial) 14:09:38 INFO - PID 4604 | RSS: Main: 148590592 14:09:38 INFO - PID 4604 | 14:09:39 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:59172/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59172/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:09:40 INFO - PID 4604 | RSS: Main: 148705280 14:09:40 INFO - PID 4604 | 14:09:42 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:59172/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59172/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:09:42 INFO - PID 4604 | RSS: Main: 148467712 14:09:42 INFO - PID 4604 | 14:09:44 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:59172/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59172/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:09:45 INFO - PID 4604 | RSS: Main: 148701184 14:09:45 INFO - PID 4604 | 14:09:47 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:59172/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59172/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:09:48 INFO - PID 4604 | RSS: Main: 148905984 14:09:48 INFO - PID 4604 | 14:09:50 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:59172/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59172/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:09:51 INFO - PID 4604 | RSS: Main: 149188608 14:09:51 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:59172/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59172/tests/kraken/driver.html?testName=ai-astar) 14:09:53 INFO - PID 4604 | RSS: Main: 150409216 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | __start_tp_report 14:09:53 INFO - PID 4604 | _x_x_mozilla_page_load 14:09:53 INFO - PID 4604 | _x_x_mozilla_page_load_details 14:09:53 INFO - PID 4604 | |i|pagename|runs| 14:09:53 INFO - PID 4604 | |0;ai-astar;104;105;105;106;105;107;105;104;107;104 14:09:53 INFO - PID 4604 | |1;audio-beat-detection;112;111;110;110;114;110;111;113;112;112 14:09:53 INFO - PID 4604 | |2;audio-dft;162;164;164;162;161;161;162;166;164;162 14:09:53 INFO - PID 4604 | |3;audio-fft;74;72;72;73;76;74;72;74;76;81 14:09:53 INFO - PID 4604 | |4;audio-oscillator;78;78;76;76;77;78;77;78;78;76 14:09:53 INFO - PID 4604 | |5;imaging-gaussian-blur;113;114;111;114;117;113;117;111;113;115 14:09:53 INFO - PID 4604 | |6;imaging-darkroom;149;147;148;148;148;148;148;148;149;149 14:09:53 INFO - PID 4604 | |7;imaging-desaturate;95;94;95;95;94;93;94;94;94;94 14:09:53 INFO - PID 4604 | |8;json-parse-financial;46;43;44;44;48;45;44;49;48;49 14:09:53 INFO - PID 4604 | |9;json-stringify-tinderbox;39;39;40;40;40;40;41;40;39;40 14:09:53 INFO - PID 4604 | |10;stanford-crypto-aes;69;70;76;69;72;70;68;70;69;69 14:09:53 INFO - PID 4604 | |11;stanford-crypto-ccm;115;106;105;105;104;110;113;104;105;105 14:09:53 INFO - PID 4604 | |12;stanford-crypto-pbkdf2;152;153;151;150;159;151;151;150;156;156 14:09:53 INFO - PID 4604 | |13;stanford-crypto-sha256-iterative;57;59;60;58;60;58;62;60;57;60 14:09:53 INFO - PID 4604 | __end_tp_report 14:09:53 INFO - PID 4604 | __start_cc_report 14:09:53 INFO - PID 4604 | _x_x_mozilla_cycle_collect,680 14:09:53 INFO - PID 4604 | __end_cc_report 14:09:53 INFO - PID 4604 | __startTimestamp1507842593462__endTimestamp 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | ------- Summary: start ------- 14:09:53 INFO - PID 4604 | Number of tests: 14 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | [#0] ai-astar Cycles:10 Average:105.20 Median:105.00 stddev:1.14 (1.1%) stddev-sans-first:1.12 14:09:53 INFO - PID 4604 | Values: 104.0 105.0 105.0 106.0 105.0 107.0 105.0 104.0 107.0 104.0 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | [#1] audio-beat-detection Cycles:10 Average:111.50 Median:112.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 14:09:53 INFO - PID 4604 | Values: 112.0 111.0 110.0 110.0 114.0 110.0 111.0 113.0 112.0 112.0 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.62 (1.0%) stddev-sans-first:1.69 14:09:53 INFO - PID 4604 | Values: 162.0 164.0 164.0 162.0 161.0 161.0 162.0 166.0 164.0 162.0 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | [#3] audio-fft Cycles:10 Average:74.40 Median:74.00 stddev:2.76 (3.7%) stddev-sans-first:2.92 14:09:53 INFO - PID 4604 | Values: 74.0 72.0 72.0 73.0 76.0 74.0 72.0 74.0 76.0 81.0 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:78.00 stddev:0.92 (1.2%) stddev-sans-first:0.93 14:09:53 INFO - PID 4604 | Values: 78.0 78.0 76.0 76.0 77.0 78.0 77.0 78.0 78.0 76.0 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:2.10 (1.8%) stddev-sans-first:2.20 14:09:53 INFO - PID 4604 | Values: 113.0 114.0 111.0 114.0 117.0 113.0 117.0 111.0 113.0 115.0 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 14:09:53 INFO - PID 4604 | Values: 149.0 147.0 148.0 148.0 148.0 148.0 148.0 148.0 149.0 149.0 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 14:09:53 INFO - PID 4604 | Values: 95.0 94.0 95.0 95.0 94.0 93.0 94.0 94.0 94.0 94.0 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | [#8] json-parse-financial Cycles:10 Average:46.00 Median:47.00 stddev:2.31 (4.9%) stddev-sans-first:2.45 14:09:53 INFO - PID 4604 | Values: 46.0 43.0 44.0 44.0 48.0 45.0 44.0 49.0 48.0 49.0 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | [#9] json-stringify-tinderbox Cycles:10 Average:39.80 Median:40.00 stddev:0.63 (1.6%) stddev-sans-first:0.60 14:09:53 INFO - PID 4604 | Values: 39.0 39.0 40.0 40.0 40.0 40.0 41.0 40.0 39.0 40.0 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | [#10] stanford-crypto-aes Cycles:10 Average:70.20 Median:70.00 stddev:2.30 (3.3%) stddev-sans-first:2.40 14:09:53 INFO - PID 4604 | Values: 69.0 70.0 76.0 69.0 72.0 70.0 68.0 70.0 69.0 69.0 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | [#11] stanford-crypto-ccm Cycles:10 Average:107.20 Median:105.50 stddev:3.99 (3.8%) stddev-sans-first:3.08 14:09:53 INFO - PID 4604 | Values: 115.0 106.0 105.0 105.0 104.0 110.0 113.0 104.0 105.0 105.0 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.90 Median:152.50 stddev:3.07 (2.0%) stddev-sans-first:3.24 14:09:53 INFO - PID 4604 | Values: 152.0 153.0 151.0 150.0 159.0 151.0 151.0 150.0 156.0 156.0 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.10 Median:60.00 stddev:1.60 (2.7%) stddev-sans-first:1.50 14:09:53 INFO - PID 4604 | Values: 57.0 59.0 60.0 58.0 60.0 58.0 62.0 60.0 57.0 60.0 14:09:53 INFO - PID 4604 | -------- Summary: end -------- 14:09:53 INFO - PID 4604 | 14:09:53 INFO - PID 4604 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:09:54 INFO - TEST-INFO | 4604: exit 0 14:09:54 INFO - TEST-OK | kraken | took 58350ms 14:09:54 INFO - SUITE-END | took 1166s 14:09:54 INFO - Completed test suite (00:19:26) 14:09:54 INFO - javascript benchmark 14:09:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9503.62740589321, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3936.173403585247, 3960.3663413853787, 3971.9007024824377, 3982.542007669119, 3988.9601103988953, 6570.704318305676, 6659.001149827523, 6681.265060843303, 6698.0, 6718.227403848553, 6659.533832631718, 6672.666366681671, 6673.332666733324, 6754.560953538029, 6757.864842703143, 5972.552058595601, 5975.984082705929, 6023.789167379143, 6030.125631783389, 6054.424829641177, 6008.1888944992525, 6040.516758659319, 6041.4562689357945, 6102.938970610281, 6111.511079113682, 6005.3093894202075, 6089.6955152242435, 6118.174046503732, 6120.785772497963, 6133.570650054498, 5986.0, 6072.149899014142, 6137.324894261627, 6167.506599472032, 6174.043023331391, 5868.178455016301, 5941.494972927307, 5981.312149102865, 6033.78881739137, 6167.352427995085, 6468.159139311906, 6597.93402065978, 6620.536562440631, 6656.700448479782, 6673.46612271022, 7160.964195179043, 7169.24722904098, 7246.673899674474, 7252.70989160433, 7293.380062694678, 7137.464690148259, 7222.711091556332, 7226.132864056294, 7340.045794046793, 7348.485606007582, 6641.236257830363, 6648.301928297507, 6711.597304161766, 6779.457643388468, 6797.456203503708, 7414.518056326321, 7419.480636355512, 7497.1753107158165, 7505.362044226302, 7527.021487206737, 7081.858362832818, 7111.715531378791, 7162.498625096193, 7171.247019062923, 7228.494005419675, 7165.713371465187, 7219.422446204396, 7277.381422579034, 7289.416846652255, 7291.744788932362, 7174.1032370953635, 7193.0, 7223.024891639667, 7296.051513303237, 7296.087989001375, 7195.604241766649, 7211.783646490614, 7281.672324745399, 7288.08898887639, 7311.634418279064, 5273.604479664041, 5278.129108697099, 5328.786848526093, 5342.652727572696, 5358.089124848707, 4814.687045342112, 4836.951630483721, 4847.709137451764, 4849.054434385332, 4927.482614325444, 6778.932210677929, 6784.559003664746, 6791.830204244933, 6859.0, 6869.313068693091, 7109.146902371748, 7113.0753002109395, 7226.963865180641, 7229.132504099436, 7340.596267205355, 6798.592084474947, 6832.965835170892, 6851.177858656993, 6855.451563874878, 6870.519063665495, 5994.280686317583, 5999.4900433463645, 6078.75684972605, 6092.75628974836, 6098.0852872069545, 7290.307420795016, 7456.1798202197715, 7458.888116678254, 7477.925220747832, 7519.135299440525, 7193.856122877409, 7223.819404514824, 7228.855422891618, 7288.161861386008, 7318.268173182639, 7520.398368130427, 7544.132424771222, 7609.6575654096805, 7620.276073772982, 7663.27198916102, 7111.253318401494, 7157.7136914522835, 7227.9638601806655, 7252.129744430702, 7269.527480713737, 7090.432765378654, 7173.210946795744, 7207.603581803051, 7229.204787473269, 7350.669219885225, 6895.931040689729, 6897.41371983387, 6919.584824910521, 6920.861582768417, 6940.444764418935, 6824.590524568542, 6907.067545881242, 6910.308969103049, 6912.930870691229, 6940.652967351713, 6779.93220067793, 6794.184697836291, 6803.455723542006, 6874.931250687429, 6892.965535172292, 6833.453323734188, 6916.757913473004, 7013.719451222098, 7035.718571257297, 7139.21468638439, 6824.93175068243, 6839.076724642109, 6842.760503382557, 6867.965660171867, 6874.518783685094], "value": 6613.657924827166, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1007.4660429972115, 1035.7203555040137, 1036.9533370998304, 1037.533110100455, 1041.8072656558538, 43397.78301108494, 47121.29318060223, 47151.0, 47204.76397618011, 47301.52698473014, 44265.55734442655, 44486.33270500945, 44607.0, 44653.0, 44657.330140047925, 8156.184381561826, 8306.29396501295, 8691.739697743824, 8904.465732056065, 8966.0, 8793.164649358332, 8898.733038008837, 8914.42056266344, 8925.73222803317, 8935.508547029911, 8857.557122143868, 8899.0, 8907.331950103735, 8967.0, 9006.0, 8862.291016718647, 8890.110988901091, 8956.910430895738, 8958.148975847284, 8975.102489751038, 8790.384673072887, 8811.427257228259, 8819.338549608741, 8826.470411775314, 8851.247643950272, 42012.789936050125, 42273.0, 42405.0, 42443.7877810609, 42480.78759606213, 3857.6528112470014, 3874.8643797466952, 3904.941425878614, 3910.276598829226, 3922.4312474691296, 35117.12207194815, 35302.11744706377, 35388.469172962425, 35434.64565354365, 35454.0, 5478.753456094485, 5549.694766787825, 5553.666779993213, 5597.636153650041, 5611.2144299798065, 230989.0, 231748.0, 232229.0, 232408.0, 232484.0, 50888.23667644988, 51379.74310128426, 55336.72331638316, 55484.16773748397, 55690.16464753032, 61101.08348374778, 61153.0, 61379.0, 61593.0, 61673.383266167664, 19273.807261927483, 19327.90336048339, 19342.903285483484, 19470.8052919469, 19535.0, 15892.920535397248, 15907.0455772654, 16005.759913601305, 16061.518154455385, 16065.518034458984, 16188.0, 16253.431129910396, 16337.18314084291, 16447.437493438105, 16449.917750411172, 6140.723667434976, 6216.347283535254, 6237.438630523275, 6345.96827015862, 6392.073149393312, 1131.6831287239586, 1134.7049767060623, 1143.4968613809897, 1145.0839328537138, 1149.9712507187387, 27135.592966105523, 27392.0, 27702.307442314104, 27740.167794966183, 27804.72195278062, 1253.0602048463652, 1266.6136828267283, 1266.9239845609293, 1269.0925987918683, 1274.7577960187534, 14173.645658858404, 14521.927390363191, 14616.561503154922, 14645.853541464661, 14762.261886905611, 304772.0, 305175.0, 306520.0, 306775.0, 308631.0, 64816.351836481976, 64937.35062649407, 64941.350586494475, 65157.0, 65212.0, 1550.093195480634, 1574.7716581095676, 1607.5016744809147, 1608.3888122513604, 1619.3198856480071, 26811.0, 26813.329666758487, 26860.05989790348, 27183.59224611672, 27363.0, 42884.35673464963, 42890.0, 42919.7854010728, 43047.0, 43048.0, 263799.0, 263951.0, 264966.0, 265591.0, 265614.0, 37401.81299093487, 38790.80604596959, 38889.805550972065, 38943.221135577696, 38966.6103338963, 51143.23285150652, 51259.23111153261, 51277.230841538156, 51375.743121284155, 51690.22464663108, 37842.81078594589, 37933.430998534495, 38035.42946855744, 38165.809170953966, 38942.41586376263, 37986.2402751949, 38166.2366752669, 38238.6176138235, 38684.41973370458, 38815.80592097021, 42620.0, 42945.785271073444, 43111.56888431076, 43405.782971086206, 43436.78281608572, 36252.81873590615, 36265.81867090753, 36485.81757091304, 36602.8169859149, 36989.815050924575, 26144.346391339608, 26886.731132688423, 26910.730892691605, 27061.45877082408, 27280.72719272782], "value": 19949.2052727158, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.7927983754873, 641.929299975123, 648.5282449820373, 651.6144069267503, 655.8293446198534, 23230.30309090728, 24174.87912560437, 24223.273301800975, 24235.75764242357, 24255.75744242557, 27106.593401099, 27604.309892252702, 27632.309192270204, 27639.447211055765, 27686.584701229447, 6236.781712640059, 6474.611523308593, 6640.169978752656, 6686.933130668704, 6689.93310066898, 6646.966765166191, 6666.9333306666795, 6735.427488663445, 6736.05695202672, 6736.8315792105095, 6603.273639899608, 6687.866242675143, 6705.631190284533, 6826.624535650537, 6839.9316006840045, 6780.8304792380095, 6808.012838138467, 6826.897596536056, 6834.384905358516, 6835.829104272383, 6380.266269378988, 6399.232092148972, 6402.48780097591, 6416.262129855033, 6419.422251997296, 29193.70806291931, 29421.0, 29747.256318591993, 30126.397472050656, 30167.0, 2399.4601214726545, 2456.545539075259, 2458.139651122111, 2458.2870967419426, 2459.163884279336, 20361.592768144554, 20936.267230646856, 20989.68515472269, 21042.47393815167, 21182.894085529628, 2571.8842652080702, 2587.0945169190823, 2634.6838379394403, 2671.5591927331966, 2679.6784385873625, 147269.0, 154428.0, 168682.0, 175200.49599007948, 175818.0, 15927.840721592867, 16609.50171494833, 16797.664046718997, 17146.971181729135, 17505.912470437823, 27456.313592159957, 27459.588106178424, 27554.071215014756, 27607.171784846487, 27703.722962770516, 10661.680149595524, 10965.725856853483, 11055.613053543088, 11125.666230013112, 11209.383483908463, 9802.852957205647, 9810.65662701802, 9887.406755594688, 9924.652637157666, 9985.0, 9872.753181170528, 10100.191984641211, 10183.592656293666, 10229.488525573692, 10277.486125693686, 2844.325570486892, 2887.0238606085622, 3009.9247518812203, 3011.5633233181065, 3063.1270088024808, 1080.5785743560018, 1091.1216470740972, 1093.436880006797, 1093.781243751253, 1104.0725790336155, 22167.556648866932, 22229.0, 22246.332610021724, 22251.44371390696, 22580.774192257868, 1137.4995002199005, 1151.8099513580332, 1153.5674122204173, 1156.8669602995594, 1165.1319766773809, 12147.331896745587, 12231.449584768707, 12348.259104453762, 12386.938065309616, 12574.119811613282, 628568.0, 670856.0, 671151.0, 699495.0, 705158.0, 139128.3043584796, 142061.28969355088, 142432.0, 145034.0, 146066.0, 1137.294877176156, 1187.39442884128, 1304.2630913533824, 1306.2162702378687, 1338.076727058346, 22431.77568224297, 22730.43173920665, 22827.657585136567, 22827.771722282563, 22991.77008229963, 66122.0, 66134.0, 66825.66587167032, 66875.66562167158, 67323.32676673171, 83599.0, 85366.57316713624, 86239.13760862562, 86307.56846215729, 86713.56643216744, 16343.264553095378, 16397.672046558764, 16532.83467165313, 16576.419825306057, 16591.087490187674, 24088.638670420307, 24227.273181804576, 24700.876495618126, 24938.37654058663, 25189.370265743502, 20180.495487612927, 20245.898770506054, 20372.59254814866, 20594.38216853497, 20734.481637959172, 17811.46565602982, 18003.639927201646, 18270.177841996876, 18342.633147337245, 18443.07784610791, 20581.0, 20949.89525052365, 20961.89519052395, 20996.47508812292, 21035.474113147295, 16071.67856642884, 16075.839241607435, 16229.918850405673, 16270.674586507967, 16303.836961630706, 19719.507012324233, 19787.30744423938, 19903.900480497505, 20069.39791806248, 20198.091085901462], "value": 13321.974471996069, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.4484495891563, 1483.4140514496773, 1517.795097661816, 1524.8017757691498, 1529.082550469719, 17390.478285651436, 18112.91322520648, 18124.184411701488, 18141.90929045353, 18143.364982225623, 17640.294388224487, 17728.911355443204, 17756.378526751567, 17767.46697599071, 17785.7332140018, 3113.5018397056474, 3119.0954623159255, 3157.052884134762, 3158.415693096773, 3160.936781264373, 3109.144985129085, 3116.781825272232, 3117.890873819417, 3124.1564777510057, 3126.359096385247, 3047.939041219174, 3154.1483799374155, 3155.2427417419885, 3156.684331566848, 3159.3681263747226, 3110.8444577771133, 3118.329559144795, 3119.111053349807, 3121.5629811826475, 3126.015305178873, 3092.087834088949, 3104.798188117765, 3106.409782141386, 3113.797603155788, 3116.1274843043984, 17338.13309334528, 17456.47630571085, 17563.912180439016, 17613.471595852145, 17624.295028198856, 8560.743177704679, 8936.195742383217, 8949.105089491064, 8963.955180224122, 8980.371374003822, 5398.163284690879, 5660.179274005246, 5777.59556831022, 5802.100674395476, 5810.3899090595305, 2181.4437318483683, 2200.8129309008755, 2225.554889022202, 2253.853499522526, 2277.35095497784, 31197.532037019464, 31415.057548273588, 31554.0, 31599.21001974969, 31606.683933160602, 7262.854742905112, 7427.665755041036, 7459.962700186465, 7636.427267954815, 7669.38644908406, 20734.0, 20796.688049679266, 20811.68782468264, 20939.267125650527, 20971.8951405242, 8441.788955276168, 8736.170063843925, 8745.650173993095, 8776.122387761301, 8786.121387861163, 7926.841463170819, 7956.403269754792, 7959.403044771665, 8099.554524501209, 8114.837703245902, 5831.825045248649, 6031.185789918305, 6042.425969532887, 6088.4215999479975, 6119.5104391648565, 1547.829738728739, 1565.24085818378, 1696.5928177237622, 1741.277369891481, 1777.5644966982914, 1026.8716410448694, 1032.1123833503182, 1039.7972395382978, 1044.2429238801808, 1062.792755412687, 10087.142592879687, 10182.287239893285, 10254.436006019741, 10373.896261037444, 10377.792444151075, 1101.4712937789907, 1116.3023110555903, 1129.0910816792398, 1129.1136457880525, 1133.3962443143025, 5693.886122277614, 6268.153799237136, 6306.590071645328, 6358.650274234869, 6473.449756770728, 25848.74151258501, 26478.73521264801, 26679.733202668114, 26686.46627067448, 26850.32874178161, 25444.74555254424, 26328.736712632628, 27042.729572704415, 27116.457670846867, 27120.32199195036, 12820.35898205086, 13211.075224734368, 13344.132631379123, 13401.128926619738, 13404.463821447229, 9214.677486287948, 9826.656067037906, 9880.0, 10024.699259022242, 10129.898701012895, 22205.88897055569, 22258.66612000789, 22277.10891564319, 22400.88799555992, 22400.88799555992, 22880.656790147827, 22959.0, 22992.655110173026, 23149.3055208344, 23322.76677233206, 12700.618981430573, 12708.618741437771, 12766.744665106831, 12827.230366178059, 12914.483420663068, 14570.198639074953, 14718.0, 14722.852771472148, 14723.263836808332, 14758.0, 11346.659600212008, 11534.0, 11560.6531804046, 11618.186726929034, 11670.416479176178, 11440.256383335056, 11467.483963221508, 11718.23831450953, 11747.941260293645, 11861.76276474483, 10721.142308615448, 10738.14094872424, 10862.0, 10864.130869530261, 10907.945460272647, 8029.5583742894705, 8283.461574997606, 8284.130166332448, 8308.792280193044, 8408.621612027351, 8489.830203395773, 8640.697575584825, 8671.696490622799, 8676.0, 8728.039915609404], "value": 7655.039054098754, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.4091474409245, 577.9537636989041, 585.6925114314987, 602.6354055796243, 606.854354954811, 6358.395952384516, 6399.392057754518, 6407.839804004902, 6412.454941329993, 6493.740250389985, 6258.342873998222, 6353.650549219791, 6386.64873431961, 6415.166028416299, 6497.18785151856, 5303.7348132593315, 5311.521963023327, 5362.249285100089, 5365.302510673607, 5368.3021207243, 5254.343207099113, 5300.284461597674, 5327.094393953018, 5338.412774594792, 5347.679139251657, 4979.228219625946, 5117.257997590347, 5121.923171152435, 5123.257127716479, 5129.487051294859, 5129.25625784263, 5135.460776618476, 5142.074426603229, 5147.7683504242395, 5152.613553983466, 4616.976915115437, 4645.698029628097, 4680.812767489297, 4682.274247491644, 4722.574968252874, 6313.706679457967, 6324.778632747878, 6334.366563343675, 6340.461060809836, 6409.679516024226, 5978.910316345258, 6032.612499125182, 6042.728077236535, 6047.546434017467, 6067.848303792396, 6759.526833121683, 6794.592324460499, 6804.421624161952, 6813.591184528944, 6813.897791533131, 5020.272060551236, 5133.66311897266, 5190.455002224788, 5221.216817477371, 5258.0535503609335, 6967.198772141218, 6967.54710943787, 7057.329553692391, 7127.928720712778, 7189.496735228536, 5316.255724198615, 5333.359996800331, 5375.19372094189, 5395.0, 5428.647137936022, 5467.808626698126, 5474.7810087596845, 5476.616636835463, 5510.201020851954, 5512.145617429305, 6020.909686354708, 6043.909341359883, 6090.50782558276, 6095.323785958808, 6116.633002019893, 6877.552959057745, 6896.344847239504, 6903.75836845708, 6922.342377474132, 6949.652517374111, 1867.3090956345968, 1873.147717788403, 1876.934307299238, 1884.7738271407518, 1887.37716553537, 1304.9608511744664, 1320.4388135042761, 1339.484298545067, 1361.1764882246098, 1367.5828872194077, 6370.426661600385, 6389.840253993687, 6412.935870641327, 6434.356564343529, 6507.772227971998, 6761.3238676132, 6799.830004249933, 6870.31296870319, 6876.931230687729, 6945.756898508528, 6365.681715914186, 6369.522285828489, 6389.904151437732, 6462.192225971754, 6518.771842985473, 3634.9636503634624, 3639.9080275917117, 3653.2510835278704, 3669.559652841676, 3686.889393318205, 7105.786826395217, 7147.499675022698, 7161.0, 7234.457415693844, 7254.746083887038, 6950.165980082423, 6972.686229119702, 7005.649717514104, 7034.472414568825, 7101.680424380916, 7136.892946605805, 7224.349808517259, 7253.419726421874, 7279.235680253497, 7314.0, 6804.455643548603, 6843.452523798183, 6942.791716248521, 7016.859662806817, 7032.12098487689, 6719.832004199934, 6791.592504449749, 6838.281980391987, 6839.0, 6858.965705171442, 7179.928200718135, 7215.963920180366, 7222.313880181375, 7225.855482890418, 7287.708491660274, 5348.117560602457, 5366.195070739421, 5386.299781028441, 5405.486478784509, 5421.2139239810795, 6700.229473610597, 6817.0456136141975, 6827.0, 6843.110395648733, 6962.582245065312, 6328.7152078157515, 6645.169353830771, 6678.666066696743, 6686.69909854048, 6737.124173857367, 6571.145751052332, 6656.903075531192, 6699.9665001674675, 6714.0, 6752.831179220559, 6602.8679426410245, 6614.470842332698, 6626.370494802986, 6636.0, 6665.767102954966, 6613.338666133348, 6659.5671281368495, 6660.167479065117, 6746.460283177236, 6790.660466976533, 6341.460975816923, 6551.198420434419, 6573.704183311858, 6586.70359833799, 6706.6981985811735], "value": 5334.614727649442, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1006.195043964828, 1017.0439786600595, 1024.9590016399345, 1038.029442471289, 1049.8635177426936, 17512.562185945357, 17555.473335799914, 17701.20344584492, 19611.0, 19991.300304489345, 18239.452816415494, 18545.536361590966, 18599.53501162468, 18657.813421865776, 18663.3467828626, 1039.454286499588, 1060.7560261139943, 1065.0255016659746, 1068.60995736556, 1071.196602548089, 1078.008232426166, 1091.263397206886, 1091.2688498705886, 1094.3816743539874, 1096.4079397125543, 1122.354646078504, 1173.624440179143, 1175.8882906123904, 1179.887910648487, 1180.8819118088165, 1140.8288756686482, 1150.1603829204728, 1152.5044230980716, 1154.6824623228595, 1156.7570810129882, 822.1367564057715, 830.3772170871846, 831.1024093978489, 831.6673330667721, 833.1918039501734, 19408.514787130294, 19749.21003159872, 19987.10058047377, 20064.69902951457, 20088.49778755543, 23699.170529031402, 24114.517709645883, 24115.0, 24152.879235603887, 24153.637695434583, 18858.245670173175, 19648.607027859507, 19663.115159817844, 19832.90083549573, 19837.80162198374, 3930.0764320384687, 3975.940360894589, 3979.303621866162, 3994.0613955720382, 3994.3009973254857, 129268.0, 147814.26092869573, 167061.0, 167131.16434417872, 173342.0, 18499.352522661644, 18784.81215187858, 18824.905875470537, 19148.425547233604, 19351.90324048399, 35215.0, 35421.64578354235, 35671.28657426837, 35690.28619427649, 36117.555297787796, 10339.224558158017, 10389.168866490814, 10423.94788026055, 10438.582456701646, 10456.058954694114, 4750.14497390473, 4812.542808433193, 4825.855224343275, 4844.2007068833955, 4847.830325938575, 6122.816315510542, 6191.690415479208, 6229.7508099676415, 6237.656928868865, 6243.469305109116, 1291.4834066373526, 1304.419533307688, 1321.966950826237, 1323.9801402978962, 1326.4826717580152, 707.4305184326666, 731.2285538756663, 733.3949491669395, 737.6385571070138, 751.2374939436477, 11800.586979455678, 11978.52085916571, 12044.277343359427, 12048.819267710991, 12389.62831115068, 716.989245161323, 740.4742632730714, 743.2493181886334, 743.910730712318, 750.951188172767, 5592.7762889484775, 5682.374938756733, 5752.769889204469, 5801.6519008859605, 5802.0, 160173.0, 160216.0, 162271.0, 162900.1854990741, 163636.0, 139841.0, 143434.28282858728, 145687.2715636415, 146062.269688653, 150842.24578877256, 123603.0, 124636.99999999818, 132722.0, 134226.0, 135009.0, 12512.624621261377, 12863.163894346837, 13083.672908177372, 13236.205827650372, 13272.402741876445, 57030.0, 57357.42642573521, 57477.13784293155, 57636.71181644065, 58111.418885812294, 74774.0, 74891.0, 75782.62108689421, 76506.61746691454, 77827.6108619476, 18321.083945802922, 18411.53971150732, 18532.1660525274, 18561.35035273759, 18566.721499177795, 22759.658605120607, 23329.3001209964, 23332.416689582897, 23347.0, 23417.0, 18567.350142744937, 18608.5347866299, 18652.81347186511, 18668.253269869052, 18769.812301876806, 19360.225590976203, 19532.0, 19702.901485492483, 19756.901215493832, 19881.204751809764, 17567.385141519986, 17570.82429175692, 17599.384021559184, 17749.822501774815, 17758.37845675395, 14054.156750594997, 14284.57146285613, 14582.125072495684, 14630.561083167522, 14703.55889323322, 13280.800787987995, 13300.334983250605, 13434.328283585977, 13469.797953030908, 13538.187708737507], "value": 10264.167087311367, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1362.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 105.0, 105.0, 106.0, 105.0, 107.0, 105.0, 104.0, 107.0, 104.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 110.0, 110.0, 114.0, 110.0, 111.0, 113.0, 112.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 162.0, 161.0, 161.0, 162.0, 166.0, 164.0, 162.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 72.0, 73.0, 76.0, 74.0, 72.0, 74.0, 76.0, 81.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 76.0, 76.0, 77.0, 78.0, 77.0, 78.0, 78.0, 76.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 111.0, 114.0, 117.0, 113.0, 117.0, 111.0, 113.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 43.0, 44.0, 44.0, 48.0, 45.0, 44.0, 49.0, 48.0, 49.0], "value": 46.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 40.0, 40.0, 40.0, 40.0, 41.0, 40.0, 39.0, 40.0], "value": 39.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 76.0, 69.0, 72.0, 70.0, 68.0, 70.0, 69.0, 69.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 106.0, 105.0, 105.0, 104.0, 110.0, 113.0, 104.0, 105.0, 105.0], "value": 107.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 151.0, 150.0, 159.0, 151.0, 151.0, 150.0, 156.0, 156.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 60.0, 58.0, 60.0, 58.0, 62.0, 60.0, 57.0, 60.0], "value": 59.1, "unit": "score"}]}]} 14:09:54 INFO - Return code: 0 14:09:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:09:54 INFO - # TBPL SUCCESS # 14:09:54 INFO - Running post-action listener: _package_coverage_data 14:09:54 INFO - Running post-action listener: _resource_record_post_action 14:09:54 INFO - [mozharness: 2017-10-12 21:09:54.758955Z] Finished run-tests step (success) 14:09:54 INFO - Running post-run listener: _resource_record_post_run 14:09:54 INFO - Total resource usage - Wall time: 1182s; CPU: 13.0%; Read bytes: 9695232; Write bytes: 475402240; Read time: 3548; Write time: 371468 14:09:54 INFO - TinderboxPrint: CPU usage
13.1% 14:09:54 INFO - TinderboxPrint: I/O read bytes / time
9,695,232 / 3,548 14:09:54 INFO - TinderboxPrint: I/O write bytes / time
475,402,240 / 371,468 14:09:54 INFO - TinderboxPrint: CPU idle
8,193.7 (86.9%) 14:09:54 INFO - TinderboxPrint: CPU user
1,178.9 (12.5%) 14:09:54 INFO - TinderboxPrint: Swap in / out
0 / 0 14:09:54 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 8192; Write bytes: 147853312; Read time: 192; Write time: 137244 14:09:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:09:54 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 7942144; Write bytes: 315564032; Read time: 3296; Write time: 217480 14:09:55 INFO - Running post-run listener: _upload_blobber_files 14:09:55 INFO - Blob upload gear active. 14:09:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:09:55 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 14:09:55 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'] 14:09:55 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 14:09:55 INFO - (blobuploader) - INFO - Open directory for files ... 14:09:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:09:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:09:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:56 INFO - (blobuploader) - INFO - Done attempting. 14:09:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:09:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:10:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:03 INFO - (blobuploader) - INFO - Done attempting. 14:10:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:10:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:10:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:04 INFO - (blobuploader) - INFO - Done attempting. 14:10:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:10:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:10:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:06 INFO - (blobuploader) - INFO - Done attempting. 14:10:06 INFO - (blobuploader) - INFO - Iteration through files over. 14:10:06 INFO - Return code: 0 14:10:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:10:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:10:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c570fe23dfab16a898683feba1ef6f1fecc0a059c244fae2f7e6fff69e71c9612a5685ae39eecfc06a7407e8c2edde40776e340a2002f01eecc6202452200853", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/93ca185793d18a6d09ddb5cd8716609b818b915a2604740ef09634644fbb6740630cb3e70a7d73bc686c3deb33a24c634d32683078278e49742f3edb205c3abc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4d026956601a9fd7f77aa85fe39896829256653173afcf04a54883eda44f1b9efb71845edfa03b66d95adb0cf814923abf088a012463314882b997eed2cfc484", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/376572fa6d05d7989d35c9695842195cf943c843bd801e5a4454cd3bd7bf64df6dba6e2940fbb6de4f7b6b9ec24c10a6d754ad02d97213de09c0d6ef80fa0c34"} 14:10:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:10:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:10:06 INFO - Contents: 14:10:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c570fe23dfab16a898683feba1ef6f1fecc0a059c244fae2f7e6fff69e71c9612a5685ae39eecfc06a7407e8c2edde40776e340a2002f01eecc6202452200853", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/93ca185793d18a6d09ddb5cd8716609b818b915a2604740ef09634644fbb6740630cb3e70a7d73bc686c3deb33a24c634d32683078278e49742f3edb205c3abc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4d026956601a9fd7f77aa85fe39896829256653173afcf04a54883eda44f1b9efb71845edfa03b66d95adb0cf814923abf088a012463314882b997eed2cfc484", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/376572fa6d05d7989d35c9695842195cf943c843bd801e5a4454cd3bd7bf64df6dba6e2940fbb6de4f7b6b9ec24c10a6d754ad02d97213de09c0d6ef80fa0c34"} 14:10:06 INFO - Running post-run listener: copy_logs_to_upload_dir 14:10:06 INFO - Copying logs to upload dir... 14:10:06 INFO - mkdir: /builds/slave/test/build/upload/logs 14:10:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.938319 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-10-12 14:10:06.158433) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-12 14:10:06.162533) ========= 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=db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c570fe23dfab16a898683feba1ef6f1fecc0a059c244fae2f7e6fff69e71c9612a5685ae39eecfc06a7407e8c2edde40776e340a2002f01eecc6202452200853", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/93ca185793d18a6d09ddb5cd8716609b818b915a2604740ef09634644fbb6740630cb3e70a7d73bc686c3deb33a24c634d32683078278e49742f3edb205c3abc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4d026956601a9fd7f77aa85fe39896829256653173afcf04a54883eda44f1b9efb71845edfa03b66d95adb0cf814923abf088a012463314882b997eed2cfc484", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/376572fa6d05d7989d35c9695842195cf943c843bd801e5a4454cd3bd7bf64df6dba6e2940fbb6de4f7b6b9ec24c10a6d754ad02d97213de09c0d6ef80fa0c34"} build_url:https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011146 build_url: 'https://queue.taskcluster.net/v1/task/D5fiF01zSRyQbyL5pn7uaA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c570fe23dfab16a898683feba1ef6f1fecc0a059c244fae2f7e6fff69e71c9612a5685ae39eecfc06a7407e8c2edde40776e340a2002f01eecc6202452200853", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/93ca185793d18a6d09ddb5cd8716609b818b915a2604740ef09634644fbb6740630cb3e70a7d73bc686c3deb33a24c634d32683078278e49742f3edb205c3abc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4d026956601a9fd7f77aa85fe39896829256653173afcf04a54883eda44f1b9efb71845edfa03b66d95adb0cf814923abf088a012463314882b997eed2cfc484", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/376572fa6d05d7989d35c9695842195cf943c843bd801e5a4454cd3bd7bf64df6dba6e2940fbb6de4f7b6b9ec24c10a6d754ad02d97213de09c0d6ef80fa0c34"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-12 14:10:06.192725) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 14:10:06.193185) ========= 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=db0483c52d987ecb441a263b000001ad-1507836418.171409-84950130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 14:10:06.275473) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-12 14:10:06.275839) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-12 14:10:06.276288) ========= ========= Total master_lag: 0.21 =========