builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1506006266.77 results: success (0) revision: a2e26860d2a9c67beda535586b6eef81a575624e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 08:04:26.773843) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 08:04:26.774204) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 08:04:26.774479) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 08:04:26.845133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:04:26.845407) ========= 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=ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 08:04:26-- 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% 49.5M=0s 2017-09-21 08:04:26 (49.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.181749 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:04:27.044059) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:04:27.044387) ========= 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=ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014853 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:04:27.099079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:04:27.099369) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a2e26860d2a9c67beda535586b6eef81a575624e --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 a2e26860d2a9c67beda535586b6eef81a575624e --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=ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 08:04:27,069 truncating revision to first 12 chars 2017-09-21 08:04:27,069 Setting DEBUG logging. 2017-09-21 08:04:27,069 attempt 1/10 2017-09-21 08:04:27,069 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a2e26860d2a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 08:04:27,546 unpacking tar archive at: mozilla-beta-a2e26860d2a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.755703 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:04:27.876143) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 08:04:27.876414) ========= script_repo_revision: a2e26860d2a9c67beda535586b6eef81a575624e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 08:04:27.876772) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 08:04:27.877034) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 08:04:27.894826) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-21 08:04:27.895122) ========= /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=ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:04:27 INFO - MultiFileLogger online at 20170921 08:04:27 in /builds/slave/test 08:04:27 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 08:04:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:04:27 INFO - {'append_to_log': False, 08:04:27 INFO - 'base_work_dir': '/builds/slave/test', 08:04:27 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 08:04:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:04:27 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 08:04:27 INFO - 'buildbot_json_path': 'buildprops.json', 08:04:27 INFO - 'code_coverage': False, 08:04:27 INFO - 'config_files': ('talos/linux_config.py',), 08:04:27 INFO - 'default_actions': ('clobber', 08:04:27 INFO - 'read-buildbot-config', 08:04:27 INFO - 'download-and-extract', 08:04:27 INFO - 'populate-webroot', 08:04:27 INFO - 'create-virtualenv', 08:04:27 INFO - 'install', 08:04:27 INFO - 'setup-mitmproxy', 08:04:27 INFO - 'run-tests'), 08:04:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:04:27 INFO - 'disable_ccov_upload': False, 08:04:27 INFO - 'disable_stylo': False, 08:04:27 INFO - 'download_minidump_stackwalk': True, 08:04:27 INFO - 'download_symbols': 'ondemand', 08:04:27 INFO - 'enable_stylo': False, 08:04:27 INFO - 'enable_webrender': False, 08:04:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:04:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:04:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:04:27 INFO - 'gecko_profile': False, 08:04:27 INFO - 'gecko_profile_interval': 0, 08:04:27 INFO - 'installer_path': 'installer.exe', 08:04:27 INFO - 'log_level': 'info', 08:04:27 INFO - 'log_name': 'talos', 08:04:27 INFO - 'log_to_console': True, 08:04:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:04:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:04:28 INFO - 'opt_config_files': (), 08:04:28 INFO - 'pip_index': False, 08:04:28 INFO - 'suite': 'dromaeojs-e10s', 08:04:28 INFO - 'system_bits': '32', 08:04:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:04:28 INFO - 'title': 'talos-linux64-ix-035', 08:04:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:04:28 INFO - 'use_talos_json': True, 08:04:28 INFO - 'verify': 'False', 08:04:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:04:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:04:28 INFO - 'work_dir': 'build'} 08:04:28 INFO - [mozharness: 2017-09-21 15:04:28.001159Z] Running clobber step. 08:04:28 INFO - Running pre-action listener: _resource_record_pre_action 08:04:28 INFO - Running main action method: clobber 08:04:28 INFO - rmtree: /builds/slave/test/build 08:04:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:04:29 INFO - Running post-action listener: _resource_record_post_action 08:04:29 INFO - [mozharness: 2017-09-21 15:04:29.016684Z] Finished clobber step (success) 08:04:29 INFO - [mozharness: 2017-09-21 15:04:29.016780Z] Running read-buildbot-config step. 08:04:29 INFO - Running pre-action listener: _resource_record_pre_action 08:04:29 INFO - Running main action method: read_buildbot_config 08:04:29 INFO - Using buildbot properties: 08:04:29 INFO - { 08:04:29 INFO - "project": "", 08:04:29 INFO - "product": "firefox", 08:04:29 INFO - "who": "ryanvm@gmail.com", 08:04:29 INFO - "installer_path": "public/build/target.tar.bz2", 08:04:29 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:04:29 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 08:04:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 08:04:29 INFO - "stage_platform": "linux64", 08:04:29 INFO - "basedir": "/builds/slave/test", 08:04:29 INFO - "buildnumber": 101, 08:04:29 INFO - "platform": "ubuntu64_hw", 08:04:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:04:29 INFO - "slavebuilddir": "test", 08:04:29 INFO - "taskId": "KSmMJIe2S_CN94tTkX5R6A", 08:04:29 INFO - "branch": "mozilla-beta", 08:04:29 INFO - "script_repo_revision": "production", 08:04:29 INFO - "revision": "a2e26860d2a9c67beda535586b6eef81a575624e", 08:04:29 INFO - "slavename": "talos-linux64-ix-035", 08:04:29 INFO - "repo_path": "releases/mozilla-beta" 08:04:29 INFO - } 08:04:29 INFO - Finding installer, test and symbols from parent task. 08:04:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KSmMJIe2S_CN94tTkX5R6A'}, attempt #1 08:04:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KSmMJIe2S_CN94tTkX5R6A'}, attempt #1 08:04:29 INFO - Task dependencies: Q3zRB9X8QQaDK_Awe5vXiw 08:04:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw'}, attempt #1 08:04:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.tar.bz2 08:04:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.test_packages.json 08:04:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.crashreporter-symbols.zip 08:04:30 INFO - Running post-action listener: _resource_record_post_action 08:04:30 INFO - [mozharness: 2017-09-21 15:04:30.406995Z] Finished read-buildbot-config step (success) 08:04:30 INFO - [mozharness: 2017-09-21 15:04:30.407255Z] Running download-and-extract step. 08:04:30 INFO - Running pre-action listener: _resource_record_pre_action 08:04:30 INFO - Running main action method: download_and_extract 08:04:30 INFO - mkdir: /builds/slave/test/build/tests 08:04:30 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')]} 08:04:30 INFO - trying https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.test_packages.json 08:04:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:04:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:04:31 INFO - Downloaded 989 bytes. 08:04:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:04:31 INFO - Using the following test package requirements: 08:04:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:04:31 INFO - u'common': [u'target.common.tests.zip'], 08:04:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:04:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:04:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:04:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:04:31 INFO - u'mozbase': [u'target.common.tests.zip'], 08:04:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:04:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:04:31 INFO - u'web-platform': [u'target.common.tests.zip', 08:04:31 INFO - u'target.web-platform.tests.tar.gz'], 08:04:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:04:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 08:04:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.common.tests.zip 08:04:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:04:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.common.tests.zip into memory 08:04:37 INFO - Content-Length response header: 55178151 08:04:37 INFO - Bytes received: 55178151 08:04:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.talos.tests.zip 08:04:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:04:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.talos.tests.zip into memory 08:04:50 INFO - Content-Length response header: 14509184 08:04:50 INFO - Bytes received: 14509184 08:04:50 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')]} 08:04:50 INFO - trying https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.tar.bz2 08:04:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:04:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:04:52 INFO - Downloaded 53491137 bytes. 08:04:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.tar.bz2 08:04:52 INFO - mkdir: /builds/slave/test/properties 08:04:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:04:52 INFO - Writing to file /builds/slave/test/properties/build_url 08:04:52 INFO - Contents: 08:04:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.tar.bz2 08:04:52 INFO - Running post-action listener: _resource_record_post_action 08:04:52 INFO - Running post-action listener: find_tests_for_verification 08:04:52 INFO - Running post-action listener: set_extra_try_arguments 08:04:52 INFO - [mozharness: 2017-09-21 15:04:52.178737Z] Finished download-and-extract step (success) 08:04:52 INFO - [mozharness: 2017-09-21 15:04:52.178859Z] Running populate-webroot step. 08:04:52 INFO - Running pre-action listener: _resource_record_pre_action 08:04:52 INFO - Running main action method: populate_webroot 08:04:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:04:52 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:52 INFO - 'tests': ['tresize', 08:04:52 INFO - 'tcanvasmark']}, 08:04:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:04:52 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:52 INFO - 'tests': ['dromaeo_css', 08:04:52 INFO - 'kraken']}, 08:04:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:04:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:52 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:04:52 INFO - 'talos_options': ['--disable-stylo'], 08:04:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:04:52 INFO - 'tests': ['damp', 'tps']}, 08:04:52 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:04:52 INFO - 'talos_options': ['--disable-stylo'], 08:04:52 INFO - 'tests': ['damp', 'tps']}, 08:04:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:04:52 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:52 INFO - 'tests': ['dromaeo_dom']}, 08:04:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:04:52 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:52 INFO - 'tests': ['basic_compositor_video', 08:04:52 INFO - 'glvideo']}, 08:04:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:04:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:04:52 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:04:52 INFO - 'talos_options': ['--disable-stylo'], 08:04:52 INFO - 'tests': ['ts_paint_webext', 08:04:52 INFO - 'tp5o_webext']}, 08:04:52 INFO - 'other-e10s': {'tests': ['a11yr', 08:04:52 INFO - 'ts_paint', 08:04:52 INFO - 'tpaint', 08:04:52 INFO - 'sessionrestore', 08:04:52 INFO - 'sessionrestore_many_windows', 08:04:52 INFO - 'sessionrestore_no_auto_restore', 08:04:52 INFO - 'tabpaint']}, 08:04:52 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:52 INFO - 'tests': ['a11yr', 08:04:52 INFO - 'ts_paint', 08:04:52 INFO - 'tpaint', 08:04:52 INFO - 'sessionrestore', 08:04:52 INFO - 'sessionrestore_many_windows', 08:04:52 INFO - 'sessionrestore_no_auto_restore', 08:04:52 INFO - 'tabpaint']}, 08:04:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:04:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 08:04:52 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:52 INFO - 'tests': ['perf_reftest_singletons']}, 08:04:52 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:52 INFO - 'tests': ['bloom_basic']}, 08:04:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:04:52 INFO - 'tsvgr_opacity', 08:04:52 INFO - 'tart', 08:04:52 INFO - 'tscrollx', 08:04:52 INFO - 'tsvg_static']}, 08:04:52 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:52 INFO - 'tests': ['tsvgx', 08:04:52 INFO - 'tsvgr_opacity', 08:04:52 INFO - 'tart', 08:04:52 INFO - 'tscrollx', 08:04:52 INFO - 'tsvg_static']}, 08:04:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:04:52 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:04:52 INFO - 'talos_options': ['--disable-stylo'], 08:04:52 INFO - 'tests': ['tp5o']}, 08:04:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:04:52 INFO - 'talos_options': ['--mitmproxy', 08:04:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:04:52 INFO - '--firstNonBlankPaint'], 08:04:52 INFO - 'tests': ['tp6_google', 08:04:52 INFO - 'tp6_youtube', 08:04:52 INFO - 'tp6_amazon', 08:04:52 INFO - 'tp6_facebook']}, 08:04:52 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:04:52 INFO - 'talos_options': ['--disable-stylo', 08:04:52 INFO - '--mitmproxy', 08:04:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:04:52 INFO - '--firstNonBlankPaint'], 08:04:52 INFO - 'tests': ['tp6_google', 08:04:52 INFO - 'tp6_youtube', 08:04:52 INFO - 'tp6_amazon', 08:04:52 INFO - 'tp6_facebook']}, 08:04:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:04:52 INFO - 'talos_options': ['--stylo-threads=1', 08:04:52 INFO - '--mitmproxy', 08:04:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:04:52 INFO - '--firstNonBlankPaint'], 08:04:52 INFO - 'tests': ['tp6_google', 08:04:52 INFO - 'tp6_youtube', 08:04:52 INFO - 'tp6_amazon', 08:04:52 INFO - 'tp6_facebook']}, 08:04:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:04:52 INFO - 'talos_options': ['--xperf_path', 08:04:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:52 INFO - 'tests': ['tp5n']}, 08:04:52 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:04:52 INFO - 'talos_options': ['--disable-stylo', 08:04:52 INFO - '--xperf_path', 08:04:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:52 INFO - 'tests': ['tp5n']}}} 08:04:52 INFO - Running post-action listener: _resource_record_post_action 08:04:52 INFO - [mozharness: 2017-09-21 15:04:52.195814Z] Finished populate-webroot step (success) 08:04:52 INFO - [mozharness: 2017-09-21 15:04:52.195904Z] Running create-virtualenv step. 08:04:52 INFO - Running pre-action listener: _resource_record_pre_action 08:04:52 INFO - Running main action method: create_virtualenv 08:04:52 INFO - Creating virtualenv /builds/slave/test/build/venv 08:04:52 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:04:52 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:04:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:04:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:04:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:04:52 INFO - Installing distribute.............................................................................................................................................................................................done. 08:04:53 INFO - Installing pip...............done. 08:04:53 INFO - Return code: 0 08:04:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:04:53 INFO - Reading from file tmpfile_stdout 08:04:53 INFO - Output received: 08:04: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) 08:04:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04: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')]} 08:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04: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 0x29201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f090>, '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 0x2c8fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c89f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', '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 08:04: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 08:04: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 08:04:53 INFO - Using env: {'DISPLAY': ':0', 08:04:53 INFO - 'HOME': '/home/cltbld', 08:04:53 INFO - 'LANG': 'en_US.UTF-8', 08:04:53 INFO - 'LANGUAGE': 'en_US:en', 08:04:53 INFO - 'LOGNAME': 'cltbld', 08:04:53 INFO - 'MAIL': '/var/mail/cltbld', 08:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:53 INFO - 'MOZ_NO_REMOTE': '1', 08:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:53 INFO - 'NO_EM_RESTART': '1', 08:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:53 INFO - 'PWD': '/builds/slave/test', 08:04:53 INFO - 'SHELL': '/bin/bash', 08:04:53 INFO - 'SHLVL': '1', 08:04:53 INFO - 'TERM': 'linux', 08:04:53 INFO - 'TMOUT': '86400', 08:04:53 INFO - 'USER': 'cltbld', 08:04:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', 08:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:53 INFO - '_': '/tools/buildbot/bin/python'} 08:04:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:04:54 INFO - Downloading/unpacking pip>=1.5 08:04:54 INFO - Running setup.py egg_info for package pip 08:04:54 INFO - warning: no files found matching 'pip/cacert.pem' 08:04:54 INFO - warning: no files found matching '*.html' under directory 'docs' 08:04:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:04:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:04:54 INFO - Installing collected packages: pip 08:04:54 INFO - Found existing installation: pip 1.1 08:04:54 INFO - Uninstalling pip: 08:04:54 INFO - Successfully uninstalled pip 08:04:54 INFO - Running setup.py install for pip 08:04:54 INFO - warning: no files found matching 'pip/cacert.pem' 08:04:54 INFO - warning: no files found matching '*.html' under directory 'docs' 08:04:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:04:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:04:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:04:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:04:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:04:54 INFO - Successfully installed pip 08:04:54 INFO - Cleaning up... 08:04:54 INFO - Return code: 0 08:04:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04: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')]} 08:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04: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 0x29201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f090>, '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 0x2c8fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c89f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', '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 08:04: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 08:04: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 08:04:54 INFO - Using env: {'DISPLAY': ':0', 08:04:54 INFO - 'HOME': '/home/cltbld', 08:04:54 INFO - 'LANG': 'en_US.UTF-8', 08:04:54 INFO - 'LANGUAGE': 'en_US:en', 08:04:54 INFO - 'LOGNAME': 'cltbld', 08:04:54 INFO - 'MAIL': '/var/mail/cltbld', 08:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:54 INFO - 'MOZ_NO_REMOTE': '1', 08:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:54 INFO - 'NO_EM_RESTART': '1', 08:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:54 INFO - 'PWD': '/builds/slave/test', 08:04:54 INFO - 'SHELL': '/bin/bash', 08:04:54 INFO - 'SHLVL': '1', 08:04:54 INFO - 'TERM': 'linux', 08:04:54 INFO - 'TMOUT': '86400', 08:04:54 INFO - 'USER': 'cltbld', 08:04:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', 08:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:54 INFO - '_': '/tools/buildbot/bin/python'} 08:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:54 INFO - Downloading/unpacking psutil>=3.1.1 08:04: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 08:04: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 08:04: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 08:04: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 08:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:04:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:55 INFO - Installing collected packages: psutil 08:04:55 INFO - Running setup.py install for psutil 08:04:55 INFO - building 'psutil._psutil_linux' extension 08:04:55 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 08:04:56 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 08:04:56 INFO - building 'psutil._psutil_posix' extension 08:04:56 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 08:04:56 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 08:04:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:56 INFO - Successfully installed psutil 08:04:56 INFO - Cleaning up... 08:04:56 INFO - Return code: 0 08:04:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:04:56 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')]} 08:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:56 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')]} 08:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:56 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 0x29201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f090>, '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 0x2c8fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c89f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', '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 08:04:56 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 08:04:56 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 08:04:56 INFO - Using env: {'DISPLAY': ':0', 08:04:56 INFO - 'HOME': '/home/cltbld', 08:04:56 INFO - 'LANG': 'en_US.UTF-8', 08:04:56 INFO - 'LANGUAGE': 'en_US:en', 08:04:56 INFO - 'LOGNAME': 'cltbld', 08:04:56 INFO - 'MAIL': '/var/mail/cltbld', 08:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:56 INFO - 'MOZ_NO_REMOTE': '1', 08:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:56 INFO - 'NO_EM_RESTART': '1', 08:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:56 INFO - 'PWD': '/builds/slave/test', 08:04:56 INFO - 'SHELL': '/bin/bash', 08:04:56 INFO - 'SHLVL': '1', 08:04:56 INFO - 'TERM': 'linux', 08:04:56 INFO - 'TMOUT': '86400', 08:04:56 INFO - 'USER': 'cltbld', 08:04:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', 08:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:56 INFO - '_': '/tools/buildbot/bin/python'} 08:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:04:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:04:57 INFO - Installing collected packages: mozsystemmonitor 08:04:57 INFO - Running setup.py install for mozsystemmonitor 08:04:57 INFO - Successfully installed mozsystemmonitor 08:04:57 INFO - Cleaning up... 08:04:57 INFO - Return code: 0 08:04:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04: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')]} 08:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04: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', '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 0x29201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f090>, '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 0x2c8fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c89f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', '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 08:04: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:04: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 jsonschema==2.5.1 08:04:57 INFO - Using env: {'DISPLAY': ':0', 08:04:57 INFO - 'HOME': '/home/cltbld', 08:04:57 INFO - 'LANG': 'en_US.UTF-8', 08:04:57 INFO - 'LANGUAGE': 'en_US:en', 08:04:57 INFO - 'LOGNAME': 'cltbld', 08:04:57 INFO - 'MAIL': '/var/mail/cltbld', 08:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:57 INFO - 'MOZ_NO_REMOTE': '1', 08:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:57 INFO - 'NO_EM_RESTART': '1', 08:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:57 INFO - 'PWD': '/builds/slave/test', 08:04:57 INFO - 'SHELL': '/bin/bash', 08:04:57 INFO - 'SHLVL': '1', 08:04:57 INFO - 'TERM': 'linux', 08:04:57 INFO - 'TMOUT': '86400', 08:04:57 INFO - 'USER': 'cltbld', 08:04:57 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', 08:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:57 INFO - '_': '/tools/buildbot/bin/python'} 08:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:58 INFO - Downloading/unpacking jsonschema==2.5.1 08:04:58 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 08:04:58 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 08:04:58 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 08:04:58 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 08:04:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:04:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:04: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 08:04: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 08:04: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 08:04: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 08:04:59 INFO - Downloading functools32-3.2.3-2.tar.gz 08:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:04:59 INFO - warning: no files found matching '*.txt' 08:04:59 INFO - no previously-included directories found matching 'build' 08:04:59 INFO - no previously-included directories found matching 'dist' 08:04:59 INFO - no previously-included directories found matching '.git*' 08:04:59 INFO - Installing collected packages: jsonschema, functools32 08:04:59 INFO - Running setup.py install for functools32 08:04:59 INFO - warning: no files found matching '*.txt' 08:04:59 INFO - no previously-included directories found matching 'build' 08:04:59 INFO - no previously-included directories found matching 'dist' 08:04:59 INFO - no previously-included directories found matching '.git*' 08:04:59 INFO - Successfully installed jsonschema functools32 08:04:59 INFO - Cleaning up... 08:04:59 INFO - Return code: 0 08:04:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:04:59 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')]} 08:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:59 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')]} 08:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:59 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 0x29201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f090>, '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 0x2c8fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c89f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', '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 08:04:59 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 08:04:59 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 08:04:59 INFO - Using env: {'DISPLAY': ':0', 08:04:59 INFO - 'HOME': '/home/cltbld', 08:04:59 INFO - 'LANG': 'en_US.UTF-8', 08:04:59 INFO - 'LANGUAGE': 'en_US:en', 08:04:59 INFO - 'LOGNAME': 'cltbld', 08:04:59 INFO - 'MAIL': '/var/mail/cltbld', 08:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:59 INFO - 'MOZ_NO_REMOTE': '1', 08:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:59 INFO - 'NO_EM_RESTART': '1', 08:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:59 INFO - 'PWD': '/builds/slave/test', 08:04:59 INFO - 'SHELL': '/bin/bash', 08:04:59 INFO - 'SHLVL': '1', 08:04:59 INFO - 'TERM': 'linux', 08:04:59 INFO - 'TMOUT': '86400', 08:04:59 INFO - 'USER': 'cltbld', 08:04:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', 08:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:59 INFO - '_': '/tools/buildbot/bin/python'} 08:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:04:59 INFO - Cleaning up... 08:04:59 INFO - Return code: 0 08:04:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:04:59 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')]} 08:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:59 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')]} 08:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:59 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 0x29201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f090>, '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 0x2c8fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c89f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', '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 08:04:59 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 08:04:59 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 08:04:59 INFO - Using env: {'DISPLAY': ':0', 08:04:59 INFO - 'HOME': '/home/cltbld', 08:04:59 INFO - 'LANG': 'en_US.UTF-8', 08:04:59 INFO - 'LANGUAGE': 'en_US:en', 08:04:59 INFO - 'LOGNAME': 'cltbld', 08:04:59 INFO - 'MAIL': '/var/mail/cltbld', 08:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:59 INFO - 'MOZ_NO_REMOTE': '1', 08:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:59 INFO - 'NO_EM_RESTART': '1', 08:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:59 INFO - 'PWD': '/builds/slave/test', 08:04:59 INFO - 'SHELL': '/bin/bash', 08:04:59 INFO - 'SHLVL': '1', 08:04:59 INFO - 'TERM': 'linux', 08:04:59 INFO - 'TMOUT': '86400', 08:04:59 INFO - 'USER': 'cltbld', 08:04:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', 08:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:59 INFO - '_': '/tools/buildbot/bin/python'} 08:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:00 INFO - Downloading/unpacking blobuploader==1.2.4 08:05: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 08:05: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 08:05: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 08:05: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 08:05:01 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05: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 08:05: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 08:05: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 08:05: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 08:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:05:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05: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 08:05: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 08:05: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 08:05: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 08:05:01 INFO - Downloading docopt-0.6.1.tar.gz 08:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:02 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:02 INFO - Running setup.py install for blobuploader 08:05:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:05:02 INFO - Running setup.py install for requests 08:05:02 INFO - Running setup.py install for docopt 08:05:02 INFO - Successfully installed blobuploader requests docopt 08:05:02 INFO - Cleaning up... 08:05:02 INFO - Return code: 0 08:05:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:02 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 0x29201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f090>, '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 0x2c8fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c89f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', '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 08:05:02 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 08:05:02 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 08:05:02 INFO - Using env: {'DISPLAY': ':0', 08:05:02 INFO - 'HOME': '/home/cltbld', 08:05:02 INFO - 'LANG': 'en_US.UTF-8', 08:05:02 INFO - 'LANGUAGE': 'en_US:en', 08:05:02 INFO - 'LOGNAME': 'cltbld', 08:05:02 INFO - 'MAIL': '/var/mail/cltbld', 08:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:02 INFO - 'MOZ_NO_REMOTE': '1', 08:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:02 INFO - 'NO_EM_RESTART': '1', 08:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:02 INFO - 'PWD': '/builds/slave/test', 08:05:02 INFO - 'SHELL': '/bin/bash', 08:05:02 INFO - 'SHLVL': '1', 08:05:02 INFO - 'TERM': 'linux', 08:05:02 INFO - 'TMOUT': '86400', 08:05:02 INFO - 'USER': 'cltbld', 08:05:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', 08:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:02 INFO - '_': '/tools/buildbot/bin/python'} 08:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:02 INFO - Running setup.py (path:/tmp/pip-krw4Ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:02 INFO - Running setup.py (path:/tmp/pip-Hng0dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:03 INFO - Running setup.py (path:/tmp/pip-3GgaZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:03 INFO - Running setup.py (path:/tmp/pip-JpsD_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:03 INFO - Running setup.py (path:/tmp/pip-HDBZzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:03 INFO - Running setup.py (path:/tmp/pip-P10S9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:03 INFO - Running setup.py (path:/tmp/pip-RCKdPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:03 INFO - Running setup.py (path:/tmp/pip-SMDBwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:03 INFO - Running setup.py (path:/tmp/pip-WIejhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:03 INFO - Running setup.py (path:/tmp/pip-X21xp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:03 INFO - Running setup.py (path:/tmp/pip-pPcKA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:03 INFO - Running setup.py (path:/tmp/pip-nxMLUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:03 INFO - Running setup.py (path:/tmp/pip-6r_Lk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:03 INFO - Running setup.py (path:/tmp/pip-hJOrpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:03 INFO - Running setup.py (path:/tmp/pip-aljOcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:03 INFO - Running setup.py (path:/tmp/pip-ZjiFgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:04 INFO - Running setup.py (path:/tmp/pip-aMRqkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:04 INFO - Running setup.py install for manifestparser 08:05:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:05:04 INFO - Running setup.py install for mozcrash 08:05:04 INFO - Running setup.py install for mozdebug 08:05:04 INFO - Running setup.py install for mozdevice 08:05:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:05:04 INFO - Running setup.py install for mozfile 08:05:04 INFO - Running setup.py install for mozhttpd 08:05:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:05:04 INFO - Running setup.py install for mozinfo 08:05:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:05:04 INFO - Running setup.py install for mozInstall 08:05:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:05:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:05:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:05:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:05:04 INFO - Running setup.py install for mozleak 08:05:04 INFO - Running setup.py install for mozlog 08:05:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:05:05 INFO - Running setup.py install for moznetwork 08:05:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:05:05 INFO - Running setup.py install for mozprocess 08:05:05 INFO - Running setup.py install for mozprofile 08:05:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:05:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:05:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:05:05 INFO - Running setup.py install for mozrunner 08:05:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:05:05 INFO - Running setup.py install for mozscreenshot 08:05:05 INFO - Running setup.py install for moztest 08:05:05 INFO - Running setup.py install for mozversion 08:05:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:05:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:05 INFO - Cleaning up... 08:05:05 INFO - Return code: 0 08:05:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:05 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')]} 08:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:05 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')]} 08:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:05 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 0x29201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f090>, '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 0x2c8fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c89f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', '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 08:05:05 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 08:05:05 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 08:05:05 INFO - Using env: {'DISPLAY': ':0', 08:05:05 INFO - 'HOME': '/home/cltbld', 08:05:05 INFO - 'LANG': 'en_US.UTF-8', 08:05:05 INFO - 'LANGUAGE': 'en_US:en', 08:05:05 INFO - 'LOGNAME': 'cltbld', 08:05:05 INFO - 'MAIL': '/var/mail/cltbld', 08:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:05 INFO - 'MOZ_NO_REMOTE': '1', 08:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:05 INFO - 'NO_EM_RESTART': '1', 08:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:05 INFO - 'PWD': '/builds/slave/test', 08:05:05 INFO - 'SHELL': '/bin/bash', 08:05:05 INFO - 'SHLVL': '1', 08:05:05 INFO - 'TERM': 'linux', 08:05:05 INFO - 'TMOUT': '86400', 08:05:05 INFO - 'USER': 'cltbld', 08:05:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', 08:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:05 INFO - '_': '/tools/buildbot/bin/python'} 08:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:06 INFO - Running setup.py (path:/tmp/pip-JmJVh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05: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)) 08:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:06 INFO - Running setup.py (path:/tmp/pip-ZlNGjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05: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)) 08:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:06 INFO - Running setup.py (path:/tmp/pip-Yy1yRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:06 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)) 08:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:06 INFO - Running setup.py (path:/tmp/pip-kMkBQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:06 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)) 08:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:06 INFO - Running setup.py (path:/tmp/pip-noxJyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:06 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)) 08:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:06 INFO - Running setup.py (path:/tmp/pip-dsyCwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:06 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)) 08:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:06 INFO - Running setup.py (path:/tmp/pip-7qG_Ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:06 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)) 08:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:06 INFO - Running setup.py (path:/tmp/pip-3FlMsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:06 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)) 08:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:06 INFO - Running setup.py (path:/tmp/pip-ppm0xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:06 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)) 08:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:06 INFO - Running setup.py (path:/tmp/pip-yTtwLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:06 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)) 08:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:06 INFO - Running setup.py (path:/tmp/pip-bo_Ta6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:06 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)) 08:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:06 INFO - Running setup.py (path:/tmp/pip-Flw5oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:06 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)) 08:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:06 INFO - Running setup.py (path:/tmp/pip-YWPTkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05: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)) 08:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:07 INFO - Running setup.py (path:/tmp/pip-iZZ24u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05: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)) 08:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:07 INFO - Running setup.py (path:/tmp/pip-EHlWi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05: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)) 08:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:07 INFO - Running setup.py (path:/tmp/pip-KUgBkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05: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)) 08:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:07 INFO - Running setup.py (path:/tmp/pip-7dlRDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:07 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)) 08:05:07 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)) 08:05:07 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)) 08:05:07 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)) 08:05:07 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)) 08:05:07 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)) 08:05:07 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)) 08:05:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:07 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 08:05:07 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 08:05:07 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 08:05:07 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 08:05:08 INFO - Downloading blessings-1.6.tar.gz 08:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:05:08 INFO - Installing collected packages: blessings 08:05:08 INFO - Running setup.py install for blessings 08:05:08 INFO - Successfully installed blessings 08:05:08 INFO - Cleaning up... 08:05:08 INFO - Return code: 0 08:05:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:08 INFO - Reading from file tmpfile_stdout 08:05:08 INFO - Current package versions: 08:05:08 INFO - argparse == 1.2.1 08:05:08 INFO - blessings == 1.6 08:05:08 INFO - blobuploader == 1.2.4 08:05:08 INFO - docopt == 0.6.1 08:05:08 INFO - functools32 == 3.2.3-2 08:05:08 INFO - jsonschema == 2.5.1 08:05:08 INFO - manifestparser == 1.1 08:05:08 INFO - mozInstall == 1.13 08:05:08 INFO - mozcrash == 1.0 08:05:08 INFO - mozdebug == 0.1 08:05:08 INFO - mozdevice == 0.51 08:05:08 INFO - mozfile == 1.2 08:05:08 INFO - mozhttpd == 0.7 08:05:08 INFO - mozinfo == 0.10 08:05:08 INFO - mozleak == 0.1 08:05:08 INFO - mozlog == 3.5 08:05:08 INFO - moznetwork == 0.27 08:05:08 INFO - mozprocess == 0.25 08:05:08 INFO - mozprofile == 0.28 08:05:08 INFO - mozrunner == 6.13 08:05:08 INFO - mozscreenshot == 0.1 08:05:08 INFO - mozsystemmonitor == 0.3 08:05:08 INFO - moztest == 0.8 08:05:08 INFO - mozversion == 1.4 08:05:08 INFO - psutil == 3.1.1 08:05:08 INFO - requests == 1.2.3 08:05:08 INFO - wsgiref == 0.1.2 08:05:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:08 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 0x29201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f090>, '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 0x2c8fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c89f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', '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 08:05:08 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 08:05:08 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 08:05:08 INFO - Using env: {'DISPLAY': ':0', 08:05:08 INFO - 'HOME': '/home/cltbld', 08:05:08 INFO - 'LANG': 'en_US.UTF-8', 08:05:08 INFO - 'LANGUAGE': 'en_US:en', 08:05:08 INFO - 'LOGNAME': 'cltbld', 08:05:08 INFO - 'MAIL': '/var/mail/cltbld', 08:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:08 INFO - 'MOZ_NO_REMOTE': '1', 08:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:08 INFO - 'NO_EM_RESTART': '1', 08:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:08 INFO - 'PWD': '/builds/slave/test', 08:05:08 INFO - 'SHELL': '/bin/bash', 08:05:08 INFO - 'SHLVL': '1', 08:05:08 INFO - 'TERM': 'linux', 08:05:08 INFO - 'TMOUT': '86400', 08:05:08 INFO - 'USER': 'cltbld', 08:05:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', 08:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:08 INFO - '_': '/tools/buildbot/bin/python'} 08:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05: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)) 08:05: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)) 08:05: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)) 08:05: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)) 08:05: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)) 08:05: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)) 08:05: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)) 08:05: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)) 08:05: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)) 08:05:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:05: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 08:05: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 08:05: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 08:05: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 08:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:05:10 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)) 08:05:10 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)) 08:05:10 INFO - Installing collected packages: simplejson 08:05:10 INFO - Running setup.py install for simplejson 08:05:10 INFO - building 'simplejson._speedups' extension 08:05:10 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 08:05: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 08:05:11 INFO - Successfully installed simplejson 08:05:11 INFO - Cleaning up... 08:05:11 INFO - Return code: 0 08:05:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:05:11 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')]} 08:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:11 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')]} 08:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:11 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 0x29201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8f090>, '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 0x2c8fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c89f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', '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 08:05:11 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 08:05:11 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 08:05:11 INFO - Using env: {'DISPLAY': ':0', 08:05:11 INFO - 'HOME': '/home/cltbld', 08:05:11 INFO - 'LANG': 'en_US.UTF-8', 08:05:11 INFO - 'LANGUAGE': 'en_US:en', 08:05:11 INFO - 'LOGNAME': 'cltbld', 08:05:11 INFO - 'MAIL': '/var/mail/cltbld', 08:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:11 INFO - 'MOZ_NO_REMOTE': '1', 08:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:11 INFO - 'NO_EM_RESTART': '1', 08:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:11 INFO - 'PWD': '/builds/slave/test', 08:05:11 INFO - 'SHELL': '/bin/bash', 08:05:11 INFO - 'SHLVL': '1', 08:05:11 INFO - 'TERM': 'linux', 08:05:11 INFO - 'TMOUT': '86400', 08:05:11 INFO - 'USER': 'cltbld', 08:05:11 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', 08:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:11 INFO - '_': '/tools/buildbot/bin/python'} 08:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:05:11 INFO - Cleaning up... 08:05:11 INFO - Return code: 0 08:05:11 INFO - Running post-action listener: _resource_record_post_action 08:05:11 INFO - Running post-action listener: _start_resource_monitoring 08:05:11 INFO - Starting resource monitoring. 08:05:11 INFO - [mozharness: 2017-09-21 15:05:11.571445Z] Finished create-virtualenv step (success) 08:05:11 INFO - [mozharness: 2017-09-21 15:05:11.571952Z] Running install step. 08:05:11 INFO - Running pre-action listener: _resource_record_pre_action 08:05:11 INFO - Running main action method: install 08:05:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:11 INFO - Reading from file tmpfile_stdout 08:05:11 INFO - Detecting whether we're running mozinstall >=1.0... 08:05:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:05:11 INFO - Reading from file tmpfile_stdout 08:05:11 INFO - Output received: 08:05:11 INFO - Usage: mozinstall [options] installer 08:05:11 INFO - Options: 08:05:11 INFO - -h, --help show this help message and exit 08:05:11 INFO - -d DEST, --destination=DEST 08:05:11 INFO - Directory to install application into. [default: 08:05:11 INFO - "/builds/slave/test"] 08:05:11 INFO - --app=APP Application being installed. [default: firefox] 08:05:11 INFO - mkdir: /builds/slave/test/build/application 08:05:11 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'] 08:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:05:26 INFO - Reading from file tmpfile_stdout 08:05:26 INFO - Output received: 08:05:26 INFO - /builds/slave/test/build/application/firefox/firefox 08:05:26 INFO - Running post-action listener: _resource_record_post_action 08:05:26 INFO - [mozharness: 2017-09-21 15:05:26.492400Z] Finished install step (success) 08:05:26 INFO - [mozharness: 2017-09-21 15:05:26.492651Z] Running setup-mitmproxy step. 08:05:26 INFO - Running pre-action listener: _resource_record_pre_action 08:05:26 INFO - Running main action method: setup_mitmproxy 08:05:26 INFO - Skipping: mitmproxy is not required 08:05:26 INFO - Running post-action listener: _resource_record_post_action 08:05:26 INFO - [mozharness: 2017-09-21 15:05:26.493777Z] Finished setup-mitmproxy step (success) 08:05:26 INFO - [mozharness: 2017-09-21 15:05:26.493997Z] Running run-tests step. 08:05:26 INFO - Running pre-action listener: _resource_record_pre_action 08:05:26 INFO - Running pre-action listener: _set_gcov_prefix 08:05:26 INFO - Running main action method: run_tests 08:05:26 WARNING - Try message not found. 08:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:05:26 INFO - Python 2.7.3 08:05:26 INFO - Return code: 0 08:05:26 INFO - grabbing minidump binary from tooltool 08:05:26 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')]} 08:05:26 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 0x2c8f090>, '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 0x2c8fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c89f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:05:26 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 08:05:26 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 08:05:26 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 08:05:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:05:26 INFO - Return code: 0 08:05:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:05:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:05:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:05:26 INFO - ENV: RUST_BACKTRACE is now full 08:05:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:05:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:05:26 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/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 08:05:26 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/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 08:05:26 INFO - Using env: {'DISPLAY': ':0', 08:05:26 INFO - 'HOME': '/home/cltbld', 08:05:26 INFO - 'LANG': 'en_US.UTF-8', 08:05:26 INFO - 'LANGUAGE': 'en_US:en', 08:05:26 INFO - 'LOGNAME': 'cltbld', 08:05:26 INFO - 'MAIL': '/var/mail/cltbld', 08:05:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:05:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:26 INFO - 'MOZ_NO_REMOTE': '1', 08:05:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:26 INFO - 'NO_EM_RESTART': '1', 08:05:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:26 INFO - 'PWD': '/builds/slave/test', 08:05:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:05:26 INFO - 'RUST_BACKTRACE': 'full', 08:05:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:05:26 INFO - 'SHELL': '/bin/bash', 08:05:26 INFO - 'SHLVL': '1', 08:05:26 INFO - 'TERM': 'linux', 08:05:26 INFO - 'TMOUT': '86400', 08:05:26 INFO - 'USER': 'cltbld', 08:05:26 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', 08:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:26 INFO - '_': '/tools/buildbot/bin/python'} 08:05:26 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/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 08:05:26 INFO - mozversion application_buildid: 20170921135121 08:05:26 INFO - mozversion application_changeset: a2e26860d2a9c67beda535586b6eef81a575624e 08:05:26 INFO - mozversion application_display_name: Firefox 08:05:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:05:26 INFO - mozversion application_name: Firefox 08:05:26 INFO - mozversion application_remotingname: firefox 08:05:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:05:26 INFO - mozversion application_vendor: Mozilla 08:05:26 INFO - mozversion application_version: 57.0 08:05:26 INFO - mozversion platform_buildid: 20170921135121 08:05:26 INFO - mozversion platform_changeset: a2e26860d2a9c67beda535586b6eef81a575624e 08:05:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:05:26 INFO - mozversion platform_version: 57.0 08:05:26 INFO - using testdate: 1506006326 08:05:26 INFO - actual date: 1506006326 08:05:26 INFO - starting webserver on 'localhost:35422' 08:05:26 INFO - SUITE-START | Running 2 tests 08:05:26 INFO - TEST-START | dromaeo_css 08:05:26 INFO - Initialising browser for dromaeo_css test... 08:05:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35422/getInfo.html -profile /tmp/tmpOZ5Xuf/profile 08:05:26 INFO - TEST-INFO | started process 25900 (/builds/slave/test/build/application/firefox/firefox http://localhost:35422/getInfo.html) 08:05:31 INFO - TEST-INFO | 25900: exit 0 08:05:31 INFO - Browser initialized. 08:05:31 INFO - Running cycle 1/1 for dromaeo_css test... 08:05:31 INFO - Using env: {'DISPLAY': ':0', 08:05:31 INFO - 'HOME': '/home/cltbld', 08:05:31 INFO - 'JSGC_DISABLE_POISONING': '1', 08:05:31 INFO - 'LANG': 'en_US.UTF-8', 08:05:31 INFO - 'LANGUAGE': 'en_US:en', 08:05:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:05:31 INFO - 'LOGNAME': 'cltbld', 08:05:31 INFO - 'MAIL': '/var/mail/cltbld', 08:05:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:05:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:05:31 INFO - 'MOZ_CRASHREPORTER': '1', 08:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:05:31 INFO - 'MOZ_NO_REMOTE': '1', 08:05:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:31 INFO - 'NO_EM_RESTART': '1', 08:05:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:31 INFO - 'PWD': '/builds/slave/test', 08:05:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:05:31 INFO - 'RUST_BACKTRACE': 'full', 08:05:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:05:31 INFO - 'SHELL': '/bin/bash', 08:05:31 INFO - 'SHLVL': '1', 08:05:31 INFO - 'TERM': 'linux', 08:05:31 INFO - 'TMOUT': '86400', 08:05:31 INFO - 'USER': 'cltbld', 08:05:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', 08:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:31 INFO - '_': '/tools/buildbot/bin/python'} 08:05:31 INFO - TEST-INFO | started process 26084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOZ5Xuf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:05:42 INFO - PID 26084 | RSS: Main: 146186240 08:05:42 INFO - PID 26084 | 08:08:39 INFO - PID 26084 | Cycle 1(1): loaded http://localhost:35422/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35422/tests/dromaeo/cssquery-ext.html) 08:08:40 INFO - PID 26084 | RSS: Main: 148299776 08:08:40 INFO - PID 26084 | 08:11:42 INFO - PID 26084 | Cycle 1(1): loaded http://localhost:35422/tests/dromaeo/cssquery-ext.html (next: http://localhost:35422/tests/dromaeo/cssquery-jquery.html) 08:11:43 INFO - PID 26084 | RSS: Main: 147390464 08:11:43 INFO - PID 26084 | 08:14:44 INFO - PID 26084 | Cycle 1(1): loaded http://localhost:35422/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35422/tests/dromaeo/cssquery-mootools.html) 08:14:45 INFO - PID 26084 | RSS: Main: 148291584 08:14:45 INFO - PID 26084 | 08:17:46 INFO - PID 26084 | Cycle 1(1): loaded http://localhost:35422/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35422/tests/dromaeo/cssquery-prototype.html) 08:17:47 INFO - PID 26084 | RSS: Main: 147841024 08:17:47 INFO - PID 26084 | 08:20:50 INFO - PID 26084 | Cycle 1(1): loaded http://localhost:35422/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35422/tests/dromaeo/cssquery-yui.html) 08:20:51 INFO - PID 26084 | RSS: Main: 149262336 08:20:51 INFO - PID 26084 | 08:23:52 INFO - PID 26084 | Cycle 1(1): loaded http://localhost:35422/tests/dromaeo/cssquery-yui.html (next: http://localhost:35422/tests/dromaeo/cssquery-dojo.html) 08:23:52 INFO - PID 26084 | RSS: Main: 152363008 08:23:52 INFO - PID 26084 | 08:23:52 INFO - PID 26084 | __start_tp_report 08:23:52 INFO - PID 26084 | _x_x_mozilla_page_load 08:23:52 INFO - PID 26084 | _x_x_mozilla_page_load_details 08:23:52 INFO - PID 26084 | |i|pagename|runs| 08:23:52 INFO - PID 26084 | |0;dojo.html;3968.127012057347;3976.8608098716545;4017.6384125428704;4020.6381425671684;4031.5766844481327;6503.122078519398;6511.772087976922;6523.706433210505;6570;6611.272759996403;6485.708143133558;6539.378759017885;6603.801885943418;6615.503837212216;6630.336966303379;5767.6827774472495;5775.047117225653;5798.3331916829475;5878.323992740826;5886.175935369051;5806.941930580682;5843.766249350021;5854.063349864023;5894;5943.049112142058;5885.411458854123;5893.116032595102;5939.109133629969;5958.672273024982;5972.492338151263;5811;5852.385499522574;5915.319738230116;5943.227380440559;5958.6424814511265;5720.2849643794525;5776.046952252873;5804.970975145139;5838.41615838417;5855.443732845373;6474.773382931575;6491.545591808575;6521.93478065218;6541.378569035934;6584.8353791155605;7196.136463624399;7199.496035277532;7252.383547398477;7253.56478611285;7279.927200727978;7073.752418665322;7273.927260727378;7274.745383911538;7332.376747976428;7363.116426028911;6645.435138013275;6645.534812563171;6678.7328506859185;6682.064510968468;6691.397774200296;7342.596157211405;7345.485815992829;7345.669444874993;7348.52234604749;7475.401967842559;7118.501704880712;7118.679659415338;7182.676779544829;7209.423246140296;7210.567365958059;7265.455090868206;7297.197308296083;7331.633418329062;7350.044494215717;7385.889211661829;6967.895481567781;7071.964640176869;7122.465815063891;7159.140903091558;7198.748043818441;7144.785656430316;7162.212156662763;7162.570245785269;7162.606056666829;7169.426445884316;5319.202119682079;5321.574274058066;5330.680159190461;5334.946650533522;5336.733163341895;4808.903821923612;4827.975860120677;4871.5128487151715;4873.293372460973;4875.439324477659;6663.03386009026;6665.533412661164;6763.5941843489545;6771.593704377753;6775.254721980578;7225.89161162583;7230.891536626955;7237.167725711505;7242.6378681065735;7247.855042899218;6707.463402927754;6767.695453704595;6857.451403887677;6865.244823069458;6869.725210991604;6063.333033366326;6100.932336841124;6130.632162070201;6145.293291271471;6150.938490615126;7567.167611562723;7575.469717119859;7577.696892124363;7683.1548529661695;7689.19263477338;7018.122734658168;7126.5011449198055;7187.31720486553;7284.817879553054;7317.304856038774;7492.438067144877;7535.434842386733;7600.973868527678;7621.237876212556;7646.541207527343;7116.893246601202;7194.964025179841;7204.71181152748;7223.891641625275;7227.530210536298;7181.210066892742;7197.532160409557;7236.059312289369;7315.926840731525;7335.816604584928;6835.93164068353;6920.273371296143;6922.273161317989;6927.792166235021;7017.649117544204;6915.827104322432;6918.654067296716;6945.791626251221;6989.895151572832;6998.020277161303;6871.759488417882;6887.345702158287;6942.062821519232;6947.5831450113155;6953.4089602384365;6899.310068993061;6986.510944233854;6989.161300643956;7048.929510704827;7081.504294699322;6696.531242813151;6756.898646520404;6785.525013249223;6821.863562728817;6865.691043902936 08:23:52 INFO - PID 26084 | |1;ext.html;962.4081190068101;971.7959228562004;993.5181437003057;999.3504222255534;1025.6564051042901;45814.312785308204;46461.07077858449;46519.30221046687;46529.534704652986;46532.836679083;43079;43562;43642.34536481948;43685.56314436855;43686.56313436865;8013.519188848673;8158.796030099235;8162.877556836652;8169.142240064767;8172.959135204315;8046.275835174833;8152.796180095515;8156.755297341059;8161.061477930025;8161.632726527291;8573.699920502784;8803.691870784523;8835.911640883605;8836.513991730451;8839.381243312971;8724.43291186074;8791.384603077788;8809.251213646849;8832.293416526663;8837.160469755363;8589.484630922165;8638;8666.956665216634;8673.436226645312;8677.392582519225;41242.79378603118;41651.7917410411;41778.582214177775;41811.7909410454;41963.37054944178;3843.6925045996254;3875.0893540018074;3880.8641697540734;3892;3892.0853599404118;33599.32801343984;33715.662843371494;33787.324253515035;33865.32269354599;33971.6602833971;5638.407967163471;5642.661440313554;5684.346300175492;5695.695645901853;5748.42515748426;224886.99999999837;226301;226388;226430;226848;52412.47587524152;52761.736191319564;52776;54503.45496544984;55206.72396637991;58028.419715803146;58123.41876581265;58202.70898645564;58269;58288.12567811486;18491.965883752775;18559.81440185581;18571.81428185701;18616.81383186178;18717.251309947722;15313.693726125637;15350.23248837576;15422.691546169013;15446.150461724488;15454.536363909101;15330.770038449433;15333.156676382907;15364.769528457082;15390.846091539166;15517.146556939251;5584.832455026356;5627.943720562742;5725.971370143206;5776.942230577641;5779.508741756998;1099.2964502718266;1100.5762781329086;1103.87857335693;1120.523777394604;1123.4495097402214;26769.33076673099;26874.193774186806;26874.462510749676;27319.863400683265;27372.178834634993;1203.8134089216185;1211.8182272659171;1212.7998880184848;1222.7371115210271;1233.3463264469844;14193.148411095368;14212.147271163763;14289.214093224973;14422.42310307597;14651.706965860623;295056;300545;301651;302088;303382;64808;65046.67476662587;65335.673321634036;65424.672876636265;65464.67267663631;1502.6393665520197;1520.0879472316742;1531.670690801483;1536;1536.3547310129773;31033.68966310308;31050;31274.374512509166;31280.843595781877;31359.686403135678;42033.78983105065;42265.78867105645;42281.365779512715;42346.36480452857;42534.14931701287;270318;270319;271841;272164;273489;36157.81921090378;36905;37001.444978324806;37075;37639;47323.290150648456;47371;48059.519404805505;48077.75961120172;48256.517434825204;34234.82882585571;35537.82231088828;36059.459108112875;36164;37014.07464813401;35030.124246893014;35032.82483587566;35222.47166292559;35396;35663.64336356603;41889.79055104705;41912.371314430915;42017.57982420259;42165.57834421616;42353.152936940474;33955.66044339525;34159.31681366309;34475.827620862736;34581.308373832886;34617.65382346144;26327.868360658074;26376.60435093437;26457.867710662093;26939;26945.595816063167 08:23:52 INFO - PID 26084 | |2;jquery.html;633.6824364993379;635.0617904489412;640.4235749845492;642.1071914077189;659.423004870738;24140;25134.245972620804;25186.118485853;25236.116735914246;25340.619890701655;26866.865665671645;26942.191734247954;27128.728712712866;27164.864175679093;27238;6560.212774467047;6605.044868787486;6811.148606424197;6868.62222577758;6889.379955803976;6735.9663201683925;6799.626020568867;6821.829454263633;6830.692618832164;6833.350831670983;6587.077809106705;6711.161104861892;6784.050232967388;6834.009068685038;6840.213375461836;6779.28817474163;6797.422219111381;6800.727970881158;6809.795706128824;6857.245702972669;6336.841578960517;6389.977603583451;6392.20097487814;6399.26408463028;6439.130717353144;30890.691093089004;30904.53643195354;31052;31367.215819604466;31395.686043139733;2317.9072837086496;2377.09670325277;2378.203301893868;2378.2984019714227;2379.3456799380137;19957.401277961686;20437.693434598492;20602.484937876525;20653.380398588066;20662.896685516625;2520.5337012652717;2555.5527782637964;2618.6203000565;2623.0688105722384;2628.2115365390496;150534;151401;157005;159945;166680.16659916745;15635.530934071996;16634.417795377347;16703.582410439594;16918.492445226664;17510.12449377526;27222.863885680446;27260.45479090407;27318;27384.452310953668;27389.178324650293;11214.831777523344;11500.654980350602;11572.132090093277;11706.239094458833;11714.765704685859;10671.413072281099;10676;10704.143668506656;10735.78528429427;10855.67432977012;9728.24891519519;9868.680859997894;10239.539220735085;10241.743956401;10276.537555810006;2956.8373739444105;2985.3726723578366;3027.303720144379;3146.4651009328013;3164.3671265746943;1048.486241741541;1066.7493139112303;1070.7376692710336;1075.0969185883896;1082.6048492300254;21116.577668446545;21536.953989370984;21761.782382176294;21821.890890545765;22217.555648886933;1093.2511229807608;1117.8435019097333;1120.6301920366259;1130.3161587239765;1138.3056335635256;11438.313701177789;11704.180707350404;11805.645830625095;11886.702832429259;11889.70275743096;640370;649540;665942;676512;684232;138233;138482;140034.2998285002;140155;140909;1136.8863113688565;1188.1504724122294;1225.3995542184266;1235.1909499277988;1278.8465384153776;21758.67361989603;22464.663030054235;22494.666846520035;22577.322680319616;22642.886785566625;65618.67190664016;65676.34323656702;65866.67066664636;65893;67147.32852671607;81281.18718812735;81291.59354203191;83511.5824420874;84728.57635712028;85865;15663.216839158224;16057.197140142713;16166.353345866033;16196.271167797713;16223.107729075015;21643.78356216481;23818.40453988595;24032.639510407007;24084;24316.878415608517;18288.90855545714;18306.633867322846;18497.907510462363;18653.813461865208;19728.90135549313;17407.738883917005;17428.47714568565;17998.550036248675;18404.26382944667;18649.720254195927;20132.89933550323;20342.08460619246;20347.79652203459;20485.59028819445;20573;15745.370185192922;15749.842501575296;15753.763693544835;15768.76346854821;15779.368825246862;18835.90582047081;18982;19582.216711331388;19824.801751982297;19831.40505784829 08:23:52 INFO - PID 26084 | |3;mootools.html;1410.0763999580272;1470.3603932289454;1471.0070702275962;1477.2170749502761;1477.4754961988501;16837.915810420945;17483.300667973283;17497.91251043743;17513.474595762116;17526.561835954108;17065.91467042663;17172.656546869057;17181.140942952832;17197.570060748487;17224.224909879085;2805.2145399288233;2992.685767994351;3016.9849150754217;3017.652969908456;3027.470192716277;2691.1388355726176;2826.8727907244224;2873.1524200360946;2885.1777243485612;2885.740283374496;2774.2232174991036;2802.1733588591414;2804.5652923796843;2805.5651374037056;2805.929851753702;2839.616651752008;2865.785066120039;2872.296287409577;2889.046614617171;2890.031839333836;2777.125205560242;2824.096289187461;2843.8009339346254;2890.638670166229;2946.646402431722;16945.40691075819;17103.31586736529;17138;17153.399631012853;17177.39879104238;8683.13168683133;8919.73240802777;8941.955290223572;8969.416987895765;8985.37102402832;5235;5477.972610136963;5596.160575913605;5609.579281553859;5619.943800562024;2078.0856423173905;2109.430453777487;2122.2565741137964;2150.741910970678;2170.066871245364;32063.51904721431;32172.034838954867;32206.355872882647;32248.193795155308;32271.838640806647;7505.061867266591;7505.249475052451;7560.319571238615;7725.188855170239;7765.262300081483;20477.897610511853;20580.58838823215;20591.382258532267;20594.897025515078;20672.173113075307;8742.256908162877;8914.28685705142;8975.730728078168;8977.506237157018;8985.281177505914;8005.239502247277;8138.877916831252;8200.466969646954;8223.437546866076;8223.629936652866;5986.132010858401;6064.9090263646085;6151.3541078187045;6202.844928876724;6242.1261023456755;1641.5896025993502;1671.8683678310251;1702.6509565539034;1729.265062348522;1766.4877185616285;1015.8730158730159;1028.8805061573182;1029.3103620574234;1036.8081904847627;1051.1328154272755;10058.245631577662;10174.440405777754;10174.593016279267;10218.18254539635;10222.693319200436;1041.6041904076403;1046.3617193511952;1091.6724982505216;1094.7263184203948;1114.1922106472905;5599.776008959678;5626.662400255997;5883.617564858356;6357.554971151975;6523.412892839668;25509.362265943128;26399.076032338777;26694.866525667247;26798.19605411841;26840.731592684213;25145.622815657778;25412.491750164892;25799.74200258011;25969.610455843176;25977;12624.242545447303;12659.556915508098;12786.168899021533;12867.648896865694;12943.223406595445;9948.204143668634;9994.300398972293;10028.69913902584;10069.748256293651;10115.14021308197;21760.12959481603;21786.346409607737;21946.561068778854;22261.109555617593;22442.551148977254;22893.313200604007;22984.540309194057;23068.538629226987;23134.652980204974;23429.76570234344;12465.252084874573;12818.551350703054;12831.230126192459;12835.679108022374;12844.807327890276;15332.463363782213;15368.231588420758;15526.534203973899;15599.142047187514;15716.842831571537;12613.180143290656;12808.6797830055;12901.967842572383;12952.546660866825;13092.869071309546;12838.229706217657;12854.67863303425;12969.092163548838;13255.734885302047;13266.469341226242;11507;11521.596744113916;11622.5350985963;11633.41832908368;11645.243059201124;8557.400981931205;8631.26634236072;8651.48091114535;8877.600507977286;8880.51157186361;8751.737447876574;8762.158613967807;8766.430182038148;8876;8942.37403381757 08:23:52 INFO - PID 26084 | |4;prototype.html;567.3787203012699;583.3349981021636;587.4859497939303;610.3408319015463;626.9717862696178;6215.62706237626;6352.269489008765;6402.711877965491;6427.871442571151;6471.4175724184815;6342.067917890914;6345.650989195592;6391.872162556746;6415.326390728977;6428.967855160718;5191.094415777092;5277.498637629419;5286.629935904498;5297.125974214269;5301.363836339645;4972.900541989158;5099.158638824608;5117.590592752571;5134.1528647773075;5135.845924622267;5047.293378926953;5097.7196254206;5098.133317336044;5113.769880355393;5118.541215753511;5024.19612861944;5032.949670503284;5062.848114556569;5095.872603184913;5107.208382700706;4654.25531914892;4678.087772884289;4696.7651617419;4697.131030759287;4700.130475861943;6263.123162757218;6345.428911397997;6351.856665800154;6378.2346118466085;6392.840178995516;6049.727762250665;6068.211132552784;6068.393160683941;6080.2399700037495;6092.634441933498;6744.089547911019;6747.93252067478;6765.2219994700745;6813.727450902007;6852.45180385568;5025.497450254982;5269.235960785703;5269.525742683139;5269.947300526984;5308.973455132738;6899.551529150639;6952.721891124349;6953.582785032863;7112.217656057829;7126.536775109653;5333.5199832015305;5337.81317653888;5358.651687640291;5407.567394608501;5420.566354691615;5433.0763770159165;5474.589405794582;5475.890482190413;5490.286262785812;5516.696581688046;6031;6060.787872424532;6088.4215999479975;6094.725737341831;6133.723982420713;6936.4797640177185;6940.30596940312;6946.9652651736415;6951.582905025714;6965.651717414109;1858.851291896645;1869.9345522906633;1870.6352261308914;1891.6689579323563;1900.1829213438077;1297.3189075735127;1342.7985802129758;1345.9327033648278;1346.3470216944775;1353.8375394952668;6385.297617262097;6400.359964003563;6402;6424.1327420798525;6429.935700643027;6752.493562982796;6837.658117094125;6854.2117656469145;6879.58722476653;6881.65591720412;6406.2953075161695;6416.358364163546;6455.9677201613695;6474.223093228748;6499.252585952581;3603.819809009539;3638.1814091829656;3644.4168932970597;3652.9634703652623;3656.597774244831;7193.928060719326;7204;7268.532160033607;7291.70833166678;7310.707571697072;7004.0738796830265;7036.155661320674;7080.964595176991;7085.645717714094;7134.714611415589;7099.325564071405;7139.500234983501;7300.561966282146;7303.196648368676;7381.778546643609;6866.210385805696;6897.448204143757;6933.168019837652;6965.407940325129;6974.79075627732;6749.009042332425;6762.695678694569;6832.248452670103;6924.134483189601;6928.861422771415;7219.45854060937;7254.129504459499;7319.63401829917;7360.558366498028;7415.1101867776215;5418.160185171305;5439.864003399946;5448.536874365724;5459.672419654833;5465.234867118686;6576;6804.5696816507925;6913.688884000131;6998.930010699828;7004.824879378057;6542.149520562297;6710.362515561014;6775.322467753185;6826.078479405415;6839.213490448662;6752.324767523209;6756.493263005196;6770.424513916175;6803.4557235422035;6805.353491418307;6726.334147889314;6753.662316884038;6772.018057381751;6781.11845460087;6787.524873259022;6815.454763618998;6870.725170993304;6871.14110736158;6872.793816185523;6879.828004299932;6442.806715798533;6616.966915165393;6625.17185351831;6647.933520664731;6726.730930762715 08:23:52 INFO - PID 26084 | |5;yui.html;1000.7898341348316;1025.2618114957231;1041.1982773264585;1047.9528421221044;1053.4469403563128;18212.817871821277;18847.71728424075;18855.811441885577;18928.43214703561;18938.62122757546;16867.662646747056;17331.306747730076;17360.82639173608;18182.545436364064;18427;1067.5409573883228;1087.7280679830042;1095.353741292637;1097.1442275025493;1099.8460215569826;1058.449606204773;1062.3466568060626;1082.967510974672;1084.2735367303885;1085.5332207150923;1161.506359797087;1162.0935670177275;1162.96511104667;1163.331084626339;1172.1150531348862;1154.0709728668419;1159.194359919856;1159.8550181227347;1165.6910918606577;1167.5504930601694;863.3956230638578;864.7016779211162;864.7146441674232;865.3855762408697;865.8181781825824;17643.823561764348;17767;17787.644247114986;17788.822111778845;17960.820391796176;20765.688514672293;21197.152113915425;21212.893935530377;21313.467163320885;21403.67894481584;17800.287988480446;17853.46439606814;18097.457076287734;18134.09329533518;18134.09329533531;4037.6164264394833;4062.9593704063172;4089.488813898263;4089.5092588889224;4089.9591004089875;163827;164483.1775841125;166827;167760.16119919444;168402;17621.647567048843;17664;18056.45830625083;18060;18062.09689515519;35193.47209791855;35383.64616353855;36412;36788.44817327742;36854.8157259212;8869.068747781519;8873.29013678904;8946.68686595966;8955.328350373748;8963.551822408985;4043.1913617276073;4436.977815110904;4541.069080838421;4542.114287713864;4559.065391594715;6559.344065593403;6658.5671931324305;6663.66726654671;6667.966660166668;6695.129633147757;1060.8833028366873;1100.5377741348493;1105.1435137768133;1107.5348353691309;1118.1055155875267;741.7997140772069;744.6686224629988;758.707897459471;759.1876691939682;768.9807754806063;13853.445862165401;14061.032394732125;14493.20287384204;15004.399824006918;15014.47449339268;777.0597576931975;777.9805504862424;780.2704471319335;784.6743601405467;790.8181118342814;6447.70985305653;6456.54804163704;6457.1282876811965;6509.381608747161;6530.640814755139;154966.22516887344;156827;157172;162248;163927;139166;141657.29171354283;141753.29123354316;142427;146813;118110.40944795393;118593;120468.39765801115;121903.99999999822;121968.39015805042;12317.876821231674;12340.629781106582;12375.381230938598;12422.627321180378;12509;56838;56840;56983.14525282041;57579.42420575741;58182.7090864543;71361;71671;72002;74280.62859685667;74942.25057749571;17521.737173942656;17687.557811054827;17695.911520442314;17836.06295198624;17853.642927141125;19202.51993700113;19858;19878.801211987695;19986;20086.899565502077;18778.906105469385;18827.71758423652;18963.431097066557;19154.138063786886;19164;18126.54683632867;18492.075396230404;18510.444686659423;18540.44378668642;18727.344542940933;17836.91081544584;18035.90982045134;18045.639087218446;18188.818111818713;18314.542136446697;13947.511837085653;13963.441462341392;14011.08927919682;14147.64630884236;14160.504382346568;12975.675608109872;13055.869441305465;13066.477340906638;13155.01337399718;13429.059965802691 08:23:52 INFO - PID 26084 | __end_tp_report 08:23:52 INFO - PID 26084 | __start_cc_report 08:23:52 INFO - PID 26084 | _x_x_mozilla_cycle_collect,264 08:23:52 INFO - PID 26084 | __end_cc_report 08:23:52 INFO - PID 26084 | __startTimestamp1506007432673__endTimestamp 08:23:52 INFO - PID 26084 | 08:23:52 INFO - PID 26084 | ------- Summary: start ------- 08:23:52 INFO - PID 26084 | Number of tests: 6 08:23:52 INFO - PID 26084 | 08:23:52 INFO - PID 26084 | [#0] dojo.html Cycles:165 Average:6628.82 Median:6887.35 stddev:808.26 (11.7%) stddev-sans-first:783.32 08:23:52 INFO - PID 26084 | Values: 3968.1 3976.9 4017.6 4020.6 4031.6 6503.1 6511.8 6523.7 6570.0 6611.3 6485.7 6539.4 6603.8 6615.5 6630.3 5767.7 5775.0 5798.3 5878.3 5886.2 5806.9 5843.8 5854.1 5894.0 5943.0 5885.4 5893.1 5939.1 5958.7 5972.5 5811.0 5852.4 5915.3 5943.2 5958.6 5720.3 5776.0 5805.0 5838.4 5855.4 6474.8 6491.5 6521.9 6541.4 6584.8 7196.1 7199.5 7252.4 7253.6 7279.9 7073.8 7273.9 7274.7 7332.4 7363.1 6645.4 6645.5 6678.7 6682.1 6691.4 7342.6 7345.5 7345.7 7348.5 7475.4 7118.5 7118.7 7182.7 7209.4 7210.6 7265.5 7297.2 7331.6 7350.0 7385.9 6967.9 7072.0 7122.5 7159.1 7198.7 7144.8 7162.2 7162.6 7162.6 7169.4 5319.2 5321.6 5330.7 5334.9 5336.7 4808.9 4828.0 4871.5 4873.3 4875.4 6663.0 6665.5 6763.6 6771.6 6775.3 7225.9 7230.9 7237.2 7242.6 7247.9 6707.5 6767.7 6857.5 6865.2 6869.7 6063.3 6100.9 6130.6 6145.3 6150.9 7567.2 7575.5 7577.7 7683.2 7689.2 7018.1 7126.5 7187.3 7284.8 7317.3 7492.4 7535.4 7601.0 7621.2 7646.5 7116.9 7195.0 7204.7 7223.9 7227.5 7181.2 7197.5 7236.1 7315.9 7335.8 6835.9 6920.3 6922.3 6927.8 7017.6 6915.8 6918.7 6945.8 6989.9 6998.0 6871.8 6887.3 6942.1 6947.6 6953.4 6899.3 6986.5 6989.2 7048.9 7081.5 6696.5 6756.9 6785.5 6821.9 6865.7 08:23:52 INFO - PID 26084 | 08:23:52 INFO - PID 26084 | [#1] ext.html Cycles:180 Average:45177.56 Median:20741.35 stddev:69721.97 (336.1%) stddev-sans-first:69838.52 08:23:52 INFO - PID 26084 | Values: 962.4 971.8 993.5 999.4 1025.7 45814.3 46461.1 46519.3 46529.5 46532.8 43079.0 43562.0 43642.3 43685.6 43686.6 8013.5 8158.8 8162.9 8169.1 8173.0 8046.3 8152.8 8156.8 8161.1 8161.6 8573.7 8803.7 8835.9 8836.5 8839.4 8724.4 8791.4 8809.3 8832.3 8837.2 8589.5 8638.0 8667.0 8673.4 8677.4 41242.8 41651.8 41778.6 41811.8 41963.4 3843.7 3875.1 3880.9 3892.0 3892.1 33599.3 33715.7 33787.3 33865.3 33971.7 5638.4 5642.7 5684.3 5695.7 5748.4 224887.0 226301.0 226388.0 226430.0 226848.0 52412.5 52761.7 52776.0 54503.5 55206.7 58028.4 58123.4 58202.7 58269.0 58288.1 18492.0 18559.8 18571.8 18616.8 18717.3 15313.7 15350.2 15422.7 15446.2 15454.5 15330.8 15333.2 15364.8 15390.8 15517.1 5584.8 5627.9 5726.0 5776.9 5779.5 1099.3 1100.6 1103.9 1120.5 1123.4 26769.3 26874.2 26874.5 27319.9 27372.2 1203.8 1211.8 1212.8 1222.7 1233.3 14193.1 14212.1 14289.2 14422.4 14651.7 295056.0 300545.0 301651.0 302088.0 303382.0 64808.0 65046.7 65335.7 65424.7 65464.7 1502.6 1520.1 1531.7 1536.0 1536.4 31033.7 31050.0 31274.4 31280.8 31359.7 42033.8 42265.8 42281.4 42346.4 42534.1 270318.0 270319.0 271841.0 272164.0 273489.0 36157.8 36905.0 37001.4 37075.0 37639.0 47323.3 47371.0 48059.5 48077.8 48256.5 34234.8 35537.8 36059.5 36164.0 37014.1 35030.1 35032.8 35222.5 35396.0 35663.6 41889.8 41912.4 42017.6 42165.6 42353.2 33955.7 34159.3 34475.8 34581.3 34617.7 26327.9 26376.6 26457.9 26939.0 26945.6 08:23:52 INFO - PID 26084 | 08:23:52 INFO - PID 26084 | [#2] jquery.html Cycles:180 Average:42294.72 Median:22479.66 stddev:110784.24 (492.8%) stddev-sans-first:111050.85 08:23:52 INFO - PID 26084 | Values: 633.7 635.1 640.4 642.1 659.4 24140.0 25134.2 25186.1 25236.1 25340.6 26866.9 26942.2 27128.7 27164.9 27238.0 6560.2 6605.0 6811.1 6868.6 6889.4 6736.0 6799.6 6821.8 6830.7 6833.4 6587.1 6711.2 6784.1 6834.0 6840.2 6779.3 6797.4 6800.7 6809.8 6857.2 6336.8 6390.0 6392.2 6399.3 6439.1 30890.7 30904.5 31052.0 31367.2 31395.7 2317.9 2377.1 2378.2 2378.3 2379.3 19957.4 20437.7 20602.5 20653.4 20662.9 2520.5 2555.6 2618.6 2623.1 2628.2 150534.0 151401.0 157005.0 159945.0 166680.2 15635.5 16634.4 16703.6 16918.5 17510.1 27222.9 27260.5 27318.0 27384.5 27389.2 11214.8 11500.7 11572.1 11706.2 11714.8 10671.4 10676.0 10704.1 10735.8 10855.7 9728.2 9868.7 10239.5 10241.7 10276.5 2956.8 2985.4 3027.3 3146.5 3164.4 1048.5 1066.7 1070.7 1075.1 1082.6 21116.6 21537.0 21761.8 21821.9 22217.6 1093.3 1117.8 1120.6 1130.3 1138.3 11438.3 11704.2 11805.6 11886.7 11889.7 640370.0 649540.0 665942.0 676512.0 684232.0 138233.0 138482.0 140034.3 140155.0 140909.0 1136.9 1188.2 1225.4 1235.2 1278.8 21758.7 22464.7 22494.7 22577.3 22642.9 65618.7 65676.3 65866.7 65893.0 67147.3 81281.2 81291.6 83511.6 84728.6 85865.0 15663.2 16057.2 16166.4 16196.3 16223.1 21643.8 23818.4 24032.6 24084.0 24316.9 18288.9 18306.6 18497.9 18653.8 19728.9 17407.7 17428.5 17998.6 18404.3 18649.7 20132.9 20342.1 20347.8 20485.6 20573.0 15745.4 15749.8 15753.8 15768.8 15779.4 18835.9 18982.0 19582.2 19824.8 19831.4 08:23:52 INFO - PID 26084 | 08:23:52 INFO - PID 26084 | [#3] mootools.html Cycles:180 Average:10858.51 Median:23101.60 stddev:8045.19 (34.8%) stddev-sans-first:8036.44 08:23:52 INFO - PID 26084 | Values: 1410.1 1470.4 1471.0 1477.2 1477.5 16837.9 17483.3 17497.9 17513.5 17526.6 17065.9 17172.7 17181.1 17197.6 17224.2 2805.2 2992.7 3017.0 3017.7 3027.5 2691.1 2826.9 2873.2 2885.2 2885.7 2774.2 2802.2 2804.6 2805.6 2805.9 2839.6 2865.8 2872.3 2889.0 2890.0 2777.1 2824.1 2843.8 2890.6 2946.6 16945.4 17103.3 17138.0 17153.4 17177.4 8683.1 8919.7 8942.0 8969.4 8985.4 5235.0 5478.0 5596.2 5609.6 5619.9 2078.1 2109.4 2122.3 2150.7 2170.1 32063.5 32172.0 32206.4 32248.2 32271.8 7505.1 7505.2 7560.3 7725.2 7765.3 20477.9 20580.6 20591.4 20594.9 20672.2 8742.3 8914.3 8975.7 8977.5 8985.3 8005.2 8138.9 8200.5 8223.4 8223.6 5986.1 6064.9 6151.4 6202.8 6242.1 1641.6 1671.9 1702.7 1729.3 1766.5 1015.9 1028.9 1029.3 1036.8 1051.1 10058.2 10174.4 10174.6 10218.2 10222.7 1041.6 1046.4 1091.7 1094.7 1114.2 5599.8 5626.7 5883.6 6357.6 6523.4 25509.4 26399.1 26694.9 26798.2 26840.7 25145.6 25412.5 25799.7 25969.6 25977.0 12624.2 12659.6 12786.2 12867.6 12943.2 9948.2 9994.3 10028.7 10069.7 10115.1 21760.1 21786.3 21946.6 22261.1 22442.6 22893.3 22984.5 23068.5 23134.7 23429.8 12465.3 12818.6 12831.2 12835.7 12844.8 15332.5 15368.2 15526.5 15599.1 15716.8 12613.2 12808.7 12902.0 12952.5 13092.9 12838.2 12854.7 12969.1 13255.7 13266.5 11507.0 11521.6 11622.5 11633.4 11645.2 8557.4 8631.3 8651.5 8877.6 8880.5 8751.7 8762.2 8766.4 8876.0 8942.4 08:23:52 INFO - PID 26084 | 08:23:52 INFO - PID 26084 | [#4] prototype.html Cycles:180 Average:5809.55 Median:6415.84 stddev:1619.16 (25.2%) stddev-sans-first:1575.17 08:23:52 INFO - PID 26084 | Values: 567.4 583.3 587.5 610.3 627.0 6215.6 6352.3 6402.7 6427.9 6471.4 6342.1 6345.7 6391.9 6415.3 6429.0 5191.1 5277.5 5286.6 5297.1 5301.4 4972.9 5099.2 5117.6 5134.2 5135.8 5047.3 5097.7 5098.1 5113.8 5118.5 5024.2 5032.9 5062.8 5095.9 5107.2 4654.3 4678.1 4696.8 4697.1 4700.1 6263.1 6345.4 6351.9 6378.2 6392.8 6049.7 6068.2 6068.4 6080.2 6092.6 6744.1 6747.9 6765.2 6813.7 6852.5 5025.5 5269.2 5269.5 5269.9 5309.0 6899.6 6952.7 6953.6 7112.2 7126.5 5333.5 5337.8 5358.7 5407.6 5420.6 5433.1 5474.6 5475.9 5490.3 5516.7 6031.0 6060.8 6088.4 6094.7 6133.7 6936.5 6940.3 6947.0 6951.6 6965.7 1858.9 1869.9 1870.6 1891.7 1900.2 1297.3 1342.8 1345.9 1346.3 1353.8 6385.3 6400.4 6402.0 6424.1 6429.9 6752.5 6837.7 6854.2 6879.6 6881.7 6406.3 6416.4 6456.0 6474.2 6499.3 3603.8 3638.2 3644.4 3653.0 3656.6 7193.9 7204.0 7268.5 7291.7 7310.7 7004.1 7036.2 7081.0 7085.6 7134.7 7099.3 7139.5 7300.6 7303.2 7381.8 6866.2 6897.4 6933.2 6965.4 6974.8 6749.0 6762.7 6832.2 6924.1 6928.9 7219.5 7254.1 7319.6 7360.6 7415.1 5418.2 5439.9 5448.5 5459.7 5465.2 6576.0 6804.6 6913.7 6998.9 7004.8 6542.1 6710.4 6775.3 6826.1 6839.2 6752.3 6756.5 6770.4 6803.5 6805.4 6726.3 6753.7 6772.0 6781.1 6787.5 6815.5 6870.7 6871.1 6872.8 6879.8 6442.8 6617.0 6625.2 6647.9 6726.7 08:23:52 INFO - PID 26084 | 08:23:52 INFO - PID 26084 | [#5] yui.html Cycles:180 Average:29224.30 Median:18058.23 stddev:44714.10 (247.6%) stddev-sans-first:44789.31 08:23:52 INFO - PID 26084 | Values: 1000.8 1025.3 1041.2 1048.0 1053.4 18212.8 18847.7 18855.8 18928.4 18938.6 16867.7 17331.3 17360.8 18182.5 18427.0 1067.5 1087.7 1095.4 1097.1 1099.8 1058.4 1062.3 1083.0 1084.3 1085.5 1161.5 1162.1 1163.0 1163.3 1172.1 1154.1 1159.2 1159.9 1165.7 1167.6 863.4 864.7 864.7 865.4 865.8 17643.8 17767.0 17787.6 17788.8 17960.8 20765.7 21197.2 21212.9 21313.5 21403.7 17800.3 17853.5 18097.5 18134.1 18134.1 4037.6 4063.0 4089.5 4089.5 4090.0 163827.0 164483.2 166827.0 167760.2 168402.0 17621.6 17664.0 18056.5 18060.0 18062.1 35193.5 35383.6 36412.0 36788.4 36854.8 8869.1 8873.3 8946.7 8955.3 8963.6 4043.2 4437.0 4541.1 4542.1 4559.1 6559.3 6658.6 6663.7 6668.0 6695.1 1060.9 1100.5 1105.1 1107.5 1118.1 741.8 744.7 758.7 759.2 769.0 13853.4 14061.0 14493.2 15004.4 15014.5 777.1 778.0 780.3 784.7 790.8 6447.7 6456.5 6457.1 6509.4 6530.6 154966.2 156827.0 157172.0 162248.0 163927.0 139166.0 141657.3 141753.3 142427.0 146813.0 118110.4 118593.0 120468.4 121904.0 121968.4 12317.9 12340.6 12375.4 12422.6 12509.0 56838.0 56840.0 56983.1 57579.4 58182.7 71361.0 71671.0 72002.0 74280.6 74942.3 17521.7 17687.6 17695.9 17836.1 17853.6 19202.5 19858.0 19878.8 19986.0 20086.9 18778.9 18827.7 18963.4 19154.1 19164.0 18126.5 18492.1 18510.4 18540.4 18727.3 17836.9 18035.9 18045.6 18188.8 18314.5 13947.5 13963.4 14011.1 14147.6 14160.5 12975.7 13055.9 13066.5 13155.0 13429.1 08:23:52 INFO - PID 26084 | -------- Summary: end -------- 08:23:52 INFO - PID 26084 | 08:23:53 INFO - TEST-INFO | 26084: exit 0 08:23:53 INFO - TEST-OK | dromaeo_css | took 1106390ms 08:23:53 INFO - TEST-START | kraken 08:23:53 INFO - Initialising browser for kraken test... 08:23:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35422/getInfo.html -profile /tmp/tmpxydSfV/profile 08:23:53 INFO - TEST-INFO | started process 26446 (/builds/slave/test/build/application/firefox/firefox http://localhost:35422/getInfo.html) 08:23:58 INFO - TEST-INFO | 26446: exit 0 08:23:58 INFO - Browser initialized. 08:23:58 INFO - Running cycle 1/1 for kraken test... 08:23:58 INFO - Using env: {'DISPLAY': ':0', 08:23:58 INFO - 'HOME': '/home/cltbld', 08:23:58 INFO - 'JSGC_DISABLE_POISONING': '1', 08:23:58 INFO - 'LANG': 'en_US.UTF-8', 08:23:58 INFO - 'LANGUAGE': 'en_US:en', 08:23:58 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:23:58 INFO - 'LOGNAME': 'cltbld', 08:23:58 INFO - 'MAIL': '/var/mail/cltbld', 08:23:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:23:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:23:58 INFO - 'MOZ_CRASHREPORTER': '1', 08:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:58 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:23:58 INFO - 'MOZ_NO_REMOTE': '1', 08:23:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:58 INFO - 'NO_EM_RESTART': '1', 08:23:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:58 INFO - 'PWD': '/builds/slave/test', 08:23:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:23:58 INFO - 'RUST_BACKTRACE': 'full', 08:23:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:23:58 INFO - 'SHELL': '/bin/bash', 08:23:58 INFO - 'SHLVL': '1', 08:23:58 INFO - 'TERM': 'linux', 08:23:58 INFO - 'TMOUT': '86400', 08:23:58 INFO - 'USER': 'cltbld', 08:23:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003', 08:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:58 INFO - '_': '/tools/buildbot/bin/python'} 08:23:58 INFO - TEST-INFO | started process 26634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxydSfV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:09 INFO - PID 26634 | RSS: Main: 143679488 08:24:09 INFO - PID 26634 | 08:24:11 INFO - PID 26634 | Cycle 1(1): loaded http://localhost:35422/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35422/tests/kraken/driver.html?testName=audio-beat-detection) 08:24:12 INFO - PID 26634 | RSS: Main: 148967424 08:24:12 INFO - PID 26634 | 08:24:15 INFO - PID 26634 | Cycle 1(1): loaded http://localhost:35422/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35422/tests/kraken/driver.html?testName=audio-dft) 08:24:15 INFO - PID 26634 | RSS: Main: 149393408 08:24:15 INFO - PID 26634 | 08:24:18 INFO - PID 26634 | Cycle 1(1): loaded http://localhost:35422/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35422/tests/kraken/driver.html?testName=audio-fft) 08:24:19 INFO - PID 26634 | RSS: Main: 151642112 08:24:19 INFO - PID 26634 | 08:24:21 INFO - PID 26634 | Cycle 1(1): loaded http://localhost:35422/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35422/tests/kraken/driver.html?testName=audio-oscillator) 08:24:22 INFO - PID 26634 | RSS: Main: 151396352 08:24:22 INFO - PID 26634 | 08:24:24 INFO - PID 26634 | Cycle 1(1): loaded http://localhost:35422/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35422/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:24:24 INFO - PID 26634 | RSS: Main: 151158784 08:24:24 INFO - PID 26634 | 08:24:27 INFO - PID 26634 | Cycle 1(1): loaded http://localhost:35422/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35422/tests/kraken/driver.html?testName=imaging-darkroom) 08:24:28 INFO - PID 26634 | RSS: Main: 151236608 08:24:28 INFO - PID 26634 | 08:24:31 INFO - PID 26634 | Cycle 1(1): loaded http://localhost:35422/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35422/tests/kraken/driver.html?testName=imaging-desaturate) 08:24:32 INFO - PID 26634 | RSS: Main: 152264704 08:24:32 INFO - PID 26634 | 08:24:35 INFO - PID 26634 | Cycle 1(1): loaded http://localhost:35422/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35422/tests/kraken/driver.html?testName=json-parse-financial) 08:24:35 INFO - PID 26634 | RSS: Main: 153612288 08:24:35 INFO - PID 26634 | 08:24:37 INFO - PID 26634 | Cycle 1(1): loaded http://localhost:35422/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35422/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:24:37 INFO - PID 26634 | RSS: Main: 153759744 08:24:37 INFO - PID 26634 | 08:24:39 INFO - PID 26634 | Cycle 1(1): loaded http://localhost:35422/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35422/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:24:40 INFO - PID 26634 | RSS: Main: 153497600 08:24:40 INFO - PID 26634 | 08:24:42 INFO - PID 26634 | Cycle 1(1): loaded http://localhost:35422/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35422/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:24:42 INFO - PID 26634 | RSS: Main: 150429696 08:24:42 INFO - PID 26634 | 08:24:45 INFO - PID 26634 | Cycle 1(1): loaded http://localhost:35422/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35422/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:24:45 INFO - PID 26634 | RSS: Main: 150585344 08:24:45 INFO - PID 26634 | 08:24:48 INFO - PID 26634 | Cycle 1(1): loaded http://localhost:35422/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35422/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:24:49 INFO - PID 26634 | RSS: Main: 150798336 08:24:49 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | Cycle 1(1): loaded http://localhost:35422/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35422/tests/kraken/driver.html?testName=ai-astar) 08:24:50 INFO - PID 26634 | RSS: Main: 152625152 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | __start_tp_report 08:24:50 INFO - PID 26634 | _x_x_mozilla_page_load 08:24:50 INFO - PID 26634 | _x_x_mozilla_page_load_details 08:24:50 INFO - PID 26634 | |i|pagename|runs| 08:24:50 INFO - PID 26634 | |0;ai-astar;105;107;107;104;106;109;109;104;105;104 08:24:50 INFO - PID 26634 | |1;audio-beat-detection;111;112;109;111;119;113;111;111;111;112 08:24:50 INFO - PID 26634 | |2;audio-dft;163;163;162;164;163;161;162;162;161;162 08:24:50 INFO - PID 26634 | |3;audio-fft;75;75;74;73;74;73;74;73;72;72 08:24:50 INFO - PID 26634 | |4;audio-oscillator;77;77;76;77;77;77;77;77;77;77 08:24:50 INFO - PID 26634 | |5;imaging-gaussian-blur;113;113;111;113;113;110;114;113;114;113 08:24:50 INFO - PID 26634 | |6;imaging-darkroom;149;148;153;149;150;150;150;150;149;152 08:24:50 INFO - PID 26634 | |7;imaging-desaturate;93;96;94;93;94;94;95;93;94;97 08:24:50 INFO - PID 26634 | |8;json-parse-financial;44;43;43;43;44;44;47;43;42;42 08:24:50 INFO - PID 26634 | |9;json-stringify-tinderbox;36;36;36;35;36;36;37;36;36;36 08:24:50 INFO - PID 26634 | |10;stanford-crypto-aes;68;68;74;71;73;69;70;75;73;74 08:24:50 INFO - PID 26634 | |11;stanford-crypto-ccm;110;105;102;112;114;102;109;102;99;110 08:24:50 INFO - PID 26634 | |12;stanford-crypto-pbkdf2;150;149;153;152;154;148;153;154;151;153 08:24:50 INFO - PID 26634 | |13;stanford-crypto-sha256-iterative;64;58;58;57;59;60;57;57;58;58 08:24:50 INFO - PID 26634 | __end_tp_report 08:24:50 INFO - PID 26634 | __start_cc_report 08:24:50 INFO - PID 26634 | _x_x_mozilla_cycle_collect,685 08:24:50 INFO - PID 26634 | __end_cc_report 08:24:50 INFO - PID 26634 | __startTimestamp1506007490936__endTimestamp 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | ------- Summary: start ------- 08:24:50 INFO - PID 26634 | Number of tests: 14 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | [#0] ai-astar Cycles:10 Average:106.00 Median:106.50 stddev:1.94 (1.8%) stddev-sans-first:2.03 08:24:50 INFO - PID 26634 | Values: 105.0 107.0 107.0 104.0 106.0 109.0 109.0 104.0 105.0 104.0 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | [#1] audio-beat-detection Cycles:10 Average:112.00 Median:111.50 stddev:2.67 (2.4%) stddev-sans-first:2.80 08:24:50 INFO - PID 26634 | Values: 111.0 112.0 109.0 111.0 119.0 113.0 111.0 111.0 111.0 112.0 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 08:24:50 INFO - PID 26634 | Values: 163.0 163.0 162.0 164.0 163.0 161.0 162.0 162.0 161.0 162.0 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | [#3] audio-fft Cycles:10 Average:73.50 Median:74.00 stddev:1.08 (1.5%) stddev-sans-first:1.00 08:24:50 INFO - PID 26634 | Values: 75.0 75.0 74.0 73.0 74.0 73.0 74.0 73.0 72.0 72.0 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:77.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 08:24:50 INFO - PID 26634 | Values: 77.0 77.0 76.0 77.0 77.0 77.0 77.0 77.0 77.0 77.0 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | [#5] imaging-gaussian-blur Cycles:10 Average:112.70 Median:113.00 stddev:1.25 (1.1%) stddev-sans-first:1.32 08:24:50 INFO - PID 26634 | Values: 113.0 113.0 111.0 113.0 113.0 110.0 114.0 113.0 114.0 113.0 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:1.49 (1.0%) stddev-sans-first:1.54 08:24:50 INFO - PID 26634 | Values: 149.0 148.0 153.0 149.0 150.0 150.0 150.0 150.0 149.0 152.0 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:1.34 (1.4%) stddev-sans-first:1.33 08:24:50 INFO - PID 26634 | Values: 93.0 96.0 94.0 93.0 94.0 94.0 95.0 93.0 94.0 97.0 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | [#8] json-parse-financial Cycles:10 Average:43.50 Median:43.50 stddev:1.43 (3.3%) stddev-sans-first:1.51 08:24:50 INFO - PID 26634 | Values: 44.0 43.0 43.0 43.0 44.0 44.0 47.0 43.0 42.0 42.0 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | [#9] json-stringify-tinderbox Cycles:10 Average:36.00 Median:36.00 stddev:0.47 (1.3%) stddev-sans-first:0.50 08:24:50 INFO - PID 26634 | Values: 36.0 36.0 36.0 35.0 36.0 36.0 37.0 36.0 36.0 36.0 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | [#10] stanford-crypto-aes Cycles:10 Average:71.50 Median:73.00 stddev:2.64 (3.6%) stddev-sans-first:2.47 08:24:50 INFO - PID 26634 | Values: 68.0 68.0 74.0 71.0 73.0 69.0 70.0 75.0 73.0 74.0 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | [#11] stanford-crypto-ccm Cycles:10 Average:106.50 Median:110.00 stddev:5.13 (4.7%) stddev-sans-first:5.28 08:24:50 INFO - PID 26634 | Values: 110.0 105.0 102.0 112.0 114.0 102.0 109.0 102.0 99.0 110.0 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.70 Median:153.00 stddev:2.11 (1.4%) stddev-sans-first:2.15 08:24:50 INFO - PID 26634 | Values: 150.0 149.0 153.0 152.0 154.0 148.0 153.0 154.0 151.0 153.0 08:24:50 INFO - PID 26634 | 08:24:50 INFO - PID 26634 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.60 Median:58.00 stddev:2.12 (3.7%) stddev-sans-first:1.00 08:24:50 INFO - PID 26634 | Values: 64.0 58.0 58.0 57.0 59.0 60.0 57.0 57.0 58.0 58.0 08:24:50 INFO - PID 26634 | -------- Summary: end -------- 08:24:50 INFO - PID 26634 | 08:24:51 INFO - PID 26634 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:24:51 INFO - TEST-INFO | 26634: exit 0 08:24:51 INFO - TEST-OK | kraken | took 58273ms 08:24:51 INFO - SUITE-END | took 1164s 08:24:51 INFO - Completed test suite (00:19:24) 08:24:51 INFO - javascript benchmark 08:24:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9397.035777915344, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3968.127012057347, 3976.8608098716545, 4017.6384125428704, 4020.6381425671684, 4031.5766844481327, 6503.122078519398, 6511.772087976922, 6523.706433210505, 6570.0, 6611.272759996403, 6485.708143133558, 6539.378759017885, 6603.801885943418, 6615.503837212216, 6630.336966303379, 5767.6827774472495, 5775.047117225653, 5798.3331916829475, 5878.323992740826, 5886.175935369051, 5806.941930580682, 5843.766249350021, 5854.063349864023, 5894.0, 5943.049112142058, 5885.411458854123, 5893.116032595102, 5939.109133629969, 5958.672273024982, 5972.492338151263, 5811.0, 5852.385499522574, 5915.319738230116, 5943.227380440559, 5958.6424814511265, 5720.2849643794525, 5776.046952252873, 5804.970975145139, 5838.41615838417, 5855.443732845373, 6474.773382931575, 6491.545591808575, 6521.93478065218, 6541.378569035934, 6584.8353791155605, 7196.136463624399, 7199.496035277532, 7252.383547398477, 7253.56478611285, 7279.927200727978, 7073.752418665322, 7273.927260727378, 7274.745383911538, 7332.376747976428, 7363.116426028911, 6645.435138013275, 6645.534812563171, 6678.7328506859185, 6682.064510968468, 6691.397774200296, 7342.596157211405, 7345.485815992829, 7345.669444874993, 7348.52234604749, 7475.401967842559, 7118.501704880712, 7118.679659415338, 7182.676779544829, 7209.423246140296, 7210.567365958059, 7265.455090868206, 7297.197308296083, 7331.633418329062, 7350.044494215717, 7385.889211661829, 6967.895481567781, 7071.964640176869, 7122.465815063891, 7159.140903091558, 7198.748043818441, 7144.785656430316, 7162.212156662763, 7162.570245785269, 7162.606056666829, 7169.426445884316, 5319.202119682079, 5321.574274058066, 5330.680159190461, 5334.946650533522, 5336.733163341895, 4808.903821923612, 4827.975860120677, 4871.5128487151715, 4873.293372460973, 4875.439324477659, 6663.03386009026, 6665.533412661164, 6763.5941843489545, 6771.593704377753, 6775.254721980578, 7225.89161162583, 7230.891536626955, 7237.167725711505, 7242.6378681065735, 7247.855042899218, 6707.463402927754, 6767.695453704595, 6857.451403887677, 6865.244823069458, 6869.725210991604, 6063.333033366326, 6100.932336841124, 6130.632162070201, 6145.293291271471, 6150.938490615126, 7567.167611562723, 7575.469717119859, 7577.696892124363, 7683.1548529661695, 7689.19263477338, 7018.122734658168, 7126.5011449198055, 7187.31720486553, 7284.817879553054, 7317.304856038774, 7492.438067144877, 7535.434842386733, 7600.973868527678, 7621.237876212556, 7646.541207527343, 7116.893246601202, 7194.964025179841, 7204.71181152748, 7223.891641625275, 7227.530210536298, 7181.210066892742, 7197.532160409557, 7236.059312289369, 7315.926840731525, 7335.816604584928, 6835.93164068353, 6920.273371296143, 6922.273161317989, 6927.792166235021, 7017.649117544204, 6915.827104322432, 6918.654067296716, 6945.791626251221, 6989.895151572832, 6998.020277161303, 6871.759488417882, 6887.345702158287, 6942.062821519232, 6947.5831450113155, 6953.4089602384365, 6899.310068993061, 6986.510944233854, 6989.161300643956, 7048.929510704827, 7081.504294699322, 6696.531242813151, 6756.898646520404, 6785.525013249223, 6821.863562728817, 6865.691043902936], "value": 6572.421868211165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [962.4081190068101, 971.7959228562004, 993.5181437003057, 999.3504222255534, 1025.6564051042901, 45814.312785308204, 46461.07077858449, 46519.30221046687, 46529.534704652986, 46532.836679083, 43079.0, 43562.0, 43642.34536481948, 43685.56314436855, 43686.56313436865, 8013.519188848673, 8158.796030099235, 8162.877556836652, 8169.142240064767, 8172.959135204315, 8046.275835174833, 8152.796180095515, 8156.755297341059, 8161.061477930025, 8161.632726527291, 8573.699920502784, 8803.691870784523, 8835.911640883605, 8836.513991730451, 8839.381243312971, 8724.43291186074, 8791.384603077788, 8809.251213646849, 8832.293416526663, 8837.160469755363, 8589.484630922165, 8638.0, 8666.956665216634, 8673.436226645312, 8677.392582519225, 41242.79378603118, 41651.7917410411, 41778.582214177775, 41811.7909410454, 41963.37054944178, 3843.6925045996254, 3875.0893540018074, 3880.8641697540734, 3892.0, 3892.0853599404118, 33599.32801343984, 33715.662843371494, 33787.324253515035, 33865.32269354599, 33971.6602833971, 5638.407967163471, 5642.661440313554, 5684.346300175492, 5695.695645901853, 5748.42515748426, 224886.99999999837, 226301.0, 226388.0, 226430.0, 226848.0, 52412.47587524152, 52761.736191319564, 52776.0, 54503.45496544984, 55206.72396637991, 58028.419715803146, 58123.41876581265, 58202.70898645564, 58269.0, 58288.12567811486, 18491.965883752775, 18559.81440185581, 18571.81428185701, 18616.81383186178, 18717.251309947722, 15313.693726125637, 15350.23248837576, 15422.691546169013, 15446.150461724488, 15454.536363909101, 15330.770038449433, 15333.156676382907, 15364.769528457082, 15390.846091539166, 15517.146556939251, 5584.832455026356, 5627.943720562742, 5725.971370143206, 5776.942230577641, 5779.508741756998, 1099.2964502718266, 1100.5762781329086, 1103.87857335693, 1120.523777394604, 1123.4495097402214, 26769.33076673099, 26874.193774186806, 26874.462510749676, 27319.863400683265, 27372.178834634993, 1203.8134089216185, 1211.8182272659171, 1212.7998880184848, 1222.7371115210271, 1233.3463264469844, 14193.148411095368, 14212.147271163763, 14289.214093224973, 14422.42310307597, 14651.706965860623, 295056.0, 300545.0, 301651.0, 302088.0, 303382.0, 64808.0, 65046.67476662587, 65335.673321634036, 65424.672876636265, 65464.67267663631, 1502.6393665520197, 1520.0879472316742, 1531.670690801483, 1536.0, 1536.3547310129773, 31033.68966310308, 31050.0, 31274.374512509166, 31280.843595781877, 31359.686403135678, 42033.78983105065, 42265.78867105645, 42281.365779512715, 42346.36480452857, 42534.14931701287, 270318.0, 270319.0, 271841.0, 272164.0, 273489.0, 36157.81921090378, 36905.0, 37001.444978324806, 37075.0, 37639.0, 47323.290150648456, 47371.0, 48059.519404805505, 48077.75961120172, 48256.517434825204, 34234.82882585571, 35537.82231088828, 36059.459108112875, 36164.0, 37014.07464813401, 35030.124246893014, 35032.82483587566, 35222.47166292559, 35396.0, 35663.64336356603, 41889.79055104705, 41912.371314430915, 42017.57982420259, 42165.57834421616, 42353.152936940474, 33955.66044339525, 34159.31681366309, 34475.827620862736, 34581.308373832886, 34617.65382346144, 26327.868360658074, 26376.60435093437, 26457.867710662093, 26939.0, 26945.595816063167], "value": 19411.713847994546, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.6824364993379, 635.0617904489412, 640.4235749845492, 642.1071914077189, 659.423004870738, 24140.0, 25134.245972620804, 25186.118485853, 25236.116735914246, 25340.619890701655, 26866.865665671645, 26942.191734247954, 27128.728712712866, 27164.864175679093, 27238.0, 6560.212774467047, 6605.044868787486, 6811.148606424197, 6868.62222577758, 6889.379955803976, 6735.9663201683925, 6799.626020568867, 6821.829454263633, 6830.692618832164, 6833.350831670983, 6587.077809106705, 6711.161104861892, 6784.050232967388, 6834.009068685038, 6840.213375461836, 6779.28817474163, 6797.422219111381, 6800.727970881158, 6809.795706128824, 6857.245702972669, 6336.841578960517, 6389.977603583451, 6392.20097487814, 6399.26408463028, 6439.130717353144, 30890.691093089004, 30904.53643195354, 31052.0, 31367.215819604466, 31395.686043139733, 2317.9072837086496, 2377.09670325277, 2378.203301893868, 2378.2984019714227, 2379.3456799380137, 19957.401277961686, 20437.693434598492, 20602.484937876525, 20653.380398588066, 20662.896685516625, 2520.5337012652717, 2555.5527782637964, 2618.6203000565, 2623.0688105722384, 2628.2115365390496, 150534.0, 151401.0, 157005.0, 159945.0, 166680.16659916745, 15635.530934071996, 16634.417795377347, 16703.582410439594, 16918.492445226664, 17510.12449377526, 27222.863885680446, 27260.45479090407, 27318.0, 27384.452310953668, 27389.178324650293, 11214.831777523344, 11500.654980350602, 11572.132090093277, 11706.239094458833, 11714.765704685859, 10671.413072281099, 10676.0, 10704.143668506656, 10735.78528429427, 10855.67432977012, 9728.24891519519, 9868.680859997894, 10239.539220735085, 10241.743956401, 10276.537555810006, 2956.8373739444105, 2985.3726723578366, 3027.303720144379, 3146.4651009328013, 3164.3671265746943, 1048.486241741541, 1066.7493139112303, 1070.7376692710336, 1075.0969185883896, 1082.6048492300254, 21116.577668446545, 21536.953989370984, 21761.782382176294, 21821.890890545765, 22217.555648886933, 1093.2511229807608, 1117.8435019097333, 1120.6301920366259, 1130.3161587239765, 1138.3056335635256, 11438.313701177789, 11704.180707350404, 11805.645830625095, 11886.702832429259, 11889.70275743096, 640370.0, 649540.0, 665942.0, 676512.0, 684232.0, 138233.0, 138482.0, 140034.2998285002, 140155.0, 140909.0, 1136.8863113688565, 1188.1504724122294, 1225.3995542184266, 1235.1909499277988, 1278.8465384153776, 21758.67361989603, 22464.663030054235, 22494.666846520035, 22577.322680319616, 22642.886785566625, 65618.67190664016, 65676.34323656702, 65866.67066664636, 65893.0, 67147.32852671607, 81281.18718812735, 81291.59354203191, 83511.5824420874, 84728.57635712028, 85865.0, 15663.216839158224, 16057.197140142713, 16166.353345866033, 16196.271167797713, 16223.107729075015, 21643.78356216481, 23818.40453988595, 24032.639510407007, 24084.0, 24316.878415608517, 18288.90855545714, 18306.633867322846, 18497.907510462363, 18653.813461865208, 19728.90135549313, 17407.738883917005, 17428.47714568565, 17998.550036248675, 18404.26382944667, 18649.720254195927, 20132.89933550323, 20342.08460619246, 20347.79652203459, 20485.59028819445, 20573.0, 15745.370185192922, 15749.842501575296, 15753.763693544835, 15768.76346854821, 15779.368825246862, 18835.90582047081, 18982.0, 19582.216711331388, 19824.801751982297, 19831.40505784829], "value": 13184.14285485453, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.0763999580272, 1470.3603932289454, 1471.0070702275962, 1477.2170749502761, 1477.4754961988501, 16837.915810420945, 17483.300667973283, 17497.91251043743, 17513.474595762116, 17526.561835954108, 17065.91467042663, 17172.656546869057, 17181.140942952832, 17197.570060748487, 17224.224909879085, 2805.2145399288233, 2992.685767994351, 3016.9849150754217, 3017.652969908456, 3027.470192716277, 2691.1388355726176, 2826.8727907244224, 2873.1524200360946, 2885.1777243485612, 2885.740283374496, 2774.2232174991036, 2802.1733588591414, 2804.5652923796843, 2805.5651374037056, 2805.929851753702, 2839.616651752008, 2865.785066120039, 2872.296287409577, 2889.046614617171, 2890.031839333836, 2777.125205560242, 2824.096289187461, 2843.8009339346254, 2890.638670166229, 2946.646402431722, 16945.40691075819, 17103.31586736529, 17138.0, 17153.399631012853, 17177.39879104238, 8683.13168683133, 8919.73240802777, 8941.955290223572, 8969.416987895765, 8985.37102402832, 5235.0, 5477.972610136963, 5596.160575913605, 5609.579281553859, 5619.943800562024, 2078.0856423173905, 2109.430453777487, 2122.2565741137964, 2150.741910970678, 2170.066871245364, 32063.51904721431, 32172.034838954867, 32206.355872882647, 32248.193795155308, 32271.838640806647, 7505.061867266591, 7505.249475052451, 7560.319571238615, 7725.188855170239, 7765.262300081483, 20477.897610511853, 20580.58838823215, 20591.382258532267, 20594.897025515078, 20672.173113075307, 8742.256908162877, 8914.28685705142, 8975.730728078168, 8977.506237157018, 8985.281177505914, 8005.239502247277, 8138.877916831252, 8200.466969646954, 8223.437546866076, 8223.629936652866, 5986.132010858401, 6064.9090263646085, 6151.3541078187045, 6202.844928876724, 6242.1261023456755, 1641.5896025993502, 1671.8683678310251, 1702.6509565539034, 1729.265062348522, 1766.4877185616285, 1015.8730158730159, 1028.8805061573182, 1029.3103620574234, 1036.8081904847627, 1051.1328154272755, 10058.245631577662, 10174.440405777754, 10174.593016279267, 10218.18254539635, 10222.693319200436, 1041.6041904076403, 1046.3617193511952, 1091.6724982505216, 1094.7263184203948, 1114.1922106472905, 5599.776008959678, 5626.662400255997, 5883.617564858356, 6357.554971151975, 6523.412892839668, 25509.362265943128, 26399.076032338777, 26694.866525667247, 26798.19605411841, 26840.731592684213, 25145.622815657778, 25412.491750164892, 25799.74200258011, 25969.610455843176, 25977.0, 12624.242545447303, 12659.556915508098, 12786.168899021533, 12867.648896865694, 12943.223406595445, 9948.204143668634, 9994.300398972293, 10028.69913902584, 10069.748256293651, 10115.14021308197, 21760.12959481603, 21786.346409607737, 21946.561068778854, 22261.109555617593, 22442.551148977254, 22893.313200604007, 22984.540309194057, 23068.538629226987, 23134.652980204974, 23429.76570234344, 12465.252084874573, 12818.551350703054, 12831.230126192459, 12835.679108022374, 12844.807327890276, 15332.463363782213, 15368.231588420758, 15526.534203973899, 15599.142047187514, 15716.842831571537, 12613.180143290656, 12808.6797830055, 12901.967842572383, 12952.546660866825, 13092.869071309546, 12838.229706217657, 12854.67863303425, 12969.092163548838, 13255.734885302047, 13266.469341226242, 11507.0, 11521.596744113916, 11622.5350985963, 11633.41832908368, 11645.243059201124, 8557.400981931205, 8631.26634236072, 8651.48091114535, 8877.600507977286, 8880.51157186361, 8751.737447876574, 8762.158613967807, 8766.430182038148, 8876.0, 8942.37403381757], "value": 7600.315648035803, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.3787203012699, 583.3349981021636, 587.4859497939303, 610.3408319015463, 626.9717862696178, 6215.62706237626, 6352.269489008765, 6402.711877965491, 6427.871442571151, 6471.4175724184815, 6342.067917890914, 6345.650989195592, 6391.872162556746, 6415.326390728977, 6428.967855160718, 5191.094415777092, 5277.498637629419, 5286.629935904498, 5297.125974214269, 5301.363836339645, 4972.900541989158, 5099.158638824608, 5117.590592752571, 5134.1528647773075, 5135.845924622267, 5047.293378926953, 5097.7196254206, 5098.133317336044, 5113.769880355393, 5118.541215753511, 5024.19612861944, 5032.949670503284, 5062.848114556569, 5095.872603184913, 5107.208382700706, 4654.25531914892, 4678.087772884289, 4696.7651617419, 4697.131030759287, 4700.130475861943, 6263.123162757218, 6345.428911397997, 6351.856665800154, 6378.2346118466085, 6392.840178995516, 6049.727762250665, 6068.211132552784, 6068.393160683941, 6080.2399700037495, 6092.634441933498, 6744.089547911019, 6747.93252067478, 6765.2219994700745, 6813.727450902007, 6852.45180385568, 5025.497450254982, 5269.235960785703, 5269.525742683139, 5269.947300526984, 5308.973455132738, 6899.551529150639, 6952.721891124349, 6953.582785032863, 7112.217656057829, 7126.536775109653, 5333.5199832015305, 5337.81317653888, 5358.651687640291, 5407.567394608501, 5420.566354691615, 5433.0763770159165, 5474.589405794582, 5475.890482190413, 5490.286262785812, 5516.696581688046, 6031.0, 6060.787872424532, 6088.4215999479975, 6094.725737341831, 6133.723982420713, 6936.4797640177185, 6940.30596940312, 6946.9652651736415, 6951.582905025714, 6965.651717414109, 1858.851291896645, 1869.9345522906633, 1870.6352261308914, 1891.6689579323563, 1900.1829213438077, 1297.3189075735127, 1342.7985802129758, 1345.9327033648278, 1346.3470216944775, 1353.8375394952668, 6385.297617262097, 6400.359964003563, 6402.0, 6424.1327420798525, 6429.935700643027, 6752.493562982796, 6837.658117094125, 6854.2117656469145, 6879.58722476653, 6881.65591720412, 6406.2953075161695, 6416.358364163546, 6455.9677201613695, 6474.223093228748, 6499.252585952581, 3603.819809009539, 3638.1814091829656, 3644.4168932970597, 3652.9634703652623, 3656.597774244831, 7193.928060719326, 7204.0, 7268.532160033607, 7291.70833166678, 7310.707571697072, 7004.0738796830265, 7036.155661320674, 7080.964595176991, 7085.645717714094, 7134.714611415589, 7099.325564071405, 7139.500234983501, 7300.561966282146, 7303.196648368676, 7381.778546643609, 6866.210385805696, 6897.448204143757, 6933.168019837652, 6965.407940325129, 6974.79075627732, 6749.009042332425, 6762.695678694569, 6832.248452670103, 6924.134483189601, 6928.861422771415, 7219.45854060937, 7254.129504459499, 7319.63401829917, 7360.558366498028, 7415.1101867776215, 5418.160185171305, 5439.864003399946, 5448.536874365724, 5459.672419654833, 5465.234867118686, 6576.0, 6804.5696816507925, 6913.688884000131, 6998.930010699828, 7004.824879378057, 6542.149520562297, 6710.362515561014, 6775.322467753185, 6826.078479405415, 6839.213490448662, 6752.324767523209, 6756.493263005196, 6770.424513916175, 6803.4557235422035, 6805.353491418307, 6726.334147889314, 6753.662316884038, 6772.018057381751, 6781.11845460087, 6787.524873259022, 6815.454763618998, 6870.725170993304, 6871.14110736158, 6872.793816185523, 6879.828004299932, 6442.806715798533, 6616.966915165393, 6625.17185351831, 6647.933520664731, 6726.730930762715], "value": 5347.426378644568, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1000.7898341348316, 1025.2618114957231, 1041.1982773264585, 1047.9528421221044, 1053.4469403563128, 18212.817871821277, 18847.71728424075, 18855.811441885577, 18928.43214703561, 18938.62122757546, 16867.662646747056, 17331.306747730076, 17360.82639173608, 18182.545436364064, 18427.0, 1067.5409573883228, 1087.7280679830042, 1095.353741292637, 1097.1442275025493, 1099.8460215569826, 1058.449606204773, 1062.3466568060626, 1082.967510974672, 1084.2735367303885, 1085.5332207150923, 1161.506359797087, 1162.0935670177275, 1162.96511104667, 1163.331084626339, 1172.1150531348862, 1154.0709728668419, 1159.194359919856, 1159.8550181227347, 1165.6910918606577, 1167.5504930601694, 863.3956230638578, 864.7016779211162, 864.7146441674232, 865.3855762408697, 865.8181781825824, 17643.823561764348, 17767.0, 17787.644247114986, 17788.822111778845, 17960.820391796176, 20765.688514672293, 21197.152113915425, 21212.893935530377, 21313.467163320885, 21403.67894481584, 17800.287988480446, 17853.46439606814, 18097.457076287734, 18134.09329533518, 18134.09329533531, 4037.6164264394833, 4062.9593704063172, 4089.488813898263, 4089.5092588889224, 4089.9591004089875, 163827.0, 164483.1775841125, 166827.0, 167760.16119919444, 168402.0, 17621.647567048843, 17664.0, 18056.45830625083, 18060.0, 18062.09689515519, 35193.47209791855, 35383.64616353855, 36412.0, 36788.44817327742, 36854.8157259212, 8869.068747781519, 8873.29013678904, 8946.68686595966, 8955.328350373748, 8963.551822408985, 4043.1913617276073, 4436.977815110904, 4541.069080838421, 4542.114287713864, 4559.065391594715, 6559.344065593403, 6658.5671931324305, 6663.66726654671, 6667.966660166668, 6695.129633147757, 1060.8833028366873, 1100.5377741348493, 1105.1435137768133, 1107.5348353691309, 1118.1055155875267, 741.7997140772069, 744.6686224629988, 758.707897459471, 759.1876691939682, 768.9807754806063, 13853.445862165401, 14061.032394732125, 14493.20287384204, 15004.399824006918, 15014.47449339268, 777.0597576931975, 777.9805504862424, 780.2704471319335, 784.6743601405467, 790.8181118342814, 6447.70985305653, 6456.54804163704, 6457.1282876811965, 6509.381608747161, 6530.640814755139, 154966.22516887344, 156827.0, 157172.0, 162248.0, 163927.0, 139166.0, 141657.29171354283, 141753.29123354316, 142427.0, 146813.0, 118110.40944795393, 118593.0, 120468.39765801115, 121903.99999999822, 121968.39015805042, 12317.876821231674, 12340.629781106582, 12375.381230938598, 12422.627321180378, 12509.0, 56838.0, 56840.0, 56983.14525282041, 57579.42420575741, 58182.7090864543, 71361.0, 71671.0, 72002.0, 74280.62859685667, 74942.25057749571, 17521.737173942656, 17687.557811054827, 17695.911520442314, 17836.06295198624, 17853.642927141125, 19202.51993700113, 19858.0, 19878.801211987695, 19986.0, 20086.899565502077, 18778.906105469385, 18827.71758423652, 18963.431097066557, 19154.138063786886, 19164.0, 18126.54683632867, 18492.075396230404, 18510.444686659423, 18540.44378668642, 18727.344542940933, 17836.91081544584, 18035.90982045134, 18045.639087218446, 18188.818111818713, 18314.542136446697, 13947.511837085653, 13963.441462341392, 14011.08927919682, 14147.64630884236, 14160.504382346568, 12975.675608109872, 13055.869441305465, 13066.477340906638, 13155.01337399718, 13429.059965802691], "value": 10071.68325132373, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1355.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 107.0, 107.0, 104.0, 106.0, 109.0, 109.0, 104.0, 105.0, 104.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 109.0, 111.0, 119.0, 113.0, 111.0, 111.0, 111.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 164.0, 163.0, 161.0, 162.0, 162.0, 161.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 73.0, 74.0, 73.0, 74.0, 73.0, 72.0, 72.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 77.0, 77.0, 77.0, 77.0, 77.0, 77.0, 77.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 111.0, 113.0, 113.0, 110.0, 114.0, 113.0, 114.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 153.0, 149.0, 150.0, 150.0, 150.0, 150.0, 149.0, 152.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 94.0, 93.0, 94.0, 94.0, 95.0, 93.0, 94.0, 97.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 43.0, 43.0, 43.0, 44.0, 44.0, 47.0, 43.0, 42.0, 42.0], "value": 43.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 36.0, 35.0, 36.0, 36.0, 37.0, 36.0, 36.0, 36.0], "value": 36.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 74.0, 71.0, 73.0, 69.0, 70.0, 75.0, 73.0, 74.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 102.0, 112.0, 114.0, 102.0, 109.0, 102.0, 99.0, 110.0], "value": 106.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 153.0, 152.0, 154.0, 148.0, 153.0, 154.0, 151.0, 153.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 58.0, 58.0, 57.0, 59.0, 60.0, 57.0, 57.0, 58.0, 58.0], "value": 58.6, "unit": "score"}]}]} 08:24:51 INFO - Return code: 0 08:24:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:24:51 INFO - # TBPL SUCCESS # 08:24:51 INFO - Running post-action listener: _package_coverage_data 08:24:51 INFO - Running post-action listener: _resource_record_post_action 08:24:51 INFO - [mozharness: 2017-09-21 15:24:51.712701Z] Finished run-tests step (success) 08:24:51 INFO - Running post-run listener: _resource_record_post_run 08:24:51 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290496512; Read time: 152; Write time: 114156 08:24:51 INFO - TinderboxPrint: CPU usage
13.0% 08:24:51 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 152 08:24:51 INFO - TinderboxPrint: I/O write bytes / time
290,496,512 / 114,156 08:24:51 INFO - TinderboxPrint: CPU idle
8,183.1 (87.0%) 08:24:51 INFO - TinderboxPrint: CPU user
1,178.7 (12.5%) 08:24:51 INFO - TinderboxPrint: Swap in / out
0 / 0 08:24:51 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 524288; Read time: 0; Write time: 40 08:24:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:24:51 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 8192; Write bytes: 282382336; Read time: 152; Write time: 113460 08:24:52 INFO - Running post-run listener: _upload_blobber_files 08:24:52 INFO - Blob upload gear active. 08:24:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:24:52 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 08:24:52 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'] 08:24:52 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 08:24:52 INFO - (blobuploader) - INFO - Open directory for files ... 08:24:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:24:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:24:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:53 INFO - (blobuploader) - INFO - Done attempting. 08:24:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:24:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:25:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:01 INFO - (blobuploader) - INFO - Done attempting. 08:25:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:25:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:25:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:04 INFO - (blobuploader) - INFO - Done attempting. 08:25:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:25:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:25:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:05 INFO - (blobuploader) - INFO - Done attempting. 08:25:05 INFO - (blobuploader) - INFO - Iteration through files over. 08:25:05 INFO - Return code: 0 08:25:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:25:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:25:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6494552a3fb5814a3ae0057b5d48e29ae66382bb753746c7a37c8a9412d672491bd7c2cf25370ae840824198dad0036487e98b0fbc9250142c89baff95a14227", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0c8f2ff8b7268b89b54ddfa8bd5888c771df143c19d489b2dceb72145f9c341b0b69f4227fe07095865e92d18224ef42378dc3ce5d69aa0e2ff9e206ddc7adb1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0f3df53ffe6976bbd86453a2ded309ea4bde85ddfd6361709016dc8142bc451d6b585d1b32a26766f1fb1d5f575911dc54487e3ccce68360e32cd1896ffdf7d2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4c8a8f07c892b8e8493c85e4a9ecbc3b1b35cd0ca15c561b8291e0143d680658de40ed3c058606e0428443049cb22ec8b5602768662dd13b64f1b2952cb4e60c"} 08:25:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:25:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:25:05 INFO - Contents: 08:25:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6494552a3fb5814a3ae0057b5d48e29ae66382bb753746c7a37c8a9412d672491bd7c2cf25370ae840824198dad0036487e98b0fbc9250142c89baff95a14227", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0c8f2ff8b7268b89b54ddfa8bd5888c771df143c19d489b2dceb72145f9c341b0b69f4227fe07095865e92d18224ef42378dc3ce5d69aa0e2ff9e206ddc7adb1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0f3df53ffe6976bbd86453a2ded309ea4bde85ddfd6361709016dc8142bc451d6b585d1b32a26766f1fb1d5f575911dc54487e3ccce68360e32cd1896ffdf7d2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4c8a8f07c892b8e8493c85e4a9ecbc3b1b35cd0ca15c561b8291e0143d680658de40ed3c058606e0428443049cb22ec8b5602768662dd13b64f1b2952cb4e60c"} 08:25:05 INFO - Running post-run listener: copy_logs_to_upload_dir 08:25:05 INFO - Copying logs to upload dir... 08:25:05 INFO - mkdir: /builds/slave/test/build/upload/logs 08:25:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.064934 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-21 08:25:06.097643) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 08:25:06.099935) ========= 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=ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003 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/6494552a3fb5814a3ae0057b5d48e29ae66382bb753746c7a37c8a9412d672491bd7c2cf25370ae840824198dad0036487e98b0fbc9250142c89baff95a14227", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0c8f2ff8b7268b89b54ddfa8bd5888c771df143c19d489b2dceb72145f9c341b0b69f4227fe07095865e92d18224ef42378dc3ce5d69aa0e2ff9e206ddc7adb1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0f3df53ffe6976bbd86453a2ded309ea4bde85ddfd6361709016dc8142bc451d6b585d1b32a26766f1fb1d5f575911dc54487e3ccce68360e32cd1896ffdf7d2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4c8a8f07c892b8e8493c85e4a9ecbc3b1b35cd0ca15c561b8291e0143d680658de40ed3c058606e0428443049cb22ec8b5602768662dd13b64f1b2952cb4e60c"} build_url:https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/Q3zRB9X8QQaDK_Awe5vXiw/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/6494552a3fb5814a3ae0057b5d48e29ae66382bb753746c7a37c8a9412d672491bd7c2cf25370ae840824198dad0036487e98b0fbc9250142c89baff95a14227", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0c8f2ff8b7268b89b54ddfa8bd5888c771df143c19d489b2dceb72145f9c341b0b69f4227fe07095865e92d18224ef42378dc3ce5d69aa0e2ff9e206ddc7adb1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0f3df53ffe6976bbd86453a2ded309ea4bde85ddfd6361709016dc8142bc451d6b585d1b32a26766f1fb1d5f575911dc54487e3ccce68360e32cd1896ffdf7d2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4c8a8f07c892b8e8493c85e4a9ecbc3b1b35cd0ca15c561b8291e0143d680658de40ed3c058606e0428443049cb22ec8b5602768662dd13b64f1b2952cb4e60c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 08:25:06.137704) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:25:06.138044) ========= 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=ed14279e38b05397cf4aa391000001a4-1506006101.923321-672917003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004631 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:25:06.187477) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 08:25:06.187820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 08:25:06.188163) ========= ========= Total master_lag: 0.29 =========