builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1506545461.19 results: success (0) revision: 01cad263a6050e1ed5f58a04bf0fda1464211aef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 13:51:01.187758) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 13:51:01.188190) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 13:51:01.188471) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 13:51:01.204892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 13:51:01.205270) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 13:51:01-- 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% 228M=0s 2017-09-27 13:51:01 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145084 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 13:51:01.369080) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 13:51:01.369461) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020338 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 13:51:01.419668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-27 13:51:01.420002) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 01cad263a6050e1ed5f58a04bf0fda1464211aef --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 01cad263a6050e1ed5f58a04bf0fda1464211aef --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=7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 13:51:01,484 truncating revision to first 12 chars 2017-09-27 13:51:01,484 Setting DEBUG logging. 2017-09-27 13:51:01,484 attempt 1/10 2017-09-27 13:51:01,484 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/01cad263a605?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 13:51:02,365 unpacking tar archive at: mozilla-beta-01cad263a605/testing/mozharness/ program finished with exit code 0 elapsedTime=1.190922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-27 13:51:02.626585) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 13:51:02.626945) ========= script_repo_revision: 01cad263a6050e1ed5f58a04bf0fda1464211aef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 13:51:02.627318) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 13:51:02.627649) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 13:51:02.640906) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2017-09-27 13:51:02.641239) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:51:02 INFO - MultiFileLogger online at 20170927 13:51:02 in /builds/slave/test 13:51:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 13:51:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:51:02 INFO - {'append_to_log': False, 13:51:02 INFO - 'base_work_dir': '/builds/slave/test', 13:51:02 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 13:51:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:51:02 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 13:51:02 INFO - 'buildbot_json_path': 'buildprops.json', 13:51:02 INFO - 'code_coverage': False, 13:51:02 INFO - 'config_files': ('talos/linux_config.py',), 13:51:02 INFO - 'default_actions': ('clobber', 13:51:02 INFO - 'read-buildbot-config', 13:51:02 INFO - 'download-and-extract', 13:51:02 INFO - 'populate-webroot', 13:51:02 INFO - 'create-virtualenv', 13:51:02 INFO - 'install', 13:51:02 INFO - 'setup-mitmproxy', 13:51:02 INFO - 'run-tests'), 13:51:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:51:02 INFO - 'disable_ccov_upload': False, 13:51:02 INFO - 'disable_stylo': False, 13:51:02 INFO - 'download_minidump_stackwalk': True, 13:51:02 INFO - 'download_symbols': 'ondemand', 13:51:02 INFO - 'enable_stylo': False, 13:51:02 INFO - 'enable_webrender': False, 13:51:02 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:51:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:51:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:51:02 INFO - 'gecko_profile': False, 13:51:02 INFO - 'gecko_profile_interval': 0, 13:51:02 INFO - 'installer_path': 'installer.exe', 13:51:02 INFO - 'log_level': 'info', 13:51:02 INFO - 'log_name': 'talos', 13:51:02 INFO - 'log_to_console': True, 13:51:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:51:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:51:02 INFO - 'opt_config_files': (), 13:51:02 INFO - 'pip_index': False, 13:51:02 INFO - 'suite': 'dromaeojs-e10s', 13:51:02 INFO - 'system_bits': '32', 13:51:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:51:02 INFO - 'title': 'talos-linux64-ix-005', 13:51:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:51:02 INFO - 'use_talos_json': True, 13:51:02 INFO - 'verify': 'False', 13:51:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:51:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:51:02 INFO - 'work_dir': 'build'} 13:51:02 INFO - [mozharness: 2017-09-27 20:51:02.847360Z] Running clobber step. 13:51:02 INFO - Running pre-action listener: _resource_record_pre_action 13:51:02 INFO - Running main action method: clobber 13:51:02 INFO - rmtree: /builds/slave/test/build 13:51:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:51:03 INFO - Running post-action listener: _resource_record_post_action 13:51:03 INFO - [mozharness: 2017-09-27 20:51:03.855530Z] Finished clobber step (success) 13:51:03 INFO - [mozharness: 2017-09-27 20:51:03.855628Z] Running read-buildbot-config step. 13:51:03 INFO - Running pre-action listener: _resource_record_pre_action 13:51:03 INFO - Running main action method: read_buildbot_config 13:51:03 INFO - Using buildbot properties: 13:51:03 INFO - { 13:51:03 INFO - "project": "", 13:51:03 INFO - "product": "firefox", 13:51:03 INFO - "who": "ryanvm@gmail.com", 13:51:03 INFO - "installer_path": "public/build/target.tar.bz2", 13:51:03 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 13:51:03 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 13:51:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 13:51:03 INFO - "stage_platform": "linux64", 13:51:03 INFO - "basedir": "/builds/slave/test", 13:51:03 INFO - "buildnumber": 122, 13:51:03 INFO - "platform": "ubuntu64_hw", 13:51:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:51:03 INFO - "slavebuilddir": "test", 13:51:03 INFO - "taskId": "AhTk9aNzQeCWoKczFdMUeA", 13:51:03 INFO - "branch": "mozilla-beta", 13:51:03 INFO - "script_repo_revision": "production", 13:51:03 INFO - "revision": "01cad263a6050e1ed5f58a04bf0fda1464211aef", 13:51:03 INFO - "slavename": "talos-linux64-ix-005", 13:51:03 INFO - "repo_path": "releases/mozilla-beta" 13:51:03 INFO - } 13:51:03 INFO - Finding installer, test and symbols from parent task. 13:51:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AhTk9aNzQeCWoKczFdMUeA'}, attempt #1 13:51:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AhTk9aNzQeCWoKczFdMUeA'}, attempt #1 13:51:04 INFO - Task dependencies: V_hU81KiSRakMPfJ2NKjqg 13:51:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg'}, attempt #1 13:51:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.tar.bz2 13:51:05 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.test_packages.json 13:51:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.crashreporter-symbols.zip 13:51:05 INFO - Running post-action listener: _resource_record_post_action 13:51:05 INFO - [mozharness: 2017-09-27 20:51:05.246616Z] Finished read-buildbot-config step (success) 13:51:05 INFO - [mozharness: 2017-09-27 20:51:05.246834Z] Running download-and-extract step. 13:51:05 INFO - Running pre-action listener: _resource_record_pre_action 13:51:05 INFO - Running main action method: download_and_extract 13:51:05 INFO - mkdir: /builds/slave/test/build/tests 13:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:05 INFO - trying https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.test_packages.json 13:51:05 INFO - Downloading https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:51:05 INFO - Downloaded 989 bytes. 13:51:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:51:05 INFO - Using the following test package requirements: 13:51:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:51:05 INFO - u'common': [u'target.common.tests.zip'], 13:51:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:51:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:51:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:51:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:51:05 INFO - u'mozbase': [u'target.common.tests.zip'], 13:51:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:51:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:51:05 INFO - u'web-platform': [u'target.common.tests.zip', 13:51:05 INFO - u'target.web-platform.tests.tar.gz'], 13:51:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:51:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 13:51:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.common.tests.zip 13:51:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:51:05 INFO - Fetch https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.common.tests.zip into memory 13:51:06 INFO - Content-Length response header: 55178539 13:51:06 INFO - Bytes received: 55178539 13:51:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.talos.tests.zip 13:51:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:51:17 INFO - Fetch https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.talos.tests.zip into memory 13:51:18 INFO - Content-Length response header: 14509184 13:51:18 INFO - Bytes received: 14509184 13:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:18 INFO - trying https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.tar.bz2 13:51:18 INFO - Downloading https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:51:19 INFO - Downloaded 53503142 bytes. 13:51:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.tar.bz2 13:51:19 INFO - mkdir: /builds/slave/test/properties 13:51:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:51:19 INFO - Writing to file /builds/slave/test/properties/build_url 13:51:19 INFO - Contents: 13:51:19 INFO - build_url:https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.tar.bz2 13:51:19 INFO - Running post-action listener: _resource_record_post_action 13:51:19 INFO - Running post-action listener: find_tests_for_verification 13:51:19 INFO - Running post-action listener: set_extra_try_arguments 13:51:19 INFO - [mozharness: 2017-09-27 20:51:19.665440Z] Finished download-and-extract step (success) 13:51:19 INFO - [mozharness: 2017-09-27 20:51:19.665538Z] Running populate-webroot step. 13:51:19 INFO - Running pre-action listener: _resource_record_pre_action 13:51:19 INFO - Running main action method: populate_webroot 13:51:19 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:51:19 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:19 INFO - 'tests': ['tresize', 13:51:19 INFO - 'tcanvasmark']}, 13:51:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:51:19 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:19 INFO - 'tests': ['dromaeo_css', 13:51:19 INFO - 'kraken']}, 13:51:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:51:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:19 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:51:19 INFO - 'talos_options': ['--disable-stylo'], 13:51:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:51:19 INFO - 'tests': ['damp', 'tps']}, 13:51:19 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:51:19 INFO - 'talos_options': ['--disable-stylo'], 13:51:19 INFO - 'tests': ['damp', 'tps']}, 13:51:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:51:19 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:19 INFO - 'tests': ['dromaeo_dom']}, 13:51:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:51:19 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:19 INFO - 'tests': ['basic_compositor_video', 13:51:19 INFO - 'glvideo']}, 13:51:19 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:51:19 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:51:19 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:51:19 INFO - 'talos_options': ['--disable-stylo'], 13:51:19 INFO - 'tests': ['ts_paint_webext', 13:51:19 INFO - 'tp5o_webext']}, 13:51:19 INFO - 'other-e10s': {'tests': ['a11yr', 13:51:19 INFO - 'ts_paint', 13:51:19 INFO - 'tpaint', 13:51:19 INFO - 'sessionrestore', 13:51:19 INFO - 'sessionrestore_many_windows', 13:51:19 INFO - 'sessionrestore_no_auto_restore', 13:51:19 INFO - 'tabpaint']}, 13:51:19 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:19 INFO - 'tests': ['a11yr', 13:51:19 INFO - 'ts_paint', 13:51:19 INFO - 'tpaint', 13:51:19 INFO - 'sessionrestore', 13:51:19 INFO - 'sessionrestore_many_windows', 13:51:19 INFO - 'sessionrestore_no_auto_restore', 13:51:19 INFO - 'tabpaint']}, 13:51:19 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:51:19 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 13:51:19 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:19 INFO - 'tests': ['perf_reftest_singletons']}, 13:51:19 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:19 INFO - 'tests': ['bloom_basic']}, 13:51:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:51:19 INFO - 'tsvgr_opacity', 13:51:19 INFO - 'tart', 13:51:19 INFO - 'tscrollx', 13:51:19 INFO - 'tsvg_static']}, 13:51:19 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:51:19 INFO - 'tests': ['tsvgx', 13:51:19 INFO - 'tsvgr_opacity', 13:51:19 INFO - 'tart', 13:51:19 INFO - 'tscrollx', 13:51:19 INFO - 'tsvg_static']}, 13:51:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:51:19 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:51:19 INFO - 'talos_options': ['--disable-stylo'], 13:51:19 INFO - 'tests': ['tp5o']}, 13:51:19 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:51:19 INFO - 'talos_options': ['--mitmproxy', 13:51:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:51:19 INFO - '--firstNonBlankPaint'], 13:51:19 INFO - 'tests': ['tp6_google', 13:51:19 INFO - 'tp6_youtube', 13:51:19 INFO - 'tp6_amazon', 13:51:19 INFO - 'tp6_facebook']}, 13:51:19 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:51:19 INFO - 'talos_options': ['--disable-stylo', 13:51:19 INFO - '--mitmproxy', 13:51:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:51:19 INFO - '--firstNonBlankPaint'], 13:51:19 INFO - 'tests': ['tp6_google', 13:51:19 INFO - 'tp6_youtube', 13:51:19 INFO - 'tp6_amazon', 13:51:19 INFO - 'tp6_facebook']}, 13:51:19 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:51:19 INFO - 'talos_options': ['--stylo-threads=1', 13:51:19 INFO - '--mitmproxy', 13:51:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:51:19 INFO - '--firstNonBlankPaint'], 13:51:19 INFO - 'tests': ['tp6_google', 13:51:19 INFO - 'tp6_youtube', 13:51:19 INFO - 'tp6_amazon', 13:51:19 INFO - 'tp6_facebook']}, 13:51:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:51:19 INFO - 'talos_options': ['--xperf_path', 13:51:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:19 INFO - 'tests': ['tp5n']}, 13:51:19 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:51:19 INFO - 'talos_options': ['--disable-stylo', 13:51:19 INFO - '--xperf_path', 13:51:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:19 INFO - 'tests': ['tp5n']}}} 13:51:19 INFO - Running post-action listener: _resource_record_post_action 13:51:19 INFO - [mozharness: 2017-09-27 20:51:19.680470Z] Finished populate-webroot step (success) 13:51:19 INFO - [mozharness: 2017-09-27 20:51:19.680560Z] Running create-virtualenv step. 13:51:19 INFO - Running pre-action listener: _resource_record_pre_action 13:51:19 INFO - Running main action method: create_virtualenv 13:51:19 INFO - Creating virtualenv /builds/slave/test/build/venv 13:51:19 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:51:19 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:51:19 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:51:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:51:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:51:20 INFO - Installing distribute.............................................................................................................................................................................................done. 13:51:20 INFO - Installing pip...............done. 13:51:20 INFO - Return code: 0 13:51:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:51:20 INFO - Reading from file tmpfile_stdout 13:51:20 INFO - Output received: 13:51:20 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 13:51:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:20 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 0x170e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:51:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:51:20 INFO - Using env: {'DISPLAY': ':0', 13:51:20 INFO - 'HOME': '/home/cltbld', 13:51:20 INFO - 'LANG': 'en_US.UTF-8', 13:51:20 INFO - 'LANGUAGE': 'en_US:en', 13:51:20 INFO - 'LOGNAME': 'cltbld', 13:51:20 INFO - 'MAIL': '/var/mail/cltbld', 13:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:20 INFO - 'MOZ_NO_REMOTE': '1', 13:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:20 INFO - 'NO_EM_RESTART': '1', 13:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:20 INFO - 'PWD': '/builds/slave/test', 13:51:20 INFO - 'SHELL': '/bin/bash', 13:51:20 INFO - 'SHLVL': '1', 13:51:20 INFO - 'TERM': 'linux', 13:51:20 INFO - 'TMOUT': '86400', 13:51:20 INFO - 'USER': 'cltbld', 13:51:20 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 13:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:20 INFO - '_': '/tools/buildbot/bin/python'} 13:51:21 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:51:21 INFO - Downloading/unpacking pip>=1.5 13:51:21 INFO - Running setup.py egg_info for package pip 13:51:21 INFO - warning: no files found matching 'pip/cacert.pem' 13:51:21 INFO - warning: no files found matching '*.html' under directory 'docs' 13:51:21 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:51:21 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:51:21 INFO - Installing collected packages: pip 13:51:21 INFO - Found existing installation: pip 1.1 13:51:21 INFO - Uninstalling pip: 13:51:21 INFO - Successfully uninstalled pip 13:51:21 INFO - Running setup.py install for pip 13:51:21 INFO - warning: no files found matching 'pip/cacert.pem' 13:51:21 INFO - warning: no files found matching '*.html' under directory 'docs' 13:51:21 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:51:21 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:51:21 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:51:21 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:51:21 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:51:21 INFO - Successfully installed pip 13:51:21 INFO - Cleaning up... 13:51:21 INFO - Return code: 0 13:51:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:21 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 0x170e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:51:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:51:21 INFO - Using env: {'DISPLAY': ':0', 13:51:21 INFO - 'HOME': '/home/cltbld', 13:51:21 INFO - 'LANG': 'en_US.UTF-8', 13:51:21 INFO - 'LANGUAGE': 'en_US:en', 13:51:21 INFO - 'LOGNAME': 'cltbld', 13:51:21 INFO - 'MAIL': '/var/mail/cltbld', 13:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:21 INFO - 'MOZ_NO_REMOTE': '1', 13:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:21 INFO - 'NO_EM_RESTART': '1', 13:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:21 INFO - 'PWD': '/builds/slave/test', 13:51:21 INFO - 'SHELL': '/bin/bash', 13:51:21 INFO - 'SHLVL': '1', 13:51:21 INFO - 'TERM': 'linux', 13:51:21 INFO - 'TMOUT': '86400', 13:51:21 INFO - 'USER': 'cltbld', 13:51:21 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 13:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:21 INFO - '_': '/tools/buildbot/bin/python'} 13:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:22 INFO - Downloading/unpacking psutil>=3.1.1 13:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:51:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:23 INFO - Installing collected packages: psutil 13:51:23 INFO - Running setup.py install for psutil 13:51:23 INFO - building 'psutil._psutil_linux' extension 13:51:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:51:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:51:23 INFO - building 'psutil._psutil_posix' extension 13:51:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:51:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:51:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:23 INFO - Successfully installed psutil 13:51:23 INFO - Cleaning up... 13:51:23 INFO - Return code: 0 13:51:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:23 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 0x170e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:51:23 INFO - Using env: {'DISPLAY': ':0', 13:51:23 INFO - 'HOME': '/home/cltbld', 13:51:23 INFO - 'LANG': 'en_US.UTF-8', 13:51:23 INFO - 'LANGUAGE': 'en_US:en', 13:51:23 INFO - 'LOGNAME': 'cltbld', 13:51:23 INFO - 'MAIL': '/var/mail/cltbld', 13:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:23 INFO - 'MOZ_NO_REMOTE': '1', 13:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:23 INFO - 'NO_EM_RESTART': '1', 13:51:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:23 INFO - 'PWD': '/builds/slave/test', 13:51:23 INFO - 'SHELL': '/bin/bash', 13:51:23 INFO - 'SHLVL': '1', 13:51:23 INFO - 'TERM': 'linux', 13:51:23 INFO - 'TMOUT': '86400', 13:51:23 INFO - 'USER': 'cltbld', 13:51:23 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 13:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:23 INFO - '_': '/tools/buildbot/bin/python'} 13:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:51:25 INFO - Installing collected packages: mozsystemmonitor 13:51:25 INFO - Running setup.py install for mozsystemmonitor 13:51:25 INFO - Successfully installed mozsystemmonitor 13:51:25 INFO - Cleaning up... 13:51:25 INFO - Return code: 0 13:51:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:25 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 0x170e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:51:25 INFO - Using env: {'DISPLAY': ':0', 13:51:25 INFO - 'HOME': '/home/cltbld', 13:51:25 INFO - 'LANG': 'en_US.UTF-8', 13:51:25 INFO - 'LANGUAGE': 'en_US:en', 13:51:25 INFO - 'LOGNAME': 'cltbld', 13:51:25 INFO - 'MAIL': '/var/mail/cltbld', 13:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:25 INFO - 'MOZ_NO_REMOTE': '1', 13:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:25 INFO - 'NO_EM_RESTART': '1', 13:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:25 INFO - 'PWD': '/builds/slave/test', 13:51:25 INFO - 'SHELL': '/bin/bash', 13:51:25 INFO - 'SHLVL': '1', 13:51:25 INFO - 'TERM': 'linux', 13:51:25 INFO - 'TMOUT': '86400', 13:51:25 INFO - 'USER': 'cltbld', 13:51:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 13:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:25 INFO - '_': '/tools/buildbot/bin/python'} 13:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:25 INFO - Downloading/unpacking jsonschema==2.5.1 13:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:51:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:29 INFO - Downloading functools32-3.2.3-2.tar.gz 13:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:51:29 INFO - warning: no files found matching '*.txt' 13:51:29 INFO - no previously-included directories found matching 'build' 13:51:29 INFO - no previously-included directories found matching 'dist' 13:51:29 INFO - no previously-included directories found matching '.git*' 13:51:29 INFO - Installing collected packages: jsonschema, functools32 13:51:29 INFO - Running setup.py install for functools32 13:51:29 INFO - warning: no files found matching '*.txt' 13:51:29 INFO - no previously-included directories found matching 'build' 13:51:29 INFO - no previously-included directories found matching 'dist' 13:51:29 INFO - no previously-included directories found matching '.git*' 13:51:29 INFO - Successfully installed jsonschema functools32 13:51:29 INFO - Cleaning up... 13:51:29 INFO - Return code: 0 13:51:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:29 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 0x170e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:51:29 INFO - Using env: {'DISPLAY': ':0', 13:51:29 INFO - 'HOME': '/home/cltbld', 13:51:29 INFO - 'LANG': 'en_US.UTF-8', 13:51:29 INFO - 'LANGUAGE': 'en_US:en', 13:51:29 INFO - 'LOGNAME': 'cltbld', 13:51:29 INFO - 'MAIL': '/var/mail/cltbld', 13:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:29 INFO - 'MOZ_NO_REMOTE': '1', 13:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:29 INFO - 'NO_EM_RESTART': '1', 13:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:29 INFO - 'PWD': '/builds/slave/test', 13:51:29 INFO - 'SHELL': '/bin/bash', 13:51:29 INFO - 'SHLVL': '1', 13:51:29 INFO - 'TERM': 'linux', 13:51:29 INFO - 'TMOUT': '86400', 13:51:29 INFO - 'USER': 'cltbld', 13:51:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 13:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:29 INFO - '_': '/tools/buildbot/bin/python'} 13:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:51:29 INFO - Cleaning up... 13:51:29 INFO - Return code: 0 13:51:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:29 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 0x170e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:51:29 INFO - Using env: {'DISPLAY': ':0', 13:51:29 INFO - 'HOME': '/home/cltbld', 13:51:29 INFO - 'LANG': 'en_US.UTF-8', 13:51:29 INFO - 'LANGUAGE': 'en_US:en', 13:51:29 INFO - 'LOGNAME': 'cltbld', 13:51:29 INFO - 'MAIL': '/var/mail/cltbld', 13:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:29 INFO - 'MOZ_NO_REMOTE': '1', 13:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:29 INFO - 'NO_EM_RESTART': '1', 13:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:29 INFO - 'PWD': '/builds/slave/test', 13:51:29 INFO - 'SHELL': '/bin/bash', 13:51:29 INFO - 'SHLVL': '1', 13:51:29 INFO - 'TERM': 'linux', 13:51:29 INFO - 'TMOUT': '86400', 13:51:29 INFO - 'USER': 'cltbld', 13:51:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 13:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:29 INFO - '_': '/tools/buildbot/bin/python'} 13:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:29 INFO - Downloading/unpacking blobuploader==1.2.4 13:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:30 INFO - Downloading blobuploader-1.2.4.tar.gz 13:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:51:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:51:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:31 INFO - Downloading docopt-0.6.1.tar.gz 13:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:51:31 INFO - Installing collected packages: blobuploader, requests, docopt 13:51:31 INFO - Running setup.py install for blobuploader 13:51:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:51:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:51:31 INFO - Running setup.py install for requests 13:51:31 INFO - Running setup.py install for docopt 13:51:32 INFO - Successfully installed blobuploader requests docopt 13:51:32 INFO - Cleaning up... 13:51:32 INFO - Return code: 0 13:51:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:32 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 0x170e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:51:32 INFO - Using env: {'DISPLAY': ':0', 13:51:32 INFO - 'HOME': '/home/cltbld', 13:51:32 INFO - 'LANG': 'en_US.UTF-8', 13:51:32 INFO - 'LANGUAGE': 'en_US:en', 13:51:32 INFO - 'LOGNAME': 'cltbld', 13:51:32 INFO - 'MAIL': '/var/mail/cltbld', 13:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:32 INFO - 'MOZ_NO_REMOTE': '1', 13:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:32 INFO - 'NO_EM_RESTART': '1', 13:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:32 INFO - 'PWD': '/builds/slave/test', 13:51:32 INFO - 'SHELL': '/bin/bash', 13:51:32 INFO - 'SHLVL': '1', 13:51:32 INFO - 'TERM': 'linux', 13:51:32 INFO - 'TMOUT': '86400', 13:51:32 INFO - 'USER': 'cltbld', 13:51:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 13:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:32 INFO - '_': '/tools/buildbot/bin/python'} 13:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:32 INFO - Running setup.py (path:/tmp/pip-Y7DnN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:32 INFO - Running setup.py (path:/tmp/pip-KtmjK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:32 INFO - Running setup.py (path:/tmp/pip-45XMhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:32 INFO - Running setup.py (path:/tmp/pip-1VjKMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:32 INFO - Running setup.py (path:/tmp/pip-ruyrB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:32 INFO - Running setup.py (path:/tmp/pip-NxspEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:32 INFO - Running setup.py (path:/tmp/pip-fUv6Bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:32 INFO - Running setup.py (path:/tmp/pip-IgsB_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:32 INFO - Running setup.py (path:/tmp/pip-l73LuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:32 INFO - Running setup.py (path:/tmp/pip-pwmBa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:32 INFO - Running setup.py (path:/tmp/pip-h8cSPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:33 INFO - Running setup.py (path:/tmp/pip-jL8MsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:33 INFO - Running setup.py (path:/tmp/pip-diDBGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:33 INFO - Running setup.py (path:/tmp/pip-nEss9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:33 INFO - Running setup.py (path:/tmp/pip-I4yO7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:33 INFO - Running setup.py (path:/tmp/pip-E_9LTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:33 INFO - Running setup.py (path:/tmp/pip-tVsR7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:51:33 INFO - Running setup.py install for manifestparser 13:51:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:51:33 INFO - Running setup.py install for mozcrash 13:51:33 INFO - Running setup.py install for mozdebug 13:51:33 INFO - Running setup.py install for mozdevice 13:51:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:51:33 INFO - Running setup.py install for mozfile 13:51:33 INFO - Running setup.py install for mozhttpd 13:51:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:51:34 INFO - Running setup.py install for mozinfo 13:51:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:51:34 INFO - Running setup.py install for mozInstall 13:51:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:51:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:51:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:51:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:51:34 INFO - Running setup.py install for mozleak 13:51:34 INFO - Running setup.py install for mozlog 13:51:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:51:34 INFO - Running setup.py install for moznetwork 13:51:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:51:34 INFO - Running setup.py install for mozprocess 13:51:34 INFO - Running setup.py install for mozprofile 13:51:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:51:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:51:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:51:34 INFO - Running setup.py install for mozrunner 13:51:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:51:34 INFO - Running setup.py install for mozscreenshot 13:51:35 INFO - Running setup.py install for moztest 13:51:35 INFO - Running setup.py install for mozversion 13:51:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:51:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:51:35 INFO - Cleaning up... 13:51:35 INFO - Return code: 0 13:51:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:35 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 0x170e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:51:35 INFO - Using env: {'DISPLAY': ':0', 13:51:35 INFO - 'HOME': '/home/cltbld', 13:51:35 INFO - 'LANG': 'en_US.UTF-8', 13:51:35 INFO - 'LANGUAGE': 'en_US:en', 13:51:35 INFO - 'LOGNAME': 'cltbld', 13:51:35 INFO - 'MAIL': '/var/mail/cltbld', 13:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:35 INFO - 'MOZ_NO_REMOTE': '1', 13:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:35 INFO - 'NO_EM_RESTART': '1', 13:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:35 INFO - 'PWD': '/builds/slave/test', 13:51:35 INFO - 'SHELL': '/bin/bash', 13:51:35 INFO - 'SHLVL': '1', 13:51:35 INFO - 'TERM': 'linux', 13:51:35 INFO - 'TMOUT': '86400', 13:51:35 INFO - 'USER': 'cltbld', 13:51:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 13:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:35 INFO - '_': '/tools/buildbot/bin/python'} 13:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:35 INFO - Running setup.py (path:/tmp/pip-x3HP6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:35 INFO - Running setup.py (path:/tmp/pip-N35tmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:35 INFO - Running setup.py (path:/tmp/pip-MFbzT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:35 INFO - Running setup.py (path:/tmp/pip-SGowby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:35 INFO - Running setup.py (path:/tmp/pip-Ig9Y2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:35 INFO - Running setup.py (path:/tmp/pip-sfwy8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:35 INFO - Running setup.py (path:/tmp/pip-v09E0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:35 INFO - Running setup.py (path:/tmp/pip-YVCe3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:36 INFO - Running setup.py (path:/tmp/pip-wwaRoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:36 INFO - Running setup.py (path:/tmp/pip-Ytf1yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:36 INFO - Running setup.py (path:/tmp/pip-qYTCmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:36 INFO - Running setup.py (path:/tmp/pip-LgGxaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:36 INFO - Running setup.py (path:/tmp/pip-6pyah7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:36 INFO - Running setup.py (path:/tmp/pip-DhwUsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:36 INFO - Running setup.py (path:/tmp/pip-Jm4wVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:36 INFO - Running setup.py (path:/tmp/pip-ovIGx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:36 INFO - Running setup.py (path:/tmp/pip-TK8c4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:51:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:40 INFO - Downloading blessings-1.6.tar.gz 13:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:40 INFO - Installing collected packages: blessings 13:51:40 INFO - Running setup.py install for blessings 13:51:40 INFO - Successfully installed blessings 13:51:40 INFO - Cleaning up... 13:51:41 INFO - Return code: 0 13:51:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:41 INFO - Reading from file tmpfile_stdout 13:51:41 INFO - Current package versions: 13:51:41 INFO - argparse == 1.2.1 13:51:41 INFO - blessings == 1.6 13:51:41 INFO - blobuploader == 1.2.4 13:51:41 INFO - docopt == 0.6.1 13:51:41 INFO - functools32 == 3.2.3-2 13:51:41 INFO - jsonschema == 2.5.1 13:51:41 INFO - manifestparser == 1.1 13:51:41 INFO - mozInstall == 1.13 13:51:41 INFO - mozcrash == 1.0 13:51:41 INFO - mozdebug == 0.1 13:51:41 INFO - mozdevice == 0.51 13:51:41 INFO - mozfile == 1.2 13:51:41 INFO - mozhttpd == 0.7 13:51:41 INFO - mozinfo == 0.10 13:51:41 INFO - mozleak == 0.1 13:51:41 INFO - mozlog == 3.5 13:51:41 INFO - moznetwork == 0.27 13:51:41 INFO - mozprocess == 0.25 13:51:41 INFO - mozprofile == 0.28 13:51:41 INFO - mozrunner == 6.13 13:51:41 INFO - mozscreenshot == 0.1 13:51:41 INFO - mozsystemmonitor == 0.3 13:51:41 INFO - moztest == 0.8 13:51:41 INFO - mozversion == 1.4 13:51:41 INFO - psutil == 3.1.1 13:51:41 INFO - requests == 1.2.3 13:51:41 INFO - wsgiref == 0.1.2 13:51:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:41 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 0x170e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:51:41 INFO - Using env: {'DISPLAY': ':0', 13:51:41 INFO - 'HOME': '/home/cltbld', 13:51:41 INFO - 'LANG': 'en_US.UTF-8', 13:51:41 INFO - 'LANGUAGE': 'en_US:en', 13:51:41 INFO - 'LOGNAME': 'cltbld', 13:51:41 INFO - 'MAIL': '/var/mail/cltbld', 13:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:41 INFO - 'MOZ_NO_REMOTE': '1', 13:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:41 INFO - 'NO_EM_RESTART': '1', 13:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:41 INFO - 'PWD': '/builds/slave/test', 13:51:41 INFO - 'SHELL': '/bin/bash', 13:51:41 INFO - 'SHLVL': '1', 13:51:41 INFO - 'TERM': 'linux', 13:51:41 INFO - 'TMOUT': '86400', 13:51:41 INFO - 'USER': 'cltbld', 13:51:41 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 13:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:41 INFO - '_': '/tools/buildbot/bin/python'} 13:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:51:41 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:51:42 INFO - Installing collected packages: simplejson 13:51:42 INFO - Running setup.py install for simplejson 13:51:42 INFO - building 'simplejson._speedups' extension 13:51:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 13:51:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 13:51:43 INFO - Successfully installed simplejson 13:51:43 INFO - Cleaning up... 13:51:43 INFO - Return code: 0 13:51:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:43 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 0x170e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:51:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:51:43 INFO - Using env: {'DISPLAY': ':0', 13:51:43 INFO - 'HOME': '/home/cltbld', 13:51:43 INFO - 'LANG': 'en_US.UTF-8', 13:51:43 INFO - 'LANGUAGE': 'en_US:en', 13:51:43 INFO - 'LOGNAME': 'cltbld', 13:51:43 INFO - 'MAIL': '/var/mail/cltbld', 13:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:43 INFO - 'MOZ_NO_REMOTE': '1', 13:51:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:43 INFO - 'NO_EM_RESTART': '1', 13:51:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:43 INFO - 'PWD': '/builds/slave/test', 13:51:43 INFO - 'SHELL': '/bin/bash', 13:51:43 INFO - 'SHLVL': '1', 13:51:43 INFO - 'TERM': 'linux', 13:51:43 INFO - 'TMOUT': '86400', 13:51:43 INFO - 'USER': 'cltbld', 13:51:43 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 13:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:43 INFO - '_': '/tools/buildbot/bin/python'} 13:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:51:43 INFO - Cleaning up... 13:51:43 INFO - Return code: 0 13:51:43 INFO - Running post-action listener: _resource_record_post_action 13:51:43 INFO - Running post-action listener: _start_resource_monitoring 13:51:43 INFO - Starting resource monitoring. 13:51:43 INFO - [mozharness: 2017-09-27 20:51:43.912905Z] Finished create-virtualenv step (success) 13:51:43 INFO - [mozharness: 2017-09-27 20:51:43.913475Z] Running install step. 13:51:43 INFO - Running pre-action listener: _resource_record_pre_action 13:51:43 INFO - Running main action method: install 13:51:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:44 INFO - Reading from file tmpfile_stdout 13:51:44 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:44 INFO - Reading from file tmpfile_stdout 13:51:44 INFO - Output received: 13:51:44 INFO - Usage: mozinstall [options] installer 13:51:44 INFO - Options: 13:51:44 INFO - -h, --help show this help message and exit 13:51:44 INFO - -d DEST, --destination=DEST 13:51:44 INFO - Directory to install application into. [default: 13:51:44 INFO - "/builds/slave/test"] 13:51:44 INFO - --app=APP Application being installed. [default: firefox] 13:51:44 INFO - mkdir: /builds/slave/test/build/application 13:51:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:51:58 INFO - Reading from file tmpfile_stdout 13:51:58 INFO - Output received: 13:51:58 INFO - /builds/slave/test/build/application/firefox/firefox 13:51:58 INFO - Running post-action listener: _resource_record_post_action 13:51:58 INFO - [mozharness: 2017-09-27 20:51:58.776647Z] Finished install step (success) 13:51:58 INFO - [mozharness: 2017-09-27 20:51:58.776792Z] Running setup-mitmproxy step. 13:51:58 INFO - Running pre-action listener: _resource_record_pre_action 13:51:58 INFO - Running main action method: setup_mitmproxy 13:51:58 INFO - Skipping: mitmproxy is not required 13:51:58 INFO - Running post-action listener: _resource_record_post_action 13:51:58 INFO - [mozharness: 2017-09-27 20:51:58.777319Z] Finished setup-mitmproxy step (success) 13:51:58 INFO - [mozharness: 2017-09-27 20:51:58.777524Z] Running run-tests step. 13:51:58 INFO - Running pre-action listener: _resource_record_pre_action 13:51:58 INFO - Running pre-action listener: _set_gcov_prefix 13:51:58 INFO - Running main action method: run_tests 13:51:58 WARNING - Try message not found. 13:51:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:51:58 INFO - Python 2.7.3 13:51:58 INFO - Return code: 0 13:51:58 INFO - grabbing minidump binary from tooltool 13:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:58 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 0x1a7d090>, '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 0x1a7dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a77f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:51:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:51:58 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:51:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:51:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:51:58 INFO - Return code: 0 13:51:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:51:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:51:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:51:58 INFO - ENV: RUST_BACKTRACE is now full 13:51:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:51:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:51:58 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/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:51:58 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/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:51:58 INFO - Using env: {'DISPLAY': ':0', 13:51:58 INFO - 'HOME': '/home/cltbld', 13:51:58 INFO - 'LANG': 'en_US.UTF-8', 13:51:58 INFO - 'LANGUAGE': 'en_US:en', 13:51:58 INFO - 'LOGNAME': 'cltbld', 13:51:58 INFO - 'MAIL': '/var/mail/cltbld', 13:51:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:51:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:58 INFO - 'MOZ_NO_REMOTE': '1', 13:51:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:58 INFO - 'NO_EM_RESTART': '1', 13:51:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:58 INFO - 'PWD': '/builds/slave/test', 13:51:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:51:58 INFO - 'RUST_BACKTRACE': 'full', 13:51:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:51:58 INFO - 'SHELL': '/bin/bash', 13:51:58 INFO - 'SHLVL': '1', 13:51:58 INFO - 'TERM': 'linux', 13:51:58 INFO - 'TMOUT': '86400', 13:51:58 INFO - 'USER': 'cltbld', 13:51:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 13:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:58 INFO - '_': '/tools/buildbot/bin/python'} 13:51:58 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/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:51:59 INFO - mozversion application_buildid: 20170927192431 13:51:59 INFO - mozversion application_changeset: 01cad263a6050e1ed5f58a04bf0fda1464211aef 13:51:59 INFO - mozversion application_display_name: Firefox 13:51:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:51:59 INFO - mozversion application_name: Firefox 13:51:59 INFO - mozversion application_remotingname: firefox 13:51:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:51:59 INFO - mozversion application_vendor: Mozilla 13:51:59 INFO - mozversion application_version: 57.0 13:51:59 INFO - mozversion platform_buildid: 20170927192431 13:51:59 INFO - mozversion platform_changeset: 01cad263a6050e1ed5f58a04bf0fda1464211aef 13:51:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:51:59 INFO - mozversion platform_version: 57.0 13:51:59 INFO - using testdate: 1506545519 13:51:59 INFO - actual date: 1506545519 13:51:59 INFO - starting webserver on 'localhost:33583' 13:51:59 INFO - SUITE-START | Running 2 tests 13:51:59 INFO - TEST-START | dromaeo_css 13:51:59 INFO - Initialising browser for dromaeo_css test... 13:51:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33583/getInfo.html -profile /tmp/tmpTXUOFX/profile 13:51:59 INFO - TEST-INFO | started process 14595 (/builds/slave/test/build/application/firefox/firefox http://localhost:33583/getInfo.html) 13:52:03 INFO - TEST-INFO | 14595: exit 0 13:52:03 INFO - Browser initialized. 13:52:03 INFO - Running cycle 1/1 for dromaeo_css test... 13:52:03 INFO - Using env: {'DISPLAY': ':0', 13:52:03 INFO - 'HOME': '/home/cltbld', 13:52:03 INFO - 'JSGC_DISABLE_POISONING': '1', 13:52:03 INFO - 'LANG': 'en_US.UTF-8', 13:52:03 INFO - 'LANGUAGE': 'en_US:en', 13:52:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:52:03 INFO - 'LOGNAME': 'cltbld', 13:52:03 INFO - 'MAIL': '/var/mail/cltbld', 13:52:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:52:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:52:03 INFO - 'MOZ_CRASHREPORTER': '1', 13:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:52:03 INFO - 'MOZ_NO_REMOTE': '1', 13:52:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:03 INFO - 'NO_EM_RESTART': '1', 13:52:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:03 INFO - 'PWD': '/builds/slave/test', 13:52:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:52:03 INFO - 'RUST_BACKTRACE': 'full', 13:52:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:52:03 INFO - 'SHELL': '/bin/bash', 13:52:03 INFO - 'SHLVL': '1', 13:52:03 INFO - 'TERM': 'linux', 13:52:03 INFO - 'TMOUT': '86400', 13:52:03 INFO - 'USER': 'cltbld', 13:52:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 13:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:03 INFO - '_': '/tools/buildbot/bin/python'} 13:52:03 INFO - TEST-INFO | started process 14783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTXUOFX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:04 INFO - PID 14783 | 13:52:04 INFO - PID 14783 | (/builds/slave/test/build/application/firefox/firefox:14832): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:52:04 INFO - PID 14783 | 13:52:15 INFO - PID 14783 | RSS: Main: 143360000 13:52:15 INFO - PID 14783 | 13:55:12 INFO - PID 14783 | Cycle 1(1): loaded http://localhost:33583/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33583/tests/dromaeo/cssquery-ext.html) 13:55:13 INFO - PID 14783 | RSS: Main: 146026496 13:55:13 INFO - PID 14783 | 13:58:15 INFO - PID 14783 | Cycle 1(1): loaded http://localhost:33583/tests/dromaeo/cssquery-ext.html (next: http://localhost:33583/tests/dromaeo/cssquery-jquery.html) 13:58:15 INFO - PID 14783 | RSS: Main: 144277504 13:58:16 INFO - PID 14783 | 14:01:17 INFO - PID 14783 | Cycle 1(1): loaded http://localhost:33583/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33583/tests/dromaeo/cssquery-mootools.html) 14:01:18 INFO - PID 14783 | RSS: Main: 145821696 14:01:18 INFO - PID 14783 | 14:04:19 INFO - PID 14783 | Cycle 1(1): loaded http://localhost:33583/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33583/tests/dromaeo/cssquery-prototype.html) 14:04:20 INFO - PID 14783 | RSS: Main: 145399808 14:04:20 INFO - PID 14783 | 14:07:23 INFO - PID 14783 | Cycle 1(1): loaded http://localhost:33583/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33583/tests/dromaeo/cssquery-yui.html) 14:07:23 INFO - PID 14783 | RSS: Main: 147095552 14:07:23 INFO - PID 14783 | 14:10:25 INFO - PID 14783 | Cycle 1(1): loaded http://localhost:33583/tests/dromaeo/cssquery-yui.html (next: http://localhost:33583/tests/dromaeo/cssquery-dojo.html) 14:10:25 INFO - PID 14783 | RSS: Main: 148013056 14:10:25 INFO - PID 14783 | 14:10:25 INFO - PID 14783 | __start_tp_report 14:10:25 INFO - PID 14783 | _x_x_mozilla_page_load 14:10:25 INFO - PID 14783 | _x_x_mozilla_page_load_details 14:10:25 INFO - PID 14783 | |i|pagename|runs| 14:10:25 INFO - PID 14783 | |0;dojo.html;4022.175454031924;4027.2750904837117;4038.979805100973;4042.6255073275115;4043.757374557527;6546.9017964730565;6599.109120268762;6678.398944095031;6686.799396018121;6711.932880671186;6621.404073633372;6629.071929929813;6629.50278729096;6703.832404189898;6712.127423434947;5939.940600593982;5943.286805583336;5965.61223520472;5983.940160598404;6018.849528761783;5874.206982057411;5984.162217289583;5986;5994.910076348859;6045.576809623328;5971;6003.519718422537;6046.455818976291;6070.969645151768;6081.027035674293;6004.669743164124;6009.218801555813;6028.156058151862;6038.57729958903;6086.452219300284;5731.856703582402;5909.586328956974;5959.672218028007;5987.580869339148;6098.634081955097;6387;6474.5791523550815;6496.642684652342;6573.57271777333;6638.269790323061;7142.285771422816;7233.819154521127;7235.92764072363;7246.420286377077;7262.709491620329;7177.4258059355125;7186.317299856558;7215.314545118205;7242.31198036191;7306.634668266565;6495.188101487314;6706.899396509057;6757.831054223684;6788.966055169792;6813.3527314905505;7339.74310899116;7365;7430.405567554582;7436.814079648052;7459.627018649046;6983.650817459106;7028.156621205386;7077.433805295564;7108.609026503488;7126.109236345457;7038.929610703827;7168.211496735355;7199.460040496879;7205.7838264852135;7232;7211.423086153095;7220.169680486706;7288.635568221568;7299.41604671625;7309.707611695472;7213.819654508679;7214.783556493208;7298.452616053817;7305.305995930378;7308.30571095745;5296.655717378358;5373.623846330719;5381.48875856793;5394.703291319015;5402.459754024566;4862;4874.902501949941;4876.049170411807;4888.046830868017;4942.975285123552;6763.5265531413315;6764.3573860483175;6848.554843935129;6853.691583878737;6859.039734437183;7063.57618542889;7200.639968001579;7217.097862767154;7231.602261875647;7309.488335816442;6768.72925083001;6773.221079575814;6784.457243420515;6793.830154246085;6798.966005169942;6130.540209484307;6140.8771824563255;6143.354947730513;6225.906611400833;6230.127782110508;7333.230010848891;7357.742479013209;7437.628118594049;7480.1023877134;7534.208908064684;7178.497505174588;7178.5692858428665;7184.245654206442;7193.136823581203;7207.783766487014;7456.66445009965;7460.253974602496;7502.399808015455;7543.1325397579985;7547.320741133324;7043.36609705129;7122.287771222836;7122.8219294515975;7137.82155446118;7209.206987231505;7328.487005909536;7338.633068346669;7340.632968351454;7343.192248852729;7360.558366498028;6775.525713200226;6976.093107895941;6980.511364204457;7070.505064645426;7071.752488662872;6880.621565813728;6912.965435172792;7016.5790052597;7018.227994920657;7026.1217347831525;6921.861562768817;6933.1333583302085;6945.2707465715375;6976.720931162697;6998.475114366341;6922.411595014481;6966.582005079711;7097.432205423657;7109.857802844018;7116.181639111568;6669.333066693292;6764.86470270582;6785.9660701696175;6876.931230687629;6890.276520965427 14:10:25 INFO - PID 14783 | |1;ext.html;981.3572110267775;981.5632043740529;1010.7877345757393;1024.2113572549138;1030.5156576409095;43445.34831977519;45457.7727111364;45651.31523027153;45705.542944570545;45751.31373029403;42686.14627707452;43165.7841710791;43167.78416107923;43354.56645433545;43443.565564344346;8170.101288858221;8255.958720206421;8297.377696672744;8301.875471867927;8307.169283071675;8093.473924194908;8199.057108432517;8199.549024803633;8222.794430139264;8230.835383292331;8744.081871403507;8902.065283145273;8910.599023043946;8920.598573064195;8926.86609700855;8789.428687135347;8816.206541411304;8854.203121719043;8863.29093672511;8864.601092950801;8706.21644052032;8813.206811387006;8843.425177363451;8845.955770221108;8846.60190291432;40831.591684083076;40953.59046409557;41032.589674103176;41040.38439423411;41083.7945810272;3911.7457365271166;3918.0792513759243;3919.2553414851086;3925.038365600418;3933.0167458135465;34728.13179670528;34837.65162348395;34870.82564587186;35083.473747893804;35191.648083519096;5493.890122197534;5577.079781835992;5605.159226116074;5719.628224165416;5739.196512488255;234816;244604;244838;244969;244995;48650.5134948646;54803.451965479835;55674;55751.999999999185;55958.720206398706;58713.41286587165;58777.41222587805;58778;58808.705956469945;59126.704366478756;18772.436826895217;18978.71531927022;19022.429327120208;19083;19086.61826763457;15779.763303550455;15790.763138552931;15793.763093553605;15796.921015395079;15798.21008949548;15828;15881.841181588035;15973.440929567641;15982.36070557188;15993.840061599467;6207.937920620826;6212.751489940351;6239.625622462667;6316.810495685137;6320.462760665395;1090.7382228265317;1098.8296813993843;1104.1663544024211;1116.1851848150895;1123.393367581497;26292.605610915853;26429.207123786317;26502;26549.33626659349;26619.60070598904;1219.536576101076;1227.0858210633135;1231.1259006105586;1243.7885559454915;1244.2845363915785;13741.793873091912;13864.237466939416;13994.370253338624;14000.229987350793;14145.36345864418;294227;294290;295225;296922;297111;59908.40091599115;60487;60705.69647151736;60940;61027.38972610217;1519.4302136698739;1542.4138827245574;1575.4800915697792;1583.9762403563955;1589.4595837415334;25667.486650267263;26182.214533564023;26265;26365;26376.20871373862;41729.37405938974;42195.156096877276;42224.78887605542;42311;42313;255464;256027;256656;256698;256764;37603.2479350406;37903.24193516169;40273.79863100783;40480;40527;52678.20982685186;52819.47180528146;52925.470745292056;53228.20157697715;53228.73385633202;38431;38496.422553662276;38736.6126338733;38873;38889.6111038886;38324.233515330096;38440.80779596084;38672.41991370188;38721.4191787129;38925.2214955705;44146;45590;45699.771501142284;45912.31131532963;45992.08015839598;36585.90242292736;36838.44742328813;37043.444348334255;37295.25409491741;37396;27221.591676124477;27743.28361186356;27967.021154259503;28005.579916301678;28157.79913307004 14:10:25 INFO - PID 14783 | |2;jquery.html;643.5553990679205;646.3799769782476;647.5307329949037;650.2426057138341;656.8078936729833;24216;24854.378640533974;24868;24992.875035624842;25033.12384066558;25611.61582576263;26039.86980065097;26064;26086;26144.34639134018;6501.4798816094835;6644.468442524587;6953.965230173842;6985.511014229006;6996.755113571026;6827.965860170692;6931.3068693130535;6937.6878040488045;6952.096227490444;6953.548019378724;6681.933180668204;6900.75847345343;6914.723411063552;6918.411934985532;6939.895901561481;6350.936490635104;6983.196932352794;6997.895031574531;7033.788986330418;7033.824154396129;6504.60972341661;6532.6733663316645;6552.049952756824;6565.638889861056;6570.63861487618;30661.540076898866;30905.0728478146;31489.527657085164;31567.52648710271;31658.366832663218;2376.1802178248477;2420.056178090546;2428.7449817769057;2430.805535557151;2434.4522482441484;20462.386128416172;20920.163193472243;20940.790592094036;20975.47561310964;21172.682409763867;2312.433453803829;2350.847194932324;2386.6658667786523;2396.2571602803014;2427.490227052321;142588;148218;166831;174296.12851935785;174316;16254.75617865733;16445.6710865782;16990.06554639482;17084.899624090376;17390.21744021522;27388.45223095527;27388.72611273862;27491;27556.72443275582;27766;11190.888091119148;11288;11291;11306.321620702784;11400.600978965862;10203.38779673222;10266.948665256627;10274.589016439259;10319.226058045526;10320.535575899103;9992.600295988079;10281.331713438603;10300.22748293881;10301.896981030244;10408.895911040943;2878.150945471091;2936.309967157716;2940.9852950735108;3037.6051113355124;3101.1936896406646;1052.6684094510206;1069.844872493484;1070.240129508058;1071.4392601681986;1077.2674581284803;20930.37208883736;21618.973833504173;21667;21721;22142.88928555347;1132.750794825137;1166.1545379599722;1169.1990986174499;1170.9590164344206;1176.4235524592889;11596.18826682141;11895.762084758257;11914.702132446759;11930.642080737593;12054.578089766992;591573;611312;612894;612906;622682;125216;126890.36554817167;128234.99999999814;131197;134516;1240.34881687115;1279.526575167194;1288.3944546063335;1290.8450985881566;1299.5451591942933;18776.248950041845;19066.61866762629;19242;19426.514337141685;19529.51176220549;60860;65293;66084.33915660974;66770.33229667836;67288;80787.59606201931;81081;81237.59381203057;81321.59339203266;81790;15945.282462288993;16014.519564413085;16029.118398487728;16060.839391606401;16080.195990200209;23811.64282535798;24087;24161.395965101012;24171.274861754177;24222.51554968926;20113.497162571053;20143.294984676053;20238.291659791837;20325.695114572998;20340.186392544132;17950.371736989142;18141.546461338574;18410.81589184091;18464.630707386044;18667.159977801304;20173.49566260855;20326.390208293775;20460.38618841437;20551.383458496268;20557.383278501668;15827;15869.603259918133;15908.284127214534;15921.442749503713;15953.840461595235;19252.22991080341;19507.317243896396;19629.527785415867;19742.70385944241;19770 14:10:25 INFO - PID 14783 | |3;mootools.html;1464.5313499680103;1502.6619010722588;1512.7050225206083;1519.2176029344882;1529.7093552225076;17143.657126857455;17797.110144492774;17886.64226715465;17906.641867162663;17938;17319.39382121626;17642.911785441087;17666;17728.64542709145;17748;3051.160930744041;3110.2068972412003;3129.4836352001894;3134.8589313480948;3175.0792270241604;3111.4866047102314;3142.0730884389045;3157.1160075178987;3157.605299337583;3158.6051743532057;3084.121025507731;3116.65716771155;3189.681031896815;3191.377681352137;3195.4088493628637;3154.3848949454864;3160.320531085816;3176.825274609919;3183.633882103553;3190.0748782852943;2980.821150730963;3043.52825312077;3058.4036112957983;3061.525463553153;3074.769392295587;17019.65960680792;17219.3973210937;17259.654806903916;17376.65246695059;17435.215415306342;9100.908990910073;9495.430274183502;9507.286953478517;9510.857337139949;9524.333296669167;5721.284839395075;5746.569007324468;5847;5920.615160014629;5924.7333869975955;2018.6063717574932;2057.8887400803546;2061.680439531875;2094.3298144593737;2122.0768965500056;31241.218969525715;31513.52729709056;31525.054248372355;31671.36657266842;31694.683053169403;7505.737299194502;7522.285382888617;7577.659005344773;7737.419693523008;7755.806104847424;20579.279725209544;20739.170433182804;20783.1686732529;20802;20830.1667933281;9125.406848554823;9281.164695177331;9305.395149315273;9311.953440232755;9330.346875718771;8298.58507074656;8468.872966905501;8529.445586037013;8561.0582835888;8618.052014278424;6241.438270555672;6255.186825712719;6304.306526282106;6369.5541312108635;6385.680715964183;1614.9192540372935;1672.1105151179333;1735.3232239426634;1757.6484703059439;1767.063456368127;946.7065209784988;956.31623389277;956.53129966316;959.0553304994575;970.9126178643955;8215.178482151856;8230.62962166704;8258.380621453414;8266.338692904554;8430.915690843136;1059.8728152621734;1064.723171975292;1070.8500809886623;1077.9083777878811;1090.0734375780523;4844.685095468783;4961.900761984813;4965.205567109245;4986.426560945465;5016.774245158904;26242.606360904603;26579.468410632067;26853.194404167516;26938.865305673346;27070.45859082807;26817;26871.865640671673;27032.59451108235;27493.587596186073;27636.723632763817;12707.110502264753;13053.608391748263;13062.869371306355;13260.40328185234;13322.400491977884;9171.174594286545;9284.350095493252;9285.62857485693;9372.718818435458;9381.671641492516;22311.44221394478;22323.77676223217;22510.212142574932;23140.652890206322;23383.181588644315;23246.535069298858;23452.296431107094;23785.762142378353;23843.403914901573;23852.52294954126;13016.023798214983;13038.674033148867;13101.73796524045;13106.934465327613;13191.208527488381;15833.445829395916;15937.521874343789;16011.679766404839;16086.471785180389;16108.436204732778;12756.42596083197;13223.867761322648;13290.933545332211;13298.933505332412;13352.93323533415;12146.392680366123;12173.878261217274;12456.501739930301;12470.812937806122;12593.685157871127;9835.114839664464;9879.110880020833;10067.748306292402;10103.89896101059;10117.59529618807;7944.404169687181;8109.7161599343735;8174.386920980831;8220.876686849822;8261.091279959079;8275;8327.417080804285;8370.414071015213;8417;8473.83052338962 14:10:25 INFO - PID 14783 | |4;prototype.html;584.8245526342097;588.4527389527738;605.5882000239835;623.9251289845218;629.2323365494095;6509.251436084852;6561.587974253392;6591.307912669173;6666.100076489673;6718.764843230476;6469.547131700783;6477.894684227633;6495.967520162404;6545.705443255053;6554.934450655492;5256.763445644955;5293.497117773805;5301.416844147141;5306.363236411636;5318.30861987943;5102.234664800291;5308.867278318035;5368.436314187013;5377.919331210035;5423.376311724162;5205.401378841425;5234.790608375661;5235.895282094375;5239.161734122541;5248.160294352904;5156;5225.477452254782;5226.608004399647;5260.1320782070725;5279.762410691528;4744.3595114659765;4777.307290442866;4781.880452988703;4783.784729687172;4805.447373552051;6378.883695353295;6432.678366081724;6463.547551671385;6505.544611877171;6541.28045914949;6181.690915454209;6205.114621700885;6210;6245.687715614246;6252.124702541602;6826.214985276707;6872.828179295558;6924.065251191126;6970.4075153612;6993.335633114846;5149.510796474329;5315.681059136426;5354;5366.758495867695;5405.270288511079;6948.756793512202;7095.7161713531395;7255.45584081196;7268.345848873574;7278.199398066208;5427.972860135753;5449.746558291615;5469.5232287282215;5487.75305111271;5505.146702261156;5477.959187754314;5478.397376288605;5533.6403133796175;5551.666899986014;5600;6150.496394398916;6173.96913015441;6176.505879529627;6182.196314479089;6196.3803619638575;7002.229754726976;7014.824629384306;7043.471739619549;7056.294370563005;7071.469639777038;1897.9715304270446;1910.1117980139302;1923.2210954563425;1923.6056608395245;1923.7210604462275;1301.4989229146656;1342.2550484481208;1342.3623778705037;1358.592422273314;1375.4498200719593;6404.775832845828;6487.351264873475;6487.513436492282;6496.902546461807;6596.538242322991;6999.510034297652;7014.824629384204;7038.436925045984;7050.294970502909;7092.893606595905;6507.186601674791;6522.315156908551;6537.182852143482;6595.88931541902;6602.108715323466;3662.102784817737;3682.2819550187455;3738.831752571141;3745.9063523412133;3762.3792074307435;7046;7228.891566626505;7285.4171666266575;7393.963030184815;7406.407487400995;7126.180489243699;7148.714051437988;7159.284071592799;7220.530665506725;7224.277572242734;7224.963875180591;7296.854062918605;7399.593022383929;7408.925910740932;7454.142773580999;7050.471214659024;7108.07595012645;7127.643617819192;7134.179569349383;7134.536255143399;6999.1950925644205;7020.5787652741;7045.506814523139;7062.646867656699;7150.856982860209;7291.708331666886;7359.227281135403;7381.889271660822;7391.445641576795;7392.963035185005;5511.338639363142;5512.6968016757855;5516.9448305516435;5531.7234138293725;5539.695316757617;6738.494612903954;6995.510314277952;7107;7173.892391614234;7181.497295189287;6359.618422894456;6736.124303840666;6786.830329241611;6880.552764070319;6886.898096304567;6718.630475323904;6818.556793808387;6853.0252453577805;6870.896936546056;6907.89638155418;6729.596224226562;6778.491613129134;6807.965960170168;6855.314468553105;6871.804610855976;6892.793216203522;6957.860842783217;6961.2342642308295;6975.267596902252;7019.6490175492045;6381.234251889803;6607.9669601651685;6721.924492081439;6741.393274605113;6761.357671021246 14:10:25 INFO - PID 14783 | |5;yui.html;957.2533423929337;981.8625392445059;982.6658935961772;1007.415698894641;1041.48967006167;18117.818821811794;18901.149448274828;18913.432597022093;18921.24315027397;18940.526486837836;17108.97346159231;17320.913395433006;17474.03892785896;17612.735808962876;17826.465206043806;1053.6470282455386;1069.5775168808316;1069.6042464288205;1069.6309773128257;1070.2829104499965;1027.5376080763685;1066.3175567636679;1067.5943141606217;1096.528492748118;1097.248384856372;1155;1156.2137746332492;1159.6694941941548;1160.1936654025455;1161.628278950736;1144.719543711796;1145.2155273637543;1146.340854008948;1152.1992215410335;1156.0751398880905;856.2037305306063;857.4983634573782;857.8370109679141;858.7938894665298;860.42781550269;18234.817651823578;18297.268109275614;18304.359347422775;18337.08314584279;18956.336528221447;22667.433314167112;22716.88641556798;23291.650625240636;23305;23314.883425582764;15328.463503777426;15357.6160595986;15408.306626201736;15483.303251353716;15509.302081406364;4063.2279866825506;4073.368627862686;4085.428040074392;4116.135611521584;4126.360414135814;170409.2959070406;171773.14113429352;174052;175061;175519;17530.29878804859;17747.378841740476;17786.199621017084;17793.199306031;17799.288028478717;34541.481877771854;35427.29145417077;35515.82242088773;35639.64360356415;35881.641183588355;9603.279754018336;9742.171915387271;9948.154406875352;9972.950135249423;10056.849147262797;4814.398200224972;4852.539008794159;4886.242632391985;4899.828506002273;4903.730294833747;6374.330695276929;6384.265809431975;6464.288928217892;6475.643839588868;6483.967580162069;1167.5913430299327;1169.4620474581618;1188.3285943442102;1194.808830587102;1195.8804119587971;737.1854101218076;737.7381029734368;752.1125072414603;755.0976582983392;767.3400875247282;12739.490420383267;13041.152325098838;13610.659733506742;14299.634713692398;14385.6403589909;730.521508411991;735.860186564551;737.0344848248811;739.6523633892062;753.0398741604498;6222;6248.656323902138;6336.873262534724;6359.077933699587;6492.480601551864;153363.16592085286;153483;153925;156503;157037;131771;132369.33815331056;132424;133270;136505;117352;118286;118333.4083329595;118671;118721;12201.389930503261;12393.938030309791;12401.379931003234;12424.378781061092;12720.872791272339;56029;56433;56857.71571142283;57441;57827.4217257822;71904.28095719185;73342.26657733355;73531;74885;75964.62017689877;16592.585185370463;16732;16763.245653945356;16894.49316520506;16980.150992450082;18055.548611284823;18386.632267354846;18493.260269589067;18706.532336691147;18710.812891870908;16630.916845415697;16821.495355139366;16895.577610559343;16965;17000;16511.587210319838;16622.916885415496;16624.251908663897;16657.3337066516;16731;16927.15364231808;17010;17213.22540485706;17227.827721722624;17344.046077465355;12309.50761969547;12362.81455778182;12437.191582547106;12775.552855650008;12874.034447416294;14077.225752583707;14113.2237726926;14119.929400352932;14138.858611414165;14153.43386264538 14:10:25 INFO - PID 14783 | __end_tp_report 14:10:25 INFO - PID 14783 | __start_cc_report 14:10:25 INFO - PID 14783 | _x_x_mozilla_cycle_collect,256 14:10:25 INFO - PID 14783 | __end_cc_report 14:10:25 INFO - PID 14783 | __startTimestamp1506546625287__endTimestamp 14:10:25 INFO - PID 14783 | 14:10:25 INFO - PID 14783 | ------- Summary: start ------- 14:10:25 INFO - PID 14783 | Number of tests: 6 14:10:25 INFO - PID 14783 | 14:10:25 INFO - PID 14783 | [#0] dojo.html Cycles:165 Average:6657.88 Median:6912.97 stddev:775.37 (11.2%) stddev-sans-first:749.67 14:10:25 INFO - PID 14783 | Values: 4022.2 4027.3 4039.0 4042.6 4043.8 6546.9 6599.1 6678.4 6686.8 6711.9 6621.4 6629.1 6629.5 6703.8 6712.1 5939.9 5943.3 5965.6 5983.9 6018.8 5874.2 5984.2 5986.0 5994.9 6045.6 5971.0 6003.5 6046.5 6071.0 6081.0 6004.7 6009.2 6028.2 6038.6 6086.5 5731.9 5909.6 5959.7 5987.6 6098.6 6387.0 6474.6 6496.6 6573.6 6638.3 7142.3 7233.8 7235.9 7246.4 7262.7 7177.4 7186.3 7215.3 7242.3 7306.6 6495.2 6706.9 6757.8 6789.0 6813.4 7339.7 7365.0 7430.4 7436.8 7459.6 6983.7 7028.2 7077.4 7108.6 7126.1 7038.9 7168.2 7199.5 7205.8 7232.0 7211.4 7220.2 7288.6 7299.4 7309.7 7213.8 7214.8 7298.5 7305.3 7308.3 5296.7 5373.6 5381.5 5394.7 5402.5 4862.0 4874.9 4876.0 4888.0 4943.0 6763.5 6764.4 6848.6 6853.7 6859.0 7063.6 7200.6 7217.1 7231.6 7309.5 6768.7 6773.2 6784.5 6793.8 6799.0 6130.5 6140.9 6143.4 6225.9 6230.1 7333.2 7357.7 7437.6 7480.1 7534.2 7178.5 7178.6 7184.2 7193.1 7207.8 7456.7 7460.3 7502.4 7543.1 7547.3 7043.4 7122.3 7122.8 7137.8 7209.2 7328.5 7338.6 7340.6 7343.2 7360.6 6775.5 6976.1 6980.5 7070.5 7071.8 6880.6 6913.0 7016.6 7018.2 7026.1 6921.9 6933.1 6945.3 6976.7 6998.5 6922.4 6966.6 7097.4 7109.9 7116.2 6669.3 6764.9 6786.0 6876.9 6890.3 14:10:25 INFO - PID 14783 | 14:10:25 INFO - PID 14783 | [#1] ext.html Cycles:180 Average:45437.81 Median:3914.91 stddev:69081.88 (1764.6%) stddev-sans-first:69195.03 14:10:25 INFO - PID 14783 | Values: 981.4 981.6 1010.8 1024.2 1030.5 43445.3 45457.8 45651.3 45705.5 45751.3 42686.1 43165.8 43167.8 43354.6 43443.6 8170.1 8256.0 8297.4 8301.9 8307.2 8093.5 8199.1 8199.5 8222.8 8230.8 8744.1 8902.1 8910.6 8920.6 8926.9 8789.4 8816.2 8854.2 8863.3 8864.6 8706.2 8813.2 8843.4 8846.0 8846.6 40831.6 40953.6 41032.6 41040.4 41083.8 3911.7 3918.1 3919.3 3925.0 3933.0 34728.1 34837.7 34870.8 35083.5 35191.6 5493.9 5577.1 5605.2 5719.6 5739.2 234816.0 244604.0 244838.0 244969.0 244995.0 48650.5 54803.5 55674.0 55752.0 55958.7 58713.4 58777.4 58778.0 58808.7 59126.7 18772.4 18978.7 19022.4 19083.0 19086.6 15779.8 15790.8 15793.8 15796.9 15798.2 15828.0 15881.8 15973.4 15982.4 15993.8 6207.9 6212.8 6239.6 6316.8 6320.5 1090.7 1098.8 1104.2 1116.2 1123.4 26292.6 26429.2 26502.0 26549.3 26619.6 1219.5 1227.1 1231.1 1243.8 1244.3 13741.8 13864.2 13994.4 14000.2 14145.4 294227.0 294290.0 295225.0 296922.0 297111.0 59908.4 60487.0 60705.7 60940.0 61027.4 1519.4 1542.4 1575.5 1584.0 1589.5 25667.5 26182.2 26265.0 26365.0 26376.2 41729.4 42195.2 42224.8 42311.0 42313.0 255464.0 256027.0 256656.0 256698.0 256764.0 37603.2 37903.2 40273.8 40480.0 40527.0 52678.2 52819.5 52925.5 53228.2 53228.7 38431.0 38496.4 38736.6 38873.0 38889.6 38324.2 38440.8 38672.4 38721.4 38925.2 44146.0 45590.0 45699.8 45912.3 45992.1 36585.9 36838.4 37043.4 37295.3 37396.0 27221.6 27743.3 27967.0 28005.6 28157.8 14:10:25 INFO - PID 14783 | 14:10:25 INFO - PID 14783 | [#2] jquery.html Cycles:180 Average:40543.99 Median:21642.99 stddev:102355.42 (472.9%) stddev-sans-first:102598.72 14:10:25 INFO - PID 14783 | Values: 643.6 646.4 647.5 650.2 656.8 24216.0 24854.4 24868.0 24992.9 25033.1 25611.6 26039.9 26064.0 26086.0 26144.3 6501.5 6644.5 6954.0 6985.5 6996.8 6828.0 6931.3 6937.7 6952.1 6953.5 6681.9 6900.8 6914.7 6918.4 6939.9 6350.9 6983.2 6997.9 7033.8 7033.8 6504.6 6532.7 6552.0 6565.6 6570.6 30661.5 30905.1 31489.5 31567.5 31658.4 2376.2 2420.1 2428.7 2430.8 2434.5 20462.4 20920.2 20940.8 20975.5 21172.7 2312.4 2350.8 2386.7 2396.3 2427.5 142588.0 148218.0 166831.0 174296.1 174316.0 16254.8 16445.7 16990.1 17084.9 17390.2 27388.5 27388.7 27491.0 27556.7 27766.0 11190.9 11288.0 11291.0 11306.3 11400.6 10203.4 10266.9 10274.6 10319.2 10320.5 9992.6 10281.3 10300.2 10301.9 10408.9 2878.2 2936.3 2941.0 3037.6 3101.2 1052.7 1069.8 1070.2 1071.4 1077.3 20930.4 21619.0 21667.0 21721.0 22142.9 1132.8 1166.2 1169.2 1171.0 1176.4 11596.2 11895.8 11914.7 11930.6 12054.6 591573.0 611312.0 612894.0 612906.0 622682.0 125216.0 126890.4 128235.0 131197.0 134516.0 1240.3 1279.5 1288.4 1290.8 1299.5 18776.2 19066.6 19242.0 19426.5 19529.5 60860.0 65293.0 66084.3 66770.3 67288.0 80787.6 81081.0 81237.6 81321.6 81790.0 15945.3 16014.5 16029.1 16060.8 16080.2 23811.6 24087.0 24161.4 24171.3 24222.5 20113.5 20143.3 20238.3 20325.7 20340.2 17950.4 18141.5 18410.8 18464.6 18667.2 20173.5 20326.4 20460.4 20551.4 20557.4 15827.0 15869.6 15908.3 15921.4 15953.8 19252.2 19507.3 19629.5 19742.7 19770.0 14:10:25 INFO - PID 14783 | 14:10:25 INFO - PID 14783 | [#3] mootools.html Cycles:180 Average:10884.79 Median:3054.78 stddev:8174.54 (267.6%) stddev-sans-first:8166.83 14:10:25 INFO - PID 14783 | Values: 1464.5 1502.7 1512.7 1519.2 1529.7 17143.7 17797.1 17886.6 17906.6 17938.0 17319.4 17642.9 17666.0 17728.6 17748.0 3051.2 3110.2 3129.5 3134.9 3175.1 3111.5 3142.1 3157.1 3157.6 3158.6 3084.1 3116.7 3189.7 3191.4 3195.4 3154.4 3160.3 3176.8 3183.6 3190.1 2980.8 3043.5 3058.4 3061.5 3074.8 17019.7 17219.4 17259.7 17376.7 17435.2 9100.9 9495.4 9507.3 9510.9 9524.3 5721.3 5746.6 5847.0 5920.6 5924.7 2018.6 2057.9 2061.7 2094.3 2122.1 31241.2 31513.5 31525.1 31671.4 31694.7 7505.7 7522.3 7577.7 7737.4 7755.8 20579.3 20739.2 20783.2 20802.0 20830.2 9125.4 9281.2 9305.4 9312.0 9330.3 8298.6 8468.9 8529.4 8561.1 8618.1 6241.4 6255.2 6304.3 6369.6 6385.7 1614.9 1672.1 1735.3 1757.6 1767.1 946.7 956.3 956.5 959.1 970.9 8215.2 8230.6 8258.4 8266.3 8430.9 1059.9 1064.7 1070.9 1077.9 1090.1 4844.7 4961.9 4965.2 4986.4 5016.8 26242.6 26579.5 26853.2 26938.9 27070.5 26817.0 26871.9 27032.6 27493.6 27636.7 12707.1 13053.6 13062.9 13260.4 13322.4 9171.2 9284.4 9285.6 9372.7 9381.7 22311.4 22323.8 22510.2 23140.7 23383.2 23246.5 23452.3 23785.8 23843.4 23852.5 13016.0 13038.7 13101.7 13106.9 13191.2 15833.4 15937.5 16011.7 16086.5 16108.4 12756.4 13223.9 13290.9 13298.9 13352.9 12146.4 12173.9 12456.5 12470.8 12593.7 9835.1 9879.1 10067.7 10103.9 10117.6 7944.4 8109.7 8174.4 8220.9 8261.1 8275.0 8327.4 8370.4 8417.0 8473.8 14:10:25 INFO - PID 14783 | 14:10:25 INFO - PID 14783 | [#4] prototype.html Cycles:180 Average:5911.48 Median:6529.75 stddev:1642.59 (25.2%) stddev-sans-first:1597.80 14:10:25 INFO - PID 14783 | Values: 584.8 588.5 605.6 623.9 629.2 6509.3 6561.6 6591.3 6666.1 6718.8 6469.5 6477.9 6496.0 6545.7 6554.9 5256.8 5293.5 5301.4 5306.4 5318.3 5102.2 5308.9 5368.4 5377.9 5423.4 5205.4 5234.8 5235.9 5239.2 5248.2 5156.0 5225.5 5226.6 5260.1 5279.8 4744.4 4777.3 4781.9 4783.8 4805.4 6378.9 6432.7 6463.5 6505.5 6541.3 6181.7 6205.1 6210.0 6245.7 6252.1 6826.2 6872.8 6924.1 6970.4 6993.3 5149.5 5315.7 5354.0 5366.8 5405.3 6948.8 7095.7 7255.5 7268.3 7278.2 5428.0 5449.7 5469.5 5487.8 5505.1 5478.0 5478.4 5533.6 5551.7 5600.0 6150.5 6174.0 6176.5 6182.2 6196.4 7002.2 7014.8 7043.5 7056.3 7071.5 1898.0 1910.1 1923.2 1923.6 1923.7 1301.5 1342.3 1342.4 1358.6 1375.4 6404.8 6487.4 6487.5 6496.9 6596.5 6999.5 7014.8 7038.4 7050.3 7092.9 6507.2 6522.3 6537.2 6595.9 6602.1 3662.1 3682.3 3738.8 3745.9 3762.4 7046.0 7228.9 7285.4 7394.0 7406.4 7126.2 7148.7 7159.3 7220.5 7224.3 7225.0 7296.9 7399.6 7408.9 7454.1 7050.5 7108.1 7127.6 7134.2 7134.5 6999.2 7020.6 7045.5 7062.6 7150.9 7291.7 7359.2 7381.9 7391.4 7393.0 5511.3 5512.7 5516.9 5531.7 5539.7 6738.5 6995.5 7107.0 7173.9 7181.5 6359.6 6736.1 6786.8 6880.6 6886.9 6718.6 6818.6 6853.0 6870.9 6907.9 6729.6 6778.5 6808.0 6855.3 6871.8 6892.8 6957.9 6961.2 6975.3 7019.6 6381.2 6608.0 6721.9 6741.4 6761.4 14:10:25 INFO - PID 14783 | 14:10:25 INFO - PID 14783 | [#5] yui.html Cycles:180 Average:28779.27 Median:17332.48 stddev:44352.37 (255.9%) stddev-sans-first:44427.59 14:10:25 INFO - PID 14783 | Values: 957.3 981.9 982.7 1007.4 1041.5 18117.8 18901.1 18913.4 18921.2 18940.5 17109.0 17320.9 17474.0 17612.7 17826.5 1053.6 1069.6 1069.6 1069.6 1070.3 1027.5 1066.3 1067.6 1096.5 1097.2 1155.0 1156.2 1159.7 1160.2 1161.6 1144.7 1145.2 1146.3 1152.2 1156.1 856.2 857.5 857.8 858.8 860.4 18234.8 18297.3 18304.4 18337.1 18956.3 22667.4 22716.9 23291.7 23305.0 23314.9 15328.5 15357.6 15408.3 15483.3 15509.3 4063.2 4073.4 4085.4 4116.1 4126.4 170409.3 171773.1 174052.0 175061.0 175519.0 17530.3 17747.4 17786.2 17793.2 17799.3 34541.5 35427.3 35515.8 35639.6 35881.6 9603.3 9742.2 9948.2 9973.0 10056.8 4814.4 4852.5 4886.2 4899.8 4903.7 6374.3 6384.3 6464.3 6475.6 6484.0 1167.6 1169.5 1188.3 1194.8 1195.9 737.2 737.7 752.1 755.1 767.3 12739.5 13041.2 13610.7 14299.6 14385.6 730.5 735.9 737.0 739.7 753.0 6222.0 6248.7 6336.9 6359.1 6492.5 153363.2 153483.0 153925.0 156503.0 157037.0 131771.0 132369.3 132424.0 133270.0 136505.0 117352.0 118286.0 118333.4 118671.0 118721.0 12201.4 12393.9 12401.4 12424.4 12720.9 56029.0 56433.0 56857.7 57441.0 57827.4 71904.3 73342.3 73531.0 74885.0 75964.6 16592.6 16732.0 16763.2 16894.5 16980.2 18055.5 18386.6 18493.3 18706.5 18710.8 16630.9 16821.5 16895.6 16965.0 17000.0 16511.6 16622.9 16624.3 16657.3 16731.0 16927.2 17010.0 17213.2 17227.8 17344.0 12309.5 12362.8 12437.2 12775.6 12874.0 14077.2 14113.2 14119.9 14138.9 14153.4 14:10:25 INFO - PID 14783 | -------- Summary: end -------- 14:10:25 INFO - PID 14783 | 14:10:25 INFO - TEST-INFO | 14783: exit 0 14:10:25 INFO - TEST-OK | dromaeo_css | took 1106689ms 14:10:25 INFO - TEST-START | kraken 14:10:25 INFO - Initialising browser for kraken test... 14:10:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33583/getInfo.html -profile /tmp/tmpxDh_IA/profile 14:10:25 INFO - TEST-INFO | started process 15146 (/builds/slave/test/build/application/firefox/firefox http://localhost:33583/getInfo.html) 14:10:30 INFO - TEST-INFO | 15146: exit 0 14:10:30 INFO - Browser initialized. 14:10:30 INFO - Running cycle 1/1 for kraken test... 14:10:30 INFO - Using env: {'DISPLAY': ':0', 14:10:30 INFO - 'HOME': '/home/cltbld', 14:10:30 INFO - 'JSGC_DISABLE_POISONING': '1', 14:10:30 INFO - 'LANG': 'en_US.UTF-8', 14:10:30 INFO - 'LANGUAGE': 'en_US:en', 14:10:30 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:10:30 INFO - 'LOGNAME': 'cltbld', 14:10:30 INFO - 'MAIL': '/var/mail/cltbld', 14:10:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:10:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:10:30 INFO - 'MOZ_CRASHREPORTER': '1', 14:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:30 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:10:30 INFO - 'MOZ_NO_REMOTE': '1', 14:10:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:30 INFO - 'NO_EM_RESTART': '1', 14:10:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:30 INFO - 'PWD': '/builds/slave/test', 14:10:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:10:30 INFO - 'RUST_BACKTRACE': 'full', 14:10:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:10:30 INFO - 'SHELL': '/bin/bash', 14:10:30 INFO - 'SHLVL': '1', 14:10:30 INFO - 'TERM': 'linux', 14:10:30 INFO - 'TMOUT': '86400', 14:10:30 INFO - 'USER': 'cltbld', 14:10:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430', 14:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:30 INFO - '_': '/tools/buildbot/bin/python'} 14:10:30 INFO - TEST-INFO | started process 15337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxDh_IA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:31 INFO - PID 15337 | 14:10:31 INFO - PID 15337 | (/builds/slave/test/build/application/firefox/firefox:15385): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:10:31 INFO - PID 15337 | 14:10:41 INFO - PID 15337 | RSS: Main: 142561280 14:10:41 INFO - PID 15337 | 14:10:44 INFO - PID 15337 | Cycle 1(1): loaded http://localhost:33583/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33583/tests/kraken/driver.html?testName=audio-beat-detection) 14:10:45 INFO - PID 15337 | RSS: Main: 150061056 14:10:45 INFO - PID 15337 | 14:10:47 INFO - PID 15337 | Cycle 1(1): loaded http://localhost:33583/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33583/tests/kraken/driver.html?testName=audio-dft) 14:10:48 INFO - PID 15337 | RSS: Main: 150511616 14:10:48 INFO - PID 15337 | 14:10:51 INFO - PID 15337 | Cycle 1(1): loaded http://localhost:33583/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33583/tests/kraken/driver.html?testName=audio-fft) 14:10:51 INFO - PID 15337 | RSS: Main: 152117248 14:10:51 INFO - PID 15337 | 14:10:53 INFO - PID 15337 | Cycle 1(1): loaded http://localhost:33583/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33583/tests/kraken/driver.html?testName=audio-oscillator) 14:10:54 INFO - PID 15337 | RSS: Main: 151986176 14:10:54 INFO - PID 15337 | 14:10:56 INFO - PID 15337 | Cycle 1(1): loaded http://localhost:33583/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33583/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:10:56 INFO - PID 15337 | RSS: Main: 151609344 14:10:56 INFO - PID 15337 | 14:10:59 INFO - PID 15337 | Cycle 1(1): loaded http://localhost:33583/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33583/tests/kraken/driver.html?testName=imaging-darkroom) 14:11:00 INFO - PID 15337 | RSS: Main: 151764992 14:11:00 INFO - PID 15337 | 14:11:04 INFO - PID 15337 | Cycle 1(1): loaded http://localhost:33583/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33583/tests/kraken/driver.html?testName=imaging-desaturate) 14:11:04 INFO - PID 15337 | RSS: Main: 151728128 14:11:04 INFO - PID 15337 | 14:11:07 INFO - PID 15337 | Cycle 1(1): loaded http://localhost:33583/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33583/tests/kraken/driver.html?testName=json-parse-financial) 14:11:08 INFO - PID 15337 | RSS: Main: 153399296 14:11:08 INFO - PID 15337 | 14:11:09 INFO - PID 15337 | Cycle 1(1): loaded http://localhost:33583/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33583/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:11:10 INFO - PID 15337 | RSS: Main: 153481216 14:11:10 INFO - PID 15337 | 14:11:11 INFO - PID 15337 | Cycle 1(1): loaded http://localhost:33583/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33583/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:11:12 INFO - PID 15337 | RSS: Main: 153460736 14:11:12 INFO - PID 15337 | 14:11:14 INFO - PID 15337 | Cycle 1(1): loaded http://localhost:33583/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33583/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:11:15 INFO - PID 15337 | RSS: Main: 150036480 14:11:15 INFO - PID 15337 | 14:11:17 INFO - PID 15337 | Cycle 1(1): loaded http://localhost:33583/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:11:18 INFO - PID 15337 | RSS: Main: 150466560 14:11:18 INFO - PID 15337 | 14:11:20 INFO - PID 15337 | Cycle 1(1): loaded http://localhost:33583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:11:21 INFO - PID 15337 | RSS: Main: 150728704 14:11:21 INFO - PID 15337 | 14:11:22 INFO - PID 15337 | Cycle 1(1): loaded http://localhost:33583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33583/tests/kraken/driver.html?testName=ai-astar) 14:11:23 INFO - PID 15337 | RSS: Main: 152428544 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | __start_tp_report 14:11:23 INFO - PID 15337 | _x_x_mozilla_page_load 14:11:23 INFO - PID 15337 | _x_x_mozilla_page_load_details 14:11:23 INFO - PID 15337 | |i|pagename|runs| 14:11:23 INFO - PID 15337 | |0;ai-astar;104;105;104;106;104;104;96;107;106;105 14:11:23 INFO - PID 15337 | |1;audio-beat-detection;114;114;112;114;111;110;138;117;112;117 14:11:23 INFO - PID 15337 | |2;audio-dft;163;161;162;161;163;162;164;161;162;162 14:11:23 INFO - PID 15337 | |3;audio-fft;73;72;74;72;72;74;74;71;73;74 14:11:23 INFO - PID 15337 | |4;audio-oscillator;77;77;78;77;78;78;78;78;77;77 14:11:23 INFO - PID 15337 | |5;imaging-gaussian-blur;113;113;110;113;111;115;114;115;114;115 14:11:23 INFO - PID 15337 | |6;imaging-darkroom;149;148;148;150;148;150;148;147;149;150 14:11:23 INFO - PID 15337 | |7;imaging-desaturate;94;94;94;94;94;99;93;94;94;95 14:11:23 INFO - PID 15337 | |8;json-parse-financial;49;54;45;47;46;45;45;48;47;43 14:11:23 INFO - PID 15337 | |9;json-stringify-tinderbox;37;38;39;38;37;38;38;38;38;39 14:11:23 INFO - PID 15337 | |10;stanford-crypto-aes;70;67;68;69;70;70;69;72;71;69 14:11:23 INFO - PID 15337 | |11;stanford-crypto-ccm;107;102;106;108;106;101;102;109;108;104 14:11:23 INFO - PID 15337 | |12;stanford-crypto-pbkdf2;153;147;151;147;146;155;148;159;147;154 14:11:23 INFO - PID 15337 | |13;stanford-crypto-sha256-iterative;61;57;58;65;58;60;61;58;58;57 14:11:23 INFO - PID 15337 | __end_tp_report 14:11:23 INFO - PID 15337 | __start_cc_report 14:11:23 INFO - PID 15337 | _x_x_mozilla_cycle_collect,676 14:11:23 INFO - PID 15337 | __end_cc_report 14:11:23 INFO - PID 15337 | __startTimestamp1506546683224__endTimestamp 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | ------- Summary: start ------- 14:11:23 INFO - PID 15337 | Number of tests: 14 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | [#0] ai-astar Cycles:10 Average:104.10 Median:105.50 stddev:3.03 (2.9%) stddev-sans-first:3.22 14:11:23 INFO - PID 15337 | Values: 104.0 105.0 104.0 106.0 104.0 104.0 96.0 107.0 106.0 105.0 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | [#1] audio-beat-detection Cycles:10 Average:115.90 Median:114.00 stddev:8.10 (7.1%) stddev-sans-first:8.57 14:11:23 INFO - PID 15337 | Values: 114.0 114.0 112.0 114.0 111.0 110.0 138.0 117.0 112.0 117.0 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 14:11:23 INFO - PID 15337 | Values: 163.0 161.0 162.0 161.0 163.0 162.0 164.0 161.0 162.0 162.0 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | [#3] audio-fft Cycles:10 Average:72.90 Median:73.50 stddev:1.10 (1.5%) stddev-sans-first:1.17 14:11:23 INFO - PID 15337 | Values: 73.0 72.0 74.0 72.0 72.0 74.0 74.0 71.0 73.0 74.0 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:78.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 14:11:23 INFO - PID 15337 | Values: 77.0 77.0 78.0 77.0 78.0 78.0 78.0 78.0 77.0 77.0 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:1.70 (1.5%) stddev-sans-first:1.80 14:11:23 INFO - PID 15337 | Values: 113.0 113.0 110.0 113.0 111.0 115.0 114.0 115.0 114.0 115.0 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 14:11:23 INFO - PID 15337 | Values: 149.0 148.0 148.0 150.0 148.0 150.0 148.0 147.0 149.0 150.0 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.65 (1.8%) stddev-sans-first:1.74 14:11:23 INFO - PID 15337 | Values: 94.0 94.0 94.0 94.0 94.0 99.0 93.0 94.0 94.0 95.0 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | [#8] json-parse-financial Cycles:10 Average:46.90 Median:47.00 stddev:3.03 (6.5%) stddev-sans-first:3.12 14:11:23 INFO - PID 15337 | Values: 49.0 54.0 45.0 47.0 46.0 45.0 45.0 48.0 47.0 43.0 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.67 (1.8%) stddev-sans-first:0.60 14:11:23 INFO - PID 15337 | Values: 37.0 38.0 39.0 38.0 37.0 38.0 38.0 38.0 38.0 39.0 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | [#10] stanford-crypto-aes Cycles:10 Average:69.50 Median:70.00 stddev:1.43 (2.0%) stddev-sans-first:1.51 14:11:23 INFO - PID 15337 | Values: 70.0 67.0 68.0 69.0 70.0 70.0 69.0 72.0 71.0 69.0 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | [#11] stanford-crypto-ccm Cycles:10 Average:105.30 Median:106.50 stddev:2.87 (2.7%) stddev-sans-first:2.98 14:11:23 INFO - PID 15337 | Values: 107.0 102.0 106.0 108.0 106.0 101.0 102.0 109.0 108.0 104.0 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:152.00 stddev:4.40 (2.9%) stddev-sans-first:4.59 14:11:23 INFO - PID 15337 | Values: 153.0 147.0 151.0 147.0 146.0 155.0 148.0 159.0 147.0 154.0 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.30 Median:59.00 stddev:2.50 (4.2%) stddev-sans-first:2.57 14:11:23 INFO - PID 15337 | Values: 61.0 57.0 58.0 65.0 58.0 60.0 61.0 58.0 58.0 57.0 14:11:23 INFO - PID 15337 | -------- Summary: end -------- 14:11:23 INFO - PID 15337 | 14:11:23 INFO - PID 15337 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:11:23 INFO - TEST-INFO | 15337: exit 0 14:11:23 INFO - TEST-OK | kraken | took 57993ms 14:11:23 INFO - SUITE-END | took 1164s 14:11:23 INFO - Completed test suite (00:19:24) 14:11:23 INFO - javascript benchmark 14:11:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9426.927191792525, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4022.175454031924, 4027.2750904837117, 4038.979805100973, 4042.6255073275115, 4043.757374557527, 6546.9017964730565, 6599.109120268762, 6678.398944095031, 6686.799396018121, 6711.932880671186, 6621.404073633372, 6629.071929929813, 6629.50278729096, 6703.832404189898, 6712.127423434947, 5939.940600593982, 5943.286805583336, 5965.61223520472, 5983.940160598404, 6018.849528761783, 5874.206982057411, 5984.162217289583, 5986.0, 5994.910076348859, 6045.576809623328, 5971.0, 6003.519718422537, 6046.455818976291, 6070.969645151768, 6081.027035674293, 6004.669743164124, 6009.218801555813, 6028.156058151862, 6038.57729958903, 6086.452219300284, 5731.856703582402, 5909.586328956974, 5959.672218028007, 5987.580869339148, 6098.634081955097, 6387.0, 6474.5791523550815, 6496.642684652342, 6573.57271777333, 6638.269790323061, 7142.285771422816, 7233.819154521127, 7235.92764072363, 7246.420286377077, 7262.709491620329, 7177.4258059355125, 7186.317299856558, 7215.314545118205, 7242.31198036191, 7306.634668266565, 6495.188101487314, 6706.899396509057, 6757.831054223684, 6788.966055169792, 6813.3527314905505, 7339.74310899116, 7365.0, 7430.405567554582, 7436.814079648052, 7459.627018649046, 6983.650817459106, 7028.156621205386, 7077.433805295564, 7108.609026503488, 7126.109236345457, 7038.929610703827, 7168.211496735355, 7199.460040496879, 7205.7838264852135, 7232.0, 7211.423086153095, 7220.169680486706, 7288.635568221568, 7299.41604671625, 7309.707611695472, 7213.819654508679, 7214.783556493208, 7298.452616053817, 7305.305995930378, 7308.30571095745, 5296.655717378358, 5373.623846330719, 5381.48875856793, 5394.703291319015, 5402.459754024566, 4862.0, 4874.902501949941, 4876.049170411807, 4888.046830868017, 4942.975285123552, 6763.5265531413315, 6764.3573860483175, 6848.554843935129, 6853.691583878737, 6859.039734437183, 7063.57618542889, 7200.639968001579, 7217.097862767154, 7231.602261875647, 7309.488335816442, 6768.72925083001, 6773.221079575814, 6784.457243420515, 6793.830154246085, 6798.966005169942, 6130.540209484307, 6140.8771824563255, 6143.354947730513, 6225.906611400833, 6230.127782110508, 7333.230010848891, 7357.742479013209, 7437.628118594049, 7480.1023877134, 7534.208908064684, 7178.497505174588, 7178.5692858428665, 7184.245654206442, 7193.136823581203, 7207.783766487014, 7456.66445009965, 7460.253974602496, 7502.399808015455, 7543.1325397579985, 7547.320741133324, 7043.36609705129, 7122.287771222836, 7122.8219294515975, 7137.82155446118, 7209.206987231505, 7328.487005909536, 7338.633068346669, 7340.632968351454, 7343.192248852729, 7360.558366498028, 6775.525713200226, 6976.093107895941, 6980.511364204457, 7070.505064645426, 7071.752488662872, 6880.621565813728, 6912.965435172792, 7016.5790052597, 7018.227994920657, 7026.1217347831525, 6921.861562768817, 6933.1333583302085, 6945.2707465715375, 6976.720931162697, 6998.475114366341, 6922.411595014481, 6966.582005079711, 7097.432205423657, 7109.857802844018, 7116.181639111568, 6669.333066693292, 6764.86470270582, 6785.9660701696175, 6876.931230687629, 6890.276520965427], "value": 6605.748269560685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [981.3572110267775, 981.5632043740529, 1010.7877345757393, 1024.2113572549138, 1030.5156576409095, 43445.34831977519, 45457.7727111364, 45651.31523027153, 45705.542944570545, 45751.31373029403, 42686.14627707452, 43165.7841710791, 43167.78416107923, 43354.56645433545, 43443.565564344346, 8170.101288858221, 8255.958720206421, 8297.377696672744, 8301.875471867927, 8307.169283071675, 8093.473924194908, 8199.057108432517, 8199.549024803633, 8222.794430139264, 8230.835383292331, 8744.081871403507, 8902.065283145273, 8910.599023043946, 8920.598573064195, 8926.86609700855, 8789.428687135347, 8816.206541411304, 8854.203121719043, 8863.29093672511, 8864.601092950801, 8706.21644052032, 8813.206811387006, 8843.425177363451, 8845.955770221108, 8846.60190291432, 40831.591684083076, 40953.59046409557, 41032.589674103176, 41040.38439423411, 41083.7945810272, 3911.7457365271166, 3918.0792513759243, 3919.2553414851086, 3925.038365600418, 3933.0167458135465, 34728.13179670528, 34837.65162348395, 34870.82564587186, 35083.473747893804, 35191.648083519096, 5493.890122197534, 5577.079781835992, 5605.159226116074, 5719.628224165416, 5739.196512488255, 234816.0, 244604.0, 244838.0, 244969.0, 244995.0, 48650.5134948646, 54803.451965479835, 55674.0, 55751.999999999185, 55958.720206398706, 58713.41286587165, 58777.41222587805, 58778.0, 58808.705956469945, 59126.704366478756, 18772.436826895217, 18978.71531927022, 19022.429327120208, 19083.0, 19086.61826763457, 15779.763303550455, 15790.763138552931, 15793.763093553605, 15796.921015395079, 15798.21008949548, 15828.0, 15881.841181588035, 15973.440929567641, 15982.36070557188, 15993.840061599467, 6207.937920620826, 6212.751489940351, 6239.625622462667, 6316.810495685137, 6320.462760665395, 1090.7382228265317, 1098.8296813993843, 1104.1663544024211, 1116.1851848150895, 1123.393367581497, 26292.605610915853, 26429.207123786317, 26502.0, 26549.33626659349, 26619.60070598904, 1219.536576101076, 1227.0858210633135, 1231.1259006105586, 1243.7885559454915, 1244.2845363915785, 13741.793873091912, 13864.237466939416, 13994.370253338624, 14000.229987350793, 14145.36345864418, 294227.0, 294290.0, 295225.0, 296922.0, 297111.0, 59908.40091599115, 60487.0, 60705.69647151736, 60940.0, 61027.38972610217, 1519.4302136698739, 1542.4138827245574, 1575.4800915697792, 1583.9762403563955, 1589.4595837415334, 25667.486650267263, 26182.214533564023, 26265.0, 26365.0, 26376.20871373862, 41729.37405938974, 42195.156096877276, 42224.78887605542, 42311.0, 42313.0, 255464.0, 256027.0, 256656.0, 256698.0, 256764.0, 37603.2479350406, 37903.24193516169, 40273.79863100783, 40480.0, 40527.0, 52678.20982685186, 52819.47180528146, 52925.470745292056, 53228.20157697715, 53228.73385633202, 38431.0, 38496.422553662276, 38736.6126338733, 38873.0, 38889.6111038886, 38324.233515330096, 38440.80779596084, 38672.41991370188, 38721.4191787129, 38925.2214955705, 44146.0, 45590.0, 45699.771501142284, 45912.31131532963, 45992.08015839598, 36585.90242292736, 36838.44742328813, 37043.444348334255, 37295.25409491741, 37396.0, 27221.591676124477, 27743.28361186356, 27967.021154259503, 28005.579916301678, 28157.79913307004], "value": 19691.104086848267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.5553990679205, 646.3799769782476, 647.5307329949037, 650.2426057138341, 656.8078936729833, 24216.0, 24854.378640533974, 24868.0, 24992.875035624842, 25033.12384066558, 25611.61582576263, 26039.86980065097, 26064.0, 26086.0, 26144.34639134018, 6501.4798816094835, 6644.468442524587, 6953.965230173842, 6985.511014229006, 6996.755113571026, 6827.965860170692, 6931.3068693130535, 6937.6878040488045, 6952.096227490444, 6953.548019378724, 6681.933180668204, 6900.75847345343, 6914.723411063552, 6918.411934985532, 6939.895901561481, 6350.936490635104, 6983.196932352794, 6997.895031574531, 7033.788986330418, 7033.824154396129, 6504.60972341661, 6532.6733663316645, 6552.049952756824, 6565.638889861056, 6570.63861487618, 30661.540076898866, 30905.0728478146, 31489.527657085164, 31567.52648710271, 31658.366832663218, 2376.1802178248477, 2420.056178090546, 2428.7449817769057, 2430.805535557151, 2434.4522482441484, 20462.386128416172, 20920.163193472243, 20940.790592094036, 20975.47561310964, 21172.682409763867, 2312.433453803829, 2350.847194932324, 2386.6658667786523, 2396.2571602803014, 2427.490227052321, 142588.0, 148218.0, 166831.0, 174296.12851935785, 174316.0, 16254.75617865733, 16445.6710865782, 16990.06554639482, 17084.899624090376, 17390.21744021522, 27388.45223095527, 27388.72611273862, 27491.0, 27556.72443275582, 27766.0, 11190.888091119148, 11288.0, 11291.0, 11306.321620702784, 11400.600978965862, 10203.38779673222, 10266.948665256627, 10274.589016439259, 10319.226058045526, 10320.535575899103, 9992.600295988079, 10281.331713438603, 10300.22748293881, 10301.896981030244, 10408.895911040943, 2878.150945471091, 2936.309967157716, 2940.9852950735108, 3037.6051113355124, 3101.1936896406646, 1052.6684094510206, 1069.844872493484, 1070.240129508058, 1071.4392601681986, 1077.2674581284803, 20930.37208883736, 21618.973833504173, 21667.0, 21721.0, 22142.88928555347, 1132.750794825137, 1166.1545379599722, 1169.1990986174499, 1170.9590164344206, 1176.4235524592889, 11596.18826682141, 11895.762084758257, 11914.702132446759, 11930.642080737593, 12054.578089766992, 591573.0, 611312.0, 612894.0, 612906.0, 622682.0, 125216.0, 126890.36554817167, 128234.99999999814, 131197.0, 134516.0, 1240.34881687115, 1279.526575167194, 1288.3944546063335, 1290.8450985881566, 1299.5451591942933, 18776.248950041845, 19066.61866762629, 19242.0, 19426.514337141685, 19529.51176220549, 60860.0, 65293.0, 66084.33915660974, 66770.33229667836, 67288.0, 80787.59606201931, 81081.0, 81237.59381203057, 81321.59339203266, 81790.0, 15945.282462288993, 16014.519564413085, 16029.118398487728, 16060.839391606401, 16080.195990200209, 23811.64282535798, 24087.0, 24161.395965101012, 24171.274861754177, 24222.51554968926, 20113.497162571053, 20143.294984676053, 20238.291659791837, 20325.695114572998, 20340.186392544132, 17950.371736989142, 18141.546461338574, 18410.81589184091, 18464.630707386044, 18667.159977801304, 20173.49566260855, 20326.390208293775, 20460.38618841437, 20551.383458496268, 20557.383278501668, 15827.0, 15869.603259918133, 15908.284127214534, 15921.442749503713, 15953.840461595235, 19252.22991080341, 19507.317243896396, 19629.527785415867, 19742.70385944241, 19770.0], "value": 13131.357000314258, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.5313499680103, 1502.6619010722588, 1512.7050225206083, 1519.2176029344882, 1529.7093552225076, 17143.657126857455, 17797.110144492774, 17886.64226715465, 17906.641867162663, 17938.0, 17319.39382121626, 17642.911785441087, 17666.0, 17728.64542709145, 17748.0, 3051.160930744041, 3110.2068972412003, 3129.4836352001894, 3134.8589313480948, 3175.0792270241604, 3111.4866047102314, 3142.0730884389045, 3157.1160075178987, 3157.605299337583, 3158.6051743532057, 3084.121025507731, 3116.65716771155, 3189.681031896815, 3191.377681352137, 3195.4088493628637, 3154.3848949454864, 3160.320531085816, 3176.825274609919, 3183.633882103553, 3190.0748782852943, 2980.821150730963, 3043.52825312077, 3058.4036112957983, 3061.525463553153, 3074.769392295587, 17019.65960680792, 17219.3973210937, 17259.654806903916, 17376.65246695059, 17435.215415306342, 9100.908990910073, 9495.430274183502, 9507.286953478517, 9510.857337139949, 9524.333296669167, 5721.284839395075, 5746.569007324468, 5847.0, 5920.615160014629, 5924.7333869975955, 2018.6063717574932, 2057.8887400803546, 2061.680439531875, 2094.3298144593737, 2122.0768965500056, 31241.218969525715, 31513.52729709056, 31525.054248372355, 31671.36657266842, 31694.683053169403, 7505.737299194502, 7522.285382888617, 7577.659005344773, 7737.419693523008, 7755.806104847424, 20579.279725209544, 20739.170433182804, 20783.1686732529, 20802.0, 20830.1667933281, 9125.406848554823, 9281.164695177331, 9305.395149315273, 9311.953440232755, 9330.346875718771, 8298.58507074656, 8468.872966905501, 8529.445586037013, 8561.0582835888, 8618.052014278424, 6241.438270555672, 6255.186825712719, 6304.306526282106, 6369.5541312108635, 6385.680715964183, 1614.9192540372935, 1672.1105151179333, 1735.3232239426634, 1757.6484703059439, 1767.063456368127, 946.7065209784988, 956.31623389277, 956.53129966316, 959.0553304994575, 970.9126178643955, 8215.178482151856, 8230.62962166704, 8258.380621453414, 8266.338692904554, 8430.915690843136, 1059.8728152621734, 1064.723171975292, 1070.8500809886623, 1077.9083777878811, 1090.0734375780523, 4844.685095468783, 4961.900761984813, 4965.205567109245, 4986.426560945465, 5016.774245158904, 26242.606360904603, 26579.468410632067, 26853.194404167516, 26938.865305673346, 27070.45859082807, 26817.0, 26871.865640671673, 27032.59451108235, 27493.587596186073, 27636.723632763817, 12707.110502264753, 13053.608391748263, 13062.869371306355, 13260.40328185234, 13322.400491977884, 9171.174594286545, 9284.350095493252, 9285.62857485693, 9372.718818435458, 9381.671641492516, 22311.44221394478, 22323.77676223217, 22510.212142574932, 23140.652890206322, 23383.181588644315, 23246.535069298858, 23452.296431107094, 23785.762142378353, 23843.403914901573, 23852.52294954126, 13016.023798214983, 13038.674033148867, 13101.73796524045, 13106.934465327613, 13191.208527488381, 15833.445829395916, 15937.521874343789, 16011.679766404839, 16086.471785180389, 16108.436204732778, 12756.42596083197, 13223.867761322648, 13290.933545332211, 13298.933505332412, 13352.93323533415, 12146.392680366123, 12173.878261217274, 12456.501739930301, 12470.812937806122, 12593.685157871127, 9835.114839664464, 9879.110880020833, 10067.748306292402, 10103.89896101059, 10117.59529618807, 7944.404169687181, 8109.7161599343735, 8174.386920980831, 8220.876686849822, 8261.091279959079, 8275.0, 8327.417080804285, 8370.414071015213, 8417.0, 8473.83052338962], "value": 7614.180430155243, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.8245526342097, 588.4527389527738, 605.5882000239835, 623.9251289845218, 629.2323365494095, 6509.251436084852, 6561.587974253392, 6591.307912669173, 6666.100076489673, 6718.764843230476, 6469.547131700783, 6477.894684227633, 6495.967520162404, 6545.705443255053, 6554.934450655492, 5256.763445644955, 5293.497117773805, 5301.416844147141, 5306.363236411636, 5318.30861987943, 5102.234664800291, 5308.867278318035, 5368.436314187013, 5377.919331210035, 5423.376311724162, 5205.401378841425, 5234.790608375661, 5235.895282094375, 5239.161734122541, 5248.160294352904, 5156.0, 5225.477452254782, 5226.608004399647, 5260.1320782070725, 5279.762410691528, 4744.3595114659765, 4777.307290442866, 4781.880452988703, 4783.784729687172, 4805.447373552051, 6378.883695353295, 6432.678366081724, 6463.547551671385, 6505.544611877171, 6541.28045914949, 6181.690915454209, 6205.114621700885, 6210.0, 6245.687715614246, 6252.124702541602, 6826.214985276707, 6872.828179295558, 6924.065251191126, 6970.4075153612, 6993.335633114846, 5149.510796474329, 5315.681059136426, 5354.0, 5366.758495867695, 5405.270288511079, 6948.756793512202, 7095.7161713531395, 7255.45584081196, 7268.345848873574, 7278.199398066208, 5427.972860135753, 5449.746558291615, 5469.5232287282215, 5487.75305111271, 5505.146702261156, 5477.959187754314, 5478.397376288605, 5533.6403133796175, 5551.666899986014, 5600.0, 6150.496394398916, 6173.96913015441, 6176.505879529627, 6182.196314479089, 6196.3803619638575, 7002.229754726976, 7014.824629384306, 7043.471739619549, 7056.294370563005, 7071.469639777038, 1897.9715304270446, 1910.1117980139302, 1923.2210954563425, 1923.6056608395245, 1923.7210604462275, 1301.4989229146656, 1342.2550484481208, 1342.3623778705037, 1358.592422273314, 1375.4498200719593, 6404.775832845828, 6487.351264873475, 6487.513436492282, 6496.902546461807, 6596.538242322991, 6999.510034297652, 7014.824629384204, 7038.436925045984, 7050.294970502909, 7092.893606595905, 6507.186601674791, 6522.315156908551, 6537.182852143482, 6595.88931541902, 6602.108715323466, 3662.102784817737, 3682.2819550187455, 3738.831752571141, 3745.9063523412133, 3762.3792074307435, 7046.0, 7228.891566626505, 7285.4171666266575, 7393.963030184815, 7406.407487400995, 7126.180489243699, 7148.714051437988, 7159.284071592799, 7220.530665506725, 7224.277572242734, 7224.963875180591, 7296.854062918605, 7399.593022383929, 7408.925910740932, 7454.142773580999, 7050.471214659024, 7108.07595012645, 7127.643617819192, 7134.179569349383, 7134.536255143399, 6999.1950925644205, 7020.5787652741, 7045.506814523139, 7062.646867656699, 7150.856982860209, 7291.708331666886, 7359.227281135403, 7381.889271660822, 7391.445641576795, 7392.963035185005, 5511.338639363142, 5512.6968016757855, 5516.9448305516435, 5531.7234138293725, 5539.695316757617, 6738.494612903954, 6995.510314277952, 7107.0, 7173.892391614234, 7181.497295189287, 6359.618422894456, 6736.124303840666, 6786.830329241611, 6880.552764070319, 6886.898096304567, 6718.630475323904, 6818.556793808387, 6853.0252453577805, 6870.896936546056, 6907.89638155418, 6729.596224226562, 6778.491613129134, 6807.965960170168, 6855.314468553105, 6871.804610855976, 6892.793216203522, 6957.860842783217, 6961.2342642308295, 6975.267596902252, 7019.6490175492045, 6381.234251889803, 6607.9669601651685, 6721.924492081439, 6741.393274605113, 6761.357671021246], "value": 5441.864778096611, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [957.2533423929337, 981.8625392445059, 982.6658935961772, 1007.415698894641, 1041.48967006167, 18117.818821811794, 18901.149448274828, 18913.432597022093, 18921.24315027397, 18940.526486837836, 17108.97346159231, 17320.913395433006, 17474.03892785896, 17612.735808962876, 17826.465206043806, 1053.6470282455386, 1069.5775168808316, 1069.6042464288205, 1069.6309773128257, 1070.2829104499965, 1027.5376080763685, 1066.3175567636679, 1067.5943141606217, 1096.528492748118, 1097.248384856372, 1155.0, 1156.2137746332492, 1159.6694941941548, 1160.1936654025455, 1161.628278950736, 1144.719543711796, 1145.2155273637543, 1146.340854008948, 1152.1992215410335, 1156.0751398880905, 856.2037305306063, 857.4983634573782, 857.8370109679141, 858.7938894665298, 860.42781550269, 18234.817651823578, 18297.268109275614, 18304.359347422775, 18337.08314584279, 18956.336528221447, 22667.433314167112, 22716.88641556798, 23291.650625240636, 23305.0, 23314.883425582764, 15328.463503777426, 15357.6160595986, 15408.306626201736, 15483.303251353716, 15509.302081406364, 4063.2279866825506, 4073.368627862686, 4085.428040074392, 4116.135611521584, 4126.360414135814, 170409.2959070406, 171773.14113429352, 174052.0, 175061.0, 175519.0, 17530.29878804859, 17747.378841740476, 17786.199621017084, 17793.199306031, 17799.288028478717, 34541.481877771854, 35427.29145417077, 35515.82242088773, 35639.64360356415, 35881.641183588355, 9603.279754018336, 9742.171915387271, 9948.154406875352, 9972.950135249423, 10056.849147262797, 4814.398200224972, 4852.539008794159, 4886.242632391985, 4899.828506002273, 4903.730294833747, 6374.330695276929, 6384.265809431975, 6464.288928217892, 6475.643839588868, 6483.967580162069, 1167.5913430299327, 1169.4620474581618, 1188.3285943442102, 1194.808830587102, 1195.8804119587971, 737.1854101218076, 737.7381029734368, 752.1125072414603, 755.0976582983392, 767.3400875247282, 12739.490420383267, 13041.152325098838, 13610.659733506742, 14299.634713692398, 14385.6403589909, 730.521508411991, 735.860186564551, 737.0344848248811, 739.6523633892062, 753.0398741604498, 6222.0, 6248.656323902138, 6336.873262534724, 6359.077933699587, 6492.480601551864, 153363.16592085286, 153483.0, 153925.0, 156503.0, 157037.0, 131771.0, 132369.33815331056, 132424.0, 133270.0, 136505.0, 117352.0, 118286.0, 118333.4083329595, 118671.0, 118721.0, 12201.389930503261, 12393.938030309791, 12401.379931003234, 12424.378781061092, 12720.872791272339, 56029.0, 56433.0, 56857.71571142283, 57441.0, 57827.4217257822, 71904.28095719185, 73342.26657733355, 73531.0, 74885.0, 75964.62017689877, 16592.585185370463, 16732.0, 16763.245653945356, 16894.49316520506, 16980.150992450082, 18055.548611284823, 18386.632267354846, 18493.260269589067, 18706.532336691147, 18710.812891870908, 16630.916845415697, 16821.495355139366, 16895.577610559343, 16965.0, 17000.0, 16511.587210319838, 16622.916885415496, 16624.251908663897, 16657.3337066516, 16731.0, 16927.15364231808, 17010.0, 17213.22540485706, 17227.827721722624, 17344.046077465355, 12309.50761969547, 12362.81455778182, 12437.191582547106, 12775.552855650008, 12874.034447416294, 14077.225752583707, 14113.2237726926, 14119.929400352932, 14138.858611414165, 14153.43386264538], "value": 9915.696332155298, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1358.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 105.0, 104.0, 106.0, 104.0, 104.0, 96.0, 107.0, 106.0, 105.0], "value": 104.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 112.0, 114.0, 111.0, 110.0, 138.0, 117.0, 112.0, 117.0], "value": 115.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 161.0, 163.0, 162.0, 164.0, 161.0, 162.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 74.0, 72.0, 72.0, 74.0, 74.0, 71.0, 73.0, 74.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 77.0, 78.0, 78.0, 78.0, 78.0, 77.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 110.0, 113.0, 111.0, 115.0, 114.0, 115.0, 114.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 150.0, 148.0, 150.0, 148.0, 147.0, 149.0, 150.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 99.0, 93.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 54.0, 45.0, 47.0, 46.0, 45.0, 45.0, 48.0, 47.0, 43.0], "value": 46.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 39.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 39.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 68.0, 69.0, 70.0, 70.0, 69.0, 72.0, 71.0, 69.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 102.0, 106.0, 108.0, 106.0, 101.0, 102.0, 109.0, 108.0, 104.0], "value": 105.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 147.0, 151.0, 147.0, 146.0, 155.0, 148.0, 159.0, 147.0, 154.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 57.0, 58.0, 65.0, 58.0, 60.0, 61.0, 58.0, 58.0, 57.0], "value": 59.3, "unit": "score"}]}]} 14:11:23 INFO - Return code: 0 14:11:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:11:24 INFO - # TBPL SUCCESS # 14:11:24 INFO - Running post-action listener: _package_coverage_data 14:11:24 INFO - Running post-action listener: _resource_record_post_action 14:11:24 INFO - [mozharness: 2017-09-27 21:11:24.054155Z] Finished run-tests step (success) 14:11:24 INFO - Running post-run listener: _resource_record_post_run 14:11:24 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 281018368; Read time: 16; Write time: 122936 14:11:24 INFO - TinderboxPrint: CPU usage
13.0% 14:11:24 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 14:11:24 INFO - TinderboxPrint: I/O write bytes / time
281,018,368 / 122,936 14:11:24 INFO - TinderboxPrint: CPU idle
8,180.4 (86.9%) 14:11:24 INFO - TinderboxPrint: CPU user
1,180.0 (12.5%) 14:11:24 INFO - TinderboxPrint: Swap in / out
0 / 0 14:11:24 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9453568; Read time: 0; Write time: 816 14:11:24 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:11:24 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 8192; Write bytes: 270950400; Read time: 16; Write time: 121448 14:11:24 INFO - Running post-run listener: _upload_blobber_files 14:11:24 INFO - Blob upload gear active. 14:11:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:11:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:11:25 INFO - (blobuploader) - INFO - Open directory for files ... 14:11:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:11:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:11:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:25 INFO - (blobuploader) - INFO - Done attempting. 14:11:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:11:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:11:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:26 INFO - (blobuploader) - INFO - Done attempting. 14:11:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:11:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:11:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:30 INFO - (blobuploader) - INFO - Done attempting. 14:11:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:11:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:11:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:31 INFO - (blobuploader) - INFO - Done attempting. 14:11:31 INFO - (blobuploader) - INFO - Iteration through files over. 14:11:31 INFO - Return code: 0 14:11:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:11:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:11:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/49eb53fd8da2e6c3a5b99215eb907ae6fa7557f7742e84422339f11452ef4a7b75a24225cb1eab95bdbff5b2ea627c6d05d81ebf056fad0a544a8d210959b5fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/dff8cb7b35cf87d64523ad4c4d1a917c12f1091c5db99f7846cfe48ccbee858f7c9027fbf2ef73562c5cb98f1294df4780ffbcce49fcc88ddb8766ecfcb82031", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/64d9b8bffe4745d78a285c1c2440254934f87e6e4f90cd415dc62d1238903a14879889fd9499d1a534e6d416d69696df93caafd8a67c3c832e272ce0071c823d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4f6c1742ad8fc1fde224bbc5092f781a501c1c0aff11fab2641ecbbf88b08661638db80bfbae8db6d12266db8f1b5c6d02e07a91a5b47b4c8e39251902bf5b97"} 14:11:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:11:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:11:31 INFO - Contents: 14:11:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/49eb53fd8da2e6c3a5b99215eb907ae6fa7557f7742e84422339f11452ef4a7b75a24225cb1eab95bdbff5b2ea627c6d05d81ebf056fad0a544a8d210959b5fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/dff8cb7b35cf87d64523ad4c4d1a917c12f1091c5db99f7846cfe48ccbee858f7c9027fbf2ef73562c5cb98f1294df4780ffbcce49fcc88ddb8766ecfcb82031", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/64d9b8bffe4745d78a285c1c2440254934f87e6e4f90cd415dc62d1238903a14879889fd9499d1a534e6d416d69696df93caafd8a67c3c832e272ce0071c823d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4f6c1742ad8fc1fde224bbc5092f781a501c1c0aff11fab2641ecbbf88b08661638db80bfbae8db6d12266db8f1b5c6d02e07a91a5b47b4c8e39251902bf5b97"} 14:11:31 INFO - Running post-run listener: copy_logs_to_upload_dir 14:11:31 INFO - Copying logs to upload dir... 14:11:31 INFO - mkdir: /builds/slave/test/build/upload/logs 14:11:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.825351 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2017-09-27 14:11:31.500443) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 14:11:31.503912) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/49eb53fd8da2e6c3a5b99215eb907ae6fa7557f7742e84422339f11452ef4a7b75a24225cb1eab95bdbff5b2ea627c6d05d81ebf056fad0a544a8d210959b5fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/dff8cb7b35cf87d64523ad4c4d1a917c12f1091c5db99f7846cfe48ccbee858f7c9027fbf2ef73562c5cb98f1294df4780ffbcce49fcc88ddb8766ecfcb82031", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/64d9b8bffe4745d78a285c1c2440254934f87e6e4f90cd415dc62d1238903a14879889fd9499d1a534e6d416d69696df93caafd8a67c3c832e272ce0071c823d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4f6c1742ad8fc1fde224bbc5092f781a501c1c0aff11fab2641ecbbf88b08661638db80bfbae8db6d12266db8f1b5c6d02e07a91a5b47b4c8e39251902bf5b97"} build_url:https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011424 build_url: 'https://queue.taskcluster.net/v1/task/V_hU81KiSRakMPfJ2NKjqg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/49eb53fd8da2e6c3a5b99215eb907ae6fa7557f7742e84422339f11452ef4a7b75a24225cb1eab95bdbff5b2ea627c6d05d81ebf056fad0a544a8d210959b5fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/dff8cb7b35cf87d64523ad4c4d1a917c12f1091c5db99f7846cfe48ccbee858f7c9027fbf2ef73562c5cb98f1294df4780ffbcce49fcc88ddb8766ecfcb82031", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/64d9b8bffe4745d78a285c1c2440254934f87e6e4f90cd415dc62d1238903a14879889fd9499d1a534e6d416d69696df93caafd8a67c3c832e272ce0071c823d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4f6c1742ad8fc1fde224bbc5092f781a501c1c0aff11fab2641ecbbf88b08661638db80bfbae8db6d12266db8f1b5c6d02e07a91a5b47b4c8e39251902bf5b97"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 14:11:31.532846) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 14:11:31.533169) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1506545460.358333-392058430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 14:11:31.617501) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 14:11:31.617835) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 14:11:31.618184) ========= ========= Total master_lag: 0.20 =========