builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1506709691.87 results: success (0) revision: a8f12062e78c7d58e25c25ced1a681439415c5e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 11:28:11.867005) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 11:28:11.867461) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 11:28:11.867736) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 11:28:11.902993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 11:28:11.903257) ========= 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=52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-29 11:28:11-- 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% 31.7M=0s 2017-09-29 11:28:12 (31.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.173609 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 11:28:12.126632) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 11:28:12.127122) ========= 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=52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015595 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 11:28:12.176760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 11:28:12.177108) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a8f12062e78c7d58e25c25ced1a681439415c5e5 --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 a8f12062e78c7d58e25c25ced1a681439415c5e5 --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=52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-29 11:28:12,230 truncating revision to first 12 chars 2017-09-29 11:28:12,230 Setting DEBUG logging. 2017-09-29 11:28:12,230 attempt 1/10 2017-09-29 11:28:12,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a8f12062e78c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-29 11:28:12,593 unpacking tar archive at: mozilla-beta-a8f12062e78c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683126 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 11:28:12.876896) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 11:28:12.877201) ========= script_repo_revision: a8f12062e78c7d58e25c25ced1a681439415c5e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 11:28:12.877604) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 11:28:12.877877) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 11:28:12.891477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-29 11:28:12.891910) ========= /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=52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:28:13 INFO - MultiFileLogger online at 20170929 11:28:13 in /builds/slave/test 11:28:13 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 11:28:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:28:13 INFO - {'append_to_log': False, 11:28:13 INFO - 'base_work_dir': '/builds/slave/test', 11:28:13 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 11:28:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:28:13 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 11:28:13 INFO - 'buildbot_json_path': 'buildprops.json', 11:28:13 INFO - 'code_coverage': False, 11:28:13 INFO - 'config_files': ('talos/linux_config.py',), 11:28:13 INFO - 'default_actions': ('clobber', 11:28:13 INFO - 'read-buildbot-config', 11:28:13 INFO - 'download-and-extract', 11:28:13 INFO - 'populate-webroot', 11:28:13 INFO - 'create-virtualenv', 11:28:13 INFO - 'install', 11:28:13 INFO - 'setup-mitmproxy', 11:28:13 INFO - 'run-tests'), 11:28:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:28:13 INFO - 'disable_ccov_upload': False, 11:28:13 INFO - 'disable_stylo': False, 11:28:13 INFO - 'download_minidump_stackwalk': True, 11:28:13 INFO - 'download_symbols': 'ondemand', 11:28:13 INFO - 'enable_stylo': False, 11:28:13 INFO - 'enable_webrender': False, 11:28:13 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:28:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:28:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:28:13 INFO - 'gecko_profile': False, 11:28:13 INFO - 'gecko_profile_interval': 0, 11:28:13 INFO - 'installer_path': 'installer.exe', 11:28:13 INFO - 'log_level': 'info', 11:28:13 INFO - 'log_name': 'talos', 11:28:13 INFO - 'log_to_console': True, 11:28:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:28:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:28:13 INFO - 'opt_config_files': (), 11:28:13 INFO - 'pip_index': False, 11:28:13 INFO - 'suite': 'dromaeojs-e10s', 11:28:13 INFO - 'system_bits': '32', 11:28:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:28:13 INFO - 'title': 'talos-linux64-ix-056', 11:28:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:28:13 INFO - 'use_talos_json': True, 11:28:13 INFO - 'verify': 'False', 11:28:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:28:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:28:13 INFO - 'work_dir': 'build'} 11:28:13 INFO - [mozharness: 2017-09-29 18:28:13.189909Z] Running clobber step. 11:28:13 INFO - Running pre-action listener: _resource_record_pre_action 11:28:13 INFO - Running main action method: clobber 11:28:13 INFO - rmtree: /builds/slave/test/build 11:28:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:28:14 INFO - Running post-action listener: _resource_record_post_action 11:28:14 INFO - [mozharness: 2017-09-29 18:28:14.131414Z] Finished clobber step (success) 11:28:14 INFO - [mozharness: 2017-09-29 18:28:14.131512Z] Running read-buildbot-config step. 11:28:14 INFO - Running pre-action listener: _resource_record_pre_action 11:28:14 INFO - Running main action method: read_buildbot_config 11:28:14 INFO - Using buildbot properties: 11:28:14 INFO - { 11:28:14 INFO - "project": "", 11:28:14 INFO - "product": "firefox", 11:28:14 INFO - "who": "ryanvm@gmail.com", 11:28:14 INFO - "installer_path": "public/build/target.tar.bz2", 11:28:14 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:28:14 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 11:28:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 11:28:14 INFO - "stage_platform": "linux64", 11:28:14 INFO - "basedir": "/builds/slave/test", 11:28:14 INFO - "buildnumber": 124, 11:28:14 INFO - "platform": "ubuntu64_hw", 11:28:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:28:14 INFO - "slavebuilddir": "test", 11:28:14 INFO - "taskId": "ICTAUoTrRNmO6N0ViJDVLw", 11:28:14 INFO - "branch": "mozilla-beta", 11:28:14 INFO - "script_repo_revision": "production", 11:28:14 INFO - "revision": "a8f12062e78c7d58e25c25ced1a681439415c5e5", 11:28:14 INFO - "slavename": "talos-linux64-ix-056", 11:28:14 INFO - "repo_path": "releases/mozilla-beta" 11:28:14 INFO - } 11:28:14 INFO - Finding installer, test and symbols from parent task. 11:28:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ICTAUoTrRNmO6N0ViJDVLw'}, attempt #1 11:28:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ICTAUoTrRNmO6N0ViJDVLw'}, attempt #1 11:28:15 INFO - Task dependencies: dq74M0t_Rbal6PQJbvk0CQ 11:28:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ'}, attempt #1 11:28:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.tar.bz2 11:28:15 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.test_packages.json 11:28:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.crashreporter-symbols.zip 11:28:15 INFO - Running post-action listener: _resource_record_post_action 11:28:15 INFO - [mozharness: 2017-09-29 18:28:15.609430Z] Finished read-buildbot-config step (success) 11:28:15 INFO - [mozharness: 2017-09-29 18:28:15.609648Z] Running download-and-extract step. 11:28:15 INFO - Running pre-action listener: _resource_record_pre_action 11:28:15 INFO - Running main action method: download_and_extract 11:28:15 INFO - mkdir: /builds/slave/test/build/tests 11:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:15 INFO - trying https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.test_packages.json 11:28:15 INFO - Downloading https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:28:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:28:16 INFO - Downloaded 989 bytes. 11:28:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:28:16 INFO - Using the following test package requirements: 11:28:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:28:16 INFO - u'common': [u'target.common.tests.zip'], 11:28:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:28:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:28:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:28:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:28:16 INFO - u'mozbase': [u'target.common.tests.zip'], 11:28:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:28:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:28:16 INFO - u'web-platform': [u'target.common.tests.zip', 11:28:16 INFO - u'target.web-platform.tests.tar.gz'], 11:28:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:28:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:28:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.common.tests.zip 11:28:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:28:16 INFO - Fetch https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.common.tests.zip into memory 11:28:18 INFO - Content-Length response header: 55177272 11:28:18 INFO - Bytes received: 55177272 11:28:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.talos.tests.zip 11:28:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:28:30 INFO - Fetch https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.talos.tests.zip into memory 11:28:31 INFO - Content-Length response header: 14509184 11:28:31 INFO - Bytes received: 14509184 11:28:31 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')]} 11:28:31 INFO - trying https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.tar.bz2 11:28:31 INFO - Downloading https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:28:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:28:33 INFO - Downloaded 53513804 bytes. 11:28:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.tar.bz2 11:28:33 INFO - mkdir: /builds/slave/test/properties 11:28:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:28:33 INFO - Writing to file /builds/slave/test/properties/build_url 11:28:33 INFO - Contents: 11:28:33 INFO - build_url:https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.tar.bz2 11:28:33 INFO - Running post-action listener: _resource_record_post_action 11:28:33 INFO - Running post-action listener: find_tests_for_verification 11:28:33 INFO - Running post-action listener: set_extra_try_arguments 11:28:33 INFO - [mozharness: 2017-09-29 18:28:33.874990Z] Finished download-and-extract step (success) 11:28:33 INFO - [mozharness: 2017-09-29 18:28:33.875088Z] Running populate-webroot step. 11:28:33 INFO - Running pre-action listener: _resource_record_pre_action 11:28:33 INFO - Running main action method: populate_webroot 11:28:33 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:28:33 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:33 INFO - 'tests': ['tresize', 11:28:33 INFO - 'tcanvasmark']}, 11:28:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:28:33 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:33 INFO - 'tests': ['dromaeo_css', 11:28:33 INFO - 'kraken']}, 11:28:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:28:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:28:33 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:28:33 INFO - 'talos_options': ['--disable-stylo'], 11:28:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:28:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:28:33 INFO - 'tests': ['damp', 'tps']}, 11:28:33 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:28:33 INFO - 'talos_options': ['--disable-stylo'], 11:28:33 INFO - 'tests': ['damp', 'tps']}, 11:28:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:28:33 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:33 INFO - 'tests': ['dromaeo_dom']}, 11:28:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:28:33 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:33 INFO - 'tests': ['basic_compositor_video', 11:28:33 INFO - 'glvideo']}, 11:28:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:28:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:28:33 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:28:33 INFO - 'talos_options': ['--disable-stylo'], 11:28:33 INFO - 'tests': ['ts_paint_webext', 11:28:33 INFO - 'tp5o_webext']}, 11:28:33 INFO - 'other-e10s': {'tests': ['a11yr', 11:28:33 INFO - 'ts_paint', 11:28:33 INFO - 'tpaint', 11:28:33 INFO - 'sessionrestore', 11:28:33 INFO - 'sessionrestore_many_windows', 11:28:33 INFO - 'sessionrestore_no_auto_restore', 11:28:33 INFO - 'tabpaint']}, 11:28:33 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:33 INFO - 'tests': ['a11yr', 11:28:33 INFO - 'ts_paint', 11:28:33 INFO - 'tpaint', 11:28:33 INFO - 'sessionrestore', 11:28:33 INFO - 'sessionrestore_many_windows', 11:28:33 INFO - 'sessionrestore_no_auto_restore', 11:28:33 INFO - 'tabpaint']}, 11:28:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:28:33 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:28:33 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:33 INFO - 'tests': ['perf_reftest_singletons']}, 11:28:33 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:33 INFO - 'tests': ['bloom_basic']}, 11:28:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:28:33 INFO - 'tsvgr_opacity', 11:28:33 INFO - 'tart', 11:28:33 INFO - 'tscrollx', 11:28:33 INFO - 'tsvg_static']}, 11:28:33 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:28:33 INFO - 'tests': ['tsvgx', 11:28:33 INFO - 'tsvgr_opacity', 11:28:33 INFO - 'tart', 11:28:33 INFO - 'tscrollx', 11:28:33 INFO - 'tsvg_static']}, 11:28:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:28:33 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:28:33 INFO - 'talos_options': ['--disable-stylo'], 11:28:33 INFO - 'tests': ['tp5o']}, 11:28:33 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:28:33 INFO - 'talos_options': ['--mitmproxy', 11:28:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:28:33 INFO - '--firstNonBlankPaint'], 11:28:33 INFO - 'tests': ['tp6_google', 11:28:33 INFO - 'tp6_youtube', 11:28:33 INFO - 'tp6_amazon', 11:28:33 INFO - 'tp6_facebook']}, 11:28:33 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:28:33 INFO - 'talos_options': ['--disable-stylo', 11:28:33 INFO - '--mitmproxy', 11:28:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:28:33 INFO - '--firstNonBlankPaint'], 11:28:33 INFO - 'tests': ['tp6_google', 11:28:33 INFO - 'tp6_youtube', 11:28:33 INFO - 'tp6_amazon', 11:28:33 INFO - 'tp6_facebook']}, 11:28:33 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:28:33 INFO - 'talos_options': ['--stylo-threads=1', 11:28:33 INFO - '--mitmproxy', 11:28:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:28:33 INFO - '--firstNonBlankPaint'], 11:28:33 INFO - 'tests': ['tp6_google', 11:28:33 INFO - 'tp6_youtube', 11:28:33 INFO - 'tp6_amazon', 11:28:33 INFO - 'tp6_facebook']}, 11:28:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:28:33 INFO - 'talos_options': ['--xperf_path', 11:28:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:28:33 INFO - 'tests': ['tp5n']}, 11:28:33 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:28:33 INFO - 'talos_options': ['--disable-stylo', 11:28:33 INFO - '--xperf_path', 11:28:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:28:33 INFO - 'tests': ['tp5n']}}} 11:28:33 INFO - Running post-action listener: _resource_record_post_action 11:28:33 INFO - [mozharness: 2017-09-29 18:28:33.890167Z] Finished populate-webroot step (success) 11:28:33 INFO - [mozharness: 2017-09-29 18:28:33.890256Z] Running create-virtualenv step. 11:28:33 INFO - Running pre-action listener: _resource_record_pre_action 11:28:33 INFO - Running main action method: create_virtualenv 11:28:33 INFO - Creating virtualenv /builds/slave/test/build/venv 11:28:33 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:28:33 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:28:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:28:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:28:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:28:36 INFO - Installing distribute.............................................................................................................................................................................................done. 11:28:37 INFO - Installing pip...............done. 11:28:37 INFO - Return code: 0 11:28:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:28:37 INFO - Reading from file tmpfile_stdout 11:28:37 INFO - Output received: 11:28:37 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:28:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:28:37 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')]} 11:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:37 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')]} 11:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:37 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 0x9e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56090>, '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 0xd56d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50f90>, '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': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', '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 11:28:37 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 11:28:37 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 11:28:37 INFO - Using env: {'DISPLAY': ':0', 11:28:37 INFO - 'HOME': '/home/cltbld', 11:28:37 INFO - 'LANG': 'en_US.UTF-8', 11:28:37 INFO - 'LANGUAGE': 'en_US:en', 11:28:37 INFO - 'LOGNAME': 'cltbld', 11:28:37 INFO - 'MAIL': '/var/mail/cltbld', 11:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:37 INFO - 'MOZ_NO_REMOTE': '1', 11:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:37 INFO - 'NO_EM_RESTART': '1', 11:28:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:37 INFO - 'PWD': '/builds/slave/test', 11:28:37 INFO - 'SHELL': '/bin/bash', 11:28:37 INFO - 'SHLVL': '1', 11:28:37 INFO - 'TERM': 'linux', 11:28:37 INFO - 'TMOUT': '86400', 11:28:37 INFO - 'USER': 'cltbld', 11:28:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', 11:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:37 INFO - '_': '/tools/buildbot/bin/python'} 11:28:39 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:28:39 INFO - Downloading/unpacking pip>=1.5 11:28:39 INFO - Running setup.py egg_info for package pip 11:28:39 INFO - warning: no files found matching 'pip/cacert.pem' 11:28:39 INFO - warning: no files found matching '*.html' under directory 'docs' 11:28:39 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:28:39 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:28:39 INFO - Installing collected packages: pip 11:28:39 INFO - Found existing installation: pip 1.1 11:28:39 INFO - Uninstalling pip: 11:28:39 INFO - Successfully uninstalled pip 11:28:39 INFO - Running setup.py install for pip 11:28:39 INFO - warning: no files found matching 'pip/cacert.pem' 11:28:39 INFO - warning: no files found matching '*.html' under directory 'docs' 11:28:39 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:28:39 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:28:39 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:28:39 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:28:39 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:28:39 INFO - Successfully installed pip 11:28:39 INFO - Cleaning up... 11:28:39 INFO - Return code: 0 11:28:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:39 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 0x9e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56090>, '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 0xd56d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50f90>, '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': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', '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 11:28:39 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 11:28:39 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 11:28:39 INFO - Using env: {'DISPLAY': ':0', 11:28:39 INFO - 'HOME': '/home/cltbld', 11:28:39 INFO - 'LANG': 'en_US.UTF-8', 11:28:39 INFO - 'LANGUAGE': 'en_US:en', 11:28:39 INFO - 'LOGNAME': 'cltbld', 11:28:39 INFO - 'MAIL': '/var/mail/cltbld', 11:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:39 INFO - 'MOZ_NO_REMOTE': '1', 11:28:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:39 INFO - 'NO_EM_RESTART': '1', 11:28:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:39 INFO - 'PWD': '/builds/slave/test', 11:28:39 INFO - 'SHELL': '/bin/bash', 11:28:39 INFO - 'SHLVL': '1', 11:28:39 INFO - 'TERM': 'linux', 11:28:39 INFO - 'TMOUT': '86400', 11:28:39 INFO - 'USER': 'cltbld', 11:28:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', 11:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:39 INFO - '_': '/tools/buildbot/bin/python'} 11:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:39 INFO - Downloading/unpacking psutil>=3.1.1 11:28:39 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 11:28:39 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 11:28:39 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 11:28:39 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 11:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:28:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:28:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:28:41 INFO - Installing collected packages: psutil 11:28:41 INFO - Running setup.py install for psutil 11:28:41 INFO - building 'psutil._psutil_linux' extension 11:28:41 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 11:28:42 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 11:28:42 INFO - building 'psutil._psutil_posix' extension 11:28:42 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 11:28:42 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 11:28:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:28:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:28:42 INFO - Successfully installed psutil 11:28:42 INFO - Cleaning up... 11:28:42 INFO - Return code: 0 11:28:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:28:42 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')]} 11:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:42 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')]} 11:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:42 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 0x9e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56090>, '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 0xd56d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50f90>, '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': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', '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 11:28:42 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 11:28:42 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 11:28:42 INFO - Using env: {'DISPLAY': ':0', 11:28:42 INFO - 'HOME': '/home/cltbld', 11:28:42 INFO - 'LANG': 'en_US.UTF-8', 11:28:42 INFO - 'LANGUAGE': 'en_US:en', 11:28:42 INFO - 'LOGNAME': 'cltbld', 11:28:42 INFO - 'MAIL': '/var/mail/cltbld', 11:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:42 INFO - 'MOZ_NO_REMOTE': '1', 11:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:42 INFO - 'NO_EM_RESTART': '1', 11:28:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:42 INFO - 'PWD': '/builds/slave/test', 11:28:42 INFO - 'SHELL': '/bin/bash', 11:28:42 INFO - 'SHLVL': '1', 11:28:42 INFO - 'TERM': 'linux', 11:28:42 INFO - 'TMOUT': '86400', 11:28:42 INFO - 'USER': 'cltbld', 11:28:42 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', 11:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:42 INFO - '_': '/tools/buildbot/bin/python'} 11:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:28:43 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 11:28:43 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 11:28:43 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 11:28:43 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 11:28:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:28:44 INFO - Installing collected packages: mozsystemmonitor 11:28:44 INFO - Running setup.py install for mozsystemmonitor 11:28:44 INFO - Successfully installed mozsystemmonitor 11:28:44 INFO - Cleaning up... 11:28:44 INFO - Return code: 0 11:28:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:28: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')]} 11:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28: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')]} 11:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:44 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 0x9e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56090>, '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 0xd56d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50f90>, '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': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', '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 11:28:44 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 11:28:44 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 11:28:44 INFO - Using env: {'DISPLAY': ':0', 11:28:44 INFO - 'HOME': '/home/cltbld', 11:28:44 INFO - 'LANG': 'en_US.UTF-8', 11:28:44 INFO - 'LANGUAGE': 'en_US:en', 11:28:44 INFO - 'LOGNAME': 'cltbld', 11:28:44 INFO - 'MAIL': '/var/mail/cltbld', 11:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:44 INFO - 'MOZ_NO_REMOTE': '1', 11:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:44 INFO - 'NO_EM_RESTART': '1', 11:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:44 INFO - 'PWD': '/builds/slave/test', 11:28:44 INFO - 'SHELL': '/bin/bash', 11:28:44 INFO - 'SHLVL': '1', 11:28:44 INFO - 'TERM': 'linux', 11:28:44 INFO - 'TMOUT': '86400', 11:28:44 INFO - 'USER': 'cltbld', 11:28:44 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', 11:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:44 INFO - '_': '/tools/buildbot/bin/python'} 11:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:44 INFO - Downloading/unpacking jsonschema==2.5.1 11:28:44 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 11:28:44 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 11:28:44 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 11:28:44 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 11:28:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:28:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:28:45 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 11:28:45 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 11:28:45 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 11:28:45 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 11:28:45 INFO - Downloading functools32-3.2.3-2.tar.gz 11:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:28:45 INFO - warning: no files found matching '*.txt' 11:28:45 INFO - no previously-included directories found matching 'build' 11:28:45 INFO - no previously-included directories found matching 'dist' 11:28:45 INFO - no previously-included directories found matching '.git*' 11:28:45 INFO - Installing collected packages: jsonschema, functools32 11:28:46 INFO - Running setup.py install for functools32 11:28:46 INFO - warning: no files found matching '*.txt' 11:28:46 INFO - no previously-included directories found matching 'build' 11:28:46 INFO - no previously-included directories found matching 'dist' 11:28:46 INFO - no previously-included directories found matching '.git*' 11:28:46 INFO - Successfully installed jsonschema functools32 11:28:46 INFO - Cleaning up... 11:28:46 INFO - Return code: 0 11:28:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:28:46 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')]} 11:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:46 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')]} 11:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:46 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 0x9e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56090>, '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 0xd56d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50f90>, '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': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', '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 11:28:46 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 11:28:46 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 11:28:46 INFO - Using env: {'DISPLAY': ':0', 11:28:46 INFO - 'HOME': '/home/cltbld', 11:28:46 INFO - 'LANG': 'en_US.UTF-8', 11:28:46 INFO - 'LANGUAGE': 'en_US:en', 11:28:46 INFO - 'LOGNAME': 'cltbld', 11:28:46 INFO - 'MAIL': '/var/mail/cltbld', 11:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:46 INFO - 'MOZ_NO_REMOTE': '1', 11:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:46 INFO - 'NO_EM_RESTART': '1', 11:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:46 INFO - 'PWD': '/builds/slave/test', 11:28:46 INFO - 'SHELL': '/bin/bash', 11:28:46 INFO - 'SHLVL': '1', 11:28:46 INFO - 'TERM': 'linux', 11:28:46 INFO - 'TMOUT': '86400', 11:28:46 INFO - 'USER': 'cltbld', 11:28:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', 11:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:46 INFO - '_': '/tools/buildbot/bin/python'} 11:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:28:46 INFO - Cleaning up... 11:28:46 INFO - Return code: 0 11:28:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:28:46 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')]} 11:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:46 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')]} 11:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:46 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 0x9e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56090>, '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 0xd56d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50f90>, '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': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', '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 11:28:46 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 11:28:46 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 11:28:46 INFO - Using env: {'DISPLAY': ':0', 11:28:46 INFO - 'HOME': '/home/cltbld', 11:28:46 INFO - 'LANG': 'en_US.UTF-8', 11:28:46 INFO - 'LANGUAGE': 'en_US:en', 11:28:46 INFO - 'LOGNAME': 'cltbld', 11:28:46 INFO - 'MAIL': '/var/mail/cltbld', 11:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:46 INFO - 'MOZ_NO_REMOTE': '1', 11:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:46 INFO - 'NO_EM_RESTART': '1', 11:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:46 INFO - 'PWD': '/builds/slave/test', 11:28:46 INFO - 'SHELL': '/bin/bash', 11:28:46 INFO - 'SHLVL': '1', 11:28:46 INFO - 'TERM': 'linux', 11:28:46 INFO - 'TMOUT': '86400', 11:28:46 INFO - 'USER': 'cltbld', 11:28:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', 11:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:46 INFO - '_': '/tools/buildbot/bin/python'} 11:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:46 INFO - Downloading/unpacking blobuploader==1.2.4 11:28:46 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 11:28:46 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 11:28:46 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 11:28:46 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 11:28:47 INFO - Downloading blobuploader-1.2.4.tar.gz 11:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:28:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:28:47 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 11:28:47 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 11:28:47 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 11:28:47 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 11:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:28:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:48 INFO - Downloading docopt-0.6.1.tar.gz 11:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:28:48 INFO - Installing collected packages: blobuploader, requests, docopt 11:28:48 INFO - Running setup.py install for blobuploader 11:28:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:28:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:28:48 INFO - Running setup.py install for requests 11:28:48 INFO - Running setup.py install for docopt 11:28:48 INFO - Successfully installed blobuploader requests docopt 11:28:48 INFO - Cleaning up... 11:28:48 INFO - Return code: 0 11:28:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28: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')]} 11:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28: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')]} 11:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:48 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 0x9e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56090>, '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 0xd56d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50f90>, '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': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', '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 11:28:48 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 11:28:48 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 11:28:48 INFO - Using env: {'DISPLAY': ':0', 11:28:48 INFO - 'HOME': '/home/cltbld', 11:28:48 INFO - 'LANG': 'en_US.UTF-8', 11:28:48 INFO - 'LANGUAGE': 'en_US:en', 11:28:48 INFO - 'LOGNAME': 'cltbld', 11:28:48 INFO - 'MAIL': '/var/mail/cltbld', 11:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:48 INFO - 'MOZ_NO_REMOTE': '1', 11:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:48 INFO - 'NO_EM_RESTART': '1', 11:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:48 INFO - 'PWD': '/builds/slave/test', 11:28:48 INFO - 'SHELL': '/bin/bash', 11:28:48 INFO - 'SHLVL': '1', 11:28:48 INFO - 'TERM': 'linux', 11:28:48 INFO - 'TMOUT': '86400', 11:28:48 INFO - 'USER': 'cltbld', 11:28:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', 11:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:48 INFO - '_': '/tools/buildbot/bin/python'} 11:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:28:49 INFO - Running setup.py (path:/tmp/pip-fyziVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:28:49 INFO - Running setup.py (path:/tmp/pip-pqu8sU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:28:49 INFO - Running setup.py (path:/tmp/pip-rffTYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:28:49 INFO - Running setup.py (path:/tmp/pip-umV_E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:28:49 INFO - Running setup.py (path:/tmp/pip-nAy3Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:28:49 INFO - Running setup.py (path:/tmp/pip-hyxnN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:28:49 INFO - Running setup.py (path:/tmp/pip-m91Er8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:28:49 INFO - Running setup.py (path:/tmp/pip-Zi1ZuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:28:49 INFO - Running setup.py (path:/tmp/pip-aenw97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:28:49 INFO - Running setup.py (path:/tmp/pip-UnA6gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:28:49 INFO - Running setup.py (path:/tmp/pip-j_Urqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:28:49 INFO - Running setup.py (path:/tmp/pip-s6Hu7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:28:49 INFO - Running setup.py (path:/tmp/pip-BRQgxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:28:50 INFO - Running setup.py (path:/tmp/pip-UpmZZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:50 INFO - Running setup.py (path:/tmp/pip-_j2LWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:28:50 INFO - Running setup.py (path:/tmp/pip-e1ADXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:28:50 INFO - Running setup.py (path:/tmp/pip-S8STRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:28:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:28:50 INFO - Running setup.py install for manifestparser 11:28:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:28:50 INFO - Running setup.py install for mozcrash 11:28:50 INFO - Running setup.py install for mozdebug 11:28:50 INFO - Running setup.py install for mozdevice 11:28:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:28:50 INFO - Running setup.py install for mozfile 11:28:50 INFO - Running setup.py install for mozhttpd 11:28:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:28:50 INFO - Running setup.py install for mozinfo 11:28:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:28:51 INFO - Running setup.py install for mozInstall 11:28:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:28:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:28:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:28:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:28:51 INFO - Running setup.py install for mozleak 11:28:51 INFO - Running setup.py install for mozlog 11:28:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:28:51 INFO - Running setup.py install for moznetwork 11:28:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:28:51 INFO - Running setup.py install for mozprocess 11:28:51 INFO - Running setup.py install for mozprofile 11:28:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:28:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:28:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:28:51 INFO - Running setup.py install for mozrunner 11:28:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:28:51 INFO - Running setup.py install for mozscreenshot 11:28:51 INFO - Running setup.py install for moztest 11:28:51 INFO - Running setup.py install for mozversion 11:28:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:28:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:28:52 INFO - Cleaning up... 11:28:52 INFO - Return code: 0 11:28:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28:52 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')]} 11:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:52 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')]} 11:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:52 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 0x9e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56090>, '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 0xd56d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50f90>, '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': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', '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 11:28:52 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 11:28:52 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 11:28:52 INFO - Using env: {'DISPLAY': ':0', 11:28:52 INFO - 'HOME': '/home/cltbld', 11:28:52 INFO - 'LANG': 'en_US.UTF-8', 11:28:52 INFO - 'LANGUAGE': 'en_US:en', 11:28:52 INFO - 'LOGNAME': 'cltbld', 11:28:52 INFO - 'MAIL': '/var/mail/cltbld', 11:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:52 INFO - 'MOZ_NO_REMOTE': '1', 11:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:52 INFO - 'NO_EM_RESTART': '1', 11:28:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:52 INFO - 'PWD': '/builds/slave/test', 11:28:52 INFO - 'SHELL': '/bin/bash', 11:28:52 INFO - 'SHLVL': '1', 11:28:52 INFO - 'TERM': 'linux', 11:28:52 INFO - 'TMOUT': '86400', 11:28:52 INFO - 'USER': 'cltbld', 11:28:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', 11:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:52 INFO - '_': '/tools/buildbot/bin/python'} 11:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:28:52 INFO - Running setup.py (path:/tmp/pip-fT3d0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:28:52 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)) 11:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:28:52 INFO - Running setup.py (path:/tmp/pip-CM8aR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:28:52 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)) 11:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:28:52 INFO - Running setup.py (path:/tmp/pip-tMG690-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:28:52 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)) 11:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:28:52 INFO - Running setup.py (path:/tmp/pip-CHvhmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:28:52 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)) 11:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:28:52 INFO - Running setup.py (path:/tmp/pip-Ie1fFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:28:52 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)) 11:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:28:52 INFO - Running setup.py (path:/tmp/pip-vZEI0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:28:52 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)) 11:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:28:52 INFO - Running setup.py (path:/tmp/pip-Ma78oB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:28:52 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)) 11:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:28:52 INFO - Running setup.py (path:/tmp/pip-x4lE39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:28:52 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)) 11:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:28:52 INFO - Running setup.py (path:/tmp/pip-SfxjGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:28:52 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)) 11:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:28:52 INFO - Running setup.py (path:/tmp/pip-U2z75x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:28:53 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)) 11:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:28:53 INFO - Running setup.py (path:/tmp/pip-F1DJCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:28:53 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)) 11:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:28:53 INFO - Running setup.py (path:/tmp/pip-LoAuCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:28:53 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)) 11:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:28:53 INFO - Running setup.py (path:/tmp/pip-nVaSbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:28:53 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)) 11:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:28:53 INFO - Running setup.py (path:/tmp/pip-6QS1pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:28:53 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)) 11:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:53 INFO - Running setup.py (path:/tmp/pip-umC3vQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:53 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)) 11:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:28:53 INFO - Running setup.py (path:/tmp/pip-CqCgk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:28:53 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)) 11:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:28:53 INFO - Running setup.py (path:/tmp/pip-BGA1_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:28:53 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)) 11:28:53 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)) 11:28:53 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)) 11:28:53 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)) 11:28:53 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)) 11:28:53 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)) 11:28:53 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)) 11:28:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:28: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 11:28: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 11:28: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 11:28: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 11:28:54 INFO - Downloading blessings-1.6.tar.gz 11:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:28:54 INFO - Installing collected packages: blessings 11:28:54 INFO - Running setup.py install for blessings 11:28:54 INFO - Successfully installed blessings 11:28:54 INFO - Cleaning up... 11:28:54 INFO - Return code: 0 11:28:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:28:55 INFO - Reading from file tmpfile_stdout 11:28:55 INFO - Current package versions: 11:28:55 INFO - argparse == 1.2.1 11:28:55 INFO - blessings == 1.6 11:28:55 INFO - blobuploader == 1.2.4 11:28:55 INFO - docopt == 0.6.1 11:28:55 INFO - functools32 == 3.2.3-2 11:28:55 INFO - jsonschema == 2.5.1 11:28:55 INFO - manifestparser == 1.1 11:28:55 INFO - mozInstall == 1.13 11:28:55 INFO - mozcrash == 1.0 11:28:55 INFO - mozdebug == 0.1 11:28:55 INFO - mozdevice == 0.51 11:28:55 INFO - mozfile == 1.2 11:28:55 INFO - mozhttpd == 0.7 11:28:55 INFO - mozinfo == 0.10 11:28:55 INFO - mozleak == 0.1 11:28:55 INFO - mozlog == 3.5 11:28:55 INFO - moznetwork == 0.27 11:28:55 INFO - mozprocess == 0.25 11:28:55 INFO - mozprofile == 0.28 11:28:55 INFO - mozrunner == 6.13 11:28:55 INFO - mozscreenshot == 0.1 11:28:55 INFO - mozsystemmonitor == 0.3 11:28:55 INFO - moztest == 0.8 11:28:55 INFO - mozversion == 1.4 11:28:55 INFO - psutil == 3.1.1 11:28:55 INFO - requests == 1.2.3 11:28:55 INFO - wsgiref == 0.1.2 11:28:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28: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')]} 11:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28: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')]} 11:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:55 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 0x9e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56090>, '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 0xd56d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50f90>, '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': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', '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 11:28:55 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 11:28:55 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 11:28:55 INFO - Using env: {'DISPLAY': ':0', 11:28:55 INFO - 'HOME': '/home/cltbld', 11:28:55 INFO - 'LANG': 'en_US.UTF-8', 11:28:55 INFO - 'LANGUAGE': 'en_US:en', 11:28:55 INFO - 'LOGNAME': 'cltbld', 11:28:55 INFO - 'MAIL': '/var/mail/cltbld', 11:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:55 INFO - 'MOZ_NO_REMOTE': '1', 11:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:55 INFO - 'NO_EM_RESTART': '1', 11:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:55 INFO - 'PWD': '/builds/slave/test', 11:28:55 INFO - 'SHELL': '/bin/bash', 11:28:55 INFO - 'SHLVL': '1', 11:28:55 INFO - 'TERM': 'linux', 11:28:55 INFO - 'TMOUT': '86400', 11:28:55 INFO - 'USER': 'cltbld', 11:28:55 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', 11:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:55 INFO - '_': '/tools/buildbot/bin/python'} 11:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:55 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)) 11:28:55 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)) 11:28:55 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)) 11:28:55 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)) 11:28:55 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)) 11:28:55 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)) 11:28:55 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)) 11:28:55 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)) 11:28:55 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)) 11:28:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:28: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 11:28: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 11:28: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 11:28: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 11:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:28:56 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)) 11:28:56 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)) 11:28:56 INFO - Installing collected packages: simplejson 11:28:56 INFO - Running setup.py install for simplejson 11:28:56 INFO - building 'simplejson._speedups' extension 11:28:56 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 11:28:57 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 11:28:57 INFO - Successfully installed simplejson 11:28:57 INFO - Cleaning up... 11:28:57 INFO - Return code: 0 11:28:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbafa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd52a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56090>, '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 0xd56d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50f90>, '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': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', '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 11:28:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:28:57 INFO - Using env: {'DISPLAY': ':0', 11:28:57 INFO - 'HOME': '/home/cltbld', 11:28:57 INFO - 'LANG': 'en_US.UTF-8', 11:28:57 INFO - 'LANGUAGE': 'en_US:en', 11:28:57 INFO - 'LOGNAME': 'cltbld', 11:28:57 INFO - 'MAIL': '/var/mail/cltbld', 11:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:57 INFO - 'MOZ_NO_REMOTE': '1', 11:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:57 INFO - 'NO_EM_RESTART': '1', 11:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:57 INFO - 'PWD': '/builds/slave/test', 11:28:57 INFO - 'SHELL': '/bin/bash', 11:28:57 INFO - 'SHLVL': '1', 11:28:57 INFO - 'TERM': 'linux', 11:28:57 INFO - 'TMOUT': '86400', 11:28:57 INFO - 'USER': 'cltbld', 11:28:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', 11:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:57 INFO - '_': '/tools/buildbot/bin/python'} 11:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:28:57 INFO - Cleaning up... 11:28:57 INFO - Return code: 0 11:28:57 INFO - Running post-action listener: _resource_record_post_action 11:28:57 INFO - Running post-action listener: _start_resource_monitoring 11:28:57 INFO - Starting resource monitoring. 11:28:57 INFO - [mozharness: 2017-09-29 18:28:57.874261Z] Finished create-virtualenv step (success) 11:28:57 INFO - [mozharness: 2017-09-29 18:28:57.875224Z] Running install step. 11:28:57 INFO - Running pre-action listener: _resource_record_pre_action 11:28:57 INFO - Running main action method: install 11:28:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:28:58 INFO - Reading from file tmpfile_stdout 11:28:58 INFO - Detecting whether we're running mozinstall >=1.0... 11:28:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:28:58 INFO - Reading from file tmpfile_stdout 11:28:58 INFO - Output received: 11:28:58 INFO - Usage: mozinstall [options] installer 11:28:58 INFO - Options: 11:28:58 INFO - -h, --help show this help message and exit 11:28:58 INFO - -d DEST, --destination=DEST 11:28:58 INFO - Directory to install application into. [default: 11:28:58 INFO - "/builds/slave/test"] 11:28:58 INFO - --app=APP Application being installed. [default: firefox] 11:28:58 INFO - mkdir: /builds/slave/test/build/application 11:28:58 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'] 11:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:29:12 INFO - Reading from file tmpfile_stdout 11:29:12 INFO - Output received: 11:29:12 INFO - /builds/slave/test/build/application/firefox/firefox 11:29:12 INFO - Running post-action listener: _resource_record_post_action 11:29:12 INFO - [mozharness: 2017-09-29 18:29:12.836602Z] Finished install step (success) 11:29:12 INFO - [mozharness: 2017-09-29 18:29:12.836826Z] Running setup-mitmproxy step. 11:29:12 INFO - Running pre-action listener: _resource_record_pre_action 11:29:12 INFO - Running main action method: setup_mitmproxy 11:29:12 INFO - Skipping: mitmproxy is not required 11:29:12 INFO - Running post-action listener: _resource_record_post_action 11:29:12 INFO - [mozharness: 2017-09-29 18:29:12.837774Z] Finished setup-mitmproxy step (success) 11:29:12 INFO - [mozharness: 2017-09-29 18:29:12.837994Z] Running run-tests step. 11:29:12 INFO - Running pre-action listener: _resource_record_pre_action 11:29:12 INFO - Running pre-action listener: _set_gcov_prefix 11:29:12 INFO - Running main action method: run_tests 11:29:12 WARNING - Try message not found. 11:29:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:29:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:29:12 INFO - Python 2.7.3 11:29:12 INFO - Return code: 0 11:29:12 INFO - grabbing minidump binary from tooltool 11:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:29:12 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 0xd56090>, '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 0xd56d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd50f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:29:12 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 11:29:12 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 11:29:12 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 11:29:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:29:13 INFO - Return code: 0 11:29:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:29:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:29:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:29:13 INFO - ENV: RUST_BACKTRACE is now full 11:29:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:29:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:29:13 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/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 11:29:13 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/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 11:29:13 INFO - Using env: {'DISPLAY': ':0', 11:29:13 INFO - 'HOME': '/home/cltbld', 11:29:13 INFO - 'LANG': 'en_US.UTF-8', 11:29:13 INFO - 'LANGUAGE': 'en_US:en', 11:29:13 INFO - 'LOGNAME': 'cltbld', 11:29:13 INFO - 'MAIL': '/var/mail/cltbld', 11:29:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:29:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:13 INFO - 'MOZ_NO_REMOTE': '1', 11:29:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:13 INFO - 'NO_EM_RESTART': '1', 11:29:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:13 INFO - 'PWD': '/builds/slave/test', 11:29:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:29:13 INFO - 'RUST_BACKTRACE': 'full', 11:29:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:29:13 INFO - 'SHELL': '/bin/bash', 11:29:13 INFO - 'SHLVL': '1', 11:29:13 INFO - 'TERM': 'linux', 11:29:13 INFO - 'TMOUT': '86400', 11:29:13 INFO - 'USER': 'cltbld', 11:29:13 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', 11:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:13 INFO - '_': '/tools/buildbot/bin/python'} 11:29:13 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/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 11:29:13 INFO - mozversion application_buildid: 20170929170821 11:29:13 INFO - mozversion application_changeset: a8f12062e78c7d58e25c25ced1a681439415c5e5 11:29:13 INFO - mozversion application_display_name: Firefox 11:29:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:29:13 INFO - mozversion application_name: Firefox 11:29:13 INFO - mozversion application_remotingname: firefox 11:29:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:29:13 INFO - mozversion application_vendor: Mozilla 11:29:13 INFO - mozversion application_version: 57.0 11:29:13 INFO - mozversion platform_buildid: 20170929170821 11:29:13 INFO - mozversion platform_changeset: a8f12062e78c7d58e25c25ced1a681439415c5e5 11:29:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:29:13 INFO - mozversion platform_version: 57.0 11:29:13 INFO - using testdate: 1506709753 11:29:13 INFO - actual date: 1506709753 11:29:13 INFO - starting webserver on 'localhost:33496' 11:29:13 INFO - SUITE-START | Running 2 tests 11:29:13 INFO - TEST-START | dromaeo_css 11:29:13 INFO - Initialising browser for dromaeo_css test... 11:29:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33496/getInfo.html -profile /tmp/tmp2IupG5/profile 11:29:13 INFO - TEST-INFO | started process 3791 (/builds/slave/test/build/application/firefox/firefox http://localhost:33496/getInfo.html) 11:29:23 INFO - TEST-INFO | 3791: exit 0 11:29:23 INFO - Browser initialized. 11:29:23 INFO - Running cycle 1/1 for dromaeo_css test... 11:29:23 INFO - Using env: {'DISPLAY': ':0', 11:29:23 INFO - 'HOME': '/home/cltbld', 11:29:23 INFO - 'JSGC_DISABLE_POISONING': '1', 11:29:23 INFO - 'LANG': 'en_US.UTF-8', 11:29:23 INFO - 'LANGUAGE': 'en_US:en', 11:29:23 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:29:23 INFO - 'LOGNAME': 'cltbld', 11:29:23 INFO - 'MAIL': '/var/mail/cltbld', 11:29:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:29:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:29:23 INFO - 'MOZ_CRASHREPORTER': '1', 11:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:23 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:29:23 INFO - 'MOZ_NO_REMOTE': '1', 11:29:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:23 INFO - 'NO_EM_RESTART': '1', 11:29:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:23 INFO - 'PWD': '/builds/slave/test', 11:29:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:29:23 INFO - 'RUST_BACKTRACE': 'full', 11:29:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:29:23 INFO - 'SHELL': '/bin/bash', 11:29:23 INFO - 'SHLVL': '1', 11:29:23 INFO - 'TERM': 'linux', 11:29:23 INFO - 'TMOUT': '86400', 11:29:23 INFO - 'USER': 'cltbld', 11:29:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', 11:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:23 INFO - '_': '/tools/buildbot/bin/python'} 11:29:23 INFO - TEST-INFO | started process 3982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2IupG5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:29:24 INFO - PID 3982 | 11:29:24 INFO - PID 3982 | (/builds/slave/test/build/application/firefox/firefox:4033): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:29:24 INFO - PID 3982 | 11:29:34 INFO - PID 3982 | RSS: Main: 141848576 11:29:34 INFO - PID 3982 | 11:32:32 INFO - PID 3982 | Cycle 1(1): loaded http://localhost:33496/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33496/tests/dromaeo/cssquery-ext.html) 11:32:34 INFO - PID 3982 | RSS: Main: 145534976 11:32:34 INFO - PID 3982 | 11:35:35 INFO - PID 3982 | Cycle 1(1): loaded http://localhost:33496/tests/dromaeo/cssquery-ext.html (next: http://localhost:33496/tests/dromaeo/cssquery-jquery.html) 11:35:36 INFO - PID 3982 | RSS: Main: 144080896 11:35:36 INFO - PID 3982 | 11:38:37 INFO - PID 3982 | Cycle 1(1): loaded http://localhost:33496/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33496/tests/dromaeo/cssquery-mootools.html) 11:38:38 INFO - PID 3982 | RSS: Main: 145399808 11:38:38 INFO - PID 3982 | 11:41:40 INFO - PID 3982 | Cycle 1(1): loaded http://localhost:33496/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33496/tests/dromaeo/cssquery-prototype.html) 11:41:40 INFO - PID 3982 | RSS: Main: 145321984 11:41:40 INFO - PID 3982 | 11:44:43 INFO - PID 3982 | Cycle 1(1): loaded http://localhost:33496/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33496/tests/dromaeo/cssquery-yui.html) 11:44:44 INFO - PID 3982 | RSS: Main: 146628608 11:44:44 INFO - PID 3982 | 11:47:45 INFO - PID 3982 | Cycle 1(1): loaded http://localhost:33496/tests/dromaeo/cssquery-yui.html (next: http://localhost:33496/tests/dromaeo/cssquery-dojo.html) 11:47:46 INFO - PID 3982 | RSS: Main: 149176320 11:47:46 INFO - PID 3982 | 11:47:46 INFO - PID 3982 | __start_tp_report 11:47:46 INFO - PID 3982 | _x_x_mozilla_page_load 11:47:46 INFO - PID 3982 | _x_x_mozilla_page_load_details 11:47:46 INFO - PID 3982 | |i|pagename|runs| 11:47:46 INFO - PID 3982 | |0;dojo.html;3970.7419017763846;3975.324194886871;3978.303796835554;4006.8179886933353;4040.59594040596;6642.269350371455;6688.699008544609;6721.924492081268;6746.359095885895;6751.898721519181;6648.567843090195;6653.035309880064;6729.697163627637;6730.798076057714;6772.661366931646;5896.616719913213;5938.46553810157;6032.7285272162635;6038.516918646497;6092.6953652317425;6009.549283803711;6069.635821850703;6083.057126145454;6128.417800308964;6129.754809807625;5988.940110598882;6001.129836173752;6014.127951447038;6023.036314189731;6032.758689652409;5875.1187321901625;6031.24609423822;6031.698415079229;6079.179310793031;6113.510919126459;5906.557008224358;5928.644281343133;5984.97007514964;6131.14164017038;6136.987397079477;6597.373249541286;6620.205575330943;6661.200655921272;6711.932880671179;6875.106236189264;7099.396551293146;7147.49967502275;7184.209736928986;7207.711691532332;7260.1287845458355;7287.708491660327;7332.78001659951;7347.787615043511;7379.59412232327;7384.556926584422;6607.60354378734;6728.125343705287;6803.48973826965;6813.250542440328;6826.556273842234;7385.556866588022;7440;7477.439192060618;7538.962305188439;7555.659995300225;7189.928100718926;7210.062691850026;7261.128664560287;7277.345038946521;7283.526570772989;7241;7304.707811687473;7355.668994895243;7385.741499047615;7406.962965185139;7189.532680375759;7274.454415918827;7283.599402032939;7320.304571065741;7343.706251749977;7200.243974382614;7212.531185472927;7298.781036568911;7304.5252058616015;7306.196318404971;5328.3605967284175;5390.191471279261;5417.349918009864;5425.83722488326;5453.809116680897;4825.927611085836;4831.855044348676;4863.635227357962;4877.756112194447;4916.164252077156;6637.3030831762935;6700.2294736105;6714.462842972648;6719.260881303053;6725.966370168216;7062.6821793019435;7165.820854478679;7288.380487658608;7328.96335518319;7361.30067643573;6566.409023187936;6570.441512471398;6584.341565843377;6606.372394622503;6687.966560167265;6036.879262414727;6118.847028824226;6138.877222455526;6156.938430615726;6162.198914141222;7323.304286092813;7347.963260183665;7393.07586551681;7422.814429639194;7483.6258187090425;7012.894806577905;7092.751753688596;7136.357727804522;7201.567905925661;7251.274872512707;7452;7504.362129219077;7508.812279693051;7526.285002924714;7567.281108294703;7220.963895180491;7299.8540029200185;7309.232530584425;7311.963440182765;7312.122545294599;7260.092488438945;7312.451566132455;7318.121825380988;7321.121465424183;7386.704531818667;6990.860182796418;7086.929130708627;7088.326608972139;7092.751753688596;7125.038119853961;7043.823904402431;7070.151581810215;7073.2219455858785;7132.037174981519;7158.212596614472;6918.135233095863;6981.581105133709;6994.405475534637;7001.509894307554;7010.824729381806;7017.2631873652535;7068.752593659403;7110.680019399036;7170.641467926687;7196.8920466194095;6799.184097908283;6818.829529261609;6842.692078856563;6854.8286292841085;6884.311568843276 11:47:46 INFO - PID 3982 | |1;ext.html;992.5186284651938;1001.4191768774111;1028.855960165577;1030.299396410441;1037.8910214427485;45851;46485.30272045918;46539.30191047137;46786.76606616962;46895.531044689546;45017.324740128926;45321.54678453215;45368.77315613417;45419;45498.09003819922;8087.1508491608265;8217.876731849026;8233.217844304781;8240.423170378075;8245.95877020617;8121.878171827428;8238.340932725368;8253.628586713612;8256.215659512336;8264.21489958453;8170.836583268331;8759.868601970975;8848.734537963872;8943.32925030622;8952.507612081334;8817.779555511099;8846.336524760636;8870.955645221733;8891.822163556757;8906.73279801607;8706.608202630898;8792.560371981439;8799.076097009785;8800;8804.339674524435;42848.357274640905;43092.78453607712;43105.35341969873;43142.568574314166;43285.56714432847;3870.8838734838;3906.8437262509465;3915.0799562102884;3917;3917.902052448683;34780;34886.302273954636;34890;35002.82498587516;35015.64984350175;5589.077802162638;5645.2096706461125;5666.348369937468;5679.062954612484;5695.316562012544;218646;219954;220655;221410;221833;50824.74587627038;51959;54944.17583736247;55490.72254638701;55901.72049139728;57544.71227643835;57633.42366576364;57719.134212986835;57787.42212577904;57802.13296800551;18000;18129.45611631653;18167.63664726698;18178.27286908509;18207.08964551767;14842.40630374773;14859.851401485847;14971.850281497263;14976.47582334613;15090.396384144511;15113;15120.319585618674;15211.315490802941;15229.1623960681;15399.153046582322;5990.161377407167;6094.939050609526;6136;6177.938220617826;6210.31686514483;1115.6597237842373;1126.3861195648392;1129.277262551951;1140.0651465798132;1143.5654451308449;26095.869520652654;26767.732322676526;26941.86529067342;27001.86499067492;27581;1233.7409144079663;1233.9197952133084;1238.5479300055415;1242.043626407679;1246.9750604987848;13715.245661488514;13802.723945521033;14137.222452765196;14275.928620356832;14381;288861;289331;289712;290301;291013;61632;62134.689326553984;62152.37847621556;62305;62489.37510624836;1561.3286286896516;1577.6765763018784;1590.9124998125214;1595.3459081776416;1605.871530277575;26204.08285709991;26250.212493625222;26325.473490530465;26383.472330553665;26539.867300663373;42569.78715106405;42750.358744618236;42809.1438171241;42825.35761963635;42845.78577107094;245550;247374;247451;248111;249383;36823.26353472969;39766;40003;40161.799191003855;40430;51859;53693.463065368844;53719;53898;53900.19149712679;38155.2368952625;38523.22953540969;38775;38905;38985.805070974464;37745.24509509849;37827.24345513129;38014;38318.23363532769;38399.80800095982;44586.77706611446;44769.328460073775;45154.54845451503;45566;45583.08833823371;35673.28653426865;35831.82084089563;35949.46075808813;36362.45456318105;36752.26495470129;27324.863375682995;27373.452530949668;27485.73971034493;27653.58519622167;27659.723402765714 11:47:46 INFO - PID 3982 | |2;jquery.html;641.2974089830368;642.1078311783365;643.4426630887208;648.6966824644549;651.6661128661902;24226.15208467704;24979.37551561212;24980.12569560066;24980.750192498046;24998.375040623992;26740;26929.192124236255;27068.458630827372;27207.727922720765;27404.725952740468;6694.96652516738;7054.470914681419;7103.573785572857;7137.143542774875;7149.571025738473;7022.859542809141;7131.7503887363955;7131.89302160468;7134.001239826429;7134.393576546;6543.509236807258;6828.624425656587;6837.589744615314;7015.052967849351;7099.964500177518;6739.090222819955;6800.727970881158;6806.693698783542;6835.350641689031;6848.794536163899;6354.586951848115;6374.330695276975;6384.585001974857;6393.424591786715;6406.583572067801;30165.547516787265;30447.238819029702;30652.233694157825;30896.845515772504;31111;2325.6395258734924;2325.8837058147024;2330.8135349172194;2349.9060037598474;2389.438481956739;20490.282840100524;20868.269610563708;20995.265165719127;21064.157433702632;21188.15247390118;2546.7707906288338;2585.31489155374;2642.7885769138425;2648.192301348088;2648.9867550662316;141286;146948;161209;167516;167622;16360;16778.32886684519;17141.17170666826;17211.13944302805;17371.218295176746;27124.965627577614;27197.184084477103;27363.042293519633;27376;27437.314067148083;10970.780584388267;11156.107511399068;11220.719482012852;11264.774704505864;11396.373199474108;10103.595856165817;10142.391456512485;10256.923023082618;10261.281710280358;10338.741531461774;10009.799804003878;10162.136218421369;10260.43567603774;10272.640457584099;10481.790364192826;2871.655401351851;2881.8991335303162;2951.1146656003543;3042.6500952390757;3122.0945925681754;1053.1679972821385;1053.1837825685002;1071.7106381277013;1075.306427354352;1079.956801727922;21513.56972860534;21718.565628687655;21945.231916882833;22042.33872983813;22290.88854555717;1130.4178348150708;1136.420425582942;1141.5547936304847;1149.2127892393737;1154.3881742676394;11938.88061119395;11962.342071186169;12007.879921200676;12022.218555793845;12031.037516998618;537102;547036;547503;559699;564737;133815;137298;138143;138590;139959;1134.121056181466;1161.6795078540265;1250.5373011985441;1253.348258905364;1276.144982861485;22278.88860555687;22526.774732253125;22594.887025565426;22614.547709045397;23130;63341.68329158325;63409;64973.35026649673;65875.01187482096;66779.33220667731;79519.60240198762;79808.60095699484;80181.59909200417;80846.19153808386;80909;16410.589735256715;16693.499195024167;16763.245653945356;16784.160791960596;16832.57918552046;25241.621375679013;25291.747082529677;25379;25415.745842542077;25813.48373032491;20617.69073463869;20738.688919665914;20787.480312992295;20922.37232883016;20962.266320678704;18109.637807244046;18254.634907302046;18390.172442239862;18839.434816955512;19067.332643357415;20963.475913102295;21211.04550295271;21243.681344779532;21370.252041178483;21522.569548608626;16129.11289879068;16183.75724364159;16219.918900405895;16302.673946520767;16391.67216655684;19955;20105.597888042448;20231.19075237033;20312.390628281177;20468 11:47:46 INFO - PID 3982 | |3;mootools.html;1461.8099647045883;1501.3018946190027;1505.0668585476992;1510.131674287285;1522.4366984215842;16918.154092295383;17502.12489375531;17726.290948362068;17753.467395978143;17772.200250988735;17447.12764361783;17472.475825725247;17547.47357579275;17574.912125439387;17585.472435826912;2995.41589390069;3066.310080231947;3068.509038553832;3073.569700241968;3080.7535397168285;2638.1557901471538;2648.9470210595778;2654.4027593791434;2657.5083609532203;2667.719889411603;2956.364381657943;2993.4162838246552;3018.064400035985;3020.426119037376;3021.4108248891475;2786;2789.1353680359152;2815.7184281571886;2825.5620378841313;2825.9293517662018;2719.564869620871;2745.8627068646488;2773.9583906241423;2779.4163225722623;2787.8048536602446;16648.833511664972;16761.580960475963;16767.413140540022;16783.24475398598;16810.24353904065;8451.323894088458;8661.740147795575;8664.61009254585;8698.826023479558;8709;5496.642718223303;5805.593608447411;6020.879582408371;6045.546584006173;6096.786612468587;2171.5005548723725;2216.1689366487567;2216.1910902520463;2253.966190507144;2312.7340355858955;30281.545776813364;31051.378972420425;32788.180295492566;33589.83205084008;33607.6639233607;7949.880751788728;7981.840363192704;8061.879071813927;8108.4188583225705;8161;24207.39481512941;24243.51512969731;24278.27165185047;24286.392840178785;24339.634905476432;9010.053944335881;9108.225800806873;9143.497107659143;9143.908560914439;9148.2681385489;7942.44402891792;8085.555294458862;8199.71301004462;8219.849221109049;8232.723927791201;6513.381228783258;6522.608643481406;6524.412802847766;6532.464870755369;6641.601503909685;1949.3761996161377;1973.4770285874256;2008.1666108564782;2012.7785943546198;2014.2949967511254;990.782027953849;996.3374356053143;998.236349192868;1002.5638847101534;1021.8620486234412;8563.657453701782;8577.399582029198;8587.613557389932;8744.606492707844;8757.912420875837;800.7797855589642;811.9106898241189;823.8393513264856;824.7031068815222;830.6013113705335;5281.577473802086;5286.577073834084;5304.496072873071;5368.758405871745;5370.140777475585;26072.8696356517;27104.864475677496;27142.728572714415;27259.72740272572;27270.227435216646;25584.48831023369;26583.33541661474;26765.732342676714;26804.865975669996;26836.463270734475;11535.884641153649;12638.810417843739;12866.742665146645;12875.613731588068;13293.93353033248;9633.518324083627;9762.609495620096;9802.803943921224;9916.504174791087;10012.64955726546;21832.781672183075;21992.34022979313;22627.88686056559;22884.4278893029;23595.646065309378;23289;23547;23727.1695490657;23748;24092.638610421207;14066.226357550024;14354.928225358806;14362.497312594009;14374.568762937128;14376.496822611158;14933.775993359892;15752.369905203663;15917.840821591635;16010.599735006717;16095.597610059842;12770.68073298175;12838.614841554769;12948.870511295143;13003.739925201633;13084.672883177996;11998.420734358217;12223.388830558259;12316.014718822651;12505.374731263219;12511.624651260478;10660.84008739885;10820.242583019113;10900.291481053706;10903.78192436131;10928.672139835817;8300.2114799094;8398.118197589165;8419.158084191531;8426.620802063799;8449.66201351939;8635.6977505787;8741.256993155399;8757.211850933447;8820.029796722483;8850.557472126497 11:47:46 INFO - PID 3982 | |4;prototype.html;578.580529116391;588.4262843727365;607.077242591261;611.4741322462683;621.6239175298944;6452.2257329120575;6496.642684652342;6542.967285163568;6604.207495100589;6619.404253617174;6519.011701431062;6531.7387304507765;6554.737810487587;6572.441342485894;6589.143411356517;5367.35591728993;5374.946250537503;5410.026195284847;5413.404525502192;5421.864453388657;5037.546620804127;5240.3187585614005;5361.5978801589845;5363.839084827442;5410.1073322901675;5196.830713089563;5211.166213405856;5222;5241.344831896013;5247.816326428576;5192.948070519285;5225.608079394061;5232.686038837682;5240;5256.658317209369;4762.833300834489;4781.211100168468;4791.976040119812;4802.18362878308;4807.687500312503;6513.804585862432;6539.136346141327;6572.901406478906;6594.901076483857;6608.603483790988;6194.442500175006;6203.379662033805;6224.315325314212;6292.5280603954425;6299;6918.757843475504;6990.475714321396;7034.296570342976;7034.718611255544;7059.329363710439;5140.7172605506685;5388.245645609618;5406.270153529302;5406.648567843077;5418.783248670048;7081.114860642419;7109.75115870942;7123.860182370848;7140.4287656987835;7256.637168141625;5467.261919640877;5471.5896307777075;5475.945240547623;5510.366307874566;5535.391106978229;5549.0289199389945;5577;5588;5602.243697100921;5613.607047506635;6207.534434917399;6218.751249950042;6221.097940798559;6241.750329986749;6243.375662433811;7032.824179395454;7073.3987611053635;7075.398591119812;7084.468664850054;7097.609631470215;1880.5298675331167;1907.7424547686162;1908.8854668719644;1913.9521511962312;1938.5444420561157;1313.1202094596642;1374.6013656039636;1376.311844077961;1377.1668140774887;1385.6051025457696;6354.872902541923;6371.458426033839;6495.967520162369;6499.447546958561;6554.573952693059;7002.264762199998;7050.753223637251;7089.255628158969;7113.57318560888;7125.82185445368;6435.195600549931;6508.186476690414;6513.348665133543;6516.283208847023;6566.3105373936005;3709.2581483703366;3795.6773674237447;3799.848006079781;3814.256220037066;3846.3268927937497;7354.007209026713;7400.481966262418;7401.222871598512;7424.294692004251;7441.702331906663;7128.786136415916;7304.306090921354;7325.670344834495;7357.374623157091;7402.33378995893;7308.415326773846;7336.569368972999;7359.889601655872;7378.19234287603;7458.73894413693;6897.758578449931;6951.7914462566205;6994.691751722021;7095.751648692271;7115.6086415247655;7033.331833475811;7053.929460705327;7133.5719856808755;7156.391706704989;7165.3551180394015;7222.386097181588;7328.969067013228;7372.815679608053;7383.630818459163;7384.372328351936;5478.534324582296;5489.917651235314;5493;5501.587380946365;5523.558115350843;6873.518853680194;7122.501424900414;7125.287471252833;7129.572225666477;7192.446681428227;6595.967020164869;6824.2152152503095;6879.724811007503;6915.585064896122;6927.238003819677;6860.725570977105;6901.206361268519;6912.516123871482;6923.307669233036;6933.37599616037;6739.966300168664;6792.811258029727;6813.148356455443;6833.257519332538;6868.9049839799345;6981.79054628362;7018.824529386806;7043.542169759155;7044.330788575077;7050.753223637148;6696.662654994563;6754.0881980931945;6800.31996800316;6815.114035175396;6854.520183587101 11:47:46 INFO - PID 3982 | |5;yui.html;997.5760301871708;1006.0894890124438;1019.9694009179727;1037.7353774787427;1042.2756184451807;23833.5233295334;25828.612570811452;25828.870855645742;25926;25992.740072599267;23008;24869;24933.12734054304;24948.87525562374;24983;1104.6133853151393;1130.2822707580663;1136.5851464215584;1136.6078702847503;1136.8408422820812;825.2119226139023;839.492107275099;1102.2614848051785;1134.183387960671;1138.669785762128;1169.625719769674;1179.262960649594;1180.74613957999;1182.2788099259444;1183.1540448579265;1168.0480408467156;1169.6900321414832;1170.39724541861;1171.4377098992488;1171.4962566096574;866.0733015673233;867.5922316511229;867.9001914779755;868.2359523619238;868.8783570300163;21488.677669834964;22445.663315050286;22485.662715059287;22522;22569.210077647367;24274.39314017146;24516.877415612988;24736;24794.008239670573;24796.876015619986;18164.364247251415;18206.18072186755;18350.54123646906;18467.722984155247;18587.256509739593;4118;4140.296149654536;4141.958580414187;4146.834126634931;4149.875503734893;162989.18505407398;167475.16262418733;168821.15589422098;168923;170718;18497;18590.907045464686;18648.720269195972;18973.43079707611;18978.71531927022;29061.41877162445;29280.267993299913;35533.644663553554;35636.64363356385;35679.82160089183;10424.374537527772;10751.83872241917;10787.730306742395;10821.404822734668;10872.510737016853;5145.871353216125;5205.193195054697;5241.68549887008;5244.108501554745;5254.816081437131;6397.808065758035;6513.088167656532;6525.11910892033;6547.279799222082;6569.901451478232;1211.6243964371074;1241.3110723548518;1251.305525433375;1252.7118762684634;1257.6289994451658;742.0798210219289;753.1038064702985;759.4038679636459;768.8654485465021;773.0877564473975;13795.931020345035;14056.578302650936;14570.344334504973;15364.231788410534;15466.381344746083;771.3096778383427;773.7833406646148;775.4571799740204;779.9298063174341;787.5707739282105;6502.219733631994;6556.4427023702565;6569.9343006569325;6602.7689030883685;6603.438707709803;159982.2000889988;160639;161748;163918;164447;141492;142923.28538357242;144205.27897360447;144867;145082;124561.37719311345;127202;127503;128292.35853820857;130089.34955325352;12539.310337931136;12554;12585.748285034431;12677.746445071232;12862.421191046613;58194.4180558189;58864.70567647306;59068;59518.51203719942;60437.69781151066;76495;76603;76674.23325766894;77496.61251693705;78993;22708.432289192904;23148;23245;23633.172838950555;23720.644190336814;24990.875045625384;25423.745762542138;25539.6169057468;25545.700886920265;26143.73856261413;23657.763422365555;23949.04203831827;24258.636120457853;24368.147114850894;24709.629355559322;19432.514187145436;20272.59454810925;21991.780082198973;22516.66225006659;22816.31551053471;21241.575168496853;21462.14151433925;22484.213052543084;22544.66183007289;23187;14324.283785810876;14437.989340746048;15197.240137992834;15285.770713439086;15710.371585136467;14605;14849.554513364616;14920.701585968003;15131.789456843646;15136.621584460476 11:47:46 INFO - PID 3982 | __end_tp_report 11:47:46 INFO - PID 3982 | __start_cc_report 11:47:46 INFO - PID 3982 | _x_x_mozilla_cycle_collect,257 11:47:46 INFO - PID 3982 | __end_cc_report 11:47:46 INFO - PID 3982 | __startTimestamp1506710866159__endTimestamp 11:47:46 INFO - PID 3982 | 11:47:46 INFO - PID 3982 | ------- Summary: start ------- 11:47:46 INFO - PID 3982 | Number of tests: 6 11:47:46 INFO - PID 3982 | 11:47:46 INFO - PID 3982 | [#0] dojo.html Cycles:165 Average:6691.84 Median:6990.86 stddev:793.19 (11.3%) stddev-sans-first:766.36 11:47:46 INFO - PID 3982 | Values: 3970.7 3975.3 3978.3 4006.8 4040.6 6642.3 6688.7 6721.9 6746.4 6751.9 6648.6 6653.0 6729.7 6730.8 6772.7 5896.6 5938.5 6032.7 6038.5 6092.7 6009.5 6069.6 6083.1 6128.4 6129.8 5988.9 6001.1 6014.1 6023.0 6032.8 5875.1 6031.2 6031.7 6079.2 6113.5 5906.6 5928.6 5985.0 6131.1 6137.0 6597.4 6620.2 6661.2 6711.9 6875.1 7099.4 7147.5 7184.2 7207.7 7260.1 7287.7 7332.8 7347.8 7379.6 7384.6 6607.6 6728.1 6803.5 6813.3 6826.6 7385.6 7440.0 7477.4 7539.0 7555.7 7189.9 7210.1 7261.1 7277.3 7283.5 7241.0 7304.7 7355.7 7385.7 7407.0 7189.5 7274.5 7283.6 7320.3 7343.7 7200.2 7212.5 7298.8 7304.5 7306.2 5328.4 5390.2 5417.3 5425.8 5453.8 4825.9 4831.9 4863.6 4877.8 4916.2 6637.3 6700.2 6714.5 6719.3 6726.0 7062.7 7165.8 7288.4 7329.0 7361.3 6566.4 6570.4 6584.3 6606.4 6688.0 6036.9 6118.8 6138.9 6156.9 6162.2 7323.3 7348.0 7393.1 7422.8 7483.6 7012.9 7092.8 7136.4 7201.6 7251.3 7452.0 7504.4 7508.8 7526.3 7567.3 7221.0 7299.9 7309.2 7312.0 7312.1 7260.1 7312.5 7318.1 7321.1 7386.7 6990.9 7086.9 7088.3 7092.8 7125.0 7043.8 7070.2 7073.2 7132.0 7158.2 6918.1 6981.6 6994.4 7001.5 7010.8 7017.3 7068.8 7110.7 7170.6 7196.9 6799.2 6818.8 6842.7 6854.8 6884.3 11:47:46 INFO - PID 3982 | 11:47:46 INFO - PID 3982 | [#1] ext.html Cycles:180 Average:44487.90 Median:21446.32 stddev:66053.69 (308.0%) stddev-sans-first:66158.25 11:47:46 INFO - PID 3982 | Values: 992.5 1001.4 1028.9 1030.3 1037.9 45851.0 46485.3 46539.3 46786.8 46895.5 45017.3 45321.5 45368.8 45419.0 45498.1 8087.2 8217.9 8233.2 8240.4 8246.0 8121.9 8238.3 8253.6 8256.2 8264.2 8170.8 8759.9 8848.7 8943.3 8952.5 8817.8 8846.3 8871.0 8891.8 8906.7 8706.6 8792.6 8799.1 8800.0 8804.3 42848.4 43092.8 43105.4 43142.6 43285.6 3870.9 3906.8 3915.1 3917.0 3917.9 34780.0 34886.3 34890.0 35002.8 35015.6 5589.1 5645.2 5666.3 5679.1 5695.3 218646.0 219954.0 220655.0 221410.0 221833.0 50824.7 51959.0 54944.2 55490.7 55901.7 57544.7 57633.4 57719.1 57787.4 57802.1 18000.0 18129.5 18167.6 18178.3 18207.1 14842.4 14859.9 14971.9 14976.5 15090.4 15113.0 15120.3 15211.3 15229.2 15399.2 5990.2 6094.9 6136.0 6177.9 6210.3 1115.7 1126.4 1129.3 1140.1 1143.6 26095.9 26767.7 26941.9 27001.9 27581.0 1233.7 1233.9 1238.5 1242.0 1247.0 13715.2 13802.7 14137.2 14275.9 14381.0 288861.0 289331.0 289712.0 290301.0 291013.0 61632.0 62134.7 62152.4 62305.0 62489.4 1561.3 1577.7 1590.9 1595.3 1605.9 26204.1 26250.2 26325.5 26383.5 26539.9 42569.8 42750.4 42809.1 42825.4 42845.8 245550.0 247374.0 247451.0 248111.0 249383.0 36823.3 39766.0 40003.0 40161.8 40430.0 51859.0 53693.5 53719.0 53898.0 53900.2 38155.2 38523.2 38775.0 38905.0 38985.8 37745.2 37827.2 38014.0 38318.2 38399.8 44586.8 44769.3 45154.5 45566.0 45583.1 35673.3 35831.8 35949.5 36362.5 36752.3 27324.9 27373.5 27485.7 27653.6 27659.7 11:47:46 INFO - PID 3982 | 11:47:46 INFO - PID 3982 | [#2] jquery.html Cycles:180 Average:39225.99 Median:22408.83 stddev:93231.84 (416.0%) stddev-sans-first:93448.37 11:47:46 INFO - PID 3982 | Values: 641.3 642.1 643.4 648.7 651.7 24226.2 24979.4 24980.1 24980.8 24998.4 26740.0 26929.2 27068.5 27207.7 27404.7 6695.0 7054.5 7103.6 7137.1 7149.6 7022.9 7131.8 7131.9 7134.0 7134.4 6543.5 6828.6 6837.6 7015.1 7100.0 6739.1 6800.7 6806.7 6835.4 6848.8 6354.6 6374.3 6384.6 6393.4 6406.6 30165.5 30447.2 30652.2 30896.8 31111.0 2325.6 2325.9 2330.8 2349.9 2389.4 20490.3 20868.3 20995.3 21064.2 21188.2 2546.8 2585.3 2642.8 2648.2 2649.0 141286.0 146948.0 161209.0 167516.0 167622.0 16360.0 16778.3 17141.2 17211.1 17371.2 27125.0 27197.2 27363.0 27376.0 27437.3 10970.8 11156.1 11220.7 11264.8 11396.4 10103.6 10142.4 10256.9 10261.3 10338.7 10009.8 10162.1 10260.4 10272.6 10481.8 2871.7 2881.9 2951.1 3042.7 3122.1 1053.2 1053.2 1071.7 1075.3 1080.0 21513.6 21718.6 21945.2 22042.3 22290.9 1130.4 1136.4 1141.6 1149.2 1154.4 11938.9 11962.3 12007.9 12022.2 12031.0 537102.0 547036.0 547503.0 559699.0 564737.0 133815.0 137298.0 138143.0 138590.0 139959.0 1134.1 1161.7 1250.5 1253.3 1276.1 22278.9 22526.8 22594.9 22614.5 23130.0 63341.7 63409.0 64973.4 65875.0 66779.3 79519.6 79808.6 80181.6 80846.2 80909.0 16410.6 16693.5 16763.2 16784.2 16832.6 25241.6 25291.7 25379.0 25415.7 25813.5 20617.7 20738.7 20787.5 20922.4 20962.3 18109.6 18254.6 18390.2 18839.4 19067.3 20963.5 21211.0 21243.7 21370.3 21522.6 16129.1 16183.8 16219.9 16302.7 16391.7 19955.0 20105.6 20231.2 20312.4 20468.0 11:47:46 INFO - PID 3982 | 11:47:46 INFO - PID 3982 | [#3] mootools.html Cycles:180 Average:11000.95 Median:14931.15 stddev:8338.34 (55.8%) stddev-sans-first:8330.93 11:47:46 INFO - PID 3982 | Values: 1461.8 1501.3 1505.1 1510.1 1522.4 16918.2 17502.1 17726.3 17753.5 17772.2 17447.1 17472.5 17547.5 17574.9 17585.5 2995.4 3066.3 3068.5 3073.6 3080.8 2638.2 2648.9 2654.4 2657.5 2667.7 2956.4 2993.4 3018.1 3020.4 3021.4 2786.0 2789.1 2815.7 2825.6 2825.9 2719.6 2745.9 2774.0 2779.4 2787.8 16648.8 16761.6 16767.4 16783.2 16810.2 8451.3 8661.7 8664.6 8698.8 8709.0 5496.6 5805.6 6020.9 6045.5 6096.8 2171.5 2216.2 2216.2 2254.0 2312.7 30281.5 31051.4 32788.2 33589.8 33607.7 7949.9 7981.8 8061.9 8108.4 8161.0 24207.4 24243.5 24278.3 24286.4 24339.6 9010.1 9108.2 9143.5 9143.9 9148.3 7942.4 8085.6 8199.7 8219.8 8232.7 6513.4 6522.6 6524.4 6532.5 6641.6 1949.4 1973.5 2008.2 2012.8 2014.3 990.8 996.3 998.2 1002.6 1021.9 8563.7 8577.4 8587.6 8744.6 8757.9 800.8 811.9 823.8 824.7 830.6 5281.6 5286.6 5304.5 5368.8 5370.1 26072.9 27104.9 27142.7 27259.7 27270.2 25584.5 26583.3 26765.7 26804.9 26836.5 11535.9 12638.8 12866.7 12875.6 13293.9 9633.5 9762.6 9802.8 9916.5 10012.6 21832.8 21992.3 22627.9 22884.4 23595.6 23289.0 23547.0 23727.2 23748.0 24092.6 14066.2 14354.9 14362.5 14374.6 14376.5 14933.8 15752.4 15917.8 16010.6 16095.6 12770.7 12838.6 12948.9 13003.7 13084.7 11998.4 12223.4 12316.0 12505.4 12511.6 10660.8 10820.2 10900.3 10903.8 10928.7 8300.2 8398.1 8419.2 8426.6 8449.7 8635.7 8741.3 8757.2 8820.0 8850.6 11:47:46 INFO - PID 3982 | 11:47:46 INFO - PID 3982 | [#4] prototype.html Cycles:180 Average:5941.48 Median:6554.66 stddev:1651.08 (25.2%) stddev-sans-first:1605.90 11:47:46 INFO - PID 3982 | Values: 578.6 588.4 607.1 611.5 621.6 6452.2 6496.6 6543.0 6604.2 6619.4 6519.0 6531.7 6554.7 6572.4 6589.1 5367.4 5374.9 5410.0 5413.4 5421.9 5037.5 5240.3 5361.6 5363.8 5410.1 5196.8 5211.2 5222.0 5241.3 5247.8 5192.9 5225.6 5232.7 5240.0 5256.7 4762.8 4781.2 4792.0 4802.2 4807.7 6513.8 6539.1 6572.9 6594.9 6608.6 6194.4 6203.4 6224.3 6292.5 6299.0 6918.8 6990.5 7034.3 7034.7 7059.3 5140.7 5388.2 5406.3 5406.6 5418.8 7081.1 7109.8 7123.9 7140.4 7256.6 5467.3 5471.6 5475.9 5510.4 5535.4 5549.0 5577.0 5588.0 5602.2 5613.6 6207.5 6218.8 6221.1 6241.8 6243.4 7032.8 7073.4 7075.4 7084.5 7097.6 1880.5 1907.7 1908.9 1914.0 1938.5 1313.1 1374.6 1376.3 1377.2 1385.6 6354.9 6371.5 6496.0 6499.4 6554.6 7002.3 7050.8 7089.3 7113.6 7125.8 6435.2 6508.2 6513.3 6516.3 6566.3 3709.3 3795.7 3799.8 3814.3 3846.3 7354.0 7400.5 7401.2 7424.3 7441.7 7128.8 7304.3 7325.7 7357.4 7402.3 7308.4 7336.6 7359.9 7378.2 7458.7 6897.8 6951.8 6994.7 7095.8 7115.6 7033.3 7053.9 7133.6 7156.4 7165.4 7222.4 7329.0 7372.8 7383.6 7384.4 5478.5 5489.9 5493.0 5501.6 5523.6 6873.5 7122.5 7125.3 7129.6 7192.4 6596.0 6824.2 6879.7 6915.6 6927.2 6860.7 6901.2 6912.5 6923.3 6933.4 6740.0 6792.8 6813.1 6833.3 6868.9 6981.8 7018.8 7043.5 7044.3 7050.8 6696.7 6754.1 6800.3 6815.1 6854.5 11:47:46 INFO - PID 3982 | 11:47:46 INFO - PID 3982 | [#5] yui.html Cycles:180 Average:31135.18 Median:22501.16 stddev:45437.09 (201.9%) stddev-sans-first:45508.20 11:47:46 INFO - PID 3982 | Values: 997.6 1006.1 1020.0 1037.7 1042.3 23833.5 25828.6 25828.9 25926.0 25992.7 23008.0 24869.0 24933.1 24948.9 24983.0 1104.6 1130.3 1136.6 1136.6 1136.8 825.2 839.5 1102.3 1134.2 1138.7 1169.6 1179.3 1180.7 1182.3 1183.2 1168.0 1169.7 1170.4 1171.4 1171.5 866.1 867.6 867.9 868.2 868.9 21488.7 22445.7 22485.7 22522.0 22569.2 24274.4 24516.9 24736.0 24794.0 24796.9 18164.4 18206.2 18350.5 18467.7 18587.3 4118.0 4140.3 4142.0 4146.8 4149.9 162989.2 167475.2 168821.2 168923.0 170718.0 18497.0 18590.9 18648.7 18973.4 18978.7 29061.4 29280.3 35533.6 35636.6 35679.8 10424.4 10751.8 10787.7 10821.4 10872.5 5145.9 5205.2 5241.7 5244.1 5254.8 6397.8 6513.1 6525.1 6547.3 6569.9 1211.6 1241.3 1251.3 1252.7 1257.6 742.1 753.1 759.4 768.9 773.1 13795.9 14056.6 14570.3 15364.2 15466.4 771.3 773.8 775.5 779.9 787.6 6502.2 6556.4 6569.9 6602.8 6603.4 159982.2 160639.0 161748.0 163918.0 164447.0 141492.0 142923.3 144205.3 144867.0 145082.0 124561.4 127202.0 127503.0 128292.4 130089.3 12539.3 12554.0 12585.7 12677.7 12862.4 58194.4 58864.7 59068.0 59518.5 60437.7 76495.0 76603.0 76674.2 77496.6 78993.0 22708.4 23148.0 23245.0 23633.2 23720.6 24990.9 25423.7 25539.6 25545.7 26143.7 23657.8 23949.0 24258.6 24368.1 24709.6 19432.5 20272.6 21991.8 22516.7 22816.3 21241.6 21462.1 22484.2 22544.7 23187.0 14324.3 14438.0 15197.2 15285.8 15710.4 14605.0 14849.6 14920.7 15131.8 15136.6 11:47:46 INFO - PID 3982 | -------- Summary: end -------- 11:47:46 INFO - PID 3982 | 11:47:46 INFO - TEST-INFO | 3982: exit 0 11:47:46 INFO - TEST-OK | dromaeo_css | took 1113595ms 11:47:46 INFO - TEST-START | kraken 11:47:46 INFO - Initialising browser for kraken test... 11:47:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33496/getInfo.html -profile /tmp/tmpXji2YJ/profile 11:47:46 INFO - TEST-INFO | started process 4370 (/builds/slave/test/build/application/firefox/firefox http://localhost:33496/getInfo.html) 11:47:53 INFO - TEST-INFO | 4370: exit 0 11:47:53 INFO - Browser initialized. 11:47:53 INFO - Running cycle 1/1 for kraken test... 11:47:53 INFO - Using env: {'DISPLAY': ':0', 11:47:53 INFO - 'HOME': '/home/cltbld', 11:47:53 INFO - 'JSGC_DISABLE_POISONING': '1', 11:47:53 INFO - 'LANG': 'en_US.UTF-8', 11:47:53 INFO - 'LANGUAGE': 'en_US:en', 11:47:53 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:47:53 INFO - 'LOGNAME': 'cltbld', 11:47:53 INFO - 'MAIL': '/var/mail/cltbld', 11:47:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:47:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:47:53 INFO - 'MOZ_CRASHREPORTER': '1', 11:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:53 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:47:53 INFO - 'MOZ_NO_REMOTE': '1', 11:47:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:53 INFO - 'NO_EM_RESTART': '1', 11:47:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:53 INFO - 'PWD': '/builds/slave/test', 11:47:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:47:53 INFO - 'RUST_BACKTRACE': 'full', 11:47:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:47:53 INFO - 'SHELL': '/bin/bash', 11:47:53 INFO - 'SHLVL': '1', 11:47:53 INFO - 'TERM': 'linux', 11:47:53 INFO - 'TMOUT': '86400', 11:47:53 INFO - 'USER': 'cltbld', 11:47:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359', 11:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:53 INFO - '_': '/tools/buildbot/bin/python'} 11:47:53 INFO - TEST-INFO | started process 4559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXji2YJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:53 INFO - PID 4559 | 11:47:53 INFO - PID 4559 | (/builds/slave/test/build/application/firefox/firefox:4607): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:47:53 INFO - PID 4559 | 11:48:04 INFO - PID 4559 | RSS: Main: 141369344 11:48:04 INFO - PID 4559 | 11:48:06 INFO - PID 4559 | Cycle 1(1): loaded http://localhost:33496/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33496/tests/kraken/driver.html?testName=audio-beat-detection) 11:48:07 INFO - PID 4559 | RSS: Main: 147050496 11:48:07 INFO - PID 4559 | 11:48:10 INFO - PID 4559 | Cycle 1(1): loaded http://localhost:33496/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33496/tests/kraken/driver.html?testName=audio-dft) 11:48:10 INFO - PID 4559 | RSS: Main: 147083264 11:48:10 INFO - PID 4559 | 11:48:13 INFO - PID 4559 | Cycle 1(1): loaded http://localhost:33496/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33496/tests/kraken/driver.html?testName=audio-fft) 11:48:14 INFO - PID 4559 | RSS: Main: 149000192 11:48:14 INFO - PID 4559 | 11:48:16 INFO - PID 4559 | Cycle 1(1): loaded http://localhost:33496/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33496/tests/kraken/driver.html?testName=audio-oscillator) 11:48:16 INFO - PID 4559 | RSS: Main: 148959232 11:48:16 INFO - PID 4559 | 11:48:19 INFO - PID 4559 | Cycle 1(1): loaded http://localhost:33496/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33496/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:48:19 INFO - PID 4559 | RSS: Main: 148770816 11:48:19 INFO - PID 4559 | 11:48:22 INFO - PID 4559 | Cycle 1(1): loaded http://localhost:33496/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33496/tests/kraken/driver.html?testName=imaging-darkroom) 11:48:23 INFO - PID 4559 | RSS: Main: 149090304 11:48:23 INFO - PID 4559 | 11:48:26 INFO - PID 4559 | Cycle 1(1): loaded http://localhost:33496/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33496/tests/kraken/driver.html?testName=imaging-desaturate) 11:48:27 INFO - PID 4559 | RSS: Main: 150077440 11:48:27 INFO - PID 4559 | 11:48:30 INFO - PID 4559 | Cycle 1(1): loaded http://localhost:33496/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33496/tests/kraken/driver.html?testName=json-parse-financial) 11:48:30 INFO - PID 4559 | RSS: Main: 151232512 11:48:30 INFO - PID 4559 | 11:48:32 INFO - PID 4559 | Cycle 1(1): loaded http://localhost:33496/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33496/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:48:32 INFO - PID 4559 | RSS: Main: 151670784 11:48:32 INFO - PID 4559 | 11:48:34 INFO - PID 4559 | Cycle 1(1): loaded http://localhost:33496/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33496/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:48:35 INFO - PID 4559 | RSS: Main: 151752704 11:48:35 INFO - PID 4559 | 11:48:37 INFO - PID 4559 | Cycle 1(1): loaded http://localhost:33496/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33496/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:48:37 INFO - PID 4559 | RSS: Main: 149270528 11:48:37 INFO - PID 4559 | 11:48:40 INFO - PID 4559 | Cycle 1(1): loaded http://localhost:33496/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:48:40 INFO - PID 4559 | RSS: Main: 148938752 11:48:40 INFO - PID 4559 | 11:48:43 INFO - PID 4559 | Cycle 1(1): loaded http://localhost:33496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:48:44 INFO - PID 4559 | RSS: Main: 149585920 11:48:44 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | Cycle 1(1): loaded http://localhost:33496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33496/tests/kraken/driver.html?testName=ai-astar) 11:48:45 INFO - PID 4559 | RSS: Main: 150925312 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | __start_tp_report 11:48:45 INFO - PID 4559 | _x_x_mozilla_page_load 11:48:45 INFO - PID 4559 | _x_x_mozilla_page_load_details 11:48:45 INFO - PID 4559 | |i|pagename|runs| 11:48:45 INFO - PID 4559 | |0;ai-astar;105;106;105;106;106;99;106;105;106;106 11:48:45 INFO - PID 4559 | |1;audio-beat-detection;112;111;115;112;114;138;114;112;114;111 11:48:45 INFO - PID 4559 | |2;audio-dft;169;165;162;166;162;164;161;163;163;165 11:48:45 INFO - PID 4559 | |3;audio-fft;75;73;74;74;75;74;74;73;73;73 11:48:45 INFO - PID 4559 | |4;audio-oscillator;78;78;76;77;77;77;77;84;87;76 11:48:45 INFO - PID 4559 | |5;imaging-gaussian-blur;110;115;115;114;114;113;110;114;114;115 11:48:45 INFO - PID 4559 | |6;imaging-darkroom;150;148;150;150;150;150;152;151;150;152 11:48:45 INFO - PID 4559 | |7;imaging-desaturate;95;95;95;95;93;96;95;95;95;95 11:48:45 INFO - PID 4559 | |8;json-parse-financial;43;43;42;44;44;43;43;44;42;43 11:48:45 INFO - PID 4559 | |9;json-stringify-tinderbox;40;40;41;41;40;41;40;41;40;40 11:48:45 INFO - PID 4559 | |10;stanford-crypto-aes;73;72;71;70;73;70;77;72;69;74 11:48:45 INFO - PID 4559 | |11;stanford-crypto-ccm;114;107;108;104;103;104;106;103;101;105 11:48:45 INFO - PID 4559 | |12;stanford-crypto-pbkdf2;151;149;154;145;153;150;153;148;146;149 11:48:45 INFO - PID 4559 | |13;stanford-crypto-sha256-iterative;63;62;59;58;59;59;60;65;58;61 11:48:45 INFO - PID 4559 | __end_tp_report 11:48:45 INFO - PID 4559 | __start_cc_report 11:48:45 INFO - PID 4559 | _x_x_mozilla_cycle_collect,679 11:48:45 INFO - PID 4559 | __end_cc_report 11:48:45 INFO - PID 4559 | __startTimestamp1506710925928__endTimestamp 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | ------- Summary: start ------- 11:48:45 INFO - PID 4559 | Number of tests: 14 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | [#0] ai-astar Cycles:10 Average:105.00 Median:106.00 stddev:2.16 (2.0%) stddev-sans-first:2.29 11:48:45 INFO - PID 4559 | Values: 105.0 106.0 105.0 106.0 106.0 99.0 106.0 105.0 106.0 106.0 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | [#1] audio-beat-detection Cycles:10 Average:115.30 Median:114.00 stddev:8.10 (7.1%) stddev-sans-first:8.50 11:48:45 INFO - PID 4559 | Values: 112.0 111.0 115.0 112.0 114.0 138.0 114.0 112.0 114.0 111.0 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.50 stddev:2.36 (1.4%) stddev-sans-first:1.67 11:48:45 INFO - PID 4559 | Values: 169.0 165.0 162.0 166.0 162.0 164.0 161.0 163.0 163.0 165.0 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | [#3] audio-fft Cycles:10 Average:73.80 Median:74.00 stddev:0.79 (1.1%) stddev-sans-first:0.71 11:48:45 INFO - PID 4559 | Values: 75.0 73.0 74.0 74.0 75.0 74.0 74.0 73.0 73.0 73.0 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | [#4] audio-oscillator Cycles:10 Average:78.70 Median:77.50 stddev:3.71 (4.8%) stddev-sans-first:3.93 11:48:45 INFO - PID 4559 | Values: 78.0 78.0 76.0 77.0 77.0 77.0 77.0 84.0 87.0 76.0 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:114.00 stddev:1.90 (1.7%) stddev-sans-first:1.56 11:48:45 INFO - PID 4559 | Values: 110.0 115.0 115.0 114.0 114.0 113.0 110.0 114.0 114.0 115.0 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 11:48:45 INFO - PID 4559 | Values: 150.0 148.0 150.0 150.0 150.0 150.0 152.0 151.0 150.0 152.0 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 11:48:45 INFO - PID 4559 | Values: 95.0 95.0 95.0 95.0 93.0 96.0 95.0 95.0 95.0 95.0 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | [#8] json-parse-financial Cycles:10 Average:43.10 Median:43.00 stddev:0.74 (1.7%) stddev-sans-first:0.78 11:48:45 INFO - PID 4559 | Values: 43.0 43.0 42.0 44.0 44.0 43.0 43.0 44.0 42.0 43.0 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | [#9] json-stringify-tinderbox Cycles:10 Average:40.40 Median:40.50 stddev:0.52 (1.3%) stddev-sans-first:0.53 11:48:45 INFO - PID 4559 | Values: 40.0 40.0 41.0 41.0 40.0 41.0 40.0 41.0 40.0 40.0 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | [#10] stanford-crypto-aes Cycles:10 Average:72.10 Median:72.50 stddev:2.33 (3.2%) stddev-sans-first:2.45 11:48:45 INFO - PID 4559 | Values: 73.0 72.0 71.0 70.0 73.0 70.0 77.0 72.0 69.0 74.0 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | [#11] stanford-crypto-ccm Cycles:10 Average:105.50 Median:105.50 stddev:3.63 (3.4%) stddev-sans-first:2.19 11:48:45 INFO - PID 4559 | Values: 114.0 107.0 108.0 104.0 103.0 104.0 106.0 103.0 101.0 105.0 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:150.50 stddev:3.01 (2.0%) stddev-sans-first:3.16 11:48:45 INFO - PID 4559 | Values: 151.0 149.0 154.0 145.0 153.0 150.0 153.0 148.0 146.0 149.0 11:48:45 INFO - PID 4559 | 11:48:45 INFO - PID 4559 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:60.50 stddev:2.32 (3.8%) stddev-sans-first:2.26 11:48:45 INFO - PID 4559 | Values: 63.0 62.0 59.0 58.0 59.0 59.0 60.0 65.0 58.0 61.0 11:48:45 INFO - PID 4559 | -------- Summary: end -------- 11:48:45 INFO - PID 4559 | 11:48:46 INFO - PID 4559 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:48:46 INFO - TEST-INFO | 4559: exit 0 11:48:46 INFO - TEST-OK | kraken | took 59793ms 11:48:46 INFO - SUITE-END | took 1173s 11:48:47 INFO - Completed test suite (00:19:33) 11:48:47 INFO - javascript benchmark 11:48:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9604.39270198339, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3970.7419017763846, 3975.324194886871, 3978.303796835554, 4006.8179886933353, 4040.59594040596, 6642.269350371455, 6688.699008544609, 6721.924492081268, 6746.359095885895, 6751.898721519181, 6648.567843090195, 6653.035309880064, 6729.697163627637, 6730.798076057714, 6772.661366931646, 5896.616719913213, 5938.46553810157, 6032.7285272162635, 6038.516918646497, 6092.6953652317425, 6009.549283803711, 6069.635821850703, 6083.057126145454, 6128.417800308964, 6129.754809807625, 5988.940110598882, 6001.129836173752, 6014.127951447038, 6023.036314189731, 6032.758689652409, 5875.1187321901625, 6031.24609423822, 6031.698415079229, 6079.179310793031, 6113.510919126459, 5906.557008224358, 5928.644281343133, 5984.97007514964, 6131.14164017038, 6136.987397079477, 6597.373249541286, 6620.205575330943, 6661.200655921272, 6711.932880671179, 6875.106236189264, 7099.396551293146, 7147.49967502275, 7184.209736928986, 7207.711691532332, 7260.1287845458355, 7287.708491660327, 7332.78001659951, 7347.787615043511, 7379.59412232327, 7384.556926584422, 6607.60354378734, 6728.125343705287, 6803.48973826965, 6813.250542440328, 6826.556273842234, 7385.556866588022, 7440.0, 7477.439192060618, 7538.962305188439, 7555.659995300225, 7189.928100718926, 7210.062691850026, 7261.128664560287, 7277.345038946521, 7283.526570772989, 7241.0, 7304.707811687473, 7355.668994895243, 7385.741499047615, 7406.962965185139, 7189.532680375759, 7274.454415918827, 7283.599402032939, 7320.304571065741, 7343.706251749977, 7200.243974382614, 7212.531185472927, 7298.781036568911, 7304.5252058616015, 7306.196318404971, 5328.3605967284175, 5390.191471279261, 5417.349918009864, 5425.83722488326, 5453.809116680897, 4825.927611085836, 4831.855044348676, 4863.635227357962, 4877.756112194447, 4916.164252077156, 6637.3030831762935, 6700.2294736105, 6714.462842972648, 6719.260881303053, 6725.966370168216, 7062.6821793019435, 7165.820854478679, 7288.380487658608, 7328.96335518319, 7361.30067643573, 6566.409023187936, 6570.441512471398, 6584.341565843377, 6606.372394622503, 6687.966560167265, 6036.879262414727, 6118.847028824226, 6138.877222455526, 6156.938430615726, 6162.198914141222, 7323.304286092813, 7347.963260183665, 7393.07586551681, 7422.814429639194, 7483.6258187090425, 7012.894806577905, 7092.751753688596, 7136.357727804522, 7201.567905925661, 7251.274872512707, 7452.0, 7504.362129219077, 7508.812279693051, 7526.285002924714, 7567.281108294703, 7220.963895180491, 7299.8540029200185, 7309.232530584425, 7311.963440182765, 7312.122545294599, 7260.092488438945, 7312.451566132455, 7318.121825380988, 7321.121465424183, 7386.704531818667, 6990.860182796418, 7086.929130708627, 7088.326608972139, 7092.751753688596, 7125.038119853961, 7043.823904402431, 7070.151581810215, 7073.2219455858785, 7132.037174981519, 7158.212596614472, 6918.135233095863, 6981.581105133709, 6994.405475534637, 7001.509894307554, 7010.824729381806, 7017.2631873652535, 7068.752593659403, 7110.680019399036, 7170.641467926687, 7196.8920466194095, 6799.184097908283, 6818.829529261609, 6842.692078856563, 6854.8286292841085, 6884.311568843276], "value": 6637.209781876943, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [992.5186284651938, 1001.4191768774111, 1028.855960165577, 1030.299396410441, 1037.8910214427485, 45851.0, 46485.30272045918, 46539.30191047137, 46786.76606616962, 46895.531044689546, 45017.324740128926, 45321.54678453215, 45368.77315613417, 45419.0, 45498.09003819922, 8087.1508491608265, 8217.876731849026, 8233.217844304781, 8240.423170378075, 8245.95877020617, 8121.878171827428, 8238.340932725368, 8253.628586713612, 8256.215659512336, 8264.21489958453, 8170.836583268331, 8759.868601970975, 8848.734537963872, 8943.32925030622, 8952.507612081334, 8817.779555511099, 8846.336524760636, 8870.955645221733, 8891.822163556757, 8906.73279801607, 8706.608202630898, 8792.560371981439, 8799.076097009785, 8800.0, 8804.339674524435, 42848.357274640905, 43092.78453607712, 43105.35341969873, 43142.568574314166, 43285.56714432847, 3870.8838734838, 3906.8437262509465, 3915.0799562102884, 3917.0, 3917.902052448683, 34780.0, 34886.302273954636, 34890.0, 35002.82498587516, 35015.64984350175, 5589.077802162638, 5645.2096706461125, 5666.348369937468, 5679.062954612484, 5695.316562012544, 218646.0, 219954.0, 220655.0, 221410.0, 221833.0, 50824.74587627038, 51959.0, 54944.17583736247, 55490.72254638701, 55901.72049139728, 57544.71227643835, 57633.42366576364, 57719.134212986835, 57787.42212577904, 57802.13296800551, 18000.0, 18129.45611631653, 18167.63664726698, 18178.27286908509, 18207.08964551767, 14842.40630374773, 14859.851401485847, 14971.850281497263, 14976.47582334613, 15090.396384144511, 15113.0, 15120.319585618674, 15211.315490802941, 15229.1623960681, 15399.153046582322, 5990.161377407167, 6094.939050609526, 6136.0, 6177.938220617826, 6210.31686514483, 1115.6597237842373, 1126.3861195648392, 1129.277262551951, 1140.0651465798132, 1143.5654451308449, 26095.869520652654, 26767.732322676526, 26941.86529067342, 27001.86499067492, 27581.0, 1233.7409144079663, 1233.9197952133084, 1238.5479300055415, 1242.043626407679, 1246.9750604987848, 13715.245661488514, 13802.723945521033, 14137.222452765196, 14275.928620356832, 14381.0, 288861.0, 289331.0, 289712.0, 290301.0, 291013.0, 61632.0, 62134.689326553984, 62152.37847621556, 62305.0, 62489.37510624836, 1561.3286286896516, 1577.6765763018784, 1590.9124998125214, 1595.3459081776416, 1605.871530277575, 26204.08285709991, 26250.212493625222, 26325.473490530465, 26383.472330553665, 26539.867300663373, 42569.78715106405, 42750.358744618236, 42809.1438171241, 42825.35761963635, 42845.78577107094, 245550.0, 247374.0, 247451.0, 248111.0, 249383.0, 36823.26353472969, 39766.0, 40003.0, 40161.799191003855, 40430.0, 51859.0, 53693.463065368844, 53719.0, 53898.0, 53900.19149712679, 38155.2368952625, 38523.22953540969, 38775.0, 38905.0, 38985.805070974464, 37745.24509509849, 37827.24345513129, 38014.0, 38318.23363532769, 38399.80800095982, 44586.77706611446, 44769.328460073775, 45154.54845451503, 45566.0, 45583.08833823371, 35673.28653426865, 35831.82084089563, 35949.46075808813, 36362.45456318105, 36752.26495470129, 27324.863375682995, 27373.452530949668, 27485.73971034493, 27653.58519622167, 27659.723402765714], "value": 19601.712946813346, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.2974089830368, 642.1078311783365, 643.4426630887208, 648.6966824644549, 651.6661128661902, 24226.15208467704, 24979.37551561212, 24980.12569560066, 24980.750192498046, 24998.375040623992, 26740.0, 26929.192124236255, 27068.458630827372, 27207.727922720765, 27404.725952740468, 6694.96652516738, 7054.470914681419, 7103.573785572857, 7137.143542774875, 7149.571025738473, 7022.859542809141, 7131.7503887363955, 7131.89302160468, 7134.001239826429, 7134.393576546, 6543.509236807258, 6828.624425656587, 6837.589744615314, 7015.052967849351, 7099.964500177518, 6739.090222819955, 6800.727970881158, 6806.693698783542, 6835.350641689031, 6848.794536163899, 6354.586951848115, 6374.330695276975, 6384.585001974857, 6393.424591786715, 6406.583572067801, 30165.547516787265, 30447.238819029702, 30652.233694157825, 30896.845515772504, 31111.0, 2325.6395258734924, 2325.8837058147024, 2330.8135349172194, 2349.9060037598474, 2389.438481956739, 20490.282840100524, 20868.269610563708, 20995.265165719127, 21064.157433702632, 21188.15247390118, 2546.7707906288338, 2585.31489155374, 2642.7885769138425, 2648.192301348088, 2648.9867550662316, 141286.0, 146948.0, 161209.0, 167516.0, 167622.0, 16360.0, 16778.32886684519, 17141.17170666826, 17211.13944302805, 17371.218295176746, 27124.965627577614, 27197.184084477103, 27363.042293519633, 27376.0, 27437.314067148083, 10970.780584388267, 11156.107511399068, 11220.719482012852, 11264.774704505864, 11396.373199474108, 10103.595856165817, 10142.391456512485, 10256.923023082618, 10261.281710280358, 10338.741531461774, 10009.799804003878, 10162.136218421369, 10260.43567603774, 10272.640457584099, 10481.790364192826, 2871.655401351851, 2881.8991335303162, 2951.1146656003543, 3042.6500952390757, 3122.0945925681754, 1053.1679972821385, 1053.1837825685002, 1071.7106381277013, 1075.306427354352, 1079.956801727922, 21513.56972860534, 21718.565628687655, 21945.231916882833, 22042.33872983813, 22290.88854555717, 1130.4178348150708, 1136.420425582942, 1141.5547936304847, 1149.2127892393737, 1154.3881742676394, 11938.88061119395, 11962.342071186169, 12007.879921200676, 12022.218555793845, 12031.037516998618, 537102.0, 547036.0, 547503.0, 559699.0, 564737.0, 133815.0, 137298.0, 138143.0, 138590.0, 139959.0, 1134.121056181466, 1161.6795078540265, 1250.5373011985441, 1253.348258905364, 1276.144982861485, 22278.88860555687, 22526.774732253125, 22594.887025565426, 22614.547709045397, 23130.0, 63341.68329158325, 63409.0, 64973.35026649673, 65875.01187482096, 66779.33220667731, 79519.60240198762, 79808.60095699484, 80181.59909200417, 80846.19153808386, 80909.0, 16410.589735256715, 16693.499195024167, 16763.245653945356, 16784.160791960596, 16832.57918552046, 25241.621375679013, 25291.747082529677, 25379.0, 25415.745842542077, 25813.48373032491, 20617.69073463869, 20738.688919665914, 20787.480312992295, 20922.37232883016, 20962.266320678704, 18109.637807244046, 18254.634907302046, 18390.172442239862, 18839.434816955512, 19067.332643357415, 20963.475913102295, 21211.04550295271, 21243.681344779532, 21370.252041178483, 21522.569548608626, 16129.11289879068, 16183.75724364159, 16219.918900405895, 16302.673946520767, 16391.67216655684, 19955.0, 20105.597888042448, 20231.19075237033, 20312.390628281177, 20468.0], "value": 13258.580559239766, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.8099647045883, 1501.3018946190027, 1505.0668585476992, 1510.131674287285, 1522.4366984215842, 16918.154092295383, 17502.12489375531, 17726.290948362068, 17753.467395978143, 17772.200250988735, 17447.12764361783, 17472.475825725247, 17547.47357579275, 17574.912125439387, 17585.472435826912, 2995.41589390069, 3066.310080231947, 3068.509038553832, 3073.569700241968, 3080.7535397168285, 2638.1557901471538, 2648.9470210595778, 2654.4027593791434, 2657.5083609532203, 2667.719889411603, 2956.364381657943, 2993.4162838246552, 3018.064400035985, 3020.426119037376, 3021.4108248891475, 2786.0, 2789.1353680359152, 2815.7184281571886, 2825.5620378841313, 2825.9293517662018, 2719.564869620871, 2745.8627068646488, 2773.9583906241423, 2779.4163225722623, 2787.8048536602446, 16648.833511664972, 16761.580960475963, 16767.413140540022, 16783.24475398598, 16810.24353904065, 8451.323894088458, 8661.740147795575, 8664.61009254585, 8698.826023479558, 8709.0, 5496.642718223303, 5805.593608447411, 6020.879582408371, 6045.546584006173, 6096.786612468587, 2171.5005548723725, 2216.1689366487567, 2216.1910902520463, 2253.966190507144, 2312.7340355858955, 30281.545776813364, 31051.378972420425, 32788.180295492566, 33589.83205084008, 33607.6639233607, 7949.880751788728, 7981.840363192704, 8061.879071813927, 8108.4188583225705, 8161.0, 24207.39481512941, 24243.51512969731, 24278.27165185047, 24286.392840178785, 24339.634905476432, 9010.053944335881, 9108.225800806873, 9143.497107659143, 9143.908560914439, 9148.2681385489, 7942.44402891792, 8085.555294458862, 8199.71301004462, 8219.849221109049, 8232.723927791201, 6513.381228783258, 6522.608643481406, 6524.412802847766, 6532.464870755369, 6641.601503909685, 1949.3761996161377, 1973.4770285874256, 2008.1666108564782, 2012.7785943546198, 2014.2949967511254, 990.782027953849, 996.3374356053143, 998.236349192868, 1002.5638847101534, 1021.8620486234412, 8563.657453701782, 8577.399582029198, 8587.613557389932, 8744.606492707844, 8757.912420875837, 800.7797855589642, 811.9106898241189, 823.8393513264856, 824.7031068815222, 830.6013113705335, 5281.577473802086, 5286.577073834084, 5304.496072873071, 5368.758405871745, 5370.140777475585, 26072.8696356517, 27104.864475677496, 27142.728572714415, 27259.72740272572, 27270.227435216646, 25584.48831023369, 26583.33541661474, 26765.732342676714, 26804.865975669996, 26836.463270734475, 11535.884641153649, 12638.810417843739, 12866.742665146645, 12875.613731588068, 13293.93353033248, 9633.518324083627, 9762.609495620096, 9802.803943921224, 9916.504174791087, 10012.64955726546, 21832.781672183075, 21992.34022979313, 22627.88686056559, 22884.4278893029, 23595.646065309378, 23289.0, 23547.0, 23727.1695490657, 23748.0, 24092.638610421207, 14066.226357550024, 14354.928225358806, 14362.497312594009, 14374.568762937128, 14376.496822611158, 14933.775993359892, 15752.369905203663, 15917.840821591635, 16010.599735006717, 16095.597610059842, 12770.68073298175, 12838.614841554769, 12948.870511295143, 13003.739925201633, 13084.672883177996, 11998.420734358217, 12223.388830558259, 12316.014718822651, 12505.374731263219, 12511.624651260478, 10660.84008739885, 10820.242583019113, 10900.291481053706, 10903.78192436131, 10928.672139835817, 8300.2114799094, 8398.118197589165, 8419.158084191531, 8426.620802063799, 8449.66201351939, 8635.6977505787, 8741.256993155399, 8757.211850933447, 8820.029796722483, 8850.557472126497], "value": 7603.230887908459, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.580529116391, 588.4262843727365, 607.077242591261, 611.4741322462683, 621.6239175298944, 6452.2257329120575, 6496.642684652342, 6542.967285163568, 6604.207495100589, 6619.404253617174, 6519.011701431062, 6531.7387304507765, 6554.737810487587, 6572.441342485894, 6589.143411356517, 5367.35591728993, 5374.946250537503, 5410.026195284847, 5413.404525502192, 5421.864453388657, 5037.546620804127, 5240.3187585614005, 5361.5978801589845, 5363.839084827442, 5410.1073322901675, 5196.830713089563, 5211.166213405856, 5222.0, 5241.344831896013, 5247.816326428576, 5192.948070519285, 5225.608079394061, 5232.686038837682, 5240.0, 5256.658317209369, 4762.833300834489, 4781.211100168468, 4791.976040119812, 4802.18362878308, 4807.687500312503, 6513.804585862432, 6539.136346141327, 6572.901406478906, 6594.901076483857, 6608.603483790988, 6194.442500175006, 6203.379662033805, 6224.315325314212, 6292.5280603954425, 6299.0, 6918.757843475504, 6990.475714321396, 7034.296570342976, 7034.718611255544, 7059.329363710439, 5140.7172605506685, 5388.245645609618, 5406.270153529302, 5406.648567843077, 5418.783248670048, 7081.114860642419, 7109.75115870942, 7123.860182370848, 7140.4287656987835, 7256.637168141625, 5467.261919640877, 5471.5896307777075, 5475.945240547623, 5510.366307874566, 5535.391106978229, 5549.0289199389945, 5577.0, 5588.0, 5602.243697100921, 5613.607047506635, 6207.534434917399, 6218.751249950042, 6221.097940798559, 6241.750329986749, 6243.375662433811, 7032.824179395454, 7073.3987611053635, 7075.398591119812, 7084.468664850054, 7097.609631470215, 1880.5298675331167, 1907.7424547686162, 1908.8854668719644, 1913.9521511962312, 1938.5444420561157, 1313.1202094596642, 1374.6013656039636, 1376.311844077961, 1377.1668140774887, 1385.6051025457696, 6354.872902541923, 6371.458426033839, 6495.967520162369, 6499.447546958561, 6554.573952693059, 7002.264762199998, 7050.753223637251, 7089.255628158969, 7113.57318560888, 7125.82185445368, 6435.195600549931, 6508.186476690414, 6513.348665133543, 6516.283208847023, 6566.3105373936005, 3709.2581483703366, 3795.6773674237447, 3799.848006079781, 3814.256220037066, 3846.3268927937497, 7354.007209026713, 7400.481966262418, 7401.222871598512, 7424.294692004251, 7441.702331906663, 7128.786136415916, 7304.306090921354, 7325.670344834495, 7357.374623157091, 7402.33378995893, 7308.415326773846, 7336.569368972999, 7359.889601655872, 7378.19234287603, 7458.73894413693, 6897.758578449931, 6951.7914462566205, 6994.691751722021, 7095.751648692271, 7115.6086415247655, 7033.331833475811, 7053.929460705327, 7133.5719856808755, 7156.391706704989, 7165.3551180394015, 7222.386097181588, 7328.969067013228, 7372.815679608053, 7383.630818459163, 7384.372328351936, 5478.534324582296, 5489.917651235314, 5493.0, 5501.587380946365, 5523.558115350843, 6873.518853680194, 7122.501424900414, 7125.287471252833, 7129.572225666477, 7192.446681428227, 6595.967020164869, 6824.2152152503095, 6879.724811007503, 6915.585064896122, 6927.238003819677, 6860.725570977105, 6901.206361268519, 6912.516123871482, 6923.307669233036, 6933.37599616037, 6739.966300168664, 6792.811258029727, 6813.148356455443, 6833.257519332538, 6868.9049839799345, 6981.79054628362, 7018.824529386806, 7043.542169759155, 7044.330788575077, 7050.753223637148, 6696.662654994563, 6754.0881980931945, 6800.31996800316, 6815.114035175396, 6854.520183587101], "value": 5468.375636849148, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [997.5760301871708, 1006.0894890124438, 1019.9694009179727, 1037.7353774787427, 1042.2756184451807, 23833.5233295334, 25828.612570811452, 25828.870855645742, 25926.0, 25992.740072599267, 23008.0, 24869.0, 24933.12734054304, 24948.87525562374, 24983.0, 1104.6133853151393, 1130.2822707580663, 1136.5851464215584, 1136.6078702847503, 1136.8408422820812, 825.2119226139023, 839.492107275099, 1102.2614848051785, 1134.183387960671, 1138.669785762128, 1169.625719769674, 1179.262960649594, 1180.74613957999, 1182.2788099259444, 1183.1540448579265, 1168.0480408467156, 1169.6900321414832, 1170.39724541861, 1171.4377098992488, 1171.4962566096574, 866.0733015673233, 867.5922316511229, 867.9001914779755, 868.2359523619238, 868.8783570300163, 21488.677669834964, 22445.663315050286, 22485.662715059287, 22522.0, 22569.210077647367, 24274.39314017146, 24516.877415612988, 24736.0, 24794.008239670573, 24796.876015619986, 18164.364247251415, 18206.18072186755, 18350.54123646906, 18467.722984155247, 18587.256509739593, 4118.0, 4140.296149654536, 4141.958580414187, 4146.834126634931, 4149.875503734893, 162989.18505407398, 167475.16262418733, 168821.15589422098, 168923.0, 170718.0, 18497.0, 18590.907045464686, 18648.720269195972, 18973.43079707611, 18978.71531927022, 29061.41877162445, 29280.267993299913, 35533.644663553554, 35636.64363356385, 35679.82160089183, 10424.374537527772, 10751.83872241917, 10787.730306742395, 10821.404822734668, 10872.510737016853, 5145.871353216125, 5205.193195054697, 5241.68549887008, 5244.108501554745, 5254.816081437131, 6397.808065758035, 6513.088167656532, 6525.11910892033, 6547.279799222082, 6569.901451478232, 1211.6243964371074, 1241.3110723548518, 1251.305525433375, 1252.7118762684634, 1257.6289994451658, 742.0798210219289, 753.1038064702985, 759.4038679636459, 768.8654485465021, 773.0877564473975, 13795.931020345035, 14056.578302650936, 14570.344334504973, 15364.231788410534, 15466.381344746083, 771.3096778383427, 773.7833406646148, 775.4571799740204, 779.9298063174341, 787.5707739282105, 6502.219733631994, 6556.4427023702565, 6569.9343006569325, 6602.7689030883685, 6603.438707709803, 159982.2000889988, 160639.0, 161748.0, 163918.0, 164447.0, 141492.0, 142923.28538357242, 144205.27897360447, 144867.0, 145082.0, 124561.37719311345, 127202.0, 127503.0, 128292.35853820857, 130089.34955325352, 12539.310337931136, 12554.0, 12585.748285034431, 12677.746445071232, 12862.421191046613, 58194.4180558189, 58864.70567647306, 59068.0, 59518.51203719942, 60437.69781151066, 76495.0, 76603.0, 76674.23325766894, 77496.61251693705, 78993.0, 22708.432289192904, 23148.0, 23245.0, 23633.172838950555, 23720.644190336814, 24990.875045625384, 25423.745762542138, 25539.6169057468, 25545.700886920265, 26143.73856261413, 23657.763422365555, 23949.04203831827, 24258.636120457853, 24368.147114850894, 24709.629355559322, 19432.514187145436, 20272.59454810925, 21991.780082198973, 22516.66225006659, 22816.31551053471, 21241.575168496853, 21462.14151433925, 22484.213052543084, 22544.66183007289, 23187.0, 14324.283785810876, 14437.989340746048, 15197.240137992834, 15285.770713439086, 15710.371585136467, 14605.0, 14849.554513364616, 14920.701585968003, 15131.789456843646, 15136.621584460476], "value": 10943.621932065025, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1366.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 106.0, 105.0, 106.0, 106.0, 99.0, 106.0, 105.0, 106.0, 106.0], "value": 105.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 115.0, 112.0, 114.0, 138.0, 114.0, 112.0, 114.0, 111.0], "value": 115.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 162.0, 166.0, 162.0, 164.0, 161.0, 163.0, 163.0, 165.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 74.0, 75.0, 74.0, 74.0, 73.0, 73.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 76.0, 77.0, 77.0, 77.0, 77.0, 84.0, 87.0, 76.0], "value": 78.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 115.0, 114.0, 114.0, 113.0, 110.0, 114.0, 114.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 150.0, 150.0, 150.0, 150.0, 152.0, 151.0, 150.0, 152.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 93.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 43.0, 42.0, 44.0, 44.0, 43.0, 43.0, 44.0, 42.0, 43.0], "value": 43.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 40.0, 41.0, 41.0, 40.0, 41.0, 40.0, 41.0, 40.0, 40.0], "value": 40.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 71.0, 70.0, 73.0, 70.0, 77.0, 72.0, 69.0, 74.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 108.0, 104.0, 103.0, 104.0, 106.0, 103.0, 101.0, 105.0], "value": 105.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 154.0, 145.0, 153.0, 150.0, 153.0, 148.0, 146.0, 149.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 59.0, 58.0, 59.0, 59.0, 60.0, 65.0, 58.0, 61.0], "value": 60.4, "unit": "score"}]}]} 11:48:47 INFO - Return code: 0 11:48:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:48:47 INFO - # TBPL SUCCESS # 11:48:47 INFO - Running post-action listener: _package_coverage_data 11:48:47 INFO - Running post-action listener: _resource_record_post_action 11:48:47 INFO - [mozharness: 2017-09-29 18:48:47.244135Z] Finished run-tests step (success) 11:48:47 INFO - Running post-run listener: _resource_record_post_run 11:48:47 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 9023488; Write bytes: 475525120; Read time: 2856; Write time: 535688 11:48:47 INFO - TinderboxPrint: CPU usage
13.1% 11:48:47 INFO - TinderboxPrint: I/O read bytes / time
9,023,488 / 2,856 11:48:47 INFO - TinderboxPrint: I/O write bytes / time
475,525,120 / 535,688 11:48:47 INFO - TinderboxPrint: CPU idle
8,234.2 (86.9%) 11:48:47 INFO - TinderboxPrint: CPU user
1,183.5 (12.5%) 11:48:47 INFO - TinderboxPrint: Swap in / out
0 / 0 11:48:47 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 66072576; Read time: 0; Write time: 52908 11:48:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:48:47 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 9023488; Write bytes: 409452544; Read time: 2856; Write time: 482780 11:48:47 INFO - Running post-run listener: _upload_blobber_files 11:48:47 INFO - Blob upload gear active. 11:48:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:48:47 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 11:48:47 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'] 11:48:47 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 11:48:48 INFO - (blobuploader) - INFO - Open directory for files ... 11:48:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:48:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:48:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:49 INFO - (blobuploader) - INFO - Done attempting. 11:48:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:48:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:48:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:57 INFO - (blobuploader) - INFO - Done attempting. 11:48:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:48:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:48:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:58 INFO - (blobuploader) - INFO - Done attempting. 11:48:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:48:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:48:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:59 INFO - (blobuploader) - INFO - Done attempting. 11:48:59 INFO - (blobuploader) - INFO - Iteration through files over. 11:48:59 INFO - Return code: 0 11:48:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:48:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:48:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06010d341103f15101d8bf5c0fa33fcdcef158454dd49a00e70ad44ac32bdc51f214fa7438bf1d3c5c0f592a45a7588f945a4f8c562b707028800829e9e1cba1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0791a1848f8596cfafd45b901e3b02a7434c0c2cdf05d26fbd5eba883cb94e01d8a8260fe59c5786fa7b7913749baf993bef6af3ec72a73b04d4f1be0fb24764", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fa5c94f40e9b715f507cedbbf7eeb158ce5d87d747b464c8bd748db191d6d40135c18f9dcbea992f60a3adcddde8861b59938c66d16e13d8a4c74425fef8e054", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/17e01239a2eb034ae4f985fa0fe8961aee6c27095d0920598b584e06776966e610429a378ffbbe41b8ec306a678677b407743355b9ed4d6078fc8b5628f6eca7"} 11:48:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:48:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:48:59 INFO - Contents: 11:48:59 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06010d341103f15101d8bf5c0fa33fcdcef158454dd49a00e70ad44ac32bdc51f214fa7438bf1d3c5c0f592a45a7588f945a4f8c562b707028800829e9e1cba1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0791a1848f8596cfafd45b901e3b02a7434c0c2cdf05d26fbd5eba883cb94e01d8a8260fe59c5786fa7b7913749baf993bef6af3ec72a73b04d4f1be0fb24764", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fa5c94f40e9b715f507cedbbf7eeb158ce5d87d747b464c8bd748db191d6d40135c18f9dcbea992f60a3adcddde8861b59938c66d16e13d8a4c74425fef8e054", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/17e01239a2eb034ae4f985fa0fe8961aee6c27095d0920598b584e06776966e610429a378ffbbe41b8ec306a678677b407743355b9ed4d6078fc8b5628f6eca7"} 11:48:59 INFO - Running post-run listener: copy_logs_to_upload_dir 11:48:59 INFO - Copying logs to upload dir... 11:48:59 INFO - mkdir: /builds/slave/test/build/upload/logs 11:48:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.592844 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-29 11:48:59.521227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 11:48:59.525526) ========= 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=52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359 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/06010d341103f15101d8bf5c0fa33fcdcef158454dd49a00e70ad44ac32bdc51f214fa7438bf1d3c5c0f592a45a7588f945a4f8c562b707028800829e9e1cba1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0791a1848f8596cfafd45b901e3b02a7434c0c2cdf05d26fbd5eba883cb94e01d8a8260fe59c5786fa7b7913749baf993bef6af3ec72a73b04d4f1be0fb24764", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fa5c94f40e9b715f507cedbbf7eeb158ce5d87d747b464c8bd748db191d6d40135c18f9dcbea992f60a3adcddde8861b59938c66d16e13d8a4c74425fef8e054", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/17e01239a2eb034ae4f985fa0fe8961aee6c27095d0920598b584e06776966e610429a378ffbbe41b8ec306a678677b407743355b9ed4d6078fc8b5628f6eca7"} build_url:https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011030 build_url: 'https://queue.taskcluster.net/v1/task/dq74M0t_Rbal6PQJbvk0CQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06010d341103f15101d8bf5c0fa33fcdcef158454dd49a00e70ad44ac32bdc51f214fa7438bf1d3c5c0f592a45a7588f945a4f8c562b707028800829e9e1cba1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0791a1848f8596cfafd45b901e3b02a7434c0c2cdf05d26fbd5eba883cb94e01d8a8260fe59c5786fa7b7913749baf993bef6af3ec72a73b04d4f1be0fb24764", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fa5c94f40e9b715f507cedbbf7eeb158ce5d87d747b464c8bd748db191d6d40135c18f9dcbea992f60a3adcddde8861b59938c66d16e13d8a4c74425fef8e054", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/17e01239a2eb034ae4f985fa0fe8961aee6c27095d0920598b584e06776966e610429a378ffbbe41b8ec306a678677b407743355b9ed4d6078fc8b5628f6eca7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 11:48:59.555024) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 11:48:59.555408) ========= 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=52faae308a556c440401f8e5000001e8-1506700543.325967-1025097359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004354 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 11:48:59.638039) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 11:48:59.638388) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 11:48:59.638842) ========= ========= Total master_lag: 0.23 =========