builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1506611065.05 results: success (0) revision: 04e03b0726f97c5f89db4e08e1029147d4753063 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 08:04:25.045910) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 08:04:25.046343) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 08:04:25.046652) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 08:04:25.089909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 08:04:25.090299) ========= 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=836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-28 08:04:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.7M=0s 2017-09-28 08:04:25 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132993 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 08:04:25.247507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 08:04:25.247833) ========= 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=836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020164 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 08:04:25.317597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-28 08:04:25.317957) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 04e03b0726f97c5f89db4e08e1029147d4753063 --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 04e03b0726f97c5f89db4e08e1029147d4753063 --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=836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-28 08:04:25,366 truncating revision to first 12 chars 2017-09-28 08:04:25,366 Setting DEBUG logging. 2017-09-28 08:04:25,366 attempt 1/10 2017-09-28 08:04:25,366 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/04e03b0726f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-28 08:04:26,847 unpacking tar archive at: mozilla-beta-04e03b0726f9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.781637 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-28 08:04:27.130239) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 08:04:27.130545) ========= script_repo_revision: 04e03b0726f97c5f89db4e08e1029147d4753063 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 08:04:27.130957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 08:04:27.131229) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 08:04:27.153114) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-09-28 08:04:27.153478) ========= /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=836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:04:27 INFO - MultiFileLogger online at 20170928 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:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:04:27 INFO - 'opt_config_files': (), 08:04:27 INFO - 'pip_index': False, 08:04:27 INFO - 'suite': 'dromaeojs-e10s', 08:04:27 INFO - 'system_bits': '32', 08:04:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:04:27 INFO - 'title': 'talos-linux64-ix-028', 08:04:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:04:27 INFO - 'use_talos_json': True, 08:04:27 INFO - 'verify': 'False', 08:04:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:04:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:04:27 INFO - 'work_dir': 'build'} 08:04:27 INFO - [mozharness: 2017-09-28 15:04:27.343173Z] Running clobber step. 08:04:27 INFO - Running pre-action listener: _resource_record_pre_action 08:04:27 INFO - Running main action method: clobber 08:04:27 INFO - rmtree: /builds/slave/test/build 08:04:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:04:28 INFO - Running post-action listener: _resource_record_post_action 08:04:28 INFO - [mozharness: 2017-09-28 15:04:28.826517Z] Finished clobber step (success) 08:04:28 INFO - [mozharness: 2017-09-28 15:04:28.826614Z] Running read-buildbot-config step. 08:04:28 INFO - Running pre-action listener: _resource_record_pre_action 08:04:28 INFO - Running main action method: read_buildbot_config 08:04:28 INFO - Using buildbot properties: 08:04:28 INFO - { 08:04:28 INFO - "project": "", 08:04:28 INFO - "product": "firefox", 08:04:28 INFO - "who": "ryanvm@gmail.com", 08:04:28 INFO - "installer_path": "public/build/target.tar.bz2", 08:04:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:04:28 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 08:04:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 08:04:28 INFO - "stage_platform": "linux64", 08:04:28 INFO - "basedir": "/builds/slave/test", 08:04:28 INFO - "buildnumber": 133, 08:04:28 INFO - "platform": "ubuntu64_hw", 08:04:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:04:28 INFO - "slavebuilddir": "test", 08:04:28 INFO - "taskId": "CYFKuqM-TdyIvwOQX9_zTw", 08:04:28 INFO - "branch": "mozilla-beta", 08:04:28 INFO - "script_repo_revision": "production", 08:04:28 INFO - "revision": "04e03b0726f97c5f89db4e08e1029147d4753063", 08:04:28 INFO - "slavename": "talos-linux64-ix-028", 08:04:28 INFO - "repo_path": "releases/mozilla-beta" 08:04:28 INFO - } 08:04:28 INFO - Finding installer, test and symbols from parent task. 08:04:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CYFKuqM-TdyIvwOQX9_zTw'}, attempt #1 08:04:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CYFKuqM-TdyIvwOQX9_zTw'}, attempt #1 08:04:29 INFO - Task dependencies: IuPWjna2RiSGSle6JpgmyQ 08:04:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ'}, attempt #1 08:04:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.tar.bz2 08:04:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.test_packages.json 08:04:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/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-28 15:04:30.174374Z] Finished read-buildbot-config step (success) 08:04:30 INFO - [mozharness: 2017-09-28 15:04:30.174679Z] 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/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.test_packages.json 08:04:30 INFO - Downloading https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/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/IuPWjna2RiSGSle6JpgmyQ/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/IuPWjna2RiSGSle6JpgmyQ/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/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:04:31 INFO - Fetch https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.common.tests.zip into memory 08:04:32 INFO - Content-Length response header: 55169654 08:04:32 INFO - Bytes received: 55169654 08:04:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.talos.tests.zip 08:04:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:04:42 INFO - Fetch https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.talos.tests.zip into memory 08:04:43 INFO - Content-Length response header: 14509184 08:04:43 INFO - Bytes received: 14509184 08:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:44 INFO - trying https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.tar.bz2 08:04:44 INFO - Downloading https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:04:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:04:46 INFO - Downloaded 53535460 bytes. 08:04:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.tar.bz2 08:04:46 INFO - mkdir: /builds/slave/test/properties 08:04:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:04:46 INFO - Writing to file /builds/slave/test/properties/build_url 08:04:46 INFO - Contents: 08:04:46 INFO - build_url:https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.tar.bz2 08:04:46 INFO - Running post-action listener: _resource_record_post_action 08:04:46 INFO - Running post-action listener: find_tests_for_verification 08:04:46 INFO - Running post-action listener: set_extra_try_arguments 08:04:46 INFO - [mozharness: 2017-09-28 15:04:46.719063Z] Finished download-and-extract step (success) 08:04:46 INFO - [mozharness: 2017-09-28 15:04:46.719158Z] Running populate-webroot step. 08:04:46 INFO - Running pre-action listener: _resource_record_pre_action 08:04:46 INFO - Running main action method: populate_webroot 08:04:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:04:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:46 INFO - 'tests': ['tresize', 08:04:46 INFO - 'tcanvasmark']}, 08:04:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:04:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:46 INFO - 'tests': ['dromaeo_css', 08:04:46 INFO - 'kraken']}, 08:04:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:04:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:04:46 INFO - 'talos_options': ['--disable-stylo'], 08:04:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:04:46 INFO - 'tests': ['damp', 'tps']}, 08:04:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:04:46 INFO - 'talos_options': ['--disable-stylo'], 08:04:46 INFO - 'tests': ['damp', 'tps']}, 08:04:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:04:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:46 INFO - 'tests': ['dromaeo_dom']}, 08:04:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:04:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:46 INFO - 'tests': ['basic_compositor_video', 08:04:46 INFO - 'glvideo']}, 08:04:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:04:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:04:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:04:46 INFO - 'talos_options': ['--disable-stylo'], 08:04:46 INFO - 'tests': ['ts_paint_webext', 08:04:46 INFO - 'tp5o_webext']}, 08:04:46 INFO - 'other-e10s': {'tests': ['a11yr', 08:04:46 INFO - 'ts_paint', 08:04:46 INFO - 'tpaint', 08:04:46 INFO - 'sessionrestore', 08:04:46 INFO - 'sessionrestore_many_windows', 08:04:46 INFO - 'sessionrestore_no_auto_restore', 08:04:46 INFO - 'tabpaint']}, 08:04:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:46 INFO - 'tests': ['a11yr', 08:04:46 INFO - 'ts_paint', 08:04:46 INFO - 'tpaint', 08:04:46 INFO - 'sessionrestore', 08:04:46 INFO - 'sessionrestore_many_windows', 08:04:46 INFO - 'sessionrestore_no_auto_restore', 08:04:46 INFO - 'tabpaint']}, 08:04:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:04:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 08:04:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:46 INFO - 'tests': ['perf_reftest_singletons']}, 08:04:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:46 INFO - 'tests': ['bloom_basic']}, 08:04:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:04:46 INFO - 'tsvgr_opacity', 08:04:46 INFO - 'tart', 08:04:46 INFO - 'tscrollx', 08:04:46 INFO - 'tsvg_static']}, 08:04:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:04:46 INFO - 'tests': ['tsvgx', 08:04:46 INFO - 'tsvgr_opacity', 08:04:46 INFO - 'tart', 08:04:46 INFO - 'tscrollx', 08:04:46 INFO - 'tsvg_static']}, 08:04:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:04:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:04:46 INFO - 'talos_options': ['--disable-stylo'], 08:04:46 INFO - 'tests': ['tp5o']}, 08:04:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:04:46 INFO - 'talos_options': ['--mitmproxy', 08:04:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:04:46 INFO - '--firstNonBlankPaint'], 08:04:46 INFO - 'tests': ['tp6_google', 08:04:46 INFO - 'tp6_youtube', 08:04:46 INFO - 'tp6_amazon', 08:04:46 INFO - 'tp6_facebook']}, 08:04:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:04:46 INFO - 'talos_options': ['--disable-stylo', 08:04:46 INFO - '--mitmproxy', 08:04:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:04:46 INFO - '--firstNonBlankPaint'], 08:04:46 INFO - 'tests': ['tp6_google', 08:04:46 INFO - 'tp6_youtube', 08:04:46 INFO - 'tp6_amazon', 08:04:46 INFO - 'tp6_facebook']}, 08:04:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:04:46 INFO - 'talos_options': ['--stylo-threads=1', 08:04:46 INFO - '--mitmproxy', 08:04:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:04:46 INFO - '--firstNonBlankPaint'], 08:04:46 INFO - 'tests': ['tp6_google', 08:04:46 INFO - 'tp6_youtube', 08:04:46 INFO - 'tp6_amazon', 08:04:46 INFO - 'tp6_facebook']}, 08:04:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:04:46 INFO - 'talos_options': ['--xperf_path', 08:04:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:46 INFO - 'tests': ['tp5n']}, 08:04:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:04:46 INFO - 'talos_options': ['--disable-stylo', 08:04:46 INFO - '--xperf_path', 08:04:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:46 INFO - 'tests': ['tp5n']}}} 08:04:46 INFO - Running post-action listener: _resource_record_post_action 08:04:46 INFO - [mozharness: 2017-09-28 15:04:46.734073Z] Finished populate-webroot step (success) 08:04:46 INFO - [mozharness: 2017-09-28 15:04:46.734163Z] Running create-virtualenv step. 08:04:46 INFO - Running pre-action listener: _resource_record_pre_action 08:04:46 INFO - Running main action method: create_virtualenv 08:04:46 INFO - Creating virtualenv /builds/slave/test/build/venv 08:04:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:04:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:04:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:04:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:04:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:04:47 INFO - Installing distribute.............................................................................................................................................................................................done. 08:04:47 INFO - Installing pip...............done. 08:04:47 INFO - Return code: 0 08:04:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:04:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:04:48 INFO - Reading from file tmpfile_stdout 08:04:48 INFO - Output received: 08:04:48 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:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbcc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b090>, '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 0xf3bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf35f90>, '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': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', '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:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:04:48 INFO - Using env: {'DISPLAY': ':0', 08:04:48 INFO - 'HOME': '/home/cltbld', 08:04:48 INFO - 'LANG': 'en_US.UTF-8', 08:04:48 INFO - 'LANGUAGE': 'en_US:en', 08:04:48 INFO - 'LOGNAME': 'cltbld', 08:04:48 INFO - 'MAIL': '/var/mail/cltbld', 08:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:48 INFO - 'MOZ_NO_REMOTE': '1', 08:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:48 INFO - 'NO_EM_RESTART': '1', 08:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:48 INFO - 'PWD': '/builds/slave/test', 08:04:48 INFO - 'SHELL': '/bin/bash', 08:04:48 INFO - 'SHLVL': '1', 08:04:48 INFO - 'TERM': 'linux', 08:04:48 INFO - 'TMOUT': '86400', 08:04:48 INFO - 'USER': 'cltbld', 08:04:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', 08:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:48 INFO - '_': '/tools/buildbot/bin/python'} 08:04:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:04:49 INFO - Downloading/unpacking pip>=1.5 08:04:49 INFO - Running setup.py egg_info for package pip 08:04:49 INFO - warning: no files found matching 'pip/cacert.pem' 08:04:49 INFO - warning: no files found matching '*.html' under directory 'docs' 08:04:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:04:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:04:49 INFO - Installing collected packages: pip 08:04:49 INFO - Found existing installation: pip 1.1 08:04:49 INFO - Uninstalling pip: 08:04:49 INFO - Successfully uninstalled pip 08:04:49 INFO - Running setup.py install for pip 08:04:49 INFO - warning: no files found matching 'pip/cacert.pem' 08:04:49 INFO - warning: no files found matching '*.html' under directory 'docs' 08:04:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:04:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:04:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:04:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:04:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:04:49 INFO - Successfully installed pip 08:04:49 INFO - Cleaning up... 08:04:49 INFO - Return code: 0 08:04:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:49 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 0xbcc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b090>, '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 0xf3bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf35f90>, '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': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', '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:49 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:49 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:49 INFO - Using env: {'DISPLAY': ':0', 08:04:49 INFO - 'HOME': '/home/cltbld', 08:04:49 INFO - 'LANG': 'en_US.UTF-8', 08:04:49 INFO - 'LANGUAGE': 'en_US:en', 08:04:49 INFO - 'LOGNAME': 'cltbld', 08:04:49 INFO - 'MAIL': '/var/mail/cltbld', 08:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:49 INFO - 'MOZ_NO_REMOTE': '1', 08:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:49 INFO - 'NO_EM_RESTART': '1', 08:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:49 INFO - 'PWD': '/builds/slave/test', 08:04:49 INFO - 'SHELL': '/bin/bash', 08:04:49 INFO - 'SHLVL': '1', 08:04:49 INFO - 'TERM': 'linux', 08:04:49 INFO - 'TMOUT': '86400', 08:04:49 INFO - 'USER': 'cltbld', 08:04:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', 08:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:49 INFO - '_': '/tools/buildbot/bin/python'} 08:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:49 INFO - Downloading/unpacking psutil>=3.1.1 08:04:49 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:49 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:49 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:49 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:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:04:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:51 INFO - Installing collected packages: psutil 08:04:51 INFO - Running setup.py install for psutil 08:04:51 INFO - building 'psutil._psutil_linux' extension 08:04:51 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:51 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:51 INFO - building 'psutil._psutil_posix' extension 08:04:51 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:51 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:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:51 INFO - Successfully installed psutil 08:04:51 INFO - Cleaning up... 08:04:51 INFO - Return code: 0 08:04:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbcc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b090>, '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 0xf3bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf35f90>, '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': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', '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:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:04:51 INFO - Using env: {'DISPLAY': ':0', 08:04:51 INFO - 'HOME': '/home/cltbld', 08:04:51 INFO - 'LANG': 'en_US.UTF-8', 08:04:51 INFO - 'LANGUAGE': 'en_US:en', 08:04:51 INFO - 'LOGNAME': 'cltbld', 08:04:51 INFO - 'MAIL': '/var/mail/cltbld', 08:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:51 INFO - 'MOZ_NO_REMOTE': '1', 08:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:51 INFO - 'NO_EM_RESTART': '1', 08:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:51 INFO - 'PWD': '/builds/slave/test', 08:04:51 INFO - 'SHELL': '/bin/bash', 08:04:51 INFO - 'SHLVL': '1', 08:04:51 INFO - 'TERM': 'linux', 08:04:51 INFO - 'TMOUT': '86400', 08:04:51 INFO - 'USER': 'cltbld', 08:04:51 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', 08:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:51 INFO - '_': '/tools/buildbot/bin/python'} 08:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:04:53 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:53 INFO - Installing collected packages: mozsystemmonitor 08:04:53 INFO - Running setup.py install for mozsystemmonitor 08:04:53 INFO - Successfully installed mozsystemmonitor 08:04:53 INFO - Cleaning up... 08:04:53 INFO - Return code: 0 08:04:53 INFO - Installing jsonschema==2.5.1 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', '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 0xbcc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b090>, '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 0xf3bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf35f90>, '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': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', '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', 'jsonschema==2.5.1'] 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 jsonschema==2.5.1 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': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', 08:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:53 INFO - '_': '/tools/buildbot/bin/python'} 08:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:53 INFO - Downloading/unpacking jsonschema==2.5.1 08:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:04:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.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:54 INFO - Downloading functools32-3.2.3-2.tar.gz 08:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:04:54 INFO - warning: no files found matching '*.txt' 08:04:54 INFO - no previously-included directories found matching 'build' 08:04:54 INFO - no previously-included directories found matching 'dist' 08:04:54 INFO - no previously-included directories found matching '.git*' 08:04:54 INFO - Installing collected packages: jsonschema, functools32 08:04:54 INFO - Running setup.py install for functools32 08:04:55 INFO - warning: no files found matching '*.txt' 08:04:55 INFO - no previously-included directories found matching 'build' 08:04:55 INFO - no previously-included directories found matching 'dist' 08:04:55 INFO - no previously-included directories found matching '.git*' 08:04:55 INFO - Successfully installed jsonschema functools32 08:04:55 INFO - Cleaning up... 08:04:55 INFO - Return code: 0 08:04:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbcc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b090>, '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 0xf3bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf35f90>, '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': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', '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:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:04:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:04:55 INFO - Using env: {'DISPLAY': ':0', 08:04:55 INFO - 'HOME': '/home/cltbld', 08:04:55 INFO - 'LANG': 'en_US.UTF-8', 08:04:55 INFO - 'LANGUAGE': 'en_US:en', 08:04:55 INFO - 'LOGNAME': 'cltbld', 08:04:55 INFO - 'MAIL': '/var/mail/cltbld', 08:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:55 INFO - 'MOZ_NO_REMOTE': '1', 08:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:55 INFO - 'NO_EM_RESTART': '1', 08:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:55 INFO - 'PWD': '/builds/slave/test', 08:04:55 INFO - 'SHELL': '/bin/bash', 08:04:55 INFO - 'SHLVL': '1', 08:04:55 INFO - 'TERM': 'linux', 08:04:55 INFO - 'TMOUT': '86400', 08:04:55 INFO - 'USER': 'cltbld', 08:04:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', 08:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:55 INFO - '_': '/tools/buildbot/bin/python'} 08:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:04:55 INFO - Cleaning up... 08:04:55 INFO - Return code: 0 08:04:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbcc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b090>, '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 0xf3bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf35f90>, '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': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', '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:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:04:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:04:55 INFO - Using env: {'DISPLAY': ':0', 08:04:55 INFO - 'HOME': '/home/cltbld', 08:04:55 INFO - 'LANG': 'en_US.UTF-8', 08:04:55 INFO - 'LANGUAGE': 'en_US:en', 08:04:55 INFO - 'LOGNAME': 'cltbld', 08:04:55 INFO - 'MAIL': '/var/mail/cltbld', 08:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:55 INFO - 'MOZ_NO_REMOTE': '1', 08:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:55 INFO - 'NO_EM_RESTART': '1', 08:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:55 INFO - 'PWD': '/builds/slave/test', 08:04:55 INFO - 'SHELL': '/bin/bash', 08:04:55 INFO - 'SHLVL': '1', 08:04:55 INFO - 'TERM': 'linux', 08:04:55 INFO - 'TMOUT': '86400', 08:04:55 INFO - 'USER': 'cltbld', 08:04:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', 08:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:55 INFO - '_': '/tools/buildbot/bin/python'} 08:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:55 INFO - Downloading/unpacking blobuploader==1.2.4 08:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:04:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:04:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:04:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:58 INFO - Downloading docopt-0.6.1.tar.gz 08:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:04:58 INFO - Installing collected packages: blobuploader, requests, docopt 08:04:58 INFO - Running setup.py install for blobuploader 08:04:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:04:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:04:58 INFO - Running setup.py install for requests 08:04:58 INFO - Running setup.py install for docopt 08:04:59 INFO - Successfully installed blobuploader requests docopt 08:04:59 INFO - Cleaning up... 08:04:59 INFO - Return code: 0 08:04:59 INFO - Installing None 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', '--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 0xbcc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b090>, '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 0xf3bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf35f90>, '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': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', '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', '--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:04:59 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: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': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:04:59 INFO - Running setup.py (path:/tmp/pip-tAsEUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:04:59 INFO - Running setup.py (path:/tmp/pip-ngMkFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:04:59 INFO - Running setup.py (path:/tmp/pip-gBUkx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:04:59 INFO - Running setup.py (path:/tmp/pip-Pyd6O2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:04:59 INFO - Running setup.py (path:/tmp/pip-GjzB8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:04:59 INFO - Running setup.py (path:/tmp/pip-5ngVpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:04:59 INFO - Running setup.py (path:/tmp/pip-YwfvDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:59 INFO - Running setup.py (path:/tmp/pip-E7Yb06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:59 INFO - Running setup.py (path:/tmp/pip-uo2N37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:59 INFO - Running setup.py (path:/tmp/pip-Bj_HEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:59 INFO - Running setup.py (path:/tmp/pip-9Jm_Gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:00 INFO - Running setup.py (path:/tmp/pip-sclOBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:00 INFO - Running setup.py (path:/tmp/pip-seRu3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:00 INFO - Running setup.py (path:/tmp/pip-pNm4AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:00 INFO - Running setup.py (path:/tmp/pip-sE7cXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:00 INFO - Running setup.py (path:/tmp/pip-Dd0n_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:00 INFO - Running setup.py (path:/tmp/pip-2BxX0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:00 INFO - Running setup.py install for manifestparser 08:05:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:05:00 INFO - Running setup.py install for mozcrash 08:05:00 INFO - Running setup.py install for mozdebug 08:05:00 INFO - Running setup.py install for mozdevice 08:05:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:05:00 INFO - Running setup.py install for mozfile 08:05:01 INFO - Running setup.py install for mozhttpd 08:05:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:05:01 INFO - Running setup.py install for mozinfo 08:05:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:05:01 INFO - Running setup.py install for mozInstall 08:05:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:05:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:05:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:05:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:05:01 INFO - Running setup.py install for mozleak 08:05:01 INFO - Running setup.py install for mozlog 08:05:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:05:01 INFO - Running setup.py install for moznetwork 08:05:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:05:01 INFO - Running setup.py install for mozprocess 08:05:01 INFO - Running setup.py install for mozprofile 08:05:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:05:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:05:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:05:01 INFO - Running setup.py install for mozrunner 08:05:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:05:01 INFO - Running setup.py install for mozscreenshot 08:05:02 INFO - Running setup.py install for moztest 08:05:02 INFO - Running setup.py install for mozversion 08:05:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:05:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 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', '--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 0xbcc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b090>, '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 0xf3bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf35f90>, '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': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', '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', '--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 --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': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', 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-jN5FXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:02 INFO - Running setup.py (path:/tmp/pip-u6D9HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:02 INFO - Running setup.py (path:/tmp/pip-12_5Bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:02 INFO - Running setup.py (path:/tmp/pip-WsNRiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:02 INFO - Running setup.py (path:/tmp/pip-YKBU0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:02 INFO - Running setup.py (path:/tmp/pip-7WT4b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:02 INFO - Running setup.py (path:/tmp/pip-A6h0gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:03 INFO - Running setup.py (path:/tmp/pip-tAq_PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:03 INFO - Running setup.py (path:/tmp/pip-mon7b9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:03 INFO - Running setup.py (path:/tmp/pip-pBHzxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:03 INFO - Running setup.py (path:/tmp/pip-3LHv4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:03 INFO - Running setup.py (path:/tmp/pip-_4vFLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:03 INFO - Running setup.py (path:/tmp/pip-aYAby_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:03 INFO - Running setup.py (path:/tmp/pip-l2I6bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:03 INFO - Running setup.py (path:/tmp/pip-yiPHPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:03 INFO - Running setup.py (path:/tmp/pip-5RcNUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:03 INFO - Running setup.py (path:/tmp/pip-tj1pCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:03 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:03 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:03 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:03 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:03 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:03 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:03 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:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:03 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:03 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:03 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:03 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:04 INFO - Downloading blessings-1.6.tar.gz 08:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:05:04 INFO - Installing collected packages: blessings 08:05:04 INFO - Running setup.py install for blessings 08:05:05 INFO - Successfully installed blessings 08:05:05 INFO - Cleaning up... 08:05:05 INFO - Return code: 0 08:05:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:05:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:05 INFO - Reading from file tmpfile_stdout 08:05:05 INFO - Current package versions: 08:05:05 INFO - argparse == 1.2.1 08:05:05 INFO - blessings == 1.6 08:05:05 INFO - blobuploader == 1.2.4 08:05:05 INFO - docopt == 0.6.1 08:05:05 INFO - functools32 == 3.2.3-2 08:05:05 INFO - jsonschema == 2.5.1 08:05:05 INFO - manifestparser == 1.1 08:05:05 INFO - mozInstall == 1.13 08:05:05 INFO - mozcrash == 1.0 08:05:05 INFO - mozdebug == 0.1 08:05:05 INFO - mozdevice == 0.51 08:05:05 INFO - mozfile == 1.2 08:05:05 INFO - mozhttpd == 0.7 08:05:05 INFO - mozinfo == 0.10 08:05:05 INFO - mozleak == 0.1 08:05:05 INFO - mozlog == 3.5 08:05:05 INFO - moznetwork == 0.27 08:05:05 INFO - mozprocess == 0.25 08:05:05 INFO - mozprofile == 0.28 08:05:05 INFO - mozrunner == 6.13 08:05:05 INFO - mozscreenshot == 0.1 08:05:05 INFO - mozsystemmonitor == 0.3 08:05:05 INFO - moztest == 0.8 08:05:05 INFO - mozversion == 1.4 08:05:05 INFO - psutil == 3.1.1 08:05:05 INFO - requests == 1.2.3 08:05:05 INFO - wsgiref == 0.1.2 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/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 0xbcc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b090>, '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 0xf3bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf35f90>, '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': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', '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/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:05 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: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': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', 08:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:05 INFO - '_': '/tools/buildbot/bin/python'} 08:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:05 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:05 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:05 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:05 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:05 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:05 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:05 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:05 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:05 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:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:05:05 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:05 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:05 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:05 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:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:05:06 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:06 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:06 INFO - Installing collected packages: simplejson 08:05:06 INFO - Running setup.py install for simplejson 08:05:06 INFO - building 'simplejson._speedups' extension 08:05:06 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:07 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:07 INFO - Successfully installed simplejson 08:05:07 INFO - Cleaning up... 08:05:07 INFO - Return code: 0 08:05:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:05:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:07 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 0xbcc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b090>, '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 0xf3bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf35f90>, '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': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', '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:07 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:07 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:07 INFO - Using env: {'DISPLAY': ':0', 08:05:07 INFO - 'HOME': '/home/cltbld', 08:05:07 INFO - 'LANG': 'en_US.UTF-8', 08:05:07 INFO - 'LANGUAGE': 'en_US:en', 08:05:07 INFO - 'LOGNAME': 'cltbld', 08:05:07 INFO - 'MAIL': '/var/mail/cltbld', 08:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:07 INFO - 'MOZ_NO_REMOTE': '1', 08:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:07 INFO - 'NO_EM_RESTART': '1', 08:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:07 INFO - 'PWD': '/builds/slave/test', 08:05:07 INFO - 'SHELL': '/bin/bash', 08:05:07 INFO - 'SHLVL': '1', 08:05:07 INFO - 'TERM': 'linux', 08:05:07 INFO - 'TMOUT': '86400', 08:05:07 INFO - 'USER': 'cltbld', 08:05:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', 08:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:07 INFO - '_': '/tools/buildbot/bin/python'} 08:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:05:07 INFO - Cleaning up... 08:05:07 INFO - Return code: 0 08:05:07 INFO - Running post-action listener: _resource_record_post_action 08:05:07 INFO - Running post-action listener: _start_resource_monitoring 08:05:08 INFO - Starting resource monitoring. 08:05:08 INFO - [mozharness: 2017-09-28 15:05:08.026543Z] Finished create-virtualenv step (success) 08:05:08 INFO - [mozharness: 2017-09-28 15:05:08.027057Z] Running install step. 08:05:08 INFO - Running pre-action listener: _resource_record_pre_action 08:05:08 INFO - Running main action method: install 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 - Detecting whether we're running mozinstall >=1.0... 08:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:05:08 INFO - Reading from file tmpfile_stdout 08:05:08 INFO - Output received: 08:05:08 INFO - Usage: mozinstall [options] installer 08:05:08 INFO - Options: 08:05:08 INFO - -h, --help show this help message and exit 08:05:08 INFO - -d DEST, --destination=DEST 08:05:08 INFO - Directory to install application into. [default: 08:05:08 INFO - "/builds/slave/test"] 08:05:08 INFO - --app=APP Application being installed. [default: firefox] 08:05:08 INFO - mkdir: /builds/slave/test/build/application 08:05:08 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:08 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:22 INFO - Reading from file tmpfile_stdout 08:05:22 INFO - Output received: 08:05:22 INFO - /builds/slave/test/build/application/firefox/firefox 08:05:22 INFO - Running post-action listener: _resource_record_post_action 08:05:22 INFO - [mozharness: 2017-09-28 15:05:22.948770Z] Finished install step (success) 08:05:22 INFO - [mozharness: 2017-09-28 15:05:22.949020Z] Running setup-mitmproxy step. 08:05:22 INFO - Running pre-action listener: _resource_record_pre_action 08:05:22 INFO - Running main action method: setup_mitmproxy 08:05:22 INFO - Skipping: mitmproxy is not required 08:05:22 INFO - Running post-action listener: _resource_record_post_action 08:05:22 INFO - [mozharness: 2017-09-28 15:05:22.950246Z] Finished setup-mitmproxy step (success) 08:05:22 INFO - [mozharness: 2017-09-28 15:05:22.950465Z] Running run-tests step. 08:05:22 INFO - Running pre-action listener: _resource_record_pre_action 08:05:22 INFO - Running pre-action listener: _set_gcov_prefix 08:05:22 INFO - Running main action method: run_tests 08:05:22 WARNING - Try message not found. 08:05:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:05:22 INFO - Python 2.7.3 08:05:22 INFO - Return code: 0 08:05:22 INFO - grabbing minidump binary from tooltool 08:05:22 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:22 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 0xf3b090>, '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 0xf3bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf35f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:05:22 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:22 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:22 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:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:05:23 INFO - Return code: 0 08:05:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:05:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:05:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:05:23 INFO - ENV: RUST_BACKTRACE is now full 08:05:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:05:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:05:23 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/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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:23 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/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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:23 INFO - Using env: {'DISPLAY': ':0', 08:05:23 INFO - 'HOME': '/home/cltbld', 08:05:23 INFO - 'LANG': 'en_US.UTF-8', 08:05:23 INFO - 'LANGUAGE': 'en_US:en', 08:05:23 INFO - 'LOGNAME': 'cltbld', 08:05:23 INFO - 'MAIL': '/var/mail/cltbld', 08:05:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:05:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:23 INFO - 'MOZ_NO_REMOTE': '1', 08:05:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:23 INFO - 'NO_EM_RESTART': '1', 08:05:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:23 INFO - 'PWD': '/builds/slave/test', 08:05:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:05:23 INFO - 'RUST_BACKTRACE': 'full', 08:05:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:05:23 INFO - 'SHELL': '/bin/bash', 08:05:23 INFO - 'SHLVL': '1', 08:05:23 INFO - 'TERM': 'linux', 08:05:23 INFO - 'TMOUT': '86400', 08:05:23 INFO - 'USER': 'cltbld', 08:05:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', 08:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:23 INFO - '_': '/tools/buildbot/bin/python'} 08:05:23 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/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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:23 INFO - mozversion application_buildid: 20170928135140 08:05:23 INFO - mozversion application_changeset: 04e03b0726f97c5f89db4e08e1029147d4753063 08:05:23 INFO - mozversion application_display_name: Firefox 08:05:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:05:23 INFO - mozversion application_name: Firefox 08:05:23 INFO - mozversion application_remotingname: firefox 08:05:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:05:23 INFO - mozversion application_vendor: Mozilla 08:05:23 INFO - mozversion application_version: 57.0 08:05:23 INFO - mozversion platform_buildid: 20170928135140 08:05:23 INFO - mozversion platform_changeset: 04e03b0726f97c5f89db4e08e1029147d4753063 08:05:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:05:23 INFO - mozversion platform_version: 57.0 08:05:23 INFO - using testdate: 1506611123 08:05:23 INFO - actual date: 1506611123 08:05:23 INFO - starting webserver on 'localhost:36946' 08:05:23 INFO - SUITE-START | Running 2 tests 08:05:23 INFO - TEST-START | dromaeo_css 08:05:23 INFO - Initialising browser for dromaeo_css test... 08:05:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36946/getInfo.html -profile /tmp/tmpqY0MFF/profile 08:05:23 INFO - TEST-INFO | started process 11382 (/builds/slave/test/build/application/firefox/firefox http://localhost:36946/getInfo.html) 08:05:28 INFO - TEST-INFO | 11382: exit 0 08:05:28 INFO - Browser initialized. 08:05:28 INFO - Running cycle 1/1 for dromaeo_css test... 08:05:28 INFO - Using env: {'DISPLAY': ':0', 08:05:28 INFO - 'HOME': '/home/cltbld', 08:05:28 INFO - 'JSGC_DISABLE_POISONING': '1', 08:05:28 INFO - 'LANG': 'en_US.UTF-8', 08:05:28 INFO - 'LANGUAGE': 'en_US:en', 08:05:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:05:28 INFO - 'LOGNAME': 'cltbld', 08:05:28 INFO - 'MAIL': '/var/mail/cltbld', 08:05:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:05:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:05:28 INFO - 'MOZ_CRASHREPORTER': '1', 08:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:05:28 INFO - 'MOZ_NO_REMOTE': '1', 08:05:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:28 INFO - 'NO_EM_RESTART': '1', 08:05:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:28 INFO - 'PWD': '/builds/slave/test', 08:05:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:05:28 INFO - 'RUST_BACKTRACE': 'full', 08:05:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:05:28 INFO - 'SHELL': '/bin/bash', 08:05:28 INFO - 'SHLVL': '1', 08:05:28 INFO - 'TERM': 'linux', 08:05:28 INFO - 'TMOUT': '86400', 08:05:28 INFO - 'USER': 'cltbld', 08:05:28 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', 08:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:28 INFO - '_': '/tools/buildbot/bin/python'} 08:05:28 INFO - TEST-INFO | started process 11577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqY0MFF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:05:29 INFO - PID 11577 | 08:05:29 INFO - PID 11577 | (/builds/slave/test/build/application/firefox/firefox:11626): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:05:29 INFO - PID 11577 | 08:05:39 INFO - PID 11577 | RSS: Main: 141045760 08:05:39 INFO - PID 11577 | 08:08:37 INFO - PID 11577 | Cycle 1(1): loaded http://localhost:36946/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36946/tests/dromaeo/cssquery-ext.html) 08:08:38 INFO - PID 11577 | RSS: Main: 145309696 08:08:38 INFO - PID 11577 | 08:11:39 INFO - PID 11577 | Cycle 1(1): loaded http://localhost:36946/tests/dromaeo/cssquery-ext.html (next: http://localhost:36946/tests/dromaeo/cssquery-jquery.html) 08:11:40 INFO - PID 11577 | RSS: Main: 143773696 08:11:40 INFO - PID 11577 | 08:14:41 INFO - PID 11577 | Cycle 1(1): loaded http://localhost:36946/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36946/tests/dromaeo/cssquery-mootools.html) 08:14:42 INFO - PID 11577 | RSS: Main: 142794752 08:14:42 INFO - PID 11577 | 08:17:43 INFO - PID 11577 | Cycle 1(1): loaded http://localhost:36946/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36946/tests/dromaeo/cssquery-prototype.html) 08:17:44 INFO - PID 11577 | RSS: Main: 144769024 08:17:44 INFO - PID 11577 | 08:20:47 INFO - PID 11577 | Cycle 1(1): loaded http://localhost:36946/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36946/tests/dromaeo/cssquery-yui.html) 08:20:47 INFO - PID 11577 | RSS: Main: 146112512 08:20:47 INFO - PID 11577 | 08:23:49 INFO - PID 11577 | Cycle 1(1): loaded http://localhost:36946/tests/dromaeo/cssquery-yui.html (next: http://localhost:36946/tests/dromaeo/cssquery-dojo.html) 08:23:49 INFO - PID 11577 | RSS: Main: 149217280 08:23:49 INFO - PID 11577 | 08:23:49 INFO - PID 11577 | __start_tp_report 08:23:49 INFO - PID 11577 | _x_x_mozilla_page_load 08:23:49 INFO - PID 11577 | _x_x_mozilla_page_load_details 08:23:49 INFO - PID 11577 | |i|pagename|runs| 08:23:49 INFO - PID 11577 | |0;dojo.html;3913.745606535576;3921.21575684863;3940.763554186747;3940.92118157637;3948.703847211458;6219.844503887405;6227.408396202365;6256.061590761388;6302;6339.714712837922;6219.222597175353;6259;6305.842353941154;6326.810195694136;6341.46097581705;5631.929933312667;5633.80281690141;5645.661260324373;5752.597318187729;5769.682667453289;5599.8600034999245;5629.4652008059165;5637.887242255152;5705.629134106291;5764.337101233349;5744.856378590548;5793;5817.41825817417;5821.67980761058;5833.7374818133285;5661.1508273758855;5679.346875109353;5702.914456283159;5755.884882302352;5758.452946970031;5501.367342755594;5536.197251398525;5615.157726341041;5621.100623900197;5667.489925906647;6101.054336577838;6134.96932515339;6145.262568491809;6169.568130230886;6182.319944806068;6620.834479138012;6625.403713665745;6641.037049627826;6693.531452798306;6711;6673.432758215557;6783.457323414115;6797.6601169941305;6838.897416538756;6845.5550389224545;6251.624902505864;6336.3663633636725;6337;6337.968310158466;6347.809565713036;6855.897161542581;6873.896891546631;6951.860962780817;6963.721451141999;6965;6565;6671.39957403836;6701.932980670228;6706.396424321737;6716.093327400836;6695.79912602613;6809.250982391933;6815.7614483493835;6823.454123670094;6831.009503621947;6660.500462465237;6661.4004739573675;6669.266380698119;6760.0535924970545;6788;6714.731410743613;6718.227403848522;6749.08887300218;6762.966185169141;6784.626845523445;4959.2065269557415;4992.101421744121;5016.122178618727;5016.322796422509;5041.59667226621;4460.977695111504;4511.819527218874;4576.450825900846;4577.130345234395;4593.678442509059;6252.062190671436;6273.0904018917;6355.682215889187;6373.585716928477;6382.042693595905;6711.328867113347;6715.1941766988275;6797;6823.522353435212;6829.419499342513;6260;6266.717997690115;6350.523710721714;6362.077498762654;6372.426481616584;5556.222128901957;5565.721713914288;5645.774169033275;5648.576356773258;5664.688442135722;7050.471214658921;7060.92939070613;7073.186583542855;7084.043654106629;7090.610016449042;6604.86790264192;6687.966560167168;6760.763373281911;6772.898406524005;6787.660616969033;6961.338672826073;6980.162380514371;7029.121359830021;7059.858802823812;7103.644817758988;6511.674416279262;6590.275069742229;6597.043428702716;6621.834454138685;6629;6598.406143447113;6622.437092847162;6645.966770166118;6718.126643536309;6734.427573656294;6364.013577895434;6401.327860574759;6450.0969864218105;6475.352464753487;6484.351564843478;6475.676216189077;6521.152250207443;6524;6539;6574.27682954865;6392.169018027626;6462.903056454063;6482.805515834532;6496.7726129585235;6535.934640653722;6482.448991835558;6575.342465753578;6576.76981305652;6592.67036648156;6599.769008084694;6292.402221788922;6328.905066423915;6338.746450142127;6350.174477317919;6352.6506042166275 08:23:49 INFO - PID 11577 | |1;ext.html;964.643082059638;967.5791030901559;1007.9647212347567;1029.1818004686274;1029.5367084811837;45620.54379456204;46626.300605490906;46944.53055469449;47014.29478557824;47015;43972;44511;44516;44534;44559;7576.810579735523;7580.241975802417;7589.582572958485;7592.696292148307;7614.505057171294;7958.920410795876;7990.08114066881;8031.237032481934;8048.718294859681;8055.436119471639;7615.46691731579;7844.9215507844765;7852.685892564319;7853.607319634024;7860.724874629389;7766.417518686093;7780.221977802231;7790.143084260699;7797.961010194969;7821.687132514692;7743.728969486041;7784.649690763929;7799.805004874866;7815.570143642098;7845.686172553091;43743;44121.33817992733;44161.33757993633;44185.779071104436;44209.115817683785;3893.961060389388;3919.7060220483577;3922.0587059105897;3925.7448265862627;3926.2147570486018;34916;34958;34972.650273497195;35012.82493587516;35031.4745278821;5696.743646535916;5739.512141467981;5743.741531631086;5789.102689083199;5843.707814609295;244441;246296.9999999982;246828;248906;249719;57083;57363.42636573665;57431.712841435525;57543.712281438326;57583.13625295624;60195.69902150461;60423.39576604178;60427.69786151129;60497.370157790676;60621.69689151526;17972.9101354495;17977.550561236072;18119.45641630753;18133.18400671973;18375.264989400275;15126.621834454007;15135.848641513443;15136.54590362291;15189.544313670607;15200.087994720352;15711.842881571038;15712;15897.761533577006;15950.122743249232;15977.840221597635;6027.78902738402;6087.482563982111;6304.275008374004;6318.494520438354;6346.365363463617;1127.1827924754487;1129.6498085593491;1133.9092872570175;1134.194721747552;1137.1528211482498;26571.46857062848;26767;26799.928002880057;26906.865465672938;27089.32276693059;1222.3093951917137;1235.8084496902995;1240.9503619855286;1252.949882004728;1258.9055820813476;13882.444702212;13944.651383715489;13983.30083495821;14279.428822847178;14511.492097776527;293739;309506;312483;312528;316230;65076.34923650797;65616;65622;65690.67154664196;65878.67060664666;1572.048910409186;1574.55125289292;1593.1397045595481;1593.8884278100654;1602.943896963624;30448;30828.22929426782;30840.074797756104;30875.69124308728;31236.843815780776;43809;43933.56066439295;43988;44016.55983440125;44031.33952990772;258194;258551;258945;259960;260439;38361.808190958865;38658;39077;39235.803820981855;39251.214975700896;49455;49538;49703;50001.749991251265;50054.24918626296;35067.298654026265;35167.824160879034;35600.10999725028;35917.28165436729;36068.27863442769;35198.47202292019;35327.82336088406;35400.82299588485;35461.645383546864;35526;41192.588074120074;41606;41739.791301043304;42084.789576051924;42203.788981054895;33960;33973.320533589686;34073;34136.658633413346;34722.479162813084;25382.365440864127;25574.977000919756;25756.8712156438;26073.478530428907;26155.607665884647 08:23:49 INFO - PID 11577 | |2;jquery.html;647.1877793369321;647.9157709497764;650.0768908150426;653.8005908198;654.0908137688614;23071.538569228604;23200;23721.288361349143;23902.641460378087;24019;26183.47633047338;27315.180544583643;27318.863405682994;27329.726702732965;27348.45303093937;6711.127553418049;7093.255208203142;7104.43164546835;7122.715091396364;7132.6077065761365;6824.454043676494;6855.383015528601;6877.793666190022;6886.965565172167;6890.827729306758;6792.728290868359;6812.557183783063;6817.216020157671;6817.556858804187;6832.145981752281;6819.624920629363;6825.761098361533;6853.897191542131;6858.725650973955;6862.656867156647;6389;6410.67946602668;6427.42153206209;6434.7104380303;6439.4848412127385;29126.854365728035;30368.69631303681;30441.847790761127;30642.846785765927;30718.23204419885;2159.1471368809234;2179.6294629912954;2190.277208521184;2194.813440857529;2195.3084778294788;20273.8986305069;20492.897535512377;20650;20701;20707.27524536634;2477.665515155449;2496.0889275414524;2534.1130604288537;2541.440883005736;2548.0954261237366;141179;146690;162791;168426;168686;16196.75704864428;16289.429869954733;16712.91643541799;16814.57963550921;17139.657206855794;26898.193054208405;26954.865225674137;27104.864475677496;27178;27238.455230895666;10847.67456976292;11002.174836887265;11152.219344645797;11251.943740281245;11404.600838970762;10097.141742951932;10155.035271649182;10192.388456692623;10215.897841021495;10261.74345641365;9884.901150988399;9947.45289009097;9984.251181161297;10181.236407269336;10208.285420020677;2708.8781004854827;2722.3194201449637;2830.8867645294367;2856.9000084996924;2859.613952116479;1065.3235195650818;1065.4246706778408;1076.7361996310954;1082.5128692088592;1085.6851513061124;21407.57184856294;21852.344429667137;22127.33617991463;22230.110795567995;22439.10243590238;1135.840982262484;1143.1369316166242;1156.2715489241891;1163.4938801621151;1164.1443538998828;11902;12127.575534856238;12257.754844903053;12296.938515307545;12351.19717218378;587236;599628;604731;609596;617204;131947;133517;134123;136777.31611341878;138969.3051534756;1147.17976646698;1192.070185255502;1206.3847437806783;1293.0948336164722;1315.3949183375562;22309.7820658796;22486.77513224847;22689.886550567142;22845.88577057104;23082.653760193945;64987;65049.67475162594;65913.67043164754;66341.66829166016;67664;82978;83928;83994.16005839863;84691.57654211689;84967.15032849592;15983.200839958188;16060.116693581966;16120;16278.43025494102;16294.185290735653;24787.380315492257;24849.87575062113;24904.37739056538;24988.37529061788;25181.748182517942;20343.898280509096;20373.59252814965;20402.28591999273;20496.590068198253;20718.171273148906;17882.731759023365;18203.817961820212;18370;18384.080795960417;18681.719774203128;19389.2244310226;20322.79677203268;20359.59280814405;20430.795692042888;20486.487837804176;15808.367665293259;15843.445479408165;15858.127802970947;15941.760873586674;15994.920025399799;19679.901600491907;19722.50693732668;19799.30702425408;19843.206271748968;19941.60116797627 08:23:49 INFO - PID 11577 | |3;mootools.html;1435.1532595768497;1470.264867566217;1491.3885307024118;1492.0450911416688;1503.0831192972291;17274;17986.910065449687;17991;18003.909980450113;18017;17457.476275711717;17529.73705394417;17595;17616.647667046684;17633.7354939676;2975.3602975360295;3005.6092707947937;3062.7549796016265;3069.6776838431865;3076.646185688652;2952.571877077833;3030.045535656261;3032.9393412131853;3037.8632961516787;3037.9544306835414;2956.6008588840555;2992.895248666297;3002.084364268897;3004.173852190654;3004.4141392428487;2852.5721141828685;2887.7401033906945;2890.4797136515417;2890.624218851557;2893.088677066728;2797.720227977186;2818.6476690413697;2827.9293017674518;2832.2069820450306;2838.3329917469378;16836.579085522837;17179.31282748701;17250.223739931735;17294.740578891327;17335.653286934317;8519.361047921431;8897.288216942628;8960;8975.685850995184;8983.281337492985;5560.666360018412;5636.689982050985;5714.571407144481;5841.065429531254;5936;2113.123053932616;2125.5748850230016;2142.8500004999655;2182.334388011656;2191.2659259148204;28974.420511589862;29180;31035.22411939697;31605.84197079;31626.525602115988;8022.719204827919;8320.084790673021;8398;8415.95792021036;8593.398462107718;24335.878320608284;24365.63451548228;24387.14644987417;24398.39004024878;24403.755962440147;9213.447193168431;9317.44095354281;9397.812043759222;9432.386894851812;9441.811163776685;7937.960310198412;7990.600469976478;8172.141925097779;8279.834403312021;8287.668493260322;6274.090256912813;6306.779262725874;6321.841953951188;6345.841353966188;6433.678316084177;2029.5737895042207;2044.315154423255;2046.3042565527494;2051.8461115416403;2099.370188943311;1015.5024038221219;1016.4307987527009;1028.6451174344838;1034.446571084466;1053.2416660004785;9132.589033493508;9143.177114059634;9297.907020929704;9318.39430437033;9378.718638440858;811.4887620798859;821.8890449789202;824.332290844406;834.4867906237741;845.7209120990059;5497.976113137758;5512;5541.251930989265;5622.718864056781;5650.576206784508;25439;26346.73653263443;26658.06696765604;27373.726262737517;27391.863040684668;25454.74545254561;26434.206973790817;26707.599386009224;26795.196144115707;26975.730242697715;11592.710182245512;11932.940335298441;12983.610491685076;13083.476660933646;13432.932835335761;10507.264491485523;10579.206559507913;10605.098566621924;10728.356298622108;10733.94633026861;22139;22264.443388915406;22948.082076716746;23008.4247893804;23326;23518.882405588545;23666.645000324665;23956.760432395455;24051.51896962016;24241.878790605933;13873.375698093812;14031.29843507841;14083.647908802363;14126.434942602591;14144.504942326968;15976;16130.435434759727;16178.67642647164;16206.51380458541;16211.432599858948;12182.208156469802;12404.19372740769;12420.937895310466;12606.621801345975;12694.682632934251;12977.870221298044;13010.284434355823;13075.803862941873;13197.934010329887;13205.867941320465;11229.21395502307;11363.204575679623;11408.087353011904;11436.485358159069;11455.541778328774;8804.427712198943;8845.601947912488;8881.24509416681;8940.821183576421;9001.32490063261;8292.419530632798;8392.580370981548;8416.28461580748;8442.071372148936;8491.448055876348 08:23:49 INFO - PID 11577 | |4;prototype.html;568.2981517825486;569.5614376929767;583.7031281905698;601.7081715368046;603.8490377405649;6326.841828954272;6387.904181437282;6398.1042654028415;6425.839354016152;6440.645764482952;6232.127502149703;6252.155958945541;6283.560150789446;6304.432601065903;6317.936820631792;4982.77577509013;5078.1874900016;5120.513551212647;5199.428062913076;5209.531142197202;5090.490950904898;5100.9234861476925;5107.438181800017;5118.309028281172;5131.794728210886;5017.448080711119;5018.899622007558;5060.620453466005;5060.924086138711;5091.389033316007;5071.239314102877;5092.618053645954;5096.311997880294;5113.411957624883;5114.488551144893;4657.278121891112;4679.110968915929;4679.555442232982;4685.250359942427;4709.364235828154;6153.569250152491;6168.259808822925;6183.845403864894;6198.4731297839735;6310.463610593105;5926.259217597801;5942.881142377171;5988.670623115727;6000.4998750312425;6021.939780602182;6756.797296081126;6796.082528858639;6796.592204467748;6797.796066118024;6835.086175870764;4940.555350018516;5102.438731739506;5144.6655967362;5164.45773193813;5188.2619322527;6903.930960690379;6967.198772141218;6969.54697944632;7014.298570142996;7086.255943126001;5333.8133165339805;5348.144296912553;5354.625176237704;5359.437259087739;5360.597955153379;5364.7049412282695;5413;5457.508824205761;5460.126379779216;5468.332158691558;5946.137810017523;5964.940350596526;5999.880002399927;6018.368071352533;6024.939750602438;6824.488163387766;6834.086455792386;6884;6887.070245516891;6897.310268973062;1847.6581832361055;1852.527605460599;1856.647237024961;1876.127600665697;1890.6029733756066;1296.4230917241925;1314.2968511846116;1332.886704630098;1344.213635023522;1347.528365072217;6452.935470645328;6483.902741458882;6535.313792051861;6539.8365040873405;6542.149520562297;6879.174499060045;6888.483363747739;6923.273056329113;6953.165620125617;6972.477064220204;6446.8388290293115;6476.348531124628;6479.1901012373455;6489.480841532666;6506.577072490273;3579.534660494119;3622.3841946869097;3636.345457817565;3643.6720695137565;3661.41417373219;7241.1897025743565;7270.600116993616;7281.652894214587;7320.377767889789;7338;7054.435645148375;7115.92884071163;7122.2521635228595;7124.358807707331;7135.571865688075;7138.179109402381;7219.566825990458;7263.418926485869;7269.382102521239;7273.7998230291405;6835.03567930609;6870.27862074475;6898.172219333512;6906.551074180162;6932.7226910923;6711.926091825285;6753.932460675331;6772.221194562689;6822.249552549315;6835.965820170867;7057;7243;7274.890281818425;7292.744753933587;7301.342879140902;5304.840854774363;5308.654937429054;5317.25558421829;5338.706371149624;5378.139497680509;6559.573627714183;6644.767433139817;6827.6244806536115;6934.202566704894;6958.652067396712;6573.220398270918;6637.933620663925;6678;6703.363180497845;6741.258461569321;6553.672316384066;6601.141851559267;6642.734290628321;6665.133532640726;6733.730650773914;6399.616023038632;6469.7412103515335;6569.9343006569325;6618.867622647616;6622.900656490253;6724.655068986124;6732.461403087839;6750.8649827004165;6778.188355138202;6796.59220446755;6491.48068154537;6508.9349106508325;6537.640429776217;6548.148740663683;6601.768938087144 08:23:49 INFO - PID 11577 | |5;yui.html;955.4840386191461;973.9805203895922;991.1971303244372;1004.1615251265193;1010.4897027001366;19631.214751409927;20529.692054619172;20749.170033198672;20754.066067026983;20773.27293544726;17649.55876103098;18790.53023674409;19051.333203337887;19212.231510739555;19227.519312017208;1095.1840878545474;1099.7580532282884;1115.576081089185;1118.59730497021;1121.8822023687517;1101.9393933333704;1105.1324710102572;1108.9001989820915;1115.3475216998065;1116.542217690747;1130.7908037013137;1167.9240849344765;1172.2263306217899;1172.2614752705783;1172.78889799836;1163.5404015413906;1166.358502823448;1168.1239070696977;1168.2348062019391;1170.2159553099443;831.1812864328631;838.5388036579918;839.0267289943636;839.0895877972407;839.6515446089866;20297.289594864258;21070;22286.665700014513;22382.552348953093;22523.887380563156;23129.76870231293;23341.76658233413;23710.525789484287;23715.169969051174;23891.522169556512;17274.654506909916;17633.382831600833;17696.646067078716;17714.29142834285;17781.110944452725;3799.5440547134244;3800.2209547043067;3833.6358045985585;3833.8466461341513;3835.2137811748526;125871;146503;161918.99999999884;162491.1875440615;162960;18699.158537865827;18793.81206187948;19143.712844307345;19160.90419547893;19163.904180479007;35124;35263;35275;35356.823215883756;36217;10402.167826573856;10421.322614030063;10435.94782026085;10482.056614904543;10504.264701470976;4809.615230781529;4878.609711223094;4902.994886048352;4914.483979182134;4915.926261106087;6225.128482012522;6341.714622841891;6347.0479428086155;6366.904496432558;6376.585521941059;1186.8225787653944;1205.7046023724245;1214.4959841665786;1219.0978675780036;1219.2806244315896;739.2755100002028;750.7072241825692;759.236966848314;768.1205020251781;774.0092681367859;13545.729085418236;13592.796108058386;13735.381907814173;14943.178125203001;15080.019798713049;736.8342123022385;741.2143128284036;744.6983971491554;757.4849102610278;765.3494529649753;5848.2689663792025;5955.285365756137;5956.434138756811;6041.033434650435;6050.909236361458;156740;157892;158288.20855895878;158711;158756.66251556663;130097.34951325183;130585.34707326592;131604.3419782895;135188.32405837908;139746;113947;115177;116054.15860735132;117892;120820.79179208272;13815.516456923959;14490.63773405631;14557.92721036388;14569.344379502736;14743.705125897208;57974.13038804506;58762.41237587741;60451;61392.562518036226;61688;74926.25073749192;75495;75770;76748.61625691837;77406.2259377399;19833.20667173297;19852.90073549623;20309.187632495126;20356.694649580564;20382.184712611328;23239.419014524774;23618.29145125649;23785.167519136747;23844.642330365405;24277.63583546213;21853.890730546245;22033.449163771034;22087.889560552096;22094.005769740077;22614.886925565927;19772.90113549423;20052.799472005678;20107.59784804325;20208.292709755675;20262.797372026092;19530.90234548875;19639.901800490905;19698.803011969696;19745.901270493556;19842.305519306756;16198.595035123744;16417.343306267616;16499.83500164983;16590.419335323204;16797.748033779746;14215.669124078471;14246.35891384911;14250.928745356206;14302.57092287233;14475.638109047359 08:23:49 INFO - PID 11577 | __end_tp_report 08:23:49 INFO - PID 11577 | __start_cc_report 08:23:49 INFO - PID 11577 | _x_x_mozilla_cycle_collect,259 08:23:49 INFO - PID 11577 | __end_cc_report 08:23:49 INFO - PID 11577 | __startTimestamp1506612229692__endTimestamp 08:23:49 INFO - PID 11577 | 08:23:49 INFO - PID 11577 | ------- Summary: start ------- 08:23:49 INFO - PID 11577 | Number of tests: 6 08:23:49 INFO - PID 11577 | 08:23:49 INFO - PID 11577 | [#0] dojo.html Cycles:165 Average:6233.52 Median:6401.33 stddev:700.09 (10.9%) stddev-sans-first:678.17 08:23:49 INFO - PID 11577 | Values: 3913.7 3921.2 3940.8 3940.9 3948.7 6219.8 6227.4 6256.1 6302.0 6339.7 6219.2 6259.0 6305.8 6326.8 6341.5 5631.9 5633.8 5645.7 5752.6 5769.7 5599.9 5629.5 5637.9 5705.6 5764.3 5744.9 5793.0 5817.4 5821.7 5833.7 5661.2 5679.3 5702.9 5755.9 5758.5 5501.4 5536.2 5615.2 5621.1 5667.5 6101.1 6135.0 6145.3 6169.6 6182.3 6620.8 6625.4 6641.0 6693.5 6711.0 6673.4 6783.5 6797.7 6838.9 6845.6 6251.6 6336.4 6337.0 6338.0 6347.8 6855.9 6873.9 6951.9 6963.7 6965.0 6565.0 6671.4 6701.9 6706.4 6716.1 6695.8 6809.3 6815.8 6823.5 6831.0 6660.5 6661.4 6669.3 6760.1 6788.0 6714.7 6718.2 6749.1 6763.0 6784.6 4959.2 4992.1 5016.1 5016.3 5041.6 4461.0 4511.8 4576.5 4577.1 4593.7 6252.1 6273.1 6355.7 6373.6 6382.0 6711.3 6715.2 6797.0 6823.5 6829.4 6260.0 6266.7 6350.5 6362.1 6372.4 5556.2 5565.7 5645.8 5648.6 5664.7 7050.5 7060.9 7073.2 7084.0 7090.6 6604.9 6688.0 6760.8 6772.9 6787.7 6961.3 6980.2 7029.1 7059.9 7103.6 6511.7 6590.3 6597.0 6621.8 6629.0 6598.4 6622.4 6646.0 6718.1 6734.4 6364.0 6401.3 6450.1 6475.4 6484.4 6475.7 6521.2 6524.0 6539.0 6574.3 6392.2 6462.9 6482.8 6496.8 6535.9 6482.4 6575.3 6576.8 6592.7 6599.8 6292.4 6328.9 6338.7 6350.2 6352.7 08:23:49 INFO - PID 11577 | 08:23:49 INFO - PID 11577 | [#1] ext.html Cycles:180 Average:45971.20 Median:21485.48 stddev:71179.45 (331.3%) stddev-sans-first:71298.91 08:23:49 INFO - PID 11577 | Values: 964.6 967.6 1008.0 1029.2 1029.5 45620.5 46626.3 46944.5 47014.3 47015.0 43972.0 44511.0 44516.0 44534.0 44559.0 7576.8 7580.2 7589.6 7592.7 7614.5 7958.9 7990.1 8031.2 8048.7 8055.4 7615.5 7844.9 7852.7 7853.6 7860.7 7766.4 7780.2 7790.1 7798.0 7821.7 7743.7 7784.6 7799.8 7815.6 7845.7 43743.0 44121.3 44161.3 44185.8 44209.1 3894.0 3919.7 3922.1 3925.7 3926.2 34916.0 34958.0 34972.7 35012.8 35031.5 5696.7 5739.5 5743.7 5789.1 5843.7 244441.0 246297.0 246828.0 248906.0 249719.0 57083.0 57363.4 57431.7 57543.7 57583.1 60195.7 60423.4 60427.7 60497.4 60621.7 17972.9 17977.6 18119.5 18133.2 18375.3 15126.6 15135.8 15136.5 15189.5 15200.1 15711.8 15712.0 15897.8 15950.1 15977.8 6027.8 6087.5 6304.3 6318.5 6346.4 1127.2 1129.6 1133.9 1134.2 1137.2 26571.5 26767.0 26799.9 26906.9 27089.3 1222.3 1235.8 1241.0 1252.9 1258.9 13882.4 13944.7 13983.3 14279.4 14511.5 293739.0 309506.0 312483.0 312528.0 316230.0 65076.3 65616.0 65622.0 65690.7 65878.7 1572.0 1574.6 1593.1 1593.9 1602.9 30448.0 30828.2 30840.1 30875.7 31236.8 43809.0 43933.6 43988.0 44016.6 44031.3 258194.0 258551.0 258945.0 259960.0 260439.0 38361.8 38658.0 39077.0 39235.8 39251.2 49455.0 49538.0 49703.0 50001.7 50054.2 35067.3 35167.8 35600.1 35917.3 36068.3 35198.5 35327.8 35400.8 35461.6 35526.0 41192.6 41606.0 41739.8 42084.8 42203.8 33960.0 33973.3 34073.0 34136.7 34722.5 25382.4 25575.0 25756.9 26073.5 26155.6 08:23:49 INFO - PID 11577 | 08:23:49 INFO - PID 11577 | [#2] jquery.html Cycles:180 Average:40588.51 Median:22269.95 stddev:101375.57 (455.2%) stddev-sans-first:101615.59 08:23:49 INFO - PID 11577 | Values: 647.2 647.9 650.1 653.8 654.1 23071.5 23200.0 23721.3 23902.6 24019.0 26183.5 27315.2 27318.9 27329.7 27348.5 6711.1 7093.3 7104.4 7122.7 7132.6 6824.5 6855.4 6877.8 6887.0 6890.8 6792.7 6812.6 6817.2 6817.6 6832.1 6819.6 6825.8 6853.9 6858.7 6862.7 6389.0 6410.7 6427.4 6434.7 6439.5 29126.9 30368.7 30441.8 30642.8 30718.2 2159.1 2179.6 2190.3 2194.8 2195.3 20273.9 20492.9 20650.0 20701.0 20707.3 2477.7 2496.1 2534.1 2541.4 2548.1 141179.0 146690.0 162791.0 168426.0 168686.0 16196.8 16289.4 16712.9 16814.6 17139.7 26898.2 26954.9 27104.9 27178.0 27238.5 10847.7 11002.2 11152.2 11251.9 11404.6 10097.1 10155.0 10192.4 10215.9 10261.7 9884.9 9947.5 9984.3 10181.2 10208.3 2708.9 2722.3 2830.9 2856.9 2859.6 1065.3 1065.4 1076.7 1082.5 1085.7 21407.6 21852.3 22127.3 22230.1 22439.1 1135.8 1143.1 1156.3 1163.5 1164.1 11902.0 12127.6 12257.8 12296.9 12351.2 587236.0 599628.0 604731.0 609596.0 617204.0 131947.0 133517.0 134123.0 136777.3 138969.3 1147.2 1192.1 1206.4 1293.1 1315.4 22309.8 22486.8 22689.9 22845.9 23082.7 64987.0 65049.7 65913.7 66341.7 67664.0 82978.0 83928.0 83994.2 84691.6 84967.2 15983.2 16060.1 16120.0 16278.4 16294.2 24787.4 24849.9 24904.4 24988.4 25181.7 20343.9 20373.6 20402.3 20496.6 20718.2 17882.7 18203.8 18370.0 18384.1 18681.7 19389.2 20322.8 20359.6 20430.8 20486.5 15808.4 15843.4 15858.1 15941.8 15994.9 19679.9 19722.5 19799.3 19843.2 19941.6 08:23:49 INFO - PID 11577 | 08:23:49 INFO - PID 11577 | [#3] mootools.html Cycles:180 Average:11076.84 Median:26751.40 stddev:8212.56 (30.7%) stddev-sans-first:8203.65 08:23:49 INFO - PID 11577 | Values: 1435.2 1470.3 1491.4 1492.0 1503.1 17274.0 17986.9 17991.0 18003.9 18017.0 17457.5 17529.7 17595.0 17616.6 17633.7 2975.4 3005.6 3062.8 3069.7 3076.6 2952.6 3030.0 3032.9 3037.9 3038.0 2956.6 2992.9 3002.1 3004.2 3004.4 2852.6 2887.7 2890.5 2890.6 2893.1 2797.7 2818.6 2827.9 2832.2 2838.3 16836.6 17179.3 17250.2 17294.7 17335.7 8519.4 8897.3 8960.0 8975.7 8983.3 5560.7 5636.7 5714.6 5841.1 5936.0 2113.1 2125.6 2142.9 2182.3 2191.3 28974.4 29180.0 31035.2 31605.8 31626.5 8022.7 8320.1 8398.0 8416.0 8593.4 24335.9 24365.6 24387.1 24398.4 24403.8 9213.4 9317.4 9397.8 9432.4 9441.8 7938.0 7990.6 8172.1 8279.8 8287.7 6274.1 6306.8 6321.8 6345.8 6433.7 2029.6 2044.3 2046.3 2051.8 2099.4 1015.5 1016.4 1028.6 1034.4 1053.2 9132.6 9143.2 9297.9 9318.4 9378.7 811.5 821.9 824.3 834.5 845.7 5498.0 5512.0 5541.3 5622.7 5650.6 25439.0 26346.7 26658.1 27373.7 27391.9 25454.7 26434.2 26707.6 26795.2 26975.7 11592.7 11932.9 12983.6 13083.5 13432.9 10507.3 10579.2 10605.1 10728.4 10733.9 22139.0 22264.4 22948.1 23008.4 23326.0 23518.9 23666.6 23956.8 24051.5 24241.9 13873.4 14031.3 14083.6 14126.4 14144.5 15976.0 16130.4 16178.7 16206.5 16211.4 12182.2 12404.2 12420.9 12606.6 12694.7 12977.9 13010.3 13075.8 13197.9 13205.9 11229.2 11363.2 11408.1 11436.5 11455.5 8804.4 8845.6 8881.2 8940.8 9001.3 8292.4 8392.6 8416.3 8442.1 8491.4 08:23:49 INFO - PID 11577 | 08:23:49 INFO - PID 11577 | [#4] prototype.html Cycles:180 Average:5765.26 Median:6443.74 stddev:1611.19 (25.0%) stddev-sans-first:1567.79 08:23:49 INFO - PID 11577 | Values: 568.3 569.6 583.7 601.7 603.8 6326.8 6387.9 6398.1 6425.8 6440.6 6232.1 6252.2 6283.6 6304.4 6317.9 4982.8 5078.2 5120.5 5199.4 5209.5 5090.5 5100.9 5107.4 5118.3 5131.8 5017.4 5018.9 5060.6 5060.9 5091.4 5071.2 5092.6 5096.3 5113.4 5114.5 4657.3 4679.1 4679.6 4685.3 4709.4 6153.6 6168.3 6183.8 6198.5 6310.5 5926.3 5942.9 5988.7 6000.5 6021.9 6756.8 6796.1 6796.6 6797.8 6835.1 4940.6 5102.4 5144.7 5164.5 5188.3 6903.9 6967.2 6969.5 7014.3 7086.3 5333.8 5348.1 5354.6 5359.4 5360.6 5364.7 5413.0 5457.5 5460.1 5468.3 5946.1 5964.9 5999.9 6018.4 6024.9 6824.5 6834.1 6884.0 6887.1 6897.3 1847.7 1852.5 1856.6 1876.1 1890.6 1296.4 1314.3 1332.9 1344.2 1347.5 6452.9 6483.9 6535.3 6539.8 6542.1 6879.2 6888.5 6923.3 6953.2 6972.5 6446.8 6476.3 6479.2 6489.5 6506.6 3579.5 3622.4 3636.3 3643.7 3661.4 7241.2 7270.6 7281.7 7320.4 7338.0 7054.4 7115.9 7122.3 7124.4 7135.6 7138.2 7219.6 7263.4 7269.4 7273.8 6835.0 6870.3 6898.2 6906.6 6932.7 6711.9 6753.9 6772.2 6822.2 6836.0 7057.0 7243.0 7274.9 7292.7 7301.3 5304.8 5308.7 5317.3 5338.7 5378.1 6559.6 6644.8 6827.6 6934.2 6958.7 6573.2 6637.9 6678.0 6703.4 6741.3 6553.7 6601.1 6642.7 6665.1 6733.7 6399.6 6469.7 6569.9 6618.9 6622.9 6724.7 6732.5 6750.9 6778.2 6796.6 6491.5 6508.9 6537.6 6548.1 6601.8 08:23:49 INFO - PID 11577 | 08:23:49 INFO - PID 11577 | [#5] yui.html Cycles:180 Average:29409.58 Median:19722.35 stddev:42645.47 (216.2%) stddev-sans-first:42711.58 08:23:49 INFO - PID 11577 | Values: 955.5 974.0 991.2 1004.2 1010.5 19631.2 20529.7 20749.2 20754.1 20773.3 17649.6 18790.5 19051.3 19212.2 19227.5 1095.2 1099.8 1115.6 1118.6 1121.9 1101.9 1105.1 1108.9 1115.3 1116.5 1130.8 1167.9 1172.2 1172.3 1172.8 1163.5 1166.4 1168.1 1168.2 1170.2 831.2 838.5 839.0 839.1 839.7 20297.3 21070.0 22286.7 22382.6 22523.9 23129.8 23341.8 23710.5 23715.2 23891.5 17274.7 17633.4 17696.6 17714.3 17781.1 3799.5 3800.2 3833.6 3833.8 3835.2 125871.0 146503.0 161919.0 162491.2 162960.0 18699.2 18793.8 19143.7 19160.9 19163.9 35124.0 35263.0 35275.0 35356.8 36217.0 10402.2 10421.3 10435.9 10482.1 10504.3 4809.6 4878.6 4903.0 4914.5 4915.9 6225.1 6341.7 6347.0 6366.9 6376.6 1186.8 1205.7 1214.5 1219.1 1219.3 739.3 750.7 759.2 768.1 774.0 13545.7 13592.8 13735.4 14943.2 15080.0 736.8 741.2 744.7 757.5 765.3 5848.3 5955.3 5956.4 6041.0 6050.9 156740.0 157892.0 158288.2 158711.0 158756.7 130097.3 130585.3 131604.3 135188.3 139746.0 113947.0 115177.0 116054.2 117892.0 120820.8 13815.5 14490.6 14557.9 14569.3 14743.7 57974.1 58762.4 60451.0 61392.6 61688.0 74926.3 75495.0 75770.0 76748.6 77406.2 19833.2 19852.9 20309.2 20356.7 20382.2 23239.4 23618.3 23785.2 23844.6 24277.6 21853.9 22033.4 22087.9 22094.0 22614.9 19772.9 20052.8 20107.6 20208.3 20262.8 19530.9 19639.9 19698.8 19745.9 19842.3 16198.6 16417.3 16499.8 16590.4 16797.7 14215.7 14246.4 14250.9 14302.6 14475.6 08:23:49 INFO - PID 11577 | -------- Summary: end -------- 08:23:49 INFO - PID 11577 | 08:23:50 INFO - TEST-INFO | 11577: exit 0 08:23:50 INFO - TEST-OK | dromaeo_css | took 1107042ms 08:23:50 INFO - TEST-START | kraken 08:23:50 INFO - Initialising browser for kraken test... 08:23:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36946/getInfo.html -profile /tmp/tmpT50ymc/profile 08:23:50 INFO - TEST-INFO | started process 11944 (/builds/slave/test/build/application/firefox/firefox http://localhost:36946/getInfo.html) 08:23:55 INFO - TEST-INFO | 11944: exit 0 08:23:55 INFO - Browser initialized. 08:23:55 INFO - Running cycle 1/1 for kraken test... 08:23:55 INFO - Using env: {'DISPLAY': ':0', 08:23:55 INFO - 'HOME': '/home/cltbld', 08:23:55 INFO - 'JSGC_DISABLE_POISONING': '1', 08:23:55 INFO - 'LANG': 'en_US.UTF-8', 08:23:55 INFO - 'LANGUAGE': 'en_US:en', 08:23:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:23:55 INFO - 'LOGNAME': 'cltbld', 08:23:55 INFO - 'MAIL': '/var/mail/cltbld', 08:23:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:23:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:23:55 INFO - 'MOZ_CRASHREPORTER': '1', 08:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:23:55 INFO - 'MOZ_NO_REMOTE': '1', 08:23:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:55 INFO - 'NO_EM_RESTART': '1', 08:23:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:55 INFO - 'PWD': '/builds/slave/test', 08:23:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:23:55 INFO - 'RUST_BACKTRACE': 'full', 08:23:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:23:55 INFO - 'SHELL': '/bin/bash', 08:23:55 INFO - 'SHLVL': '1', 08:23:55 INFO - 'TERM': 'linux', 08:23:55 INFO - 'TMOUT': '86400', 08:23:55 INFO - 'USER': 'cltbld', 08:23:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826', 08:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:55 INFO - '_': '/tools/buildbot/bin/python'} 08:23:55 INFO - TEST-INFO | started process 12131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT50ymc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:55 INFO - PID 12131 | 08:23:55 INFO - PID 12131 | (/builds/slave/test/build/application/firefox/firefox:12179): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:23:55 INFO - PID 12131 | 08:24:06 INFO - PID 12131 | RSS: Main: 143187968 08:24:06 INFO - PID 12131 | 08:24:08 INFO - PID 12131 | Cycle 1(1): loaded http://localhost:36946/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36946/tests/kraken/driver.html?testName=audio-beat-detection) 08:24:09 INFO - PID 12131 | RSS: Main: 149385216 08:24:09 INFO - PID 12131 | 08:24:12 INFO - PID 12131 | Cycle 1(1): loaded http://localhost:36946/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36946/tests/kraken/driver.html?testName=audio-dft) 08:24:12 INFO - PID 12131 | RSS: Main: 149917696 08:24:12 INFO - PID 12131 | 08:24:15 INFO - PID 12131 | Cycle 1(1): loaded http://localhost:36946/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36946/tests/kraken/driver.html?testName=audio-fft) 08:24:16 INFO - PID 12131 | RSS: Main: 151273472 08:24:16 INFO - PID 12131 | 08:24:18 INFO - PID 12131 | Cycle 1(1): loaded http://localhost:36946/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36946/tests/kraken/driver.html?testName=audio-oscillator) 08:24:18 INFO - PID 12131 | RSS: Main: 151203840 08:24:18 INFO - PID 12131 | 08:24:20 INFO - PID 12131 | Cycle 1(1): loaded http://localhost:36946/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36946/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:24:21 INFO - PID 12131 | RSS: Main: 151175168 08:24:21 INFO - PID 12131 | 08:24:24 INFO - PID 12131 | Cycle 1(1): loaded http://localhost:36946/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36946/tests/kraken/driver.html?testName=imaging-darkroom) 08:24:25 INFO - PID 12131 | RSS: Main: 151117824 08:24:25 INFO - PID 12131 | 08:24:28 INFO - PID 12131 | Cycle 1(1): loaded http://localhost:36946/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36946/tests/kraken/driver.html?testName=imaging-desaturate) 08:24:29 INFO - PID 12131 | RSS: Main: 151953408 08:24:29 INFO - PID 12131 | 08:24:32 INFO - PID 12131 | Cycle 1(1): loaded http://localhost:36946/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36946/tests/kraken/driver.html?testName=json-parse-financial) 08:24:32 INFO - PID 12131 | RSS: Main: 153391104 08:24:32 INFO - PID 12131 | 08:24:34 INFO - PID 12131 | Cycle 1(1): loaded http://localhost:36946/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36946/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:24:34 INFO - PID 12131 | RSS: Main: 153677824 08:24:34 INFO - PID 12131 | 08:24:36 INFO - PID 12131 | Cycle 1(1): loaded http://localhost:36946/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36946/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:24:36 INFO - PID 12131 | RSS: Main: 153722880 08:24:36 INFO - PID 12131 | 08:24:38 INFO - PID 12131 | Cycle 1(1): loaded http://localhost:36946/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36946/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:24:39 INFO - PID 12131 | RSS: Main: 150577152 08:24:39 INFO - PID 12131 | 08:24:42 INFO - PID 12131 | Cycle 1(1): loaded http://localhost:36946/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36946/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:24:42 INFO - PID 12131 | RSS: Main: 150638592 08:24:42 INFO - PID 12131 | 08:24:45 INFO - PID 12131 | Cycle 1(1): loaded http://localhost:36946/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36946/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:24:45 INFO - PID 12131 | RSS: Main: 150962176 08:24:45 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | Cycle 1(1): loaded http://localhost:36946/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36946/tests/kraken/driver.html?testName=ai-astar) 08:24:47 INFO - PID 12131 | RSS: Main: 152559616 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | __start_tp_report 08:24:47 INFO - PID 12131 | _x_x_mozilla_page_load 08:24:47 INFO - PID 12131 | _x_x_mozilla_page_load_details 08:24:47 INFO - PID 12131 | |i|pagename|runs| 08:24:47 INFO - PID 12131 | |0;ai-astar;104;105;103;104;105;105;106;106;104;104 08:24:47 INFO - PID 12131 | |1;audio-beat-detection;114;112;110;110;110;111;114;115;112;111 08:24:47 INFO - PID 12131 | |2;audio-dft;162;162;162;161;162;162;161;162;163;161 08:24:47 INFO - PID 12131 | |3;audio-fft;73;72;73;85;83;82;76;74;73;75 08:24:47 INFO - PID 12131 | |4;audio-oscillator;77;76;77;77;78;78;77;77;77;76 08:24:47 INFO - PID 12131 | |5;imaging-gaussian-blur;113;114;113;113;113;114;114;114;117;114 08:24:47 INFO - PID 12131 | |6;imaging-darkroom;151;149;149;149;149;149;148;148;150;149 08:24:47 INFO - PID 12131 | |7;imaging-desaturate;94;95;95;94;94;94;93;95;94;94 08:24:47 INFO - PID 12131 | |8;json-parse-financial;43;45;44;45;45;44;43;43;43;44 08:24:47 INFO - PID 12131 | |9;json-stringify-tinderbox;38;38;38;39;44;37;38;37;38;37 08:24:47 INFO - PID 12131 | |10;stanford-crypto-aes;72;75;71;69;76;75;69;70;74;68 08:24:47 INFO - PID 12131 | |11;stanford-crypto-ccm;100;106;101;104;106;107;106;101;105;107 08:24:47 INFO - PID 12131 | |12;stanford-crypto-pbkdf2;153;152;145;148;146;150;148;150;152;148 08:24:47 INFO - PID 12131 | |13;stanford-crypto-sha256-iterative;56;63;58;59;61;64;58;64;60;61 08:24:47 INFO - PID 12131 | __end_tp_report 08:24:47 INFO - PID 12131 | __start_cc_report 08:24:47 INFO - PID 12131 | _x_x_mozilla_cycle_collect,690 08:24:47 INFO - PID 12131 | __end_cc_report 08:24:47 INFO - PID 12131 | __startTimestamp1506612287804__endTimestamp 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | ------- Summary: start ------- 08:24:47 INFO - PID 12131 | Number of tests: 14 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | [#0] ai-astar Cycles:10 Average:104.60 Median:105.00 stddev:0.97 (0.9%) stddev-sans-first:1.00 08:24:47 INFO - PID 12131 | Values: 104.0 105.0 103.0 104.0 105.0 105.0 106.0 106.0 104.0 104.0 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | [#1] audio-beat-detection Cycles:10 Average:111.90 Median:112.00 stddev:1.85 (1.7%) stddev-sans-first:1.80 08:24:47 INFO - PID 12131 | Values: 114.0 112.0 110.0 110.0 110.0 111.0 114.0 115.0 112.0 111.0 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:24:47 INFO - PID 12131 | Values: 162.0 162.0 162.0 161.0 162.0 162.0 161.0 162.0 163.0 161.0 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | [#3] audio-fft Cycles:10 Average:76.60 Median:75.50 stddev:4.84 (6.4%) stddev-sans-first:4.95 08:24:47 INFO - PID 12131 | Values: 73.0 72.0 73.0 85.0 83.0 82.0 76.0 74.0 73.0 75.0 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:77.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 08:24:47 INFO - PID 12131 | Values: 77.0 76.0 77.0 77.0 78.0 78.0 77.0 77.0 77.0 76.0 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:1.20 (1.1%) stddev-sans-first:1.22 08:24:47 INFO - PID 12131 | Values: 113.0 114.0 113.0 113.0 113.0 114.0 114.0 114.0 117.0 114.0 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:0.88 (0.6%) stddev-sans-first:0.60 08:24:47 INFO - PID 12131 | Values: 151.0 149.0 149.0 149.0 149.0 149.0 148.0 148.0 150.0 149.0 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:24:47 INFO - PID 12131 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 93.0 95.0 94.0 94.0 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | [#8] json-parse-financial Cycles:10 Average:43.90 Median:44.00 stddev:0.88 (2.0%) stddev-sans-first:0.87 08:24:47 INFO - PID 12131 | Values: 43.0 45.0 44.0 45.0 45.0 44.0 43.0 43.0 43.0 44.0 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | [#9] json-stringify-tinderbox Cycles:10 Average:38.40 Median:38.00 stddev:2.07 (5.4%) stddev-sans-first:2.19 08:24:47 INFO - PID 12131 | Values: 38.0 38.0 38.0 39.0 44.0 37.0 38.0 37.0 38.0 37.0 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | [#10] stanford-crypto-aes Cycles:10 Average:71.90 Median:73.00 stddev:2.92 (4.0%) stddev-sans-first:3.10 08:24:47 INFO - PID 12131 | Values: 72.0 75.0 71.0 69.0 76.0 75.0 69.0 70.0 74.0 68.0 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | [#11] stanford-crypto-ccm Cycles:10 Average:104.30 Median:106.00 stddev:2.67 (2.5%) stddev-sans-first:2.33 08:24:47 INFO - PID 12131 | Values: 100.0 106.0 101.0 104.0 106.0 107.0 106.0 101.0 105.0 107.0 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:150.00 stddev:2.66 (1.8%) stddev-sans-first:2.44 08:24:47 INFO - PID 12131 | Values: 153.0 152.0 145.0 148.0 146.0 150.0 148.0 150.0 152.0 148.0 08:24:47 INFO - PID 12131 | 08:24:47 INFO - PID 12131 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:61.00 stddev:2.72 (4.5%) stddev-sans-first:2.37 08:24:47 INFO - PID 12131 | Values: 56.0 63.0 58.0 59.0 61.0 64.0 58.0 64.0 60.0 61.0 08:24:47 INFO - PID 12131 | -------- Summary: end -------- 08:24:47 INFO - PID 12131 | 08:24:48 INFO - PID 12131 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:24:48 INFO - TEST-INFO | 12131: exit 0 08:24:48 INFO - TEST-OK | kraken | took 58150ms 08:24:48 INFO - SUITE-END | took 1165s 08:24:48 INFO - Completed test suite (00:19:25) 08:24:48 INFO - javascript benchmark 08:24:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9376.841273943817, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3913.745606535576, 3921.21575684863, 3940.763554186747, 3940.92118157637, 3948.703847211458, 6219.844503887405, 6227.408396202365, 6256.061590761388, 6302.0, 6339.714712837922, 6219.222597175353, 6259.0, 6305.842353941154, 6326.810195694136, 6341.46097581705, 5631.929933312667, 5633.80281690141, 5645.661260324373, 5752.597318187729, 5769.682667453289, 5599.8600034999245, 5629.4652008059165, 5637.887242255152, 5705.629134106291, 5764.337101233349, 5744.856378590548, 5793.0, 5817.41825817417, 5821.67980761058, 5833.7374818133285, 5661.1508273758855, 5679.346875109353, 5702.914456283159, 5755.884882302352, 5758.452946970031, 5501.367342755594, 5536.197251398525, 5615.157726341041, 5621.100623900197, 5667.489925906647, 6101.054336577838, 6134.96932515339, 6145.262568491809, 6169.568130230886, 6182.319944806068, 6620.834479138012, 6625.403713665745, 6641.037049627826, 6693.531452798306, 6711.0, 6673.432758215557, 6783.457323414115, 6797.6601169941305, 6838.897416538756, 6845.5550389224545, 6251.624902505864, 6336.3663633636725, 6337.0, 6337.968310158466, 6347.809565713036, 6855.897161542581, 6873.896891546631, 6951.860962780817, 6963.721451141999, 6965.0, 6565.0, 6671.39957403836, 6701.932980670228, 6706.396424321737, 6716.093327400836, 6695.79912602613, 6809.250982391933, 6815.7614483493835, 6823.454123670094, 6831.009503621947, 6660.500462465237, 6661.4004739573675, 6669.266380698119, 6760.0535924970545, 6788.0, 6714.731410743613, 6718.227403848522, 6749.08887300218, 6762.966185169141, 6784.626845523445, 4959.2065269557415, 4992.101421744121, 5016.122178618727, 5016.322796422509, 5041.59667226621, 4460.977695111504, 4511.819527218874, 4576.450825900846, 4577.130345234395, 4593.678442509059, 6252.062190671436, 6273.0904018917, 6355.682215889187, 6373.585716928477, 6382.042693595905, 6711.328867113347, 6715.1941766988275, 6797.0, 6823.522353435212, 6829.419499342513, 6260.0, 6266.717997690115, 6350.523710721714, 6362.077498762654, 6372.426481616584, 5556.222128901957, 5565.721713914288, 5645.774169033275, 5648.576356773258, 5664.688442135722, 7050.471214658921, 7060.92939070613, 7073.186583542855, 7084.043654106629, 7090.610016449042, 6604.86790264192, 6687.966560167168, 6760.763373281911, 6772.898406524005, 6787.660616969033, 6961.338672826073, 6980.162380514371, 7029.121359830021, 7059.858802823812, 7103.644817758988, 6511.674416279262, 6590.275069742229, 6597.043428702716, 6621.834454138685, 6629.0, 6598.406143447113, 6622.437092847162, 6645.966770166118, 6718.126643536309, 6734.427573656294, 6364.013577895434, 6401.327860574759, 6450.0969864218105, 6475.352464753487, 6484.351564843478, 6475.676216189077, 6521.152250207443, 6524.0, 6539.0, 6574.27682954865, 6392.169018027626, 6462.903056454063, 6482.805515834532, 6496.7726129585235, 6535.934640653722, 6482.448991835558, 6575.342465753578, 6576.76981305652, 6592.67036648156, 6599.769008084694, 6292.402221788922, 6328.905066423915, 6338.746450142127, 6350.174477317919, 6352.6506042166275], "value": 6188.563830906507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [964.643082059638, 967.5791030901559, 1007.9647212347567, 1029.1818004686274, 1029.5367084811837, 45620.54379456204, 46626.300605490906, 46944.53055469449, 47014.29478557824, 47015.0, 43972.0, 44511.0, 44516.0, 44534.0, 44559.0, 7576.810579735523, 7580.241975802417, 7589.582572958485, 7592.696292148307, 7614.505057171294, 7958.920410795876, 7990.08114066881, 8031.237032481934, 8048.718294859681, 8055.436119471639, 7615.46691731579, 7844.9215507844765, 7852.685892564319, 7853.607319634024, 7860.724874629389, 7766.417518686093, 7780.221977802231, 7790.143084260699, 7797.961010194969, 7821.687132514692, 7743.728969486041, 7784.649690763929, 7799.805004874866, 7815.570143642098, 7845.686172553091, 43743.0, 44121.33817992733, 44161.33757993633, 44185.779071104436, 44209.115817683785, 3893.961060389388, 3919.7060220483577, 3922.0587059105897, 3925.7448265862627, 3926.2147570486018, 34916.0, 34958.0, 34972.650273497195, 35012.82493587516, 35031.4745278821, 5696.743646535916, 5739.512141467981, 5743.741531631086, 5789.102689083199, 5843.707814609295, 244441.0, 246296.9999999982, 246828.0, 248906.0, 249719.0, 57083.0, 57363.42636573665, 57431.712841435525, 57543.712281438326, 57583.13625295624, 60195.69902150461, 60423.39576604178, 60427.69786151129, 60497.370157790676, 60621.69689151526, 17972.9101354495, 17977.550561236072, 18119.45641630753, 18133.18400671973, 18375.264989400275, 15126.621834454007, 15135.848641513443, 15136.54590362291, 15189.544313670607, 15200.087994720352, 15711.842881571038, 15712.0, 15897.761533577006, 15950.122743249232, 15977.840221597635, 6027.78902738402, 6087.482563982111, 6304.275008374004, 6318.494520438354, 6346.365363463617, 1127.1827924754487, 1129.6498085593491, 1133.9092872570175, 1134.194721747552, 1137.1528211482498, 26571.46857062848, 26767.0, 26799.928002880057, 26906.865465672938, 27089.32276693059, 1222.3093951917137, 1235.8084496902995, 1240.9503619855286, 1252.949882004728, 1258.9055820813476, 13882.444702212, 13944.651383715489, 13983.30083495821, 14279.428822847178, 14511.492097776527, 293739.0, 309506.0, 312483.0, 312528.0, 316230.0, 65076.34923650797, 65616.0, 65622.0, 65690.67154664196, 65878.67060664666, 1572.048910409186, 1574.55125289292, 1593.1397045595481, 1593.8884278100654, 1602.943896963624, 30448.0, 30828.22929426782, 30840.074797756104, 30875.69124308728, 31236.843815780776, 43809.0, 43933.56066439295, 43988.0, 44016.55983440125, 44031.33952990772, 258194.0, 258551.0, 258945.0, 259960.0, 260439.0, 38361.808190958865, 38658.0, 39077.0, 39235.803820981855, 39251.214975700896, 49455.0, 49538.0, 49703.0, 50001.749991251265, 50054.24918626296, 35067.298654026265, 35167.824160879034, 35600.10999725028, 35917.28165436729, 36068.27863442769, 35198.47202292019, 35327.82336088406, 35400.82299588485, 35461.645383546864, 35526.0, 41192.588074120074, 41606.0, 41739.791301043304, 42084.789576051924, 42203.788981054895, 33960.0, 33973.320533589686, 34073.0, 34136.658633413346, 34722.479162813084, 25382.365440864127, 25574.977000919756, 25756.8712156438, 26073.478530428907, 26155.607665884647], "value": 19470.656572186377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.1877793369321, 647.9157709497764, 650.0768908150426, 653.8005908198, 654.0908137688614, 23071.538569228604, 23200.0, 23721.288361349143, 23902.641460378087, 24019.0, 26183.47633047338, 27315.180544583643, 27318.863405682994, 27329.726702732965, 27348.45303093937, 6711.127553418049, 7093.255208203142, 7104.43164546835, 7122.715091396364, 7132.6077065761365, 6824.454043676494, 6855.383015528601, 6877.793666190022, 6886.965565172167, 6890.827729306758, 6792.728290868359, 6812.557183783063, 6817.216020157671, 6817.556858804187, 6832.145981752281, 6819.624920629363, 6825.761098361533, 6853.897191542131, 6858.725650973955, 6862.656867156647, 6389.0, 6410.67946602668, 6427.42153206209, 6434.7104380303, 6439.4848412127385, 29126.854365728035, 30368.69631303681, 30441.847790761127, 30642.846785765927, 30718.23204419885, 2159.1471368809234, 2179.6294629912954, 2190.277208521184, 2194.813440857529, 2195.3084778294788, 20273.8986305069, 20492.897535512377, 20650.0, 20701.0, 20707.27524536634, 2477.665515155449, 2496.0889275414524, 2534.1130604288537, 2541.440883005736, 2548.0954261237366, 141179.0, 146690.0, 162791.0, 168426.0, 168686.0, 16196.75704864428, 16289.429869954733, 16712.91643541799, 16814.57963550921, 17139.657206855794, 26898.193054208405, 26954.865225674137, 27104.864475677496, 27178.0, 27238.455230895666, 10847.67456976292, 11002.174836887265, 11152.219344645797, 11251.943740281245, 11404.600838970762, 10097.141742951932, 10155.035271649182, 10192.388456692623, 10215.897841021495, 10261.74345641365, 9884.901150988399, 9947.45289009097, 9984.251181161297, 10181.236407269336, 10208.285420020677, 2708.8781004854827, 2722.3194201449637, 2830.8867645294367, 2856.9000084996924, 2859.613952116479, 1065.3235195650818, 1065.4246706778408, 1076.7361996310954, 1082.5128692088592, 1085.6851513061124, 21407.57184856294, 21852.344429667137, 22127.33617991463, 22230.110795567995, 22439.10243590238, 1135.840982262484, 1143.1369316166242, 1156.2715489241891, 1163.4938801621151, 1164.1443538998828, 11902.0, 12127.575534856238, 12257.754844903053, 12296.938515307545, 12351.19717218378, 587236.0, 599628.0, 604731.0, 609596.0, 617204.0, 131947.0, 133517.0, 134123.0, 136777.31611341878, 138969.3051534756, 1147.17976646698, 1192.070185255502, 1206.3847437806783, 1293.0948336164722, 1315.3949183375562, 22309.7820658796, 22486.77513224847, 22689.886550567142, 22845.88577057104, 23082.653760193945, 64987.0, 65049.67475162594, 65913.67043164754, 66341.66829166016, 67664.0, 82978.0, 83928.0, 83994.16005839863, 84691.57654211689, 84967.15032849592, 15983.200839958188, 16060.116693581966, 16120.0, 16278.43025494102, 16294.185290735653, 24787.380315492257, 24849.87575062113, 24904.37739056538, 24988.37529061788, 25181.748182517942, 20343.898280509096, 20373.59252814965, 20402.28591999273, 20496.590068198253, 20718.171273148906, 17882.731759023365, 18203.817961820212, 18370.0, 18384.080795960417, 18681.719774203128, 19389.2244310226, 20322.79677203268, 20359.59280814405, 20430.795692042888, 20486.487837804176, 15808.367665293259, 15843.445479408165, 15858.127802970947, 15941.760873586674, 15994.920025399799, 19679.901600491907, 19722.50693732668, 19799.30702425408, 19843.206271748968, 19941.60116797627], "value": 13143.981685935909, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.1532595768497, 1470.264867566217, 1491.3885307024118, 1492.0450911416688, 1503.0831192972291, 17274.0, 17986.910065449687, 17991.0, 18003.909980450113, 18017.0, 17457.476275711717, 17529.73705394417, 17595.0, 17616.647667046684, 17633.7354939676, 2975.3602975360295, 3005.6092707947937, 3062.7549796016265, 3069.6776838431865, 3076.646185688652, 2952.571877077833, 3030.045535656261, 3032.9393412131853, 3037.8632961516787, 3037.9544306835414, 2956.6008588840555, 2992.895248666297, 3002.084364268897, 3004.173852190654, 3004.4141392428487, 2852.5721141828685, 2887.7401033906945, 2890.4797136515417, 2890.624218851557, 2893.088677066728, 2797.720227977186, 2818.6476690413697, 2827.9293017674518, 2832.2069820450306, 2838.3329917469378, 16836.579085522837, 17179.31282748701, 17250.223739931735, 17294.740578891327, 17335.653286934317, 8519.361047921431, 8897.288216942628, 8960.0, 8975.685850995184, 8983.281337492985, 5560.666360018412, 5636.689982050985, 5714.571407144481, 5841.065429531254, 5936.0, 2113.123053932616, 2125.5748850230016, 2142.8500004999655, 2182.334388011656, 2191.2659259148204, 28974.420511589862, 29180.0, 31035.22411939697, 31605.84197079, 31626.525602115988, 8022.719204827919, 8320.084790673021, 8398.0, 8415.95792021036, 8593.398462107718, 24335.878320608284, 24365.63451548228, 24387.14644987417, 24398.39004024878, 24403.755962440147, 9213.447193168431, 9317.44095354281, 9397.812043759222, 9432.386894851812, 9441.811163776685, 7937.960310198412, 7990.600469976478, 8172.141925097779, 8279.834403312021, 8287.668493260322, 6274.090256912813, 6306.779262725874, 6321.841953951188, 6345.841353966188, 6433.678316084177, 2029.5737895042207, 2044.315154423255, 2046.3042565527494, 2051.8461115416403, 2099.370188943311, 1015.5024038221219, 1016.4307987527009, 1028.6451174344838, 1034.446571084466, 1053.2416660004785, 9132.589033493508, 9143.177114059634, 9297.907020929704, 9318.39430437033, 9378.718638440858, 811.4887620798859, 821.8890449789202, 824.332290844406, 834.4867906237741, 845.7209120990059, 5497.976113137758, 5512.0, 5541.251930989265, 5622.718864056781, 5650.576206784508, 25439.0, 26346.73653263443, 26658.06696765604, 27373.726262737517, 27391.863040684668, 25454.74545254561, 26434.206973790817, 26707.599386009224, 26795.196144115707, 26975.730242697715, 11592.710182245512, 11932.940335298441, 12983.610491685076, 13083.476660933646, 13432.932835335761, 10507.264491485523, 10579.206559507913, 10605.098566621924, 10728.356298622108, 10733.94633026861, 22139.0, 22264.443388915406, 22948.082076716746, 23008.4247893804, 23326.0, 23518.882405588545, 23666.645000324665, 23956.760432395455, 24051.51896962016, 24241.878790605933, 13873.375698093812, 14031.29843507841, 14083.647908802363, 14126.434942602591, 14144.504942326968, 15976.0, 16130.435434759727, 16178.67642647164, 16206.51380458541, 16211.432599858948, 12182.208156469802, 12404.19372740769, 12420.937895310466, 12606.621801345975, 12694.682632934251, 12977.870221298044, 13010.284434355823, 13075.803862941873, 13197.934010329887, 13205.867941320465, 11229.21395502307, 11363.204575679623, 11408.087353011904, 11436.485358159069, 11455.541778328774, 8804.427712198943, 8845.601947912488, 8881.24509416681, 8940.821183576421, 9001.32490063261, 8292.419530632798, 8392.580370981548, 8416.28461580748, 8442.071372148936, 8491.448055876348], "value": 7708.192374222471, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.2981517825486, 569.5614376929767, 583.7031281905698, 601.7081715368046, 603.8490377405649, 6326.841828954272, 6387.904181437282, 6398.1042654028415, 6425.839354016152, 6440.645764482952, 6232.127502149703, 6252.155958945541, 6283.560150789446, 6304.432601065903, 6317.936820631792, 4982.77577509013, 5078.1874900016, 5120.513551212647, 5199.428062913076, 5209.531142197202, 5090.490950904898, 5100.9234861476925, 5107.438181800017, 5118.309028281172, 5131.794728210886, 5017.448080711119, 5018.899622007558, 5060.620453466005, 5060.924086138711, 5091.389033316007, 5071.239314102877, 5092.618053645954, 5096.311997880294, 5113.411957624883, 5114.488551144893, 4657.278121891112, 4679.110968915929, 4679.555442232982, 4685.250359942427, 4709.364235828154, 6153.569250152491, 6168.259808822925, 6183.845403864894, 6198.4731297839735, 6310.463610593105, 5926.259217597801, 5942.881142377171, 5988.670623115727, 6000.4998750312425, 6021.939780602182, 6756.797296081126, 6796.082528858639, 6796.592204467748, 6797.796066118024, 6835.086175870764, 4940.555350018516, 5102.438731739506, 5144.6655967362, 5164.45773193813, 5188.2619322527, 6903.930960690379, 6967.198772141218, 6969.54697944632, 7014.298570142996, 7086.255943126001, 5333.8133165339805, 5348.144296912553, 5354.625176237704, 5359.437259087739, 5360.597955153379, 5364.7049412282695, 5413.0, 5457.508824205761, 5460.126379779216, 5468.332158691558, 5946.137810017523, 5964.940350596526, 5999.880002399927, 6018.368071352533, 6024.939750602438, 6824.488163387766, 6834.086455792386, 6884.0, 6887.070245516891, 6897.310268973062, 1847.6581832361055, 1852.527605460599, 1856.647237024961, 1876.127600665697, 1890.6029733756066, 1296.4230917241925, 1314.2968511846116, 1332.886704630098, 1344.213635023522, 1347.528365072217, 6452.935470645328, 6483.902741458882, 6535.313792051861, 6539.8365040873405, 6542.149520562297, 6879.174499060045, 6888.483363747739, 6923.273056329113, 6953.165620125617, 6972.477064220204, 6446.8388290293115, 6476.348531124628, 6479.1901012373455, 6489.480841532666, 6506.577072490273, 3579.534660494119, 3622.3841946869097, 3636.345457817565, 3643.6720695137565, 3661.41417373219, 7241.1897025743565, 7270.600116993616, 7281.652894214587, 7320.377767889789, 7338.0, 7054.435645148375, 7115.92884071163, 7122.2521635228595, 7124.358807707331, 7135.571865688075, 7138.179109402381, 7219.566825990458, 7263.418926485869, 7269.382102521239, 7273.7998230291405, 6835.03567930609, 6870.27862074475, 6898.172219333512, 6906.551074180162, 6932.7226910923, 6711.926091825285, 6753.932460675331, 6772.221194562689, 6822.249552549315, 6835.965820170867, 7057.0, 7243.0, 7274.890281818425, 7292.744753933587, 7301.342879140902, 5304.840854774363, 5308.654937429054, 5317.25558421829, 5338.706371149624, 5378.139497680509, 6559.573627714183, 6644.767433139817, 6827.6244806536115, 6934.202566704894, 6958.652067396712, 6573.220398270918, 6637.933620663925, 6678.0, 6703.363180497845, 6741.258461569321, 6553.672316384066, 6601.141851559267, 6642.734290628321, 6665.133532640726, 6733.730650773914, 6399.616023038632, 6469.7412103515335, 6569.9343006569325, 6618.867622647616, 6622.900656490253, 6724.655068986124, 6732.461403087839, 6750.8649827004165, 6778.188355138202, 6796.59220446755, 6491.48068154537, 6508.9349106508325, 6537.640429776217, 6548.148740663683, 6601.768938087144], "value": 5304.843809616188, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [955.4840386191461, 973.9805203895922, 991.1971303244372, 1004.1615251265193, 1010.4897027001366, 19631.214751409927, 20529.692054619172, 20749.170033198672, 20754.066067026983, 20773.27293544726, 17649.55876103098, 18790.53023674409, 19051.333203337887, 19212.231510739555, 19227.519312017208, 1095.1840878545474, 1099.7580532282884, 1115.576081089185, 1118.59730497021, 1121.8822023687517, 1101.9393933333704, 1105.1324710102572, 1108.9001989820915, 1115.3475216998065, 1116.542217690747, 1130.7908037013137, 1167.9240849344765, 1172.2263306217899, 1172.2614752705783, 1172.78889799836, 1163.5404015413906, 1166.358502823448, 1168.1239070696977, 1168.2348062019391, 1170.2159553099443, 831.1812864328631, 838.5388036579918, 839.0267289943636, 839.0895877972407, 839.6515446089866, 20297.289594864258, 21070.0, 22286.665700014513, 22382.552348953093, 22523.887380563156, 23129.76870231293, 23341.76658233413, 23710.525789484287, 23715.169969051174, 23891.522169556512, 17274.654506909916, 17633.382831600833, 17696.646067078716, 17714.29142834285, 17781.110944452725, 3799.5440547134244, 3800.2209547043067, 3833.6358045985585, 3833.8466461341513, 3835.2137811748526, 125871.0, 146503.0, 161918.99999999884, 162491.1875440615, 162960.0, 18699.158537865827, 18793.81206187948, 19143.712844307345, 19160.90419547893, 19163.904180479007, 35124.0, 35263.0, 35275.0, 35356.823215883756, 36217.0, 10402.167826573856, 10421.322614030063, 10435.94782026085, 10482.056614904543, 10504.264701470976, 4809.615230781529, 4878.609711223094, 4902.994886048352, 4914.483979182134, 4915.926261106087, 6225.128482012522, 6341.714622841891, 6347.0479428086155, 6366.904496432558, 6376.585521941059, 1186.8225787653944, 1205.7046023724245, 1214.4959841665786, 1219.0978675780036, 1219.2806244315896, 739.2755100002028, 750.7072241825692, 759.236966848314, 768.1205020251781, 774.0092681367859, 13545.729085418236, 13592.796108058386, 13735.381907814173, 14943.178125203001, 15080.019798713049, 736.8342123022385, 741.2143128284036, 744.6983971491554, 757.4849102610278, 765.3494529649753, 5848.2689663792025, 5955.285365756137, 5956.434138756811, 6041.033434650435, 6050.909236361458, 156740.0, 157892.0, 158288.20855895878, 158711.0, 158756.66251556663, 130097.34951325183, 130585.34707326592, 131604.3419782895, 135188.32405837908, 139746.0, 113947.0, 115177.0, 116054.15860735132, 117892.0, 120820.79179208272, 13815.516456923959, 14490.63773405631, 14557.92721036388, 14569.344379502736, 14743.705125897208, 57974.13038804506, 58762.41237587741, 60451.0, 61392.562518036226, 61688.0, 74926.25073749192, 75495.0, 75770.0, 76748.61625691837, 77406.2259377399, 19833.20667173297, 19852.90073549623, 20309.187632495126, 20356.694649580564, 20382.184712611328, 23239.419014524774, 23618.29145125649, 23785.167519136747, 23844.642330365405, 24277.63583546213, 21853.890730546245, 22033.449163771034, 22087.889560552096, 22094.005769740077, 22614.886925565927, 19772.90113549423, 20052.799472005678, 20107.59784804325, 20208.292709755675, 20262.797372026092, 19530.90234548875, 19639.901800490905, 19698.803011969696, 19745.901270493556, 19842.305519306756, 16198.595035123744, 16417.343306267616, 16499.83500164983, 16590.419335323204, 16797.748033779746, 14215.669124078471, 14246.35891384911, 14250.928745356206, 14302.57092287233, 14475.638109047359], "value": 10495.173223632379, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1357.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 105.0, 103.0, 104.0, 105.0, 105.0, 106.0, 106.0, 104.0, 104.0], "value": 104.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 110.0, 110.0, 110.0, 111.0, 114.0, 115.0, 112.0, 111.0], "value": 111.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 161.0, 162.0, 163.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 85.0, 83.0, 82.0, 76.0, 74.0, 73.0, 75.0], "value": 76.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 77.0, 78.0, 78.0, 77.0, 77.0, 77.0, 76.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 117.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 149.0, 149.0, 149.0, 149.0, 148.0, 148.0, 150.0, 149.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 93.0, 95.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 45.0, 44.0, 45.0, 45.0, 44.0, 43.0, 43.0, 43.0, 44.0], "value": 43.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 39.0, 44.0, 37.0, 38.0, 37.0, 38.0, 37.0], "value": 38.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 71.0, 69.0, 76.0, 75.0, 69.0, 70.0, 74.0, 68.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 106.0, 101.0, 104.0, 106.0, 107.0, 106.0, 101.0, 105.0, 107.0], "value": 104.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 145.0, 148.0, 146.0, 150.0, 148.0, 150.0, 152.0, 148.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 63.0, 58.0, 59.0, 61.0, 64.0, 58.0, 64.0, 60.0, 61.0], "value": 60.4, "unit": "score"}]}]} 08:24:49 INFO - Return code: 0 08:24:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:24:49 INFO - # TBPL SUCCESS # 08:24:49 INFO - Running post-action listener: _package_coverage_data 08:24:49 INFO - Running post-action listener: _resource_record_post_action 08:24:49 INFO - [mozharness: 2017-09-28 15:24:49.095561Z] Finished run-tests step (success) 08:24:49 INFO - Running post-run listener: _resource_record_post_run 08:24:49 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285532160; Read time: 12; Write time: 221724 08:24:49 INFO - TinderboxPrint: CPU usage
13.0% 08:24:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:24:49 INFO - TinderboxPrint: I/O write bytes / time
285,532,160 / 221,724 08:24:49 INFO - TinderboxPrint: CPU idle
8,187.4 (86.9%) 08:24:49 INFO - TinderboxPrint: CPU user
1,179.1 (12.5%) 08:24:49 INFO - TinderboxPrint: Swap in / out
0 / 0 08:24:49 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 8716288; Read time: 0; Write time: 1132 08:24:49 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:49 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276815872; Read time: 12; Write time: 220592 08:24:49 INFO - Running post-run listener: _upload_blobber_files 08:24:49 INFO - Blob upload gear active. 08:24:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:24:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:24:50 INFO - (blobuploader) - INFO - Open directory for files ... 08:24:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:24:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:24:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:51 INFO - (blobuploader) - INFO - Done attempting. 08:24:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:24:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:24:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:52 INFO - (blobuploader) - INFO - Done attempting. 08:24:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:24:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:24:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:55 INFO - (blobuploader) - INFO - Done attempting. 08:24:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:24:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:24:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:56 INFO - (blobuploader) - INFO - Done attempting. 08:24:56 INFO - (blobuploader) - INFO - Iteration through files over. 08:24:56 INFO - Return code: 0 08:24:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:24:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:24:56 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/507e135e10ab565776dd43ecc6da4b296b22ba4eb4f527b819709f3a5ace29587d263f33b9bacefc7f3c23130334577abb3445fc21ec27ddde70fe86cf402019", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e1ce4802133ed5030f1119dbc26724d0f072e6860e67d02582b2a60f5c9bc0bf36f71779e3b983892f9a312aef9132b353827f15d3ce65bac206a9373a6f2385", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5ddbf612f44993d506fe77c33e66c72333642bd8b995fa54437dae7f949919a3d9feaa8d76596469f562427ebe7f77716481c39bc22c23b7de9226e7619100c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c32fb0571e51a911bd9a6ed53ad881e6529af940a6c0af5a6703331abc29ed6c0691983364b6c8913b2e42a4357c6d51bff61bdea826bda76128f1875ecd20b4"} 08:24:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:24:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:24:56 INFO - Contents: 08:24:56 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/507e135e10ab565776dd43ecc6da4b296b22ba4eb4f527b819709f3a5ace29587d263f33b9bacefc7f3c23130334577abb3445fc21ec27ddde70fe86cf402019", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e1ce4802133ed5030f1119dbc26724d0f072e6860e67d02582b2a60f5c9bc0bf36f71779e3b983892f9a312aef9132b353827f15d3ce65bac206a9373a6f2385", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5ddbf612f44993d506fe77c33e66c72333642bd8b995fa54437dae7f949919a3d9feaa8d76596469f562427ebe7f77716481c39bc22c23b7de9226e7619100c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c32fb0571e51a911bd9a6ed53ad881e6529af940a6c0af5a6703331abc29ed6c0691983364b6c8913b2e42a4357c6d51bff61bdea826bda76128f1875ecd20b4"} 08:24:56 INFO - Running post-run listener: copy_logs_to_upload_dir 08:24:56 INFO - Copying logs to upload dir... 08:24:56 INFO - mkdir: /builds/slave/test/build/upload/logs 08:24:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.437499 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-09-28 08:24:56.661161) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 08:24:56.665183) ========= 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=836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/507e135e10ab565776dd43ecc6da4b296b22ba4eb4f527b819709f3a5ace29587d263f33b9bacefc7f3c23130334577abb3445fc21ec27ddde70fe86cf402019", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e1ce4802133ed5030f1119dbc26724d0f072e6860e67d02582b2a60f5c9bc0bf36f71779e3b983892f9a312aef9132b353827f15d3ce65bac206a9373a6f2385", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5ddbf612f44993d506fe77c33e66c72333642bd8b995fa54437dae7f949919a3d9feaa8d76596469f562427ebe7f77716481c39bc22c23b7de9226e7619100c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c32fb0571e51a911bd9a6ed53ad881e6529af940a6c0af5a6703331abc29ed6c0691983364b6c8913b2e42a4357c6d51bff61bdea826bda76128f1875ecd20b4"} build_url:https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/IuPWjna2RiSGSle6JpgmyQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/507e135e10ab565776dd43ecc6da4b296b22ba4eb4f527b819709f3a5ace29587d263f33b9bacefc7f3c23130334577abb3445fc21ec27ddde70fe86cf402019", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e1ce4802133ed5030f1119dbc26724d0f072e6860e67d02582b2a60f5c9bc0bf36f71779e3b983892f9a312aef9132b353827f15d3ce65bac206a9373a6f2385", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5ddbf612f44993d506fe77c33e66c72333642bd8b995fa54437dae7f949919a3d9feaa8d76596469f562427ebe7f77716481c39bc22c23b7de9226e7619100c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c32fb0571e51a911bd9a6ed53ad881e6529af940a6c0af5a6703331abc29ed6c0691983364b6c8913b2e42a4357c6d51bff61bdea826bda76128f1875ecd20b4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 08:24:56.693506) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 08:24:56.697855) ========= 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=836cfdc75598d54cb747368e000001a9-1506610578.48878-316307826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004737 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 08:24:56.748990) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 08:24:56.749304) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 08:24:56.749622) ========= ========= Total master_lag: 0.24 =========