builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-050 starttime: 1508240221.82 results: success (0) revision: ffe120cce31ac18d8cb8bd30ddd194ed766a4a48 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-17 04:37:01.819926) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-17 04:37:01.820363) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-17 04:37:01.820633) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-17 04:37:01.839215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-17 04:37:01.839481) ========= 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=ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-17 04:37: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% 45.8M=0s 2017-10-17 04:37:01 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130665 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-17 04:37:01.987928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-17 04:37:01.988236) ========= 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=ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021641 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-17 04:37:02.041332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-17 04:37:02.041661) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ffe120cce31ac18d8cb8bd30ddd194ed766a4a48 --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 ffe120cce31ac18d8cb8bd30ddd194ed766a4a48 --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=ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-17 04:37:02,088 truncating revision to first 12 chars 2017-10-17 04:37:02,088 Setting DEBUG logging. 2017-10-17 04:37:02,088 attempt 1/10 2017-10-17 04:37:02,088 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ffe120cce31a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-17 04:37:02,460 unpacking tar archive at: mozilla-beta-ffe120cce31a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.717318 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-17 04:37:02.782404) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-17 04:37:02.782703) ========= script_repo_revision: ffe120cce31ac18d8cb8bd30ddd194ed766a4a48 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-17 04:37:02.783068) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-17 04:37:02.783338) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-17 04:37:02.800734) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-10-17 04:37:02.801008) ========= /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=ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:37:02 INFO - MultiFileLogger online at 20171017 04:37:02 in /builds/slave/test 04:37: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 04:37:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:37:02 INFO - {'append_to_log': False, 04:37:02 INFO - 'base_work_dir': '/builds/slave/test', 04:37:02 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 04:37:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:37:02 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 04:37:02 INFO - 'buildbot_json_path': 'buildprops.json', 04:37:02 INFO - 'code_coverage': False, 04:37:02 INFO - 'config_files': ('talos/linux_config.py',), 04:37:02 INFO - 'default_actions': ('clobber', 04:37:02 INFO - 'read-buildbot-config', 04:37:02 INFO - 'download-and-extract', 04:37:02 INFO - 'populate-webroot', 04:37:02 INFO - 'create-virtualenv', 04:37:02 INFO - 'install', 04:37:02 INFO - 'setup-mitmproxy', 04:37:02 INFO - 'run-tests'), 04:37:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:37:02 INFO - 'disable_ccov_upload': False, 04:37:02 INFO - 'disable_stylo': False, 04:37:02 INFO - 'download_minidump_stackwalk': True, 04:37:02 INFO - 'download_symbols': 'ondemand', 04:37:02 INFO - 'enable_stylo': False, 04:37:02 INFO - 'enable_webrender': False, 04:37:02 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:37:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:37:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:37:02 INFO - 'gecko_profile': False, 04:37:02 INFO - 'gecko_profile_interval': 0, 04:37:02 INFO - 'installer_path': 'installer.exe', 04:37:02 INFO - 'log_level': 'info', 04:37:02 INFO - 'log_name': 'talos', 04:37:02 INFO - 'log_to_console': True, 04:37:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:37:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:37:02 INFO - 'opt_config_files': (), 04:37:02 INFO - 'pip_index': False, 04:37:02 INFO - 'suite': 'dromaeojs-e10s', 04:37:02 INFO - 'system_bits': '32', 04:37:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:37:02 INFO - 'title': 'talos-linux64-ix-050', 04:37:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:37:02 INFO - 'use_talos_json': True, 04:37:02 INFO - 'verify': 'False', 04:37:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:37:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:37:02 INFO - 'work_dir': 'build'} 04:37:02 INFO - [mozharness: 2017-10-17 11:37:02.990137Z] Running clobber step. 04:37:02 INFO - Running pre-action listener: _resource_record_pre_action 04:37:02 INFO - Running main action method: clobber 04:37:02 INFO - rmtree: /builds/slave/test/build 04:37:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:37:04 INFO - Running post-action listener: _resource_record_post_action 04:37:04 INFO - [mozharness: 2017-10-17 11:37:04.075193Z] Finished clobber step (success) 04:37:04 INFO - [mozharness: 2017-10-17 11:37:04.075290Z] Running read-buildbot-config step. 04:37:04 INFO - Running pre-action listener: _resource_record_pre_action 04:37:04 INFO - Running main action method: read_buildbot_config 04:37:04 INFO - Using buildbot properties: 04:37:04 INFO - { 04:37:04 INFO - "project": "", 04:37:04 INFO - "product": "firefox", 04:37:04 INFO - "who": "ffxbld@noreply.mozilla.org", 04:37:04 INFO - "installer_path": "public/build/target.tar.bz2", 04:37:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 04:37:04 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 04:37:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 04:37:04 INFO - "stage_platform": "linux64", 04:37:04 INFO - "basedir": "/builds/slave/test", 04:37:04 INFO - "buildnumber": 165, 04:37:04 INFO - "platform": "ubuntu64_hw", 04:37:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:37:04 INFO - "slavebuilddir": "test", 04:37:04 INFO - "taskId": "a-rHU2VOSBebBr0URtzE0A", 04:37:04 INFO - "branch": "mozilla-beta", 04:37:04 INFO - "script_repo_revision": "production", 04:37:04 INFO - "revision": "ffe120cce31ac18d8cb8bd30ddd194ed766a4a48", 04:37:04 INFO - "slavename": "talos-linux64-ix-050", 04:37:04 INFO - "repo_path": "releases/mozilla-beta" 04:37:04 INFO - } 04:37:04 INFO - Finding installer, test and symbols from parent task. 04:37:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a-rHU2VOSBebBr0URtzE0A'}, attempt #1 04:37:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a-rHU2VOSBebBr0URtzE0A'}, attempt #1 04:37:04 INFO - Task dependencies: eyFwn2NRSNiePaal5ihiTw 04:37:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw'}, attempt #1 04:37:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.tar.bz2 04:37:05 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.test_packages.json 04:37:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.crashreporter-symbols.zip 04:37:05 INFO - Running post-action listener: _resource_record_post_action 04:37:05 INFO - [mozharness: 2017-10-17 11:37:05.437978Z] Finished read-buildbot-config step (success) 04:37:05 INFO - [mozharness: 2017-10-17 11:37:05.438196Z] Running download-and-extract step. 04:37:05 INFO - Running pre-action listener: _resource_record_pre_action 04:37:05 INFO - Running main action method: download_and_extract 04:37:05 INFO - mkdir: /builds/slave/test/build/tests 04:37: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')]} 04:37:05 INFO - trying https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.test_packages.json 04:37:05 INFO - Downloading https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:37:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:37:06 INFO - Downloaded 989 bytes. 04:37:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:37:06 INFO - Using the following test package requirements: 04:37:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:37:06 INFO - u'common': [u'target.common.tests.zip'], 04:37:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:37:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:37:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:37:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:37:06 INFO - u'mozbase': [u'target.common.tests.zip'], 04:37:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:37:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:37:06 INFO - u'web-platform': [u'target.common.tests.zip', 04:37:06 INFO - u'target.web-platform.tests.tar.gz'], 04:37:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:37:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:37:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.common.tests.zip 04:37:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:37:06 INFO - Fetch https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.common.tests.zip into memory 04:37:13 INFO - Content-Length response header: 55179484 04:37:13 INFO - Bytes received: 55179484 04:37:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.talos.tests.zip 04:37:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:37:24 INFO - Fetch https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.talos.tests.zip into memory 04:37:26 INFO - Content-Length response header: 14509251 04:37:26 INFO - Bytes received: 14509251 04:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:27 INFO - trying https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.tar.bz2 04:37:27 INFO - Downloading https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:37:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:37:35 INFO - Downloaded 53561012 bytes. 04:37:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.tar.bz2 04:37:35 INFO - mkdir: /builds/slave/test/properties 04:37:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:37:35 INFO - Writing to file /builds/slave/test/properties/build_url 04:37:35 INFO - Contents: 04:37:35 INFO - build_url:https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.tar.bz2 04:37:35 INFO - Running post-action listener: _resource_record_post_action 04:37:35 INFO - Running post-action listener: find_tests_for_verification 04:37:35 INFO - Running post-action listener: set_extra_try_arguments 04:37:35 INFO - [mozharness: 2017-10-17 11:37:35.826329Z] Finished download-and-extract step (success) 04:37:35 INFO - [mozharness: 2017-10-17 11:37:35.826557Z] Running populate-webroot step. 04:37:35 INFO - Running pre-action listener: _resource_record_pre_action 04:37:35 INFO - Running main action method: populate_webroot 04:37:35 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:37:35 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:37:35 INFO - 'tests': ['tresize', 04:37:35 INFO - 'tcanvasmark']}, 04:37:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:37:35 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:37:35 INFO - 'tests': ['dromaeo_css', 04:37:35 INFO - 'kraken']}, 04:37:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:37:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:35 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:37:35 INFO - 'talos_options': ['--disable-stylo'], 04:37:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:37:35 INFO - 'tests': ['damp', 'tps']}, 04:37:35 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:37:35 INFO - 'talos_options': ['--disable-stylo'], 04:37:35 INFO - 'tests': ['damp', 'tps']}, 04:37:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:37:35 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:37:35 INFO - 'tests': ['dromaeo_dom']}, 04:37:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:37:35 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:37:35 INFO - 'tests': ['basic_compositor_video', 04:37:35 INFO - 'glvideo']}, 04:37:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:37:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:37:35 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:37:35 INFO - 'talos_options': ['--disable-stylo'], 04:37:35 INFO - 'tests': ['ts_paint_webext', 04:37:35 INFO - 'tp5o_webext']}, 04:37:35 INFO - 'other-e10s': {'tests': ['a11yr', 04:37:35 INFO - 'ts_paint', 04:37:35 INFO - 'tpaint', 04:37:35 INFO - 'sessionrestore', 04:37:35 INFO - 'sessionrestore_many_windows', 04:37:35 INFO - 'sessionrestore_no_auto_restore', 04:37:35 INFO - 'tabpaint']}, 04:37:35 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:37:35 INFO - 'tests': ['a11yr', 04:37:35 INFO - 'ts_paint', 04:37:35 INFO - 'tpaint', 04:37:35 INFO - 'sessionrestore', 04:37:35 INFO - 'sessionrestore_many_windows', 04:37:35 INFO - 'sessionrestore_no_auto_restore', 04:37:35 INFO - 'tabpaint']}, 04:37:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:37:35 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:37:35 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:37:35 INFO - 'tests': ['perf_reftest_singletons']}, 04:37:35 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:37:35 INFO - 'tests': ['bloom_basic']}, 04:37:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:37:35 INFO - 'tsvgr_opacity', 04:37:35 INFO - 'tart', 04:37:35 INFO - 'tscrollx', 04:37:35 INFO - 'tsvg_static']}, 04:37:35 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:37:35 INFO - 'tests': ['tsvgx', 04:37:35 INFO - 'tsvgr_opacity', 04:37:35 INFO - 'tart', 04:37:35 INFO - 'tscrollx', 04:37:35 INFO - 'tsvg_static']}, 04:37:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:37:35 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:37:35 INFO - 'talos_options': ['--disable-stylo'], 04:37:35 INFO - 'tests': ['tp5o']}, 04:37:35 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:37:35 INFO - 'talos_options': ['--mitmproxy', 04:37:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:37:35 INFO - '--firstNonBlankPaint'], 04:37:35 INFO - 'tests': ['tp6_google', 04:37:35 INFO - 'tp6_youtube', 04:37:35 INFO - 'tp6_amazon', 04:37:35 INFO - 'tp6_facebook']}, 04:37:35 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:37:35 INFO - 'talos_options': ['--disable-stylo', 04:37:35 INFO - '--mitmproxy', 04:37:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:37:35 INFO - '--firstNonBlankPaint'], 04:37:35 INFO - 'tests': ['tp6_google', 04:37:35 INFO - 'tp6_youtube', 04:37:35 INFO - 'tp6_amazon', 04:37:35 INFO - 'tp6_facebook']}, 04:37:35 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:37:35 INFO - 'talos_options': ['--stylo-threads=1', 04:37:35 INFO - '--mitmproxy', 04:37:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:37:35 INFO - '--firstNonBlankPaint'], 04:37:35 INFO - 'tests': ['tp6_google', 04:37:35 INFO - 'tp6_youtube', 04:37:35 INFO - 'tp6_amazon', 04:37:35 INFO - 'tp6_facebook']}, 04:37:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:37:35 INFO - 'talos_options': ['--xperf_path', 04:37:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:35 INFO - 'tests': ['tp5n']}, 04:37:35 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:37:35 INFO - 'talos_options': ['--disable-stylo', 04:37:35 INFO - '--xperf_path', 04:37:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:35 INFO - 'tests': ['tp5n']}}} 04:37:35 INFO - Running post-action listener: _resource_record_post_action 04:37:35 INFO - [mozharness: 2017-10-17 11:37:35.844622Z] Finished populate-webroot step (success) 04:37:35 INFO - [mozharness: 2017-10-17 11:37:35.844712Z] Running create-virtualenv step. 04:37:35 INFO - Running pre-action listener: _resource_record_pre_action 04:37:35 INFO - Running main action method: create_virtualenv 04:37:35 INFO - Creating virtualenv /builds/slave/test/build/venv 04:37:35 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:37:35 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:37:35 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:37:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:37:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:37:36 INFO - Installing distribute.............................................................................................................................................................................................done. 04:37:36 INFO - Installing pip...............done. 04:37:36 INFO - Return code: 0 04:37:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:37:36 INFO - Reading from file tmpfile_stdout 04:37:36 INFO - Output received: 04:37:36 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:37:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:37:36 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')]} 04:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:36 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')]} 04:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:36 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 0x16101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f090>, '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 0x197fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1979f90>, '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': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', '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 04:37:36 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 04:37:36 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 04:37:36 INFO - Using env: {'DISPLAY': ':0', 04:37:36 INFO - 'HOME': '/home/cltbld', 04:37:36 INFO - 'LANG': 'en_US.UTF-8', 04:37:36 INFO - 'LANGUAGE': 'en_US:en', 04:37:36 INFO - 'LOGNAME': 'cltbld', 04:37:36 INFO - 'MAIL': '/var/mail/cltbld', 04:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:36 INFO - 'MOZ_NO_REMOTE': '1', 04:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:36 INFO - 'NO_EM_RESTART': '1', 04:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:36 INFO - 'PWD': '/builds/slave/test', 04:37:36 INFO - 'SHELL': '/bin/bash', 04:37:36 INFO - 'SHLVL': '1', 04:37:36 INFO - 'TERM': 'linux', 04:37:36 INFO - 'TMOUT': '86400', 04:37:36 INFO - 'USER': 'cltbld', 04:37:36 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', 04:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:36 INFO - '_': '/tools/buildbot/bin/python'} 04:37:38 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:37:38 INFO - Downloading/unpacking pip>=1.5 04:37:38 INFO - Running setup.py egg_info for package pip 04:37:38 INFO - warning: no files found matching 'pip/cacert.pem' 04:37:38 INFO - warning: no files found matching '*.html' under directory 'docs' 04:37:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:37:38 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:37:38 INFO - Installing collected packages: pip 04:37:38 INFO - Found existing installation: pip 1.1 04:37:38 INFO - Uninstalling pip: 04:37:38 INFO - Successfully uninstalled pip 04:37:38 INFO - Running setup.py install for pip 04:37:38 INFO - warning: no files found matching 'pip/cacert.pem' 04:37:38 INFO - warning: no files found matching '*.html' under directory 'docs' 04:37:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:37:38 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:37:38 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:37:38 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:37:38 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:37:38 INFO - Successfully installed pip 04:37:38 INFO - Cleaning up... 04:37:38 INFO - Return code: 0 04:37:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:37:38 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')]} 04:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:38 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')]} 04:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:38 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 0x16101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f090>, '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 0x197fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1979f90>, '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': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', '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 04:37:38 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 04:37:38 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 04:37:38 INFO - Using env: {'DISPLAY': ':0', 04:37:38 INFO - 'HOME': '/home/cltbld', 04:37:38 INFO - 'LANG': 'en_US.UTF-8', 04:37:38 INFO - 'LANGUAGE': 'en_US:en', 04:37:38 INFO - 'LOGNAME': 'cltbld', 04:37:38 INFO - 'MAIL': '/var/mail/cltbld', 04:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:38 INFO - 'MOZ_NO_REMOTE': '1', 04:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:38 INFO - 'NO_EM_RESTART': '1', 04:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:38 INFO - 'PWD': '/builds/slave/test', 04:37:38 INFO - 'SHELL': '/bin/bash', 04:37:38 INFO - 'SHLVL': '1', 04:37:38 INFO - 'TERM': 'linux', 04:37:38 INFO - 'TMOUT': '86400', 04:37:38 INFO - 'USER': 'cltbld', 04:37:38 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', 04:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:38 INFO - '_': '/tools/buildbot/bin/python'} 04:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:38 INFO - Downloading/unpacking psutil>=3.1.1 04:37:38 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 04:37:38 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 04:37:38 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 04:37:38 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 04:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:37:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:39 INFO - Installing collected packages: psutil 04:37:39 INFO - Running setup.py install for psutil 04:37:39 INFO - building 'psutil._psutil_linux' extension 04:37:39 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 04:37:39 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 04:37:39 INFO - building 'psutil._psutil_posix' extension 04:37:39 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 04:37:39 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 04:37:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:39 INFO - Successfully installed psutil 04:37:39 INFO - Cleaning up... 04:37:40 INFO - Return code: 0 04:37:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:37:40 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')]} 04:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:40 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')]} 04:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:40 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 0x16101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f090>, '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 0x197fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1979f90>, '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': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', '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 04:37:40 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 04:37:40 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 04:37:40 INFO - Using env: {'DISPLAY': ':0', 04:37:40 INFO - 'HOME': '/home/cltbld', 04:37:40 INFO - 'LANG': 'en_US.UTF-8', 04:37:40 INFO - 'LANGUAGE': 'en_US:en', 04:37:40 INFO - 'LOGNAME': 'cltbld', 04:37:40 INFO - 'MAIL': '/var/mail/cltbld', 04:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:40 INFO - 'MOZ_NO_REMOTE': '1', 04:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:40 INFO - 'NO_EM_RESTART': '1', 04:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:40 INFO - 'PWD': '/builds/slave/test', 04:37:40 INFO - 'SHELL': '/bin/bash', 04:37:40 INFO - 'SHLVL': '1', 04:37:40 INFO - 'TERM': 'linux', 04:37:40 INFO - 'TMOUT': '86400', 04:37:40 INFO - 'USER': 'cltbld', 04:37:40 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', 04:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:40 INFO - '_': '/tools/buildbot/bin/python'} 04:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:37:40 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 04:37:40 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 04:37:40 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 04:37:40 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 04:37:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:37:41 INFO - Installing collected packages: mozsystemmonitor 04:37:41 INFO - Running setup.py install for mozsystemmonitor 04:37:41 INFO - Successfully installed mozsystemmonitor 04:37:41 INFO - Cleaning up... 04:37:41 INFO - Return code: 0 04:37:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37: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')]} 04:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:41 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 0x16101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f090>, '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 0x197fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1979f90>, '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': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', '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 04:37:41 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 04:37:41 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 04:37:41 INFO - Using env: {'DISPLAY': ':0', 04:37:41 INFO - 'HOME': '/home/cltbld', 04:37:41 INFO - 'LANG': 'en_US.UTF-8', 04:37:41 INFO - 'LANGUAGE': 'en_US:en', 04:37:41 INFO - 'LOGNAME': 'cltbld', 04:37:41 INFO - 'MAIL': '/var/mail/cltbld', 04:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:41 INFO - 'MOZ_NO_REMOTE': '1', 04:37:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:41 INFO - 'NO_EM_RESTART': '1', 04:37:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:41 INFO - 'PWD': '/builds/slave/test', 04:37:41 INFO - 'SHELL': '/bin/bash', 04:37:41 INFO - 'SHLVL': '1', 04:37:41 INFO - 'TERM': 'linux', 04:37:41 INFO - 'TMOUT': '86400', 04:37:41 INFO - 'USER': 'cltbld', 04:37:41 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', 04:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:41 INFO - '_': '/tools/buildbot/bin/python'} 04:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:41 INFO - Downloading/unpacking jsonschema==2.5.1 04:37: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 04:37: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 04:37: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 04:37: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 04:37:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:37:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:37:42 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 04:37:42 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 04:37:42 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 04:37:42 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 04:37:42 INFO - Downloading functools32-3.2.3-2.tar.gz 04:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:37:43 INFO - warning: no files found matching '*.txt' 04:37:43 INFO - no previously-included directories found matching 'build' 04:37:43 INFO - no previously-included directories found matching 'dist' 04:37:43 INFO - no previously-included directories found matching '.git*' 04:37:43 INFO - Installing collected packages: jsonschema, functools32 04:37:43 INFO - Running setup.py install for functools32 04:37:43 INFO - warning: no files found matching '*.txt' 04:37:43 INFO - no previously-included directories found matching 'build' 04:37:43 INFO - no previously-included directories found matching 'dist' 04:37:43 INFO - no previously-included directories found matching '.git*' 04:37:43 INFO - Successfully installed jsonschema functools32 04:37:43 INFO - Cleaning up... 04:37:43 INFO - Return code: 0 04:37:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37: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')]} 04:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37: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', '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 0x16101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f090>, '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 0x197fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1979f90>, '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': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', '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 04:37: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:37: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 functools32==3.2.3-2 04:37:43 INFO - Using env: {'DISPLAY': ':0', 04:37:43 INFO - 'HOME': '/home/cltbld', 04:37:43 INFO - 'LANG': 'en_US.UTF-8', 04:37:43 INFO - 'LANGUAGE': 'en_US:en', 04:37:43 INFO - 'LOGNAME': 'cltbld', 04:37:43 INFO - 'MAIL': '/var/mail/cltbld', 04:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:43 INFO - 'MOZ_NO_REMOTE': '1', 04:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:43 INFO - 'NO_EM_RESTART': '1', 04:37:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:43 INFO - 'PWD': '/builds/slave/test', 04:37:43 INFO - 'SHELL': '/bin/bash', 04:37:43 INFO - 'SHLVL': '1', 04:37:43 INFO - 'TERM': 'linux', 04:37:43 INFO - 'TMOUT': '86400', 04:37:43 INFO - 'USER': 'cltbld', 04:37:43 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', 04:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:43 INFO - '_': '/tools/buildbot/bin/python'} 04:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:37:43 INFO - Cleaning up... 04:37:43 INFO - Return code: 0 04:37:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37: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')]} 04:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37: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', '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 0x16101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f090>, '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 0x197fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1979f90>, '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': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', '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 04:37: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:37: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 blobuploader==1.2.4 04:37:43 INFO - Using env: {'DISPLAY': ':0', 04:37:43 INFO - 'HOME': '/home/cltbld', 04:37:43 INFO - 'LANG': 'en_US.UTF-8', 04:37:43 INFO - 'LANGUAGE': 'en_US:en', 04:37:43 INFO - 'LOGNAME': 'cltbld', 04:37:43 INFO - 'MAIL': '/var/mail/cltbld', 04:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:43 INFO - 'MOZ_NO_REMOTE': '1', 04:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:43 INFO - 'NO_EM_RESTART': '1', 04:37:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:43 INFO - 'PWD': '/builds/slave/test', 04:37:43 INFO - 'SHELL': '/bin/bash', 04:37:43 INFO - 'SHLVL': '1', 04:37:43 INFO - 'TERM': 'linux', 04:37:43 INFO - 'TMOUT': '86400', 04:37:43 INFO - 'USER': 'cltbld', 04:37:43 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', 04:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:43 INFO - '_': '/tools/buildbot/bin/python'} 04:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:43 INFO - Downloading/unpacking blobuploader==1.2.4 04:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:44 INFO - Downloading blobuploader-1.2.4.tar.gz 04:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:37:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:37:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:45 INFO - Downloading docopt-0.6.1.tar.gz 04:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:37:45 INFO - Installing collected packages: blobuploader, requests, docopt 04:37:45 INFO - Running setup.py install for blobuploader 04:37:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:37:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:37:45 INFO - Running setup.py install for requests 04:37:45 INFO - Running setup.py install for docopt 04:37:45 INFO - Successfully installed blobuploader requests docopt 04:37:45 INFO - Cleaning up... 04:37:45 INFO - Return code: 0 04:37:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:45 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')]} 04:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:45 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')]} 04:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:45 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 0x16101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f090>, '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 0x197fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1979f90>, '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': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', '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 04:37:45 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 04:37:45 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 04:37:45 INFO - Using env: {'DISPLAY': ':0', 04:37:45 INFO - 'HOME': '/home/cltbld', 04:37:45 INFO - 'LANG': 'en_US.UTF-8', 04:37:45 INFO - 'LANGUAGE': 'en_US:en', 04:37:45 INFO - 'LOGNAME': 'cltbld', 04:37:45 INFO - 'MAIL': '/var/mail/cltbld', 04:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:45 INFO - 'MOZ_NO_REMOTE': '1', 04:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:45 INFO - 'NO_EM_RESTART': '1', 04:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:45 INFO - 'PWD': '/builds/slave/test', 04:37:45 INFO - 'SHELL': '/bin/bash', 04:37:45 INFO - 'SHLVL': '1', 04:37:45 INFO - 'TERM': 'linux', 04:37:45 INFO - 'TMOUT': '86400', 04:37:45 INFO - 'USER': 'cltbld', 04:37:45 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', 04:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:45 INFO - '_': '/tools/buildbot/bin/python'} 04:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:46 INFO - Running setup.py (path:/tmp/pip-gonkMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:46 INFO - Running setup.py (path:/tmp/pip-XB7kHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:46 INFO - Running setup.py (path:/tmp/pip-EvkoVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:46 INFO - Running setup.py (path:/tmp/pip-Q2XLT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:46 INFO - Running setup.py (path:/tmp/pip-UUb9Wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:46 INFO - Running setup.py (path:/tmp/pip-s2vbLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:46 INFO - Running setup.py (path:/tmp/pip-LCIsix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:46 INFO - Running setup.py (path:/tmp/pip-NGFlbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:46 INFO - Running setup.py (path:/tmp/pip-t3MZxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:46 INFO - Running setup.py (path:/tmp/pip-8aAPRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:46 INFO - Running setup.py (path:/tmp/pip-eFXDjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:46 INFO - Running setup.py (path:/tmp/pip-rn55JV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:47 INFO - Running setup.py (path:/tmp/pip-DMstxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:47 INFO - Running setup.py (path:/tmp/pip-0X3Jbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:47 INFO - Running setup.py (path:/tmp/pip-EPPT5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:47 INFO - Running setup.py (path:/tmp/pip-oAEJC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:47 INFO - Running setup.py (path:/tmp/pip-EWfpUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:37:47 INFO - Running setup.py install for manifestparser 04:37:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:37:47 INFO - Running setup.py install for mozcrash 04:37:47 INFO - Running setup.py install for mozdebug 04:37:47 INFO - Running setup.py install for mozdevice 04:37:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:37:47 INFO - Running setup.py install for mozfile 04:37:47 INFO - Running setup.py install for mozhttpd 04:37:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:37:47 INFO - Running setup.py install for mozinfo 04:37:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:37:48 INFO - Running setup.py install for mozInstall 04:37:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:37:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:37:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:37:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:37:48 INFO - Running setup.py install for mozleak 04:37:48 INFO - Running setup.py install for mozlog 04:37:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:37:48 INFO - Running setup.py install for moznetwork 04:37:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:37:48 INFO - Running setup.py install for mozprocess 04:37:48 INFO - Running setup.py install for mozprofile 04:37:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:37:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:37:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:37:48 INFO - Running setup.py install for mozrunner 04:37:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:37:48 INFO - Running setup.py install for mozscreenshot 04:37:48 INFO - Running setup.py install for moztest 04:37:49 INFO - Running setup.py install for mozversion 04:37:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:37:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:37:49 INFO - Cleaning up... 04:37:49 INFO - Return code: 0 04:37:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:49 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 0x16101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f090>, '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 0x197fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1979f90>, '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': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', '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 04:37:49 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 04:37:49 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 04:37:49 INFO - Using env: {'DISPLAY': ':0', 04:37:49 INFO - 'HOME': '/home/cltbld', 04:37:49 INFO - 'LANG': 'en_US.UTF-8', 04:37:49 INFO - 'LANGUAGE': 'en_US:en', 04:37:49 INFO - 'LOGNAME': 'cltbld', 04:37:49 INFO - 'MAIL': '/var/mail/cltbld', 04:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:49 INFO - 'MOZ_NO_REMOTE': '1', 04:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:49 INFO - 'NO_EM_RESTART': '1', 04:37:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:49 INFO - 'PWD': '/builds/slave/test', 04:37:49 INFO - 'SHELL': '/bin/bash', 04:37:49 INFO - 'SHLVL': '1', 04:37:49 INFO - 'TERM': 'linux', 04:37:49 INFO - 'TMOUT': '86400', 04:37:49 INFO - 'USER': 'cltbld', 04:37:49 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', 04:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:49 INFO - '_': '/tools/buildbot/bin/python'} 04:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:49 INFO - Running setup.py (path:/tmp/pip-Fm5sZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:49 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)) 04:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:49 INFO - Running setup.py (path:/tmp/pip-WpUMeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:49 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)) 04:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:49 INFO - Running setup.py (path:/tmp/pip-2QZT0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:49 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)) 04:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:49 INFO - Running setup.py (path:/tmp/pip-tbLyT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:49 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)) 04:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:49 INFO - Running setup.py (path:/tmp/pip-YgvgmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:49 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)) 04:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:49 INFO - Running setup.py (path:/tmp/pip-ddw1ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:49 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)) 04:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:49 INFO - Running setup.py (path:/tmp/pip-PoK_u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:49 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)) 04:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:49 INFO - Running setup.py (path:/tmp/pip-R5LiMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:49 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)) 04:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:49 INFO - Running setup.py (path:/tmp/pip-SG81SN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:49 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)) 04:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:49 INFO - Running setup.py (path:/tmp/pip-4w5xYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:50 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)) 04:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:50 INFO - Running setup.py (path:/tmp/pip-rZwipB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:50 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)) 04:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:50 INFO - Running setup.py (path:/tmp/pip-VqYeG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:50 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)) 04:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:50 INFO - Running setup.py (path:/tmp/pip-6oMciH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:50 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)) 04:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:50 INFO - Running setup.py (path:/tmp/pip-eNGJhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:50 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)) 04:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:50 INFO - Running setup.py (path:/tmp/pip-c7p3IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:50 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)) 04:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:50 INFO - Running setup.py (path:/tmp/pip-iinoBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:50 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)) 04:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:50 INFO - Running setup.py (path:/tmp/pip-RUm8_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:50 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)) 04:37:50 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)) 04:37:50 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)) 04:37:50 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)) 04:37:50 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)) 04:37:50 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)) 04:37:50 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)) 04:37:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:37:50 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 04:37:50 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 04:37:50 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 04:37:50 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 04:37:51 INFO - Downloading blessings-1.6.tar.gz 04:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:37:51 INFO - Installing collected packages: blessings 04:37:51 INFO - Running setup.py install for blessings 04:37:51 INFO - Successfully installed blessings 04:37:51 INFO - Cleaning up... 04:37:51 INFO - Return code: 0 04:37:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:37:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:52 INFO - Reading from file tmpfile_stdout 04:37:52 INFO - Current package versions: 04:37:52 INFO - argparse == 1.2.1 04:37:52 INFO - blessings == 1.6 04:37:52 INFO - blobuploader == 1.2.4 04:37:52 INFO - docopt == 0.6.1 04:37:52 INFO - functools32 == 3.2.3-2 04:37:52 INFO - jsonschema == 2.5.1 04:37:52 INFO - manifestparser == 1.1 04:37:52 INFO - mozInstall == 1.13 04:37:52 INFO - mozcrash == 1.0 04:37:52 INFO - mozdebug == 0.1 04:37:52 INFO - mozdevice == 0.51 04:37:52 INFO - mozfile == 1.2 04:37:52 INFO - mozhttpd == 0.7 04:37:52 INFO - mozinfo == 0.10 04:37:52 INFO - mozleak == 0.1 04:37:52 INFO - mozlog == 3.5 04:37:52 INFO - moznetwork == 0.27 04:37:52 INFO - mozprocess == 0.25 04:37:52 INFO - mozprofile == 0.28 04:37:52 INFO - mozrunner == 6.13 04:37:52 INFO - mozscreenshot == 0.1 04:37:52 INFO - mozsystemmonitor == 0.3 04:37:52 INFO - moztest == 0.8 04:37:52 INFO - mozversion == 1.4 04:37:52 INFO - psutil == 3.1.1 04:37:52 INFO - requests == 1.2.3 04:37:52 INFO - wsgiref == 0.1.2 04:37:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:52 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 0x16101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f090>, '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 0x197fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1979f90>, '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': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', '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 04:37:52 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 04:37:52 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 04:37:52 INFO - Using env: {'DISPLAY': ':0', 04:37:52 INFO - 'HOME': '/home/cltbld', 04:37:52 INFO - 'LANG': 'en_US.UTF-8', 04:37:52 INFO - 'LANGUAGE': 'en_US:en', 04:37:52 INFO - 'LOGNAME': 'cltbld', 04:37:52 INFO - 'MAIL': '/var/mail/cltbld', 04:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:52 INFO - 'MOZ_NO_REMOTE': '1', 04:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:52 INFO - 'NO_EM_RESTART': '1', 04:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:52 INFO - 'PWD': '/builds/slave/test', 04:37:52 INFO - 'SHELL': '/bin/bash', 04:37:52 INFO - 'SHLVL': '1', 04:37:52 INFO - 'TERM': 'linux', 04:37:52 INFO - 'TMOUT': '86400', 04:37:52 INFO - 'USER': 'cltbld', 04:37:52 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', 04:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:52 INFO - '_': '/tools/buildbot/bin/python'} 04:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:52 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)) 04:37:52 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)) 04:37:52 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)) 04:37:52 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)) 04:37:52 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)) 04:37:52 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)) 04:37:52 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)) 04:37:52 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)) 04:37:52 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)) 04:37:52 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:37:52 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 04:37:52 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 04:37:52 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 04:37:52 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 04:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:37:53 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)) 04:37:53 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)) 04:37:53 INFO - Installing collected packages: simplejson 04:37:53 INFO - Running setup.py install for simplejson 04:37:53 INFO - building 'simplejson._speedups' extension 04:37:53 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 04:37:54 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 04:37:54 INFO - Successfully installed simplejson 04:37:54 INFO - Cleaning up... 04:37:54 INFO - Return code: 0 04:37:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197f090>, '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 0x197fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1979f90>, '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': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', '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 04:37:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:37:54 INFO - Using env: {'DISPLAY': ':0', 04:37:54 INFO - 'HOME': '/home/cltbld', 04:37:54 INFO - 'LANG': 'en_US.UTF-8', 04:37:54 INFO - 'LANGUAGE': 'en_US:en', 04:37:54 INFO - 'LOGNAME': 'cltbld', 04:37:54 INFO - 'MAIL': '/var/mail/cltbld', 04:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:54 INFO - 'MOZ_NO_REMOTE': '1', 04:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:54 INFO - 'NO_EM_RESTART': '1', 04:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:54 INFO - 'PWD': '/builds/slave/test', 04:37:54 INFO - 'SHELL': '/bin/bash', 04:37:54 INFO - 'SHLVL': '1', 04:37:54 INFO - 'TERM': 'linux', 04:37:54 INFO - 'TMOUT': '86400', 04:37:54 INFO - 'USER': 'cltbld', 04:37:54 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', 04:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:54 INFO - '_': '/tools/buildbot/bin/python'} 04:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:37:54 INFO - Cleaning up... 04:37:54 INFO - Return code: 0 04:37:54 INFO - Running post-action listener: _resource_record_post_action 04:37:54 INFO - Running post-action listener: _start_resource_monitoring 04:37:54 INFO - Starting resource monitoring. 04:37:54 INFO - [mozharness: 2017-10-17 11:37:54.844437Z] Finished create-virtualenv step (success) 04:37:54 INFO - [mozharness: 2017-10-17 11:37:54.844955Z] Running install step. 04:37:54 INFO - Running pre-action listener: _resource_record_pre_action 04:37:54 INFO - Running main action method: install 04:37:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:55 INFO - Reading from file tmpfile_stdout 04:37:55 INFO - Detecting whether we're running mozinstall >=1.0... 04:37:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:37:55 INFO - Reading from file tmpfile_stdout 04:37:55 INFO - Output received: 04:37:55 INFO - Usage: mozinstall [options] installer 04:37:55 INFO - Options: 04:37:55 INFO - -h, --help show this help message and exit 04:37:55 INFO - -d DEST, --destination=DEST 04:37:55 INFO - Directory to install application into. [default: 04:37:55 INFO - "/builds/slave/test"] 04:37:55 INFO - --app=APP Application being installed. [default: firefox] 04:37:55 INFO - mkdir: /builds/slave/test/build/application 04:37:55 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'] 04:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:38:09 INFO - Reading from file tmpfile_stdout 04:38:09 INFO - Output received: 04:38:09 INFO - /builds/slave/test/build/application/firefox/firefox 04:38:09 INFO - Running post-action listener: _resource_record_post_action 04:38:09 INFO - [mozharness: 2017-10-17 11:38:09.801299Z] Finished install step (success) 04:38:09 INFO - [mozharness: 2017-10-17 11:38:09.801635Z] Running setup-mitmproxy step. 04:38:09 INFO - Running pre-action listener: _resource_record_pre_action 04:38:09 INFO - Running main action method: setup_mitmproxy 04:38:09 INFO - Skipping: mitmproxy is not required 04:38:09 INFO - Running post-action listener: _resource_record_post_action 04:38:09 INFO - [mozharness: 2017-10-17 11:38:09.803227Z] Finished setup-mitmproxy step (success) 04:38:09 INFO - [mozharness: 2017-10-17 11:38:09.803635Z] Running run-tests step. 04:38:09 INFO - Running pre-action listener: _resource_record_pre_action 04:38:09 INFO - Running pre-action listener: _set_gcov_prefix 04:38:09 INFO - Running main action method: run_tests 04:38:09 WARNING - Try message not found. 04:38:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:38:09 INFO - Python 2.7.3 04:38:09 INFO - Return code: 0 04:38:09 INFO - grabbing minidump binary from tooltool 04:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:09 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 0x197f090>, '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 0x197fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1979f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:38:09 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 04:38:09 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 04:38:09 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 04:38:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:38:09 INFO - Return code: 0 04:38:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:38:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:38:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:38:09 INFO - ENV: RUST_BACKTRACE is now full 04:38:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:38:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:38:09 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/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 04:38:09 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/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 04:38:09 INFO - Using env: {'DISPLAY': ':0', 04:38:09 INFO - 'HOME': '/home/cltbld', 04:38:09 INFO - 'LANG': 'en_US.UTF-8', 04:38:09 INFO - 'LANGUAGE': 'en_US:en', 04:38:09 INFO - 'LOGNAME': 'cltbld', 04:38:09 INFO - 'MAIL': '/var/mail/cltbld', 04:38:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:38:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:09 INFO - 'MOZ_NO_REMOTE': '1', 04:38:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:09 INFO - 'NO_EM_RESTART': '1', 04:38:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:09 INFO - 'PWD': '/builds/slave/test', 04:38:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:38:09 INFO - 'RUST_BACKTRACE': 'full', 04:38:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:38:09 INFO - 'SHELL': '/bin/bash', 04:38:09 INFO - 'SHLVL': '1', 04:38:09 INFO - 'TERM': 'linux', 04:38:09 INFO - 'TMOUT': '86400', 04:38:09 INFO - 'USER': 'cltbld', 04:38:09 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', 04:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:09 INFO - '_': '/tools/buildbot/bin/python'} 04:38:09 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/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 04:38:10 INFO - mozversion application_buildid: 20171017101139 04:38:10 INFO - mozversion application_changeset: ffe120cce31ac18d8cb8bd30ddd194ed766a4a48 04:38:10 INFO - mozversion application_display_name: Firefox 04:38:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:38:10 INFO - mozversion application_name: Firefox 04:38:10 INFO - mozversion application_remotingname: firefox 04:38:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:38:10 INFO - mozversion application_vendor: Mozilla 04:38:10 INFO - mozversion application_version: 57.0 04:38:10 INFO - mozversion platform_buildid: 20171017101139 04:38:10 INFO - mozversion platform_changeset: ffe120cce31ac18d8cb8bd30ddd194ed766a4a48 04:38:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:38:10 INFO - mozversion platform_version: 57.0 04:38:10 INFO - using testdate: 1508240290 04:38:10 INFO - actual date: 1508240290 04:38:10 INFO - starting webserver on 'localhost:42321' 04:38:10 INFO - SUITE-START | Running 2 tests 04:38:10 INFO - TEST-START | dromaeo_css 04:38:10 INFO - Initialising browser for dromaeo_css test... 04:38:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42321/getInfo.html -profile /tmp/tmpjY0Et6/profile 04:38:10 INFO - TEST-INFO | started process 9495 (/builds/slave/test/build/application/firefox/firefox http://localhost:42321/getInfo.html) 04:38:15 INFO - TEST-INFO | 9495: exit 0 04:38:15 INFO - Browser initialized. 04:38:15 INFO - Running cycle 1/1 for dromaeo_css test... 04:38:15 INFO - Using env: {'DISPLAY': ':0', 04:38:15 INFO - 'HOME': '/home/cltbld', 04:38:15 INFO - 'JSGC_DISABLE_POISONING': '1', 04:38:15 INFO - 'LANG': 'en_US.UTF-8', 04:38:15 INFO - 'LANGUAGE': 'en_US:en', 04:38:15 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:38:15 INFO - 'LOGNAME': 'cltbld', 04:38:15 INFO - 'MAIL': '/var/mail/cltbld', 04:38:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:38:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:38:15 INFO - 'MOZ_CRASHREPORTER': '1', 04:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:15 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:38:15 INFO - 'MOZ_NO_REMOTE': '1', 04:38:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:15 INFO - 'NO_EM_RESTART': '1', 04:38:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:15 INFO - 'PWD': '/builds/slave/test', 04:38:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:38:15 INFO - 'RUST_BACKTRACE': 'full', 04:38:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:38:15 INFO - 'SHELL': '/bin/bash', 04:38:15 INFO - 'SHLVL': '1', 04:38:15 INFO - 'TERM': 'linux', 04:38:15 INFO - 'TMOUT': '86400', 04:38:15 INFO - 'USER': 'cltbld', 04:38:15 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', 04:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:15 INFO - '_': '/tools/buildbot/bin/python'} 04:38:15 INFO - TEST-INFO | started process 9731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjY0Et6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:38:15 INFO - PID 9731 | 04:38:15 INFO - PID 9731 | (/builds/slave/test/build/application/firefox/firefox:9780): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:38:15 INFO - PID 9731 | 04:38:26 INFO - PID 9731 | RSS: Main: 143159296 04:38:26 INFO - PID 9731 | 04:41:23 INFO - PID 9731 | Cycle 1(1): loaded http://localhost:42321/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42321/tests/dromaeo/cssquery-ext.html) 04:41:24 INFO - PID 9731 | RSS: Main: 147046400 04:41:24 INFO - PID 9731 | 04:44:26 INFO - PID 9731 | Cycle 1(1): loaded http://localhost:42321/tests/dromaeo/cssquery-ext.html (next: http://localhost:42321/tests/dromaeo/cssquery-jquery.html) 04:44:26 INFO - PID 9731 | RSS: Main: 145076224 04:44:26 INFO - PID 9731 | 04:47:28 INFO - PID 9731 | Cycle 1(1): loaded http://localhost:42321/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42321/tests/dromaeo/cssquery-mootools.html) 04:47:29 INFO - PID 9731 | RSS: Main: 146735104 04:47:29 INFO - PID 9731 | 04:50:30 INFO - PID 9731 | Cycle 1(1): loaded http://localhost:42321/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42321/tests/dromaeo/cssquery-prototype.html) 04:50:31 INFO - PID 9731 | RSS: Main: 146432000 04:50:31 INFO - PID 9731 | 04:53:34 INFO - PID 9731 | Cycle 1(1): loaded http://localhost:42321/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42321/tests/dromaeo/cssquery-yui.html) 04:53:34 INFO - PID 9731 | RSS: Main: 145207296 04:53:34 INFO - PID 9731 | 04:56:36 INFO - PID 9731 | Cycle 1(1): loaded http://localhost:42321/tests/dromaeo/cssquery-yui.html (next: http://localhost:42321/tests/dromaeo/cssquery-dojo.html) 04:56:36 INFO - PID 9731 | RSS: Main: 150040576 04:56:36 INFO - PID 9731 | 04:56:36 INFO - PID 9731 | __start_tp_report 04:56:36 INFO - PID 9731 | _x_x_mozilla_page_load 04:56:36 INFO - PID 9731 | _x_x_mozilla_page_load_details 04:56:36 INFO - PID 9731 | |i|pagename|runs| 04:56:36 INFO - PID 9731 | |0;dojo.html;3978.244133614613;3990.56103828579;3996.2806694794926;4001.5398229203643;4017.7388469749462;6471.805845824627;6503.934960650392;6527.771527996521;6603.504737144709;6626.204855417351;6553.918603430428;6585.967070164643;6623.437007854338;6636.0377745226915;6663.333666633346;5869.618474799146;5884.735186916599;5907.6750778707155;5935.73289201987;5965.642061476304;5916.201312822778;5926.140709597106;5930.555208359368;6003.8198854034445;6048.032314829607;5989.520838332945;6048.092786082101;6053.727582258787;6065.878682426349;6072.362401947798;5870;5942.2275104236605;5977.372375900533;6051.062085376751;6078.331383547807;5844.47399734026;5875;5882.6470411775;5898.557608179361;5949.137375080589;6501.577397469149;6575.3095924927675;6589.308122647101;6597.736090556372;6633.86732265352;7115.075040244787;7131.964340178318;7194.568325900463;7212.8557428851655;7215.675294611702;7111.146662400545;7141.500094993353;7197.964010179968;7233.819154521127;7251.456140789462;6484;6604.636744979024;6608.107905432801;6613.834654133637;6651.368120028589;7244.89132663;7247.16657584374;7272.200057993617;7290.5625662460425;7364.005859208938;6958.199807022156;6959.060526828814;7032.191298000693;7113.75101871432;7115.822104447327;7100.502964792415;7156.427485801123;7221.675024623904;7248.746293879794;7280.453965952574;6971.163460384786;7060.54106483077;7077.363037326665;7097.680604372712;7112.039874616964;7010.754623588252;7056.6118863463;7108.466864985044;7111.92888071123;7120.394766444807;5262.684238945599;5264.894702105937;5295.258663787073;5324.068288049576;5330.227117068003;4804.567588917014;4828.130936431476;4848.418189817174;4864.513548645178;4865.318855360252;6530.379613936669;6579.638119903356;6608.8347791305605;6636.767713130017;6725.461963042945;7097.9645101775195;7152.749653762094;7158.391536719333;7180;7185.317394847481;6599.637019963852;6607;6621.668916554249;6699.933000670028;6701.899471507932;5930.080837470199;5947.107933809876;6004.909926351108;6016.578839481194;6050.273967123973;7273.563586184846;7388.15036270825;7404.296591823768;7450.776476705708;7473.252674732484;7119.96440017807;7129.857402852018;7144.9642751785905;7180.676869540987;7194.064771579661;7395.297446742551;7395.852082958203;7401.64503022491;7418.36943859778;7527.2849079337375;6930.618815964968;6990.9164079567745;6993.895091573732;7084.539504932163;7153.105861767279;7120.679569419285;7170.354668079898;7191.065161529177;7208.89186662211;7218.747343843151;6779.186497620317;6807.217170025312;6881.518293719391;6928.549644273106;6947.5831450113155;6831.0436538883605;6834.794956151323;6836;6837;6846.383825455733;6767.154105736783;6777.085093512313;6778.593284402755;6785.050092987084;6788.049673045876;6891.345322194384;6961.756338528127;6968.268331825288;6982.1272340957385;7005;6629.668516574248;6672.499562532732;6719.764808231688;6769.695363708546;6792.456603471809 04:56:36 INFO - PID 9731 | |1;ext.html;886.700483474677;900.3382513852313;921.1019256225179;947.625687853298;949.976250593735;45225.77387113064;45285;45418.772906135506;45513.544864551346;45561.77219113908;41565.168696626046;41727.374089388606;41988.58011419885;42005.15989680205;42058.369124463155;8025.0369955605265;8108.7161949331785;8141.267285944264;8143.104258531557;8146;7936.722214722486;7996.160403157672;8008.199180081974;8015.959920200391;8017;8710.825783484326;8923.286137109015;8927.687530936419;8930.55347232639;8930.687425940094;8767.123287671213;8827.249683776887;8847.292216622654;8851.867221991708;8893.911060889437;8748.693795717183;8774.07872173419;8823;8823.911760882373;8855.911440885573;41201.1759764803;41275.174496510204;41408;41507.58492415067;41618.37572436416;3819.579846216914;3866.420036994445;3868.12967082407;3869.8645547405704;3871.5160604924104;33160;33178.170545736306;33357.33285334304;33466.33067338664;33484.665153348644;5438.45615438453;5490.533304669108;5599.216109744639;5655.4344565543115;5686.0333743263745;222535;224158;225092;225390;225803.87098064568;51482.742586286826;51602;51803.222951655756;51842.74078629583;51898.74050629798;54265.45734542604;54528.72735636376;54607.45392546103;54740;54898.72550637301;17687.557811054827;17847.46457606274;18028.909855450638;18029.18868650914;18046.729299060524;14824.629384265263;14923;15006;15056.096634201984;15079.773803392958;15110.622234444007;15368.231588420758;15398.46105386306;15517.689646207013;15576.844231557767;6115.089948358326;6163.722632481549;6232.532560058014;6249.593776404519;6259.1550140730415;1110.1840147491587;1116.2744216259334;1119.6864877834219;1129.271619805221;1143.7941170589374;25823;26299;26471.33821654474;26534.46931061368;26676.59985100186;1228.8832560906699;1230.7538492301576;1235.7096082420624;1254.2223821230896;1257.1451413039222;13731.588052358446;13805.792913106312;13814.516491922734;14039.298035098203;14052.22712750788;310362;313581;327282;329984;331501;57109.42890571041;57461;57500;57796.42203577994;57812.71093644505;1515.4695856450155;1542.7994360733032;1560.0639616230171;1560.4382422327953;1589.7535881938318;31130;31229.219269518442;31371.215719607193;31859;32238.35523289568;42569.57430425656;42732.78633606812;42795.57204427916;42806;42819.357709633754;269090;269699;270864;271022;272550;36140;36947;37182;37302.25395492129;37537;45990.540094598626;47309.7634511839;47345;47493;47630.761846190544;34330.82834585811;34573.30853382969;34702;35175.296494069466;35380.29239415146;34361.48457773085;34418.311633767684;34587.4811877817;34764.13089672779;35116.64883351134;39852.60147398605;41156.1768764617;41179.7941010293;41291.38062928998;41302.586974129874;33581.83209083939;33647.495287570215;33946.32107357888;33961;34502.65497344994;25178.496430071664;25508.48983020292;25845;26245.868770656787;26285.737142628328 04:56:36 INFO - PID 9731 | |2;jquery.html;640.0046901107061;643.0710803985671;643.3068710648781;646.7180044130148;653.2795728327179;23859.880700596495;24796.75203247967;24812.87593562034;24817.379565510848;24833.875830620866;26414.33964150897;26961.32596685084;26979.055733049347;27128.32179195521;27134.864325678394;6330.177076979986;6540.182477190363;6641.103451034097;6670.59976401415;6679.732810687567;6737.427318677918;6831.4534837212905;6836.829079273009;6840.931590684079;6841.726330946756;6562.737490500374;6775.322467753234;6796.864062718742;6864.485163612724;6867.313268673142;6908.861822763567;6926.376626103674;6931.445484361239;6953.478489113311;6956.5478243913985;6450.387213214737;6497.577657452251;6507.2191337039385;6518.511111666644;6527;30734.23164420885;31551.36897262065;31819;31955.84022079898;32064;2399.196269249786;2477.1082410332265;2478.91323803666;2480.875956202183;2482.91309804156;20190;20715.5856882863;20748.85881276529;20797.16811327545;20847.583048338947;2505.110685706566;2536.543422184006;2575.9098431554994;2595.5587550116525;2599.7790187834057;146734;153314;162414.1879290596;170396;171085;16265.674686506203;16496.505104846874;17124.229409676595;17181.484555463358;17279.74080388795;27656.75544600498;27830.3042423941;27881.86059069732;27914.441711165662;27982.72017279801;11139.443027848574;11391.487383067783;11640.825387619192;11713.238639488405;11763.764724705628;10289.639862604923;10296.227782916161;10435.37387756737;10503.68703912011;10608.469576521298;9920.503974801231;10065.496725163712;10126.54430550627;10161.136303414145;10415.739606509898;2947.8083924545267;2952.217662319487;2966.2710306518056;2989.9850500747357;3157.905262842118;1055.6199768083484;1062.3519653011656;1084.3493903657743;1092.759592889563;1105.690406686129;21557.814320212226;21686.89156554207;21807.454813629785;21934.89032554827;22031.228906988177;1131.620906996149;1158.988410115905;1159.3391766693073;1169.2575214738702;1175.9470823812949;11924.165308428326;11983.820242696367;12102.757944841054;12154.392280385946;12231.69420764488;634046;644662;659333;661345;692980;142819;143169.28415358064;145072;146350;147884;1268.9048321375933;1290.6257185416125;1313.6518822512041;1356.1252991820024;1373.601655519888;22691.886540567193;22804.65793013073;22826.315210543045;22856.800945386352;22931.88534057319;67716;67754;68023.65988170226;69053.65473172603;69134.65432673006;87143.56428217818;88223;88868.11131888599;89931.75170620787;91743.54128229317;16021.679566408373;16178.595535111717;16448.83551164473;16566.50300490987;16567.42014029503;24036.158734444212;24121.155759548332;24123.155689550782;24332.270031899072;24508.50982980366;19882.50293742668;20132;20282.59434811325;20392.694109588072;20473.181072756925;16878.24047917822;17340.91329543344;17811.55471113181;18414.079296035412;18479.72280415768;19381.51546211356;19577.51056223549;20689.482762931046;20747.792522074586;20833.895830521356;16057.277422515781;16208.10855402964;16209.189540523163;16219.594510136869;16239.675206495567;19392.61214775725;19709.507262318555;19898.104585293408;19921.701174482103;20086 04:56:36 INFO - PID 9731 | |3;mootools.html;1442.1851653815593;1475.3066058952288;1480.1711041816584;1485.4031915690634;1496.887733419993;17369.218385172666;18019.279228830863;18023.188956496957;18029.188686509107;18049.819501804977;17408.39070632528;17548;17561.648767024682;17580.120993950317;17637.82362176378;3037.7569794416395;3098.5971823662894;3139.5604615353755;3151.921201969946;3155.668654791248;3003.279212988889;3085.42919559881;3086.1513083901996;3089.845507724605;3096.5974423325047;3006.3235771951354;3071.6006919100487;3135.0281412762;3138.5449109879055;3138.890138845141;3032.3328867649084;3120.1731541141617;3126.9843650781713;3142.9371412571736;3151.212196950774;2906.433245517125;2943.5878976943245;2956.5712971618996;2964.1552157635188;2980.135760629415;16565.337386504525;16762.32950681971;16824.83175168257;16851.24169412367;16861.915690421592;8610.354223433205;8898.911010889873;8905.465672059698;8909.777255568597;8910.331725120643;5699.116636921284;5804.970975145097;5849.888521181005;5873.676947767871;6089.3910608939195;2074.782147874482;2164.3182397544724;2172.0334451169238;2179.9891000544894;2188.2669305782424;31354.21614459634;31534.211644708837;31594.526082108787;31628.841855790804;31648.208794780083;7219.530730502501;7351.852962940711;7397.519161254501;7531;7553.8866916996285;20232.190712371634;20472.97635118238;20480;20573;20590.382288531368;8712.695055673148;8881.24509416694;8883.689070882489;8885.42244754089;8926.73219803407;8020.398470114765;8078.192180781874;8166.918330816735;8199.180081991753;8300.501969881827;5819.94180058194;6021.096835474714;6027.186329845503;6090.665013424305;6091.0558863376245;1477.4238047161616;1486.0829529906516;1697.6010637500178;1712.9828701713072;1731.9480415587552;985.1183191043975;992.5235886774244;999.4952548962727;1002.7894142230214;1017.9185665146771;8787.253083487847;8843.51360675169;8894.911050889537;8899.866502002345;8908.599113039929;1014.1734486393713;1056.2817284246632;1068.4497483795851;1069.4438891776233;1083.6315652678127;5188.533032027136;5298.178782288752;5401.405845357008;5430.83707488776;5510.476504732044;25323.987040518543;25878.87060564685;26166.73833261681;26513.204603861916;26653.733462665514;25582.616260756102;26313.73686263151;26320.34199145037;26510;26673.599896001186;12819.743605127846;12937.611871643678;12963.481460741465;13096.738065238642;13111.409986550629;9576.904230957602;9676.56455459492;9717.659881904383;9802;9902;21438.249661262405;21508.784912150677;21882;21957.451063723536;21990.35072369547;22462.88768556147;22833.31500055001;22964;23006.42483937848;23133.421664458525;12909.935450322688;13034.608961731163;13200;13202.537911173064;13244.602661920158;16114.597135071717;16397.59006024859;16482.42311519091;16489.09309987962;16514.66970660556;12948.741025179632;13043;13180.670483237996;13277.867221327662;13329.733405332034;12668.873311267138;12979.935100324816;12989.480420783062;13101.148425352321;13179.802302965654;10071.597136114473;10284.434356110187;10287.948560257151;10293.330933489298;10318.845217321596;8328.125546817497;8388.790280243044;8421.747347579583;8555.914440855511;8570.57147142628;7749.496282741604;7860.960695196487;7919.524828510308;7950.801229969297;7963.12405635368 04:56:36 INFO - PID 9731 | |4;prototype.html;574.9913751293732;580.0921557762099;592.339541411326;607.5382709141053;616.7163104971713;6268.247810262769;6312.495000399968;6350.841228969278;6468.32082631324;6484.1570595822595;6213.378662133784;6260.812175634738;6300.369963003697;6338.556301058928;6353.745850165999;5216.530512253897;5236.947630523684;5252.842414727565;5267.894642107156;5287.39194992575;5003.849884503471;5100.795968161269;5239.921401178985;5240.711760853152;5255.658382205163;5094.184930411135;5116.488351164872;5116.769745361467;5139.451585346977;5146.228065790124;4987.526185012418;4989.027139707722;5065.265536497206;5102.846914592549;5105.753468473859;4604.654650901162;4612.192866248427;4644.071185762861;4664.463586687541;4676.649251306166;6127.816165515042;6219.937800621981;6236.282827474854;6252.124702541648;6332.303446620868;5887.0286402743495;5957.463828255434;5986.491148252404;5993.670348130851;6004.78983235589;6574.967125164344;6662.367075127855;6669.466442684574;6691.230508491537;6773.796786096425;5152.355955505562;5197.896042079137;5212.739363031833;5230.823064810425;5236.3978142513715;6794.76218332356;6963.617001064939;6974.302569743036;7031.8593628127155;7092.9290707093305;5353.9196912046355;5360.946390536123;5366.221897824794;5377.381601115843;5383.5047735140815;5396.2984811974975;5402.108652072364;5420.674759514442;5441.075017247077;5461.890762184734;5971.313298970587;5974.819190995256;6016.548758843104;6030.246219222598;6047.425494578008;6636.435902948304;6653.700583473756;6761.932380676229;6775.62734049632;6819.693113809891;1860.3488778927267;1863.6645403827442;1872.6816441204755;1903.1530968718787;1905.8665893387606;1287.9356032198352;1319.9343028160897;1348.4134401535364;1362.8364596248316;1367.2890097149625;6362.491000719931;6370.235571731329;6380.776672816429;6409.487241020707;6425.967870160619;6578.703958321887;6692.330766923366;6722.831929201809;6833.248342682301;6896.172459304916;6325.683715814191;6335.936640633627;6344.048392741126;6382.266039405435;6485.67571621417;3593.8382772774767;3595.406757884972;3595.7303202259936;3600.5499312585926;3608.350496910529;7208.71165153388;7229.421646268286;7272.600006999666;7275.818104547428;7288.854222915618;7096.254893236239;7113.395361394236;7115.679794409264;7132.3580877720215;7147;7172.318629730167;7189.209186989427;7201.299512682849;7222.277772222841;7240.782776516713;6862.279460656759;6889.483288753263;6916.3429474201885;6917;6926.653667316513;6681.465482761465;6816.420604248694;6818.386345228953;6835.726570937107;6905.1713794345;6987.580745155307;7034.155901291878;7040.5071644984355;7152.320529549685;7255.020572222894;5247.134222853187;5262.6316157870115;5285.550728188147;5319.920201197063;5370.516653501204;6577.2436169841085;6789.72841086351;6802.523823332319;6815.625140617313;6905.585664860125;6257.468115210076;6622.403983641495;6628.746226282894;6632.204135503771;6712.899306510309;6604.867902642017;6635.137432133792;6684.63234522106;6692.59844409337;6701.832454188684;6276.215473065867;6592.505562082767;6646.534742567974;6647.966760166169;6703.8156875483755;6704;6733.360330768569;6783.559068660718;6784.6946887389195;6827.419669328163;6522.249941256627;6558.213014438298;6583.144191255106;6585.267114147575;6587.143671322698 04:56:36 INFO - PID 9731 | |5;yui.html;1021.1932573267125;1029.8609687692162;1052.4737631184407;1053.7839742852716;1057.6826951914427;21186.89406552967;21393.57212855742;21701.02345394457;22066.88966555169;22123;19489.220431182737;19584.314548990787;19642.90178549109;19650.508737281576;19656.803431965676;1013.3413281367096;1025.6410256410272;1027.1577306608583;1029.325791606499;1036.6682661548307;1102.5699977008974;1107.224942540221;1108.6784832398594;1110.9333439993586;1111;1118.6196693124336;1132.2810015640086;1159.565163063851;1162.9825552616676;1167.4804711903207;1146.3694967767735;1147.833564133196;1152.8847115288488;1154.4920235096615;1155.6128696886553;841.5834162089805;845.9788505287355;850.8511010573125;851.0213254757017;851.6508231625004;21051.578968420545;21207.151713931424;21403.464913377135;21440.249591264386;21831.235906743186;23262.06951721929;23648;23853;23975.496725081553;24034.519309613886;18953.24187032517;19304.613907721767;19336.4199074028;19368.225270989144;19511.609767804708;4129.463169787939;4203.516595591515;4207.221663992172;4207.873763787091;4209.5790420957965;128255;148402;158511;161052;168257;18740.344087956855;19263.807361926483;19278;19631.82209067432;19851.503712407306;35893.308806622066;36422.27155456876;36702;36710;37208.44187337192;10553.155747540179;10596.364218146937;10638;10661.253712240225;10744.194185436123;4854.514548545188;4890.462049174588;4945.7774400152075;4952.876178095505;4988.501149884983;6630.701618427182;6695.330466953265;6721;6723.731050757915;6744.393004629607;1326.6882282663566;1358.8369395672582;1375.40170026039;1377.827771528559;1382.4539306973688;787.2127872127872;790.6402586822982;798.3652995868299;800.1198681450358;812.25272749071;13996.950228732885;14150;14844.92577537127;15056.849431505763;15264.313105910262;785.6621652689398;792.2157064506213;797.8843067755143;806.3226889412921;810.2505182705974;6459.418652321314;6507.7071531781185;6611.50413718973;6613.801585952429;6671.532992690562;144075.47545554285;145238;147120;149008;159387;114043.42978285055;115023;127176.36411817881;131305;136984.31507842397;114125;114829;117934.41032794953;119079.99999999827;121652;14131.222782747047;14784.408623654934;14795.852041479448;15185.772213417029;15446.532579404939;56078.43921560732;56871.146932795215;57476.71261643665;57601.71199143978;58236.4176358231;93275;96464;98210;98522;100017;20328;20605.17579296811;20624.27815026467;20639.690404643643;20684.689729653765;24222.636660449756;24278.27165185047;24359.878200608884;24389.14637987662;24399.878000609882;22588.435289117904;22705.318840434815;22746.886265568566;22781.202657906895;22789.202377916692;20459.38621841347;20520.38438846837;20626;20705.792942070388;20741.170353186306;21476;21593.568128637653;21852;21875.343739687836;22059.448513787283;15530.301136448661;16047.759283610989;16104.114273715059;16254.51236462908;16389.508314750576;14662.193579352812;15504.224788760743;15602.921985390001;15658.608534786721;15666.451674191349 04:56:36 INFO - PID 9731 | __end_tp_report 04:56:36 INFO - PID 9731 | __start_cc_report 04:56:36 INFO - PID 9731 | _x_x_mozilla_cycle_collect,244 04:56:36 INFO - PID 9731 | __end_cc_report 04:56:36 INFO - PID 9731 | __startTimestamp1508241396424__endTimestamp 04:56:36 INFO - PID 9731 | 04:56:36 INFO - PID 9731 | ------- Summary: start ------- 04:56:36 INFO - PID 9731 | Number of tests: 6 04:56:36 INFO - PID 9731 | 04:56:36 INFO - PID 9731 | [#0] dojo.html Cycles:165 Average:6577.37 Median:6779.19 stddev:760.69 (11.2%) stddev-sans-first:735.19 04:56:36 INFO - PID 9731 | Values: 3978.2 3990.6 3996.3 4001.5 4017.7 6471.8 6503.9 6527.8 6603.5 6626.2 6553.9 6586.0 6623.4 6636.0 6663.3 5869.6 5884.7 5907.7 5935.7 5965.6 5916.2 5926.1 5930.6 6003.8 6048.0 5989.5 6048.1 6053.7 6065.9 6072.4 5870.0 5942.2 5977.4 6051.1 6078.3 5844.5 5875.0 5882.6 5898.6 5949.1 6501.6 6575.3 6589.3 6597.7 6633.9 7115.1 7132.0 7194.6 7212.9 7215.7 7111.1 7141.5 7198.0 7233.8 7251.5 6484.0 6604.6 6608.1 6613.8 6651.4 7244.9 7247.2 7272.2 7290.6 7364.0 6958.2 6959.1 7032.2 7113.8 7115.8 7100.5 7156.4 7221.7 7248.7 7280.5 6971.2 7060.5 7077.4 7097.7 7112.0 7010.8 7056.6 7108.5 7111.9 7120.4 5262.7 5264.9 5295.3 5324.1 5330.2 4804.6 4828.1 4848.4 4864.5 4865.3 6530.4 6579.6 6608.8 6636.8 6725.5 7098.0 7152.7 7158.4 7180.0 7185.3 6599.6 6607.0 6621.7 6699.9 6701.9 5930.1 5947.1 6004.9 6016.6 6050.3 7273.6 7388.2 7404.3 7450.8 7473.3 7120.0 7129.9 7145.0 7180.7 7194.1 7395.3 7395.9 7401.6 7418.4 7527.3 6930.6 6990.9 6993.9 7084.5 7153.1 7120.7 7170.4 7191.1 7208.9 7218.7 6779.2 6807.2 6881.5 6928.5 6947.6 6831.0 6834.8 6836.0 6837.0 6846.4 6767.2 6777.1 6778.6 6785.1 6788.0 6891.3 6961.8 6968.3 6982.1 7005.0 6629.7 6672.5 6719.8 6769.7 6792.5 04:56:36 INFO - PID 9731 | 04:56:36 INFO - PID 9731 | [#1] ext.html Cycles:180 Average:45110.57 Median:3843.00 stddev:71809.74 (1868.6%) stddev-sans-first:71934.41 04:56:36 INFO - PID 9731 | Values: 886.7 900.3 921.1 947.6 950.0 45225.8 45285.0 45418.8 45513.5 45561.8 41565.2 41727.4 41988.6 42005.2 42058.4 8025.0 8108.7 8141.3 8143.1 8146.0 7936.7 7996.2 8008.2 8016.0 8017.0 8710.8 8923.3 8927.7 8930.6 8930.7 8767.1 8827.2 8847.3 8851.9 8893.9 8748.7 8774.1 8823.0 8823.9 8855.9 41201.2 41275.2 41408.0 41507.6 41618.4 3819.6 3866.4 3868.1 3869.9 3871.5 33160.0 33178.2 33357.3 33466.3 33484.7 5438.5 5490.5 5599.2 5655.4 5686.0 222535.0 224158.0 225092.0 225390.0 225803.9 51482.7 51602.0 51803.2 51842.7 51898.7 54265.5 54528.7 54607.5 54740.0 54898.7 17687.6 17847.5 18028.9 18029.2 18046.7 14824.6 14923.0 15006.0 15056.1 15079.8 15110.6 15368.2 15398.5 15517.7 15576.8 6115.1 6163.7 6232.5 6249.6 6259.2 1110.2 1116.3 1119.7 1129.3 1143.8 25823.0 26299.0 26471.3 26534.5 26676.6 1228.9 1230.8 1235.7 1254.2 1257.1 13731.6 13805.8 13814.5 14039.3 14052.2 310362.0 313581.0 327282.0 329984.0 331501.0 57109.4 57461.0 57500.0 57796.4 57812.7 1515.5 1542.8 1560.1 1560.4 1589.8 31130.0 31229.2 31371.2 31859.0 32238.4 42569.6 42732.8 42795.6 42806.0 42819.4 269090.0 269699.0 270864.0 271022.0 272550.0 36140.0 36947.0 37182.0 37302.3 37537.0 45990.5 47309.8 47345.0 47493.0 47630.8 34330.8 34573.3 34702.0 35175.3 35380.3 34361.5 34418.3 34587.5 34764.1 35116.6 39852.6 41156.2 41179.8 41291.4 41302.6 33581.8 33647.5 33946.3 33961.0 34502.7 25178.5 25508.5 25845.0 26245.9 26285.7 04:56:36 INFO - PID 9731 | 04:56:36 INFO - PID 9731 | [#2] jquery.html Cycles:180 Average:42773.88 Median:22815.49 stddev:110349.57 (483.7%) stddev-sans-first:110613.78 04:56:36 INFO - PID 9731 | Values: 640.0 643.1 643.3 646.7 653.3 23859.9 24796.8 24812.9 24817.4 24833.9 26414.3 26961.3 26979.1 27128.3 27134.9 6330.2 6540.2 6641.1 6670.6 6679.7 6737.4 6831.5 6836.8 6840.9 6841.7 6562.7 6775.3 6796.9 6864.5 6867.3 6908.9 6926.4 6931.4 6953.5 6956.5 6450.4 6497.6 6507.2 6518.5 6527.0 30734.2 31551.4 31819.0 31955.8 32064.0 2399.2 2477.1 2478.9 2480.9 2482.9 20190.0 20715.6 20748.9 20797.2 20847.6 2505.1 2536.5 2575.9 2595.6 2599.8 146734.0 153314.0 162414.2 170396.0 171085.0 16265.7 16496.5 17124.2 17181.5 17279.7 27656.8 27830.3 27881.9 27914.4 27982.7 11139.4 11391.5 11640.8 11713.2 11763.8 10289.6 10296.2 10435.4 10503.7 10608.5 9920.5 10065.5 10126.5 10161.1 10415.7 2947.8 2952.2 2966.3 2990.0 3157.9 1055.6 1062.4 1084.3 1092.8 1105.7 21557.8 21686.9 21807.5 21934.9 22031.2 1131.6 1159.0 1159.3 1169.3 1175.9 11924.2 11983.8 12102.8 12154.4 12231.7 634046.0 644662.0 659333.0 661345.0 692980.0 142819.0 143169.3 145072.0 146350.0 147884.0 1268.9 1290.6 1313.7 1356.1 1373.6 22691.9 22804.7 22826.3 22856.8 22931.9 67716.0 67754.0 68023.7 69053.7 69134.7 87143.6 88223.0 88868.1 89931.8 91743.5 16021.7 16178.6 16448.8 16566.5 16567.4 24036.2 24121.2 24123.2 24332.3 24508.5 19882.5 20132.0 20282.6 20392.7 20473.2 16878.2 17340.9 17811.6 18414.1 18479.7 19381.5 19577.5 20689.5 20747.8 20833.9 16057.3 16208.1 16209.2 16219.6 16239.7 19392.6 19709.5 19898.1 19921.7 20086.0 04:56:36 INFO - PID 9731 | 04:56:36 INFO - PID 9731 | [#3] mootools.html Cycles:180 Average:10785.35 Median:26663.67 stddev:8025.75 (30.1%) stddev-sans-first:8017.56 04:56:36 INFO - PID 9731 | Values: 1442.2 1475.3 1480.2 1485.4 1496.9 17369.2 18019.3 18023.2 18029.2 18049.8 17408.4 17548.0 17561.6 17580.1 17637.8 3037.8 3098.6 3139.6 3151.9 3155.7 3003.3 3085.4 3086.2 3089.8 3096.6 3006.3 3071.6 3135.0 3138.5 3138.9 3032.3 3120.2 3127.0 3142.9 3151.2 2906.4 2943.6 2956.6 2964.2 2980.1 16565.3 16762.3 16824.8 16851.2 16861.9 8610.4 8898.9 8905.5 8909.8 8910.3 5699.1 5805.0 5849.9 5873.7 6089.4 2074.8 2164.3 2172.0 2180.0 2188.3 31354.2 31534.2 31594.5 31628.8 31648.2 7219.5 7351.9 7397.5 7531.0 7553.9 20232.2 20473.0 20480.0 20573.0 20590.4 8712.7 8881.2 8883.7 8885.4 8926.7 8020.4 8078.2 8166.9 8199.2 8300.5 5819.9 6021.1 6027.2 6090.7 6091.1 1477.4 1486.1 1697.6 1713.0 1731.9 985.1 992.5 999.5 1002.8 1017.9 8787.3 8843.5 8894.9 8899.9 8908.6 1014.2 1056.3 1068.4 1069.4 1083.6 5188.5 5298.2 5401.4 5430.8 5510.5 25324.0 25878.9 26166.7 26513.2 26653.7 25582.6 26313.7 26320.3 26510.0 26673.6 12819.7 12937.6 12963.5 13096.7 13111.4 9576.9 9676.6 9717.7 9802.0 9902.0 21438.2 21508.8 21882.0 21957.5 21990.4 22462.9 22833.3 22964.0 23006.4 23133.4 12909.9 13034.6 13200.0 13202.5 13244.6 16114.6 16397.6 16482.4 16489.1 16514.7 12948.7 13043.0 13180.7 13277.9 13329.7 12668.9 12979.9 12989.5 13101.1 13179.8 10071.6 10284.4 10287.9 10293.3 10318.8 8328.1 8388.8 8421.7 8555.9 8570.6 7749.5 7861.0 7919.5 7950.8 7963.1 04:56:36 INFO - PID 9731 | 04:56:36 INFO - PID 9731 | [#4] prototype.html Cycles:180 Average:5750.34 Median:6347.44 stddev:1593.05 (25.1%) stddev-sans-first:1549.44 04:56:36 INFO - PID 9731 | Values: 575.0 580.1 592.3 607.5 616.7 6268.2 6312.5 6350.8 6468.3 6484.2 6213.4 6260.8 6300.4 6338.6 6353.7 5216.5 5236.9 5252.8 5267.9 5287.4 5003.8 5100.8 5239.9 5240.7 5255.7 5094.2 5116.5 5116.8 5139.5 5146.2 4987.5 4989.0 5065.3 5102.8 5105.8 4604.7 4612.2 4644.1 4664.5 4676.6 6127.8 6219.9 6236.3 6252.1 6332.3 5887.0 5957.5 5986.5 5993.7 6004.8 6575.0 6662.4 6669.5 6691.2 6773.8 5152.4 5197.9 5212.7 5230.8 5236.4 6794.8 6963.6 6974.3 7031.9 7092.9 5353.9 5360.9 5366.2 5377.4 5383.5 5396.3 5402.1 5420.7 5441.1 5461.9 5971.3 5974.8 6016.5 6030.2 6047.4 6636.4 6653.7 6761.9 6775.6 6819.7 1860.3 1863.7 1872.7 1903.2 1905.9 1287.9 1319.9 1348.4 1362.8 1367.3 6362.5 6370.2 6380.8 6409.5 6426.0 6578.7 6692.3 6722.8 6833.2 6896.2 6325.7 6335.9 6344.0 6382.3 6485.7 3593.8 3595.4 3595.7 3600.5 3608.4 7208.7 7229.4 7272.6 7275.8 7288.9 7096.3 7113.4 7115.7 7132.4 7147.0 7172.3 7189.2 7201.3 7222.3 7240.8 6862.3 6889.5 6916.3 6917.0 6926.7 6681.5 6816.4 6818.4 6835.7 6905.2 6987.6 7034.2 7040.5 7152.3 7255.0 5247.1 5262.6 5285.6 5319.9 5370.5 6577.2 6789.7 6802.5 6815.6 6905.6 6257.5 6622.4 6628.7 6632.2 6712.9 6604.9 6635.1 6684.6 6692.6 6701.8 6276.2 6592.5 6646.5 6648.0 6703.8 6704.0 6733.4 6783.6 6784.7 6827.4 6522.2 6558.2 6583.1 6585.3 6587.1 04:56:36 INFO - PID 9731 | 04:56:36 INFO - PID 9731 | [#5] yui.html Cycles:180 Average:29829.49 Median:20089.75 stddev:42145.49 (209.8%) stddev-sans-first:42208.21 04:56:36 INFO - PID 9731 | Values: 1021.2 1029.9 1052.5 1053.8 1057.7 21186.9 21393.6 21701.0 22066.9 22123.0 19489.2 19584.3 19642.9 19650.5 19656.8 1013.3 1025.6 1027.2 1029.3 1036.7 1102.6 1107.2 1108.7 1110.9 1111.0 1118.6 1132.3 1159.6 1163.0 1167.5 1146.4 1147.8 1152.9 1154.5 1155.6 841.6 846.0 850.9 851.0 851.7 21051.6 21207.2 21403.5 21440.2 21831.2 23262.1 23648.0 23853.0 23975.5 24034.5 18953.2 19304.6 19336.4 19368.2 19511.6 4129.5 4203.5 4207.2 4207.9 4209.6 128255.0 148402.0 158511.0 161052.0 168257.0 18740.3 19263.8 19278.0 19631.8 19851.5 35893.3 36422.3 36702.0 36710.0 37208.4 10553.2 10596.4 10638.0 10661.3 10744.2 4854.5 4890.5 4945.8 4952.9 4988.5 6630.7 6695.3 6721.0 6723.7 6744.4 1326.7 1358.8 1375.4 1377.8 1382.5 787.2 790.6 798.4 800.1 812.3 13997.0 14150.0 14844.9 15056.8 15264.3 785.7 792.2 797.9 806.3 810.3 6459.4 6507.7 6611.5 6613.8 6671.5 144075.5 145238.0 147120.0 149008.0 159387.0 114043.4 115023.0 127176.4 131305.0 136984.3 114125.0 114829.0 117934.4 119080.0 121652.0 14131.2 14784.4 14795.9 15185.8 15446.5 56078.4 56871.1 57476.7 57601.7 58236.4 93275.0 96464.0 98210.0 98522.0 100017.0 20328.0 20605.2 20624.3 20639.7 20684.7 24222.6 24278.3 24359.9 24389.1 24399.9 22588.4 22705.3 22746.9 22781.2 22789.2 20459.4 20520.4 20626.0 20705.8 20741.2 21476.0 21593.6 21852.0 21875.3 22059.4 15530.3 16047.8 16104.1 16254.5 16389.5 14662.2 15504.2 15602.9 15658.6 15666.5 04:56:36 INFO - PID 9731 | -------- Summary: end -------- 04:56:36 INFO - PID 9731 | 04:56:37 INFO - TEST-INFO | 9731: exit 0 04:56:37 INFO - TEST-OK | dromaeo_css | took 1106844ms 04:56:37 INFO - TEST-START | kraken 04:56:37 INFO - Initialising browser for kraken test... 04:56:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42321/getInfo.html -profile /tmp/tmpBTt6ey/profile 04:56:37 INFO - TEST-INFO | started process 10096 (/builds/slave/test/build/application/firefox/firefox http://localhost:42321/getInfo.html) 04:56:41 INFO - TEST-INFO | 10096: exit 0 04:56:41 INFO - Browser initialized. 04:56:41 INFO - Running cycle 1/1 for kraken test... 04:56:41 INFO - Using env: {'DISPLAY': ':0', 04:56:41 INFO - 'HOME': '/home/cltbld', 04:56:41 INFO - 'JSGC_DISABLE_POISONING': '1', 04:56:41 INFO - 'LANG': 'en_US.UTF-8', 04:56:41 INFO - 'LANGUAGE': 'en_US:en', 04:56:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:56:41 INFO - 'LOGNAME': 'cltbld', 04:56:41 INFO - 'MAIL': '/var/mail/cltbld', 04:56:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:56:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:56:41 INFO - 'MOZ_CRASHREPORTER': '1', 04:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:56:41 INFO - 'MOZ_NO_REMOTE': '1', 04:56:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:41 INFO - 'NO_EM_RESTART': '1', 04:56:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:41 INFO - 'PWD': '/builds/slave/test', 04:56:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:56:41 INFO - 'RUST_BACKTRACE': 'full', 04:56:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:56:41 INFO - 'SHELL': '/bin/bash', 04:56:41 INFO - 'SHLVL': '1', 04:56:41 INFO - 'TERM': 'linux', 04:56:41 INFO - 'TMOUT': '86400', 04:56:41 INFO - 'USER': 'cltbld', 04:56:41 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575', 04:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:41 INFO - '_': '/tools/buildbot/bin/python'} 04:56:41 INFO - TEST-INFO | started process 10328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBTt6ey/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:42 INFO - PID 10328 | 04:56:42 INFO - PID 10328 | (/builds/slave/test/build/application/firefox/firefox:10376): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:56:42 INFO - PID 10328 | 04:56:52 INFO - PID 10328 | RSS: Main: 143560704 04:56:52 INFO - PID 10328 | 04:56:55 INFO - PID 10328 | Cycle 1(1): loaded http://localhost:42321/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42321/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:56 INFO - PID 10328 | RSS: Main: 150315008 04:56:56 INFO - PID 10328 | 04:56:58 INFO - PID 10328 | Cycle 1(1): loaded http://localhost:42321/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42321/tests/kraken/driver.html?testName=audio-dft) 04:56:59 INFO - PID 10328 | RSS: Main: 150982656 04:56:59 INFO - PID 10328 | 04:57:02 INFO - PID 10328 | Cycle 1(1): loaded http://localhost:42321/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42321/tests/kraken/driver.html?testName=audio-fft) 04:57:02 INFO - PID 10328 | RSS: Main: 152588288 04:57:02 INFO - PID 10328 | 04:57:04 INFO - PID 10328 | Cycle 1(1): loaded http://localhost:42321/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42321/tests/kraken/driver.html?testName=audio-oscillator) 04:57:05 INFO - PID 10328 | RSS: Main: 152883200 04:57:05 INFO - PID 10328 | 04:57:07 INFO - PID 10328 | Cycle 1(1): loaded http://localhost:42321/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42321/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:57:08 INFO - PID 10328 | RSS: Main: 152457216 04:57:08 INFO - PID 10328 | 04:57:11 INFO - PID 10328 | Cycle 1(1): loaded http://localhost:42321/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42321/tests/kraken/driver.html?testName=imaging-darkroom) 04:57:11 INFO - PID 10328 | RSS: Main: 152330240 04:57:11 INFO - PID 10328 | 04:57:15 INFO - PID 10328 | Cycle 1(1): loaded http://localhost:42321/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42321/tests/kraken/driver.html?testName=imaging-desaturate) 04:57:15 INFO - PID 10328 | RSS: Main: 152883200 04:57:15 INFO - PID 10328 | 04:57:18 INFO - PID 10328 | Cycle 1(1): loaded http://localhost:42321/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42321/tests/kraken/driver.html?testName=json-parse-financial) 04:57:19 INFO - PID 10328 | RSS: Main: 154836992 04:57:19 INFO - PID 10328 | 04:57:20 INFO - PID 10328 | Cycle 1(1): loaded http://localhost:42321/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42321/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:57:21 INFO - PID 10328 | RSS: Main: 154509312 04:57:21 INFO - PID 10328 | 04:57:23 INFO - PID 10328 | Cycle 1(1): loaded http://localhost:42321/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42321/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:57:23 INFO - PID 10328 | RSS: Main: 154914816 04:57:23 INFO - PID 10328 | 04:57:25 INFO - PID 10328 | Cycle 1(1): loaded http://localhost:42321/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42321/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:57:26 INFO - PID 10328 | RSS: Main: 151724032 04:57:26 INFO - PID 10328 | 04:57:28 INFO - PID 10328 | Cycle 1(1): loaded http://localhost:42321/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42321/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:57:29 INFO - PID 10328 | RSS: Main: 151822336 04:57:29 INFO - PID 10328 | 04:57:31 INFO - PID 10328 | Cycle 1(1): loaded http://localhost:42321/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42321/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:57:32 INFO - PID 10328 | RSS: Main: 152109056 04:57:32 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | Cycle 1(1): loaded http://localhost:42321/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42321/tests/kraken/driver.html?testName=ai-astar) 04:57:34 INFO - PID 10328 | RSS: Main: 153747456 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | __start_tp_report 04:57:34 INFO - PID 10328 | _x_x_mozilla_page_load 04:57:34 INFO - PID 10328 | _x_x_mozilla_page_load_details 04:57:34 INFO - PID 10328 | |i|pagename|runs| 04:57:34 INFO - PID 10328 | |0;ai-astar;104;104;104;105;107;104;107;105;105;105 04:57:34 INFO - PID 10328 | |1;audio-beat-detection;115;110;113;110;138;113;111;111;118;122 04:57:34 INFO - PID 10328 | |2;audio-dft;162;163;163;162;162;161;160;163;161;162 04:57:34 INFO - PID 10328 | |3;audio-fft;74;74;73;73;73;75;73;73;75;73 04:57:34 INFO - PID 10328 | |4;audio-oscillator;77;78;78;77;78;79;77;80;77;77 04:57:34 INFO - PID 10328 | |5;imaging-gaussian-blur;113;114;114;114;113;114;115;110;117;111 04:57:34 INFO - PID 10328 | |6;imaging-darkroom;152;148;152;149;148;148;152;148;148;149 04:57:34 INFO - PID 10328 | |7;imaging-desaturate;99;99;95;98;99;94;95;95;94;94 04:57:34 INFO - PID 10328 | |8;json-parse-financial;44;44;42;47;43;44;44;44;43;43 04:57:34 INFO - PID 10328 | |9;json-stringify-tinderbox;38;38;38;38;39;38;38;38;38;39 04:57:34 INFO - PID 10328 | |10;stanford-crypto-aes;77;73;71;72;69;77;72;71;70;75 04:57:34 INFO - PID 10328 | |11;stanford-crypto-ccm;104;102;105;103;111;103;105;104;103;121 04:57:34 INFO - PID 10328 | |12;stanford-crypto-pbkdf2;156;150;149;148;155;150;146;152;147;148 04:57:34 INFO - PID 10328 | |13;stanford-crypto-sha256-iterative;59;60;58;64;60;58;61;58;61;61 04:57:34 INFO - PID 10328 | __end_tp_report 04:57:34 INFO - PID 10328 | __start_cc_report 04:57:34 INFO - PID 10328 | _x_x_mozilla_cycle_collect,662 04:57:34 INFO - PID 10328 | __end_cc_report 04:57:34 INFO - PID 10328 | __startTimestamp1508241454407__endTimestamp 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | ------- Summary: start ------- 04:57:34 INFO - PID 10328 | Number of tests: 14 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | [#0] ai-astar Cycles:10 Average:105.00 Median:105.00 stddev:1.15 (1.1%) stddev-sans-first:1.17 04:57:34 INFO - PID 10328 | Values: 104.0 104.0 104.0 105.0 107.0 104.0 107.0 105.0 105.0 105.0 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | [#1] audio-beat-detection Cycles:10 Average:116.10 Median:114.00 stddev:8.60 (7.5%) stddev-sans-first:9.11 04:57:34 INFO - PID 10328 | Values: 115.0 110.0 113.0 110.0 138.0 113.0 111.0 111.0 118.0 122.0 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 04:57:34 INFO - PID 10328 | Values: 162.0 163.0 163.0 162.0 162.0 161.0 160.0 163.0 161.0 162.0 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | [#3] audio-fft Cycles:10 Average:73.60 Median:73.50 stddev:0.84 (1.1%) stddev-sans-first:0.88 04:57:34 INFO - PID 10328 | Values: 74.0 74.0 73.0 73.0 73.0 75.0 73.0 73.0 75.0 73.0 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.00 stddev:1.03 (1.3%) stddev-sans-first:1.05 04:57:34 INFO - PID 10328 | Values: 77.0 78.0 78.0 77.0 78.0 79.0 77.0 80.0 77.0 77.0 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:1.96 (1.7%) stddev-sans-first:2.07 04:57:34 INFO - PID 10328 | Values: 113.0 114.0 114.0 114.0 113.0 114.0 115.0 110.0 117.0 111.0 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.00 stddev:1.84 (1.2%) stddev-sans-first:1.69 04:57:34 INFO - PID 10328 | Values: 152.0 148.0 152.0 149.0 148.0 148.0 152.0 148.0 148.0 149.0 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.50 stddev:2.25 (2.3%) stddev-sans-first:2.15 04:57:34 INFO - PID 10328 | Values: 99.0 99.0 95.0 98.0 99.0 94.0 95.0 95.0 94.0 94.0 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | [#8] json-parse-financial Cycles:10 Average:43.80 Median:44.00 stddev:1.32 (3.0%) stddev-sans-first:1.39 04:57:34 INFO - PID 10328 | Values: 44.0 44.0 42.0 47.0 43.0 44.0 44.0 44.0 43.0 43.0 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 04:57:34 INFO - PID 10328 | Values: 38.0 38.0 38.0 38.0 39.0 38.0 38.0 38.0 38.0 39.0 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:72.50 stddev:2.79 (3.8%) stddev-sans-first:2.49 04:57:34 INFO - PID 10328 | Values: 77.0 73.0 71.0 72.0 69.0 77.0 72.0 71.0 70.0 75.0 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | [#11] stanford-crypto-ccm Cycles:10 Average:106.10 Median:104.50 stddev:5.80 (5.6%) stddev-sans-first:6.10 04:57:34 INFO - PID 10328 | Values: 104.0 102.0 105.0 103.0 111.0 103.0 105.0 104.0 103.0 121.0 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:150.00 stddev:3.31 (2.2%) stddev-sans-first:2.74 04:57:34 INFO - PID 10328 | Values: 156.0 150.0 149.0 148.0 155.0 150.0 146.0 152.0 147.0 148.0 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.00 Median:60.50 stddev:1.89 (3.1%) stddev-sans-first:1.96 04:57:34 INFO - PID 10328 | Values: 59.0 60.0 58.0 64.0 60.0 58.0 61.0 58.0 61.0 61.0 04:57:34 INFO - PID 10328 | -------- Summary: end -------- 04:57:34 INFO - PID 10328 | 04:57:34 INFO - PID 10328 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:57:34 INFO - TEST-INFO | 10328: exit 0 04:57:34 INFO - TEST-OK | kraken | took 57967ms 04:57:34 INFO - SUITE-END | took 1164s 04:57:35 INFO - Completed test suite (00:19:24) 04:57:35 INFO - javascript benchmark 04:57:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9482.5138501614, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3978.244133614613, 3990.56103828579, 3996.2806694794926, 4001.5398229203643, 4017.7388469749462, 6471.805845824627, 6503.934960650392, 6527.771527996521, 6603.504737144709, 6626.204855417351, 6553.918603430428, 6585.967070164643, 6623.437007854338, 6636.0377745226915, 6663.333666633346, 5869.618474799146, 5884.735186916599, 5907.6750778707155, 5935.73289201987, 5965.642061476304, 5916.201312822778, 5926.140709597106, 5930.555208359368, 6003.8198854034445, 6048.032314829607, 5989.520838332945, 6048.092786082101, 6053.727582258787, 6065.878682426349, 6072.362401947798, 5870.0, 5942.2275104236605, 5977.372375900533, 6051.062085376751, 6078.331383547807, 5844.47399734026, 5875.0, 5882.6470411775, 5898.557608179361, 5949.137375080589, 6501.577397469149, 6575.3095924927675, 6589.308122647101, 6597.736090556372, 6633.86732265352, 7115.075040244787, 7131.964340178318, 7194.568325900463, 7212.8557428851655, 7215.675294611702, 7111.146662400545, 7141.500094993353, 7197.964010179968, 7233.819154521127, 7251.456140789462, 6484.0, 6604.636744979024, 6608.107905432801, 6613.834654133637, 6651.368120028589, 7244.89132663, 7247.16657584374, 7272.200057993617, 7290.5625662460425, 7364.005859208938, 6958.199807022156, 6959.060526828814, 7032.191298000693, 7113.75101871432, 7115.822104447327, 7100.502964792415, 7156.427485801123, 7221.675024623904, 7248.746293879794, 7280.453965952574, 6971.163460384786, 7060.54106483077, 7077.363037326665, 7097.680604372712, 7112.039874616964, 7010.754623588252, 7056.6118863463, 7108.466864985044, 7111.92888071123, 7120.394766444807, 5262.684238945599, 5264.894702105937, 5295.258663787073, 5324.068288049576, 5330.227117068003, 4804.567588917014, 4828.130936431476, 4848.418189817174, 4864.513548645178, 4865.318855360252, 6530.379613936669, 6579.638119903356, 6608.8347791305605, 6636.767713130017, 6725.461963042945, 7097.9645101775195, 7152.749653762094, 7158.391536719333, 7180.0, 7185.317394847481, 6599.637019963852, 6607.0, 6621.668916554249, 6699.933000670028, 6701.899471507932, 5930.080837470199, 5947.107933809876, 6004.909926351108, 6016.578839481194, 6050.273967123973, 7273.563586184846, 7388.15036270825, 7404.296591823768, 7450.776476705708, 7473.252674732484, 7119.96440017807, 7129.857402852018, 7144.9642751785905, 7180.676869540987, 7194.064771579661, 7395.297446742551, 7395.852082958203, 7401.64503022491, 7418.36943859778, 7527.2849079337375, 6930.618815964968, 6990.9164079567745, 6993.895091573732, 7084.539504932163, 7153.105861767279, 7120.679569419285, 7170.354668079898, 7191.065161529177, 7208.89186662211, 7218.747343843151, 6779.186497620317, 6807.217170025312, 6881.518293719391, 6928.549644273106, 6947.5831450113155, 6831.0436538883605, 6834.794956151323, 6836.0, 6837.0, 6846.383825455733, 6767.154105736783, 6777.085093512313, 6778.593284402755, 6785.050092987084, 6788.049673045876, 6891.345322194384, 6961.756338528127, 6968.268331825288, 6982.1272340957385, 7005.0, 6629.668516574248, 6672.499562532732, 6719.764808231688, 6769.695363708546, 6792.456603471809], "value": 6526.558473441271, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.700483474677, 900.3382513852313, 921.1019256225179, 947.625687853298, 949.976250593735, 45225.77387113064, 45285.0, 45418.772906135506, 45513.544864551346, 45561.77219113908, 41565.168696626046, 41727.374089388606, 41988.58011419885, 42005.15989680205, 42058.369124463155, 8025.0369955605265, 8108.7161949331785, 8141.267285944264, 8143.104258531557, 8146.0, 7936.722214722486, 7996.160403157672, 8008.199180081974, 8015.959920200391, 8017.0, 8710.825783484326, 8923.286137109015, 8927.687530936419, 8930.55347232639, 8930.687425940094, 8767.123287671213, 8827.249683776887, 8847.292216622654, 8851.867221991708, 8893.911060889437, 8748.693795717183, 8774.07872173419, 8823.0, 8823.911760882373, 8855.911440885573, 41201.1759764803, 41275.174496510204, 41408.0, 41507.58492415067, 41618.37572436416, 3819.579846216914, 3866.420036994445, 3868.12967082407, 3869.8645547405704, 3871.5160604924104, 33160.0, 33178.170545736306, 33357.33285334304, 33466.33067338664, 33484.665153348644, 5438.45615438453, 5490.533304669108, 5599.216109744639, 5655.4344565543115, 5686.0333743263745, 222535.0, 224158.0, 225092.0, 225390.0, 225803.87098064568, 51482.742586286826, 51602.0, 51803.222951655756, 51842.74078629583, 51898.74050629798, 54265.45734542604, 54528.72735636376, 54607.45392546103, 54740.0, 54898.72550637301, 17687.557811054827, 17847.46457606274, 18028.909855450638, 18029.18868650914, 18046.729299060524, 14824.629384265263, 14923.0, 15006.0, 15056.096634201984, 15079.773803392958, 15110.622234444007, 15368.231588420758, 15398.46105386306, 15517.689646207013, 15576.844231557767, 6115.089948358326, 6163.722632481549, 6232.532560058014, 6249.593776404519, 6259.1550140730415, 1110.1840147491587, 1116.2744216259334, 1119.6864877834219, 1129.271619805221, 1143.7941170589374, 25823.0, 26299.0, 26471.33821654474, 26534.46931061368, 26676.59985100186, 1228.8832560906699, 1230.7538492301576, 1235.7096082420624, 1254.2223821230896, 1257.1451413039222, 13731.588052358446, 13805.792913106312, 13814.516491922734, 14039.298035098203, 14052.22712750788, 310362.0, 313581.0, 327282.0, 329984.0, 331501.0, 57109.42890571041, 57461.0, 57500.0, 57796.42203577994, 57812.71093644505, 1515.4695856450155, 1542.7994360733032, 1560.0639616230171, 1560.4382422327953, 1589.7535881938318, 31130.0, 31229.219269518442, 31371.215719607193, 31859.0, 32238.35523289568, 42569.57430425656, 42732.78633606812, 42795.57204427916, 42806.0, 42819.357709633754, 269090.0, 269699.0, 270864.0, 271022.0, 272550.0, 36140.0, 36947.0, 37182.0, 37302.25395492129, 37537.0, 45990.540094598626, 47309.7634511839, 47345.0, 47493.0, 47630.761846190544, 34330.82834585811, 34573.30853382969, 34702.0, 35175.296494069466, 35380.29239415146, 34361.48457773085, 34418.311633767684, 34587.4811877817, 34764.13089672779, 35116.64883351134, 39852.60147398605, 41156.1768764617, 41179.7941010293, 41291.38062928998, 41302.586974129874, 33581.83209083939, 33647.495287570215, 33946.32107357888, 33961.0, 34502.65497344994, 25178.496430071664, 25508.48983020292, 25845.0, 26245.868770656787, 26285.737142628328], "value": 19188.3098671102, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.0046901107061, 643.0710803985671, 643.3068710648781, 646.7180044130148, 653.2795728327179, 23859.880700596495, 24796.75203247967, 24812.87593562034, 24817.379565510848, 24833.875830620866, 26414.33964150897, 26961.32596685084, 26979.055733049347, 27128.32179195521, 27134.864325678394, 6330.177076979986, 6540.182477190363, 6641.103451034097, 6670.59976401415, 6679.732810687567, 6737.427318677918, 6831.4534837212905, 6836.829079273009, 6840.931590684079, 6841.726330946756, 6562.737490500374, 6775.322467753234, 6796.864062718742, 6864.485163612724, 6867.313268673142, 6908.861822763567, 6926.376626103674, 6931.445484361239, 6953.478489113311, 6956.5478243913985, 6450.387213214737, 6497.577657452251, 6507.2191337039385, 6518.511111666644, 6527.0, 30734.23164420885, 31551.36897262065, 31819.0, 31955.84022079898, 32064.0, 2399.196269249786, 2477.1082410332265, 2478.91323803666, 2480.875956202183, 2482.91309804156, 20190.0, 20715.5856882863, 20748.85881276529, 20797.16811327545, 20847.583048338947, 2505.110685706566, 2536.543422184006, 2575.9098431554994, 2595.5587550116525, 2599.7790187834057, 146734.0, 153314.0, 162414.1879290596, 170396.0, 171085.0, 16265.674686506203, 16496.505104846874, 17124.229409676595, 17181.484555463358, 17279.74080388795, 27656.75544600498, 27830.3042423941, 27881.86059069732, 27914.441711165662, 27982.72017279801, 11139.443027848574, 11391.487383067783, 11640.825387619192, 11713.238639488405, 11763.764724705628, 10289.639862604923, 10296.227782916161, 10435.37387756737, 10503.68703912011, 10608.469576521298, 9920.503974801231, 10065.496725163712, 10126.54430550627, 10161.136303414145, 10415.739606509898, 2947.8083924545267, 2952.217662319487, 2966.2710306518056, 2989.9850500747357, 3157.905262842118, 1055.6199768083484, 1062.3519653011656, 1084.3493903657743, 1092.759592889563, 1105.690406686129, 21557.814320212226, 21686.89156554207, 21807.454813629785, 21934.89032554827, 22031.228906988177, 1131.620906996149, 1158.988410115905, 1159.3391766693073, 1169.2575214738702, 1175.9470823812949, 11924.165308428326, 11983.820242696367, 12102.757944841054, 12154.392280385946, 12231.69420764488, 634046.0, 644662.0, 659333.0, 661345.0, 692980.0, 142819.0, 143169.28415358064, 145072.0, 146350.0, 147884.0, 1268.9048321375933, 1290.6257185416125, 1313.6518822512041, 1356.1252991820024, 1373.601655519888, 22691.886540567193, 22804.65793013073, 22826.315210543045, 22856.800945386352, 22931.88534057319, 67716.0, 67754.0, 68023.65988170226, 69053.65473172603, 69134.65432673006, 87143.56428217818, 88223.0, 88868.11131888599, 89931.75170620787, 91743.54128229317, 16021.679566408373, 16178.595535111717, 16448.83551164473, 16566.50300490987, 16567.42014029503, 24036.158734444212, 24121.155759548332, 24123.155689550782, 24332.270031899072, 24508.50982980366, 19882.50293742668, 20132.0, 20282.59434811325, 20392.694109588072, 20473.181072756925, 16878.24047917822, 17340.91329543344, 17811.55471113181, 18414.079296035412, 18479.72280415768, 19381.51546211356, 19577.51056223549, 20689.482762931046, 20747.792522074586, 20833.895830521356, 16057.277422515781, 16208.10855402964, 16209.189540523163, 16219.594510136869, 16239.675206495567, 19392.61214775725, 19709.507262318555, 19898.104585293408, 19921.701174482103, 20086.0], "value": 13382.168906479836, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.1851653815593, 1475.3066058952288, 1480.1711041816584, 1485.4031915690634, 1496.887733419993, 17369.218385172666, 18019.279228830863, 18023.188956496957, 18029.188686509107, 18049.819501804977, 17408.39070632528, 17548.0, 17561.648767024682, 17580.120993950317, 17637.82362176378, 3037.7569794416395, 3098.5971823662894, 3139.5604615353755, 3151.921201969946, 3155.668654791248, 3003.279212988889, 3085.42919559881, 3086.1513083901996, 3089.845507724605, 3096.5974423325047, 3006.3235771951354, 3071.6006919100487, 3135.0281412762, 3138.5449109879055, 3138.890138845141, 3032.3328867649084, 3120.1731541141617, 3126.9843650781713, 3142.9371412571736, 3151.212196950774, 2906.433245517125, 2943.5878976943245, 2956.5712971618996, 2964.1552157635188, 2980.135760629415, 16565.337386504525, 16762.32950681971, 16824.83175168257, 16851.24169412367, 16861.915690421592, 8610.354223433205, 8898.911010889873, 8905.465672059698, 8909.777255568597, 8910.331725120643, 5699.116636921284, 5804.970975145097, 5849.888521181005, 5873.676947767871, 6089.3910608939195, 2074.782147874482, 2164.3182397544724, 2172.0334451169238, 2179.9891000544894, 2188.2669305782424, 31354.21614459634, 31534.211644708837, 31594.526082108787, 31628.841855790804, 31648.208794780083, 7219.530730502501, 7351.852962940711, 7397.519161254501, 7531.0, 7553.8866916996285, 20232.190712371634, 20472.97635118238, 20480.0, 20573.0, 20590.382288531368, 8712.695055673148, 8881.24509416694, 8883.689070882489, 8885.42244754089, 8926.73219803407, 8020.398470114765, 8078.192180781874, 8166.918330816735, 8199.180081991753, 8300.501969881827, 5819.94180058194, 6021.096835474714, 6027.186329845503, 6090.665013424305, 6091.0558863376245, 1477.4238047161616, 1486.0829529906516, 1697.6010637500178, 1712.9828701713072, 1731.9480415587552, 985.1183191043975, 992.5235886774244, 999.4952548962727, 1002.7894142230214, 1017.9185665146771, 8787.253083487847, 8843.51360675169, 8894.911050889537, 8899.866502002345, 8908.599113039929, 1014.1734486393713, 1056.2817284246632, 1068.4497483795851, 1069.4438891776233, 1083.6315652678127, 5188.533032027136, 5298.178782288752, 5401.405845357008, 5430.83707488776, 5510.476504732044, 25323.987040518543, 25878.87060564685, 26166.73833261681, 26513.204603861916, 26653.733462665514, 25582.616260756102, 26313.73686263151, 26320.34199145037, 26510.0, 26673.599896001186, 12819.743605127846, 12937.611871643678, 12963.481460741465, 13096.738065238642, 13111.409986550629, 9576.904230957602, 9676.56455459492, 9717.659881904383, 9802.0, 9902.0, 21438.249661262405, 21508.784912150677, 21882.0, 21957.451063723536, 21990.35072369547, 22462.88768556147, 22833.31500055001, 22964.0, 23006.42483937848, 23133.421664458525, 12909.935450322688, 13034.608961731163, 13200.0, 13202.537911173064, 13244.602661920158, 16114.597135071717, 16397.59006024859, 16482.42311519091, 16489.09309987962, 16514.66970660556, 12948.741025179632, 13043.0, 13180.670483237996, 13277.867221327662, 13329.733405332034, 12668.873311267138, 12979.935100324816, 12989.480420783062, 13101.148425352321, 13179.802302965654, 10071.597136114473, 10284.434356110187, 10287.948560257151, 10293.330933489298, 10318.845217321596, 8328.125546817497, 8388.790280243044, 8421.747347579583, 8555.914440855511, 8570.57147142628, 7749.496282741604, 7860.960695196487, 7919.524828510308, 7950.801229969297, 7963.12405635368], "value": 7566.66381882165, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.9913751293732, 580.0921557762099, 592.339541411326, 607.5382709141053, 616.7163104971713, 6268.247810262769, 6312.495000399968, 6350.841228969278, 6468.32082631324, 6484.1570595822595, 6213.378662133784, 6260.812175634738, 6300.369963003697, 6338.556301058928, 6353.745850165999, 5216.530512253897, 5236.947630523684, 5252.842414727565, 5267.894642107156, 5287.39194992575, 5003.849884503471, 5100.795968161269, 5239.921401178985, 5240.711760853152, 5255.658382205163, 5094.184930411135, 5116.488351164872, 5116.769745361467, 5139.451585346977, 5146.228065790124, 4987.526185012418, 4989.027139707722, 5065.265536497206, 5102.846914592549, 5105.753468473859, 4604.654650901162, 4612.192866248427, 4644.071185762861, 4664.463586687541, 4676.649251306166, 6127.816165515042, 6219.937800621981, 6236.282827474854, 6252.124702541648, 6332.303446620868, 5887.0286402743495, 5957.463828255434, 5986.491148252404, 5993.670348130851, 6004.78983235589, 6574.967125164344, 6662.367075127855, 6669.466442684574, 6691.230508491537, 6773.796786096425, 5152.355955505562, 5197.896042079137, 5212.739363031833, 5230.823064810425, 5236.3978142513715, 6794.76218332356, 6963.617001064939, 6974.302569743036, 7031.8593628127155, 7092.9290707093305, 5353.9196912046355, 5360.946390536123, 5366.221897824794, 5377.381601115843, 5383.5047735140815, 5396.2984811974975, 5402.108652072364, 5420.674759514442, 5441.075017247077, 5461.890762184734, 5971.313298970587, 5974.819190995256, 6016.548758843104, 6030.246219222598, 6047.425494578008, 6636.435902948304, 6653.700583473756, 6761.932380676229, 6775.62734049632, 6819.693113809891, 1860.3488778927267, 1863.6645403827442, 1872.6816441204755, 1903.1530968718787, 1905.8665893387606, 1287.9356032198352, 1319.9343028160897, 1348.4134401535364, 1362.8364596248316, 1367.2890097149625, 6362.491000719931, 6370.235571731329, 6380.776672816429, 6409.487241020707, 6425.967870160619, 6578.703958321887, 6692.330766923366, 6722.831929201809, 6833.248342682301, 6896.172459304916, 6325.683715814191, 6335.936640633627, 6344.048392741126, 6382.266039405435, 6485.67571621417, 3593.8382772774767, 3595.406757884972, 3595.7303202259936, 3600.5499312585926, 3608.350496910529, 7208.71165153388, 7229.421646268286, 7272.600006999666, 7275.818104547428, 7288.854222915618, 7096.254893236239, 7113.395361394236, 7115.679794409264, 7132.3580877720215, 7147.0, 7172.318629730167, 7189.209186989427, 7201.299512682849, 7222.277772222841, 7240.782776516713, 6862.279460656759, 6889.483288753263, 6916.3429474201885, 6917.0, 6926.653667316513, 6681.465482761465, 6816.420604248694, 6818.386345228953, 6835.726570937107, 6905.1713794345, 6987.580745155307, 7034.155901291878, 7040.5071644984355, 7152.320529549685, 7255.020572222894, 5247.134222853187, 5262.6316157870115, 5285.550728188147, 5319.920201197063, 5370.516653501204, 6577.2436169841085, 6789.72841086351, 6802.523823332319, 6815.625140617313, 6905.585664860125, 6257.468115210076, 6622.403983641495, 6628.746226282894, 6632.204135503771, 6712.899306510309, 6604.867902642017, 6635.137432133792, 6684.63234522106, 6692.59844409337, 6701.832454188684, 6276.215473065867, 6592.505562082767, 6646.534742567974, 6647.966760166169, 6703.8156875483755, 6704.0, 6733.360330768569, 6783.559068660718, 6784.6946887389195, 6827.419669328163, 6522.249941256627, 6558.213014438298, 6583.144191255106, 6585.267114147575, 6587.143671322698], "value": 5298.171434375909, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1021.1932573267125, 1029.8609687692162, 1052.4737631184407, 1053.7839742852716, 1057.6826951914427, 21186.89406552967, 21393.57212855742, 21701.02345394457, 22066.88966555169, 22123.0, 19489.220431182737, 19584.314548990787, 19642.90178549109, 19650.508737281576, 19656.803431965676, 1013.3413281367096, 1025.6410256410272, 1027.1577306608583, 1029.325791606499, 1036.6682661548307, 1102.5699977008974, 1107.224942540221, 1108.6784832398594, 1110.9333439993586, 1111.0, 1118.6196693124336, 1132.2810015640086, 1159.565163063851, 1162.9825552616676, 1167.4804711903207, 1146.3694967767735, 1147.833564133196, 1152.8847115288488, 1154.4920235096615, 1155.6128696886553, 841.5834162089805, 845.9788505287355, 850.8511010573125, 851.0213254757017, 851.6508231625004, 21051.578968420545, 21207.151713931424, 21403.464913377135, 21440.249591264386, 21831.235906743186, 23262.06951721929, 23648.0, 23853.0, 23975.496725081553, 24034.519309613886, 18953.24187032517, 19304.613907721767, 19336.4199074028, 19368.225270989144, 19511.609767804708, 4129.463169787939, 4203.516595591515, 4207.221663992172, 4207.873763787091, 4209.5790420957965, 128255.0, 148402.0, 158511.0, 161052.0, 168257.0, 18740.344087956855, 19263.807361926483, 19278.0, 19631.82209067432, 19851.503712407306, 35893.308806622066, 36422.27155456876, 36702.0, 36710.0, 37208.44187337192, 10553.155747540179, 10596.364218146937, 10638.0, 10661.253712240225, 10744.194185436123, 4854.514548545188, 4890.462049174588, 4945.7774400152075, 4952.876178095505, 4988.501149884983, 6630.701618427182, 6695.330466953265, 6721.0, 6723.731050757915, 6744.393004629607, 1326.6882282663566, 1358.8369395672582, 1375.40170026039, 1377.827771528559, 1382.4539306973688, 787.2127872127872, 790.6402586822982, 798.3652995868299, 800.1198681450358, 812.25272749071, 13996.950228732885, 14150.0, 14844.92577537127, 15056.849431505763, 15264.313105910262, 785.6621652689398, 792.2157064506213, 797.8843067755143, 806.3226889412921, 810.2505182705974, 6459.418652321314, 6507.7071531781185, 6611.50413718973, 6613.801585952429, 6671.532992690562, 144075.47545554285, 145238.0, 147120.0, 149008.0, 159387.0, 114043.42978285055, 115023.0, 127176.36411817881, 131305.0, 136984.31507842397, 114125.0, 114829.0, 117934.41032794953, 119079.99999999827, 121652.0, 14131.222782747047, 14784.408623654934, 14795.852041479448, 15185.772213417029, 15446.532579404939, 56078.43921560732, 56871.146932795215, 57476.71261643665, 57601.71199143978, 58236.4176358231, 93275.0, 96464.0, 98210.0, 98522.0, 100017.0, 20328.0, 20605.17579296811, 20624.27815026467, 20639.690404643643, 20684.689729653765, 24222.636660449756, 24278.27165185047, 24359.878200608884, 24389.14637987662, 24399.878000609882, 22588.435289117904, 22705.318840434815, 22746.886265568566, 22781.202657906895, 22789.202377916692, 20459.38621841347, 20520.38438846837, 20626.0, 20705.792942070388, 20741.170353186306, 21476.0, 21593.568128637653, 21852.0, 21875.343739687836, 22059.448513787283, 15530.301136448661, 16047.759283610989, 16104.114273715059, 16254.51236462908, 16389.508314750576, 14662.193579352812, 15504.224788760743, 15602.921985390001, 15658.608534786721, 15666.451674191349], "value": 10820.234544397843, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1364.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 104.0, 104.0, 105.0, 107.0, 104.0, 107.0, 105.0, 105.0, 105.0], "value": 105.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 113.0, 110.0, 138.0, 113.0, 111.0, 111.0, 118.0, 122.0], "value": 116.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 162.0, 162.0, 161.0, 160.0, 163.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 73.0, 73.0, 75.0, 73.0, 73.0, 75.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 77.0, 78.0, 79.0, 77.0, 80.0, 77.0, 77.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 115.0, 110.0, 117.0, 111.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 148.0, 152.0, 149.0, 148.0, 148.0, 152.0, 148.0, 148.0, 149.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 95.0, 98.0, 99.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 42.0, 47.0, 43.0, 44.0, 44.0, 44.0, 43.0, 43.0], "value": 43.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 38.0, 38.0, 39.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 71.0, 72.0, 69.0, 77.0, 72.0, 71.0, 70.0, 75.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 102.0, 105.0, 103.0, 111.0, 103.0, 105.0, 104.0, 103.0, 121.0], "value": 106.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 150.0, 149.0, 148.0, 155.0, 150.0, 146.0, 152.0, 147.0, 148.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 64.0, 60.0, 58.0, 61.0, 58.0, 61.0, 61.0], "value": 60.0, "unit": "score"}]}]} 04:57:35 INFO - Return code: 0 04:57:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:57:35 INFO - # TBPL SUCCESS # 04:57:35 INFO - Running post-action listener: _package_coverage_data 04:57:35 INFO - Running post-action listener: _resource_record_post_action 04:57:35 INFO - [mozharness: 2017-10-17 11:57:35.176223Z] Finished run-tests step (success) 04:57:35 INFO - Running post-run listener: _resource_record_post_run 04:57:35 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 440115200; Read time: 112; Write time: 265648 04:57:35 INFO - TinderboxPrint: CPU usage
13.1% 04:57:35 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 112 04:57:35 INFO - TinderboxPrint: I/O write bytes / time
440,115,200 / 265,648 04:57:35 INFO - TinderboxPrint: CPU idle
8,180.0 (86.9%) 04:57:35 INFO - TinderboxPrint: CPU user
1,179.8 (12.5%) 04:57:35 INFO - TinderboxPrint: Swap in / out
0 / 0 04:57:35 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 105213952; Read time: 104; Write time: 60844 04:57:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:57:35 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282521600; Read time: 8; Write time: 146016 04:57:35 INFO - Running post-run listener: _upload_blobber_files 04:57:35 INFO - Blob upload gear active. 04:57:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:57:35 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 04:57:35 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'] 04:57:35 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 04:57:36 INFO - (blobuploader) - INFO - Open directory for files ... 04:57:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:57:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:57:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:37 INFO - (blobuploader) - INFO - Done attempting. 04:57:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:57:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:57:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:44 INFO - (blobuploader) - INFO - Done attempting. 04:57:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:57:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:57:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:45 INFO - (blobuploader) - INFO - Done attempting. 04:57:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:57:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:57:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:46 INFO - (blobuploader) - INFO - Done attempting. 04:57:46 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:46 INFO - Return code: 0 04:57:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:57:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2646b8f524f05a8a852520f5ca66c56a63c31b9a0bf0b24282f4e4dbdad6337495c81608ad4b6cfd36f7b9a5efbc62a7e58402a774da17a018f44325b740c24d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c362829e9588d59e8f4376732318f2f5c2c16611c7c809178ec6dd711cb0354cdce07df5b497f30a98a83a51f7b32a3a897d3ff1937e2c3747cce3e3bb068873", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/44d2ed42dbb68326e7af36b244b7729b916b853393d51f686c55972efcc005d0dc971a8429fd1c7b31c4b59c62d6dc649685a8d583f89c9506275a6c6355bddb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/654a83322f3ea2793f92c376002b2925cf1b8b607895636005cf6559f862f0e3672d733cf54fbd34706cb6c533cda2dcff43a55540c91770c560802401dca20d"} 04:57:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:57:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:57:46 INFO - Contents: 04:57:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2646b8f524f05a8a852520f5ca66c56a63c31b9a0bf0b24282f4e4dbdad6337495c81608ad4b6cfd36f7b9a5efbc62a7e58402a774da17a018f44325b740c24d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c362829e9588d59e8f4376732318f2f5c2c16611c7c809178ec6dd711cb0354cdce07df5b497f30a98a83a51f7b32a3a897d3ff1937e2c3747cce3e3bb068873", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/44d2ed42dbb68326e7af36b244b7729b916b853393d51f686c55972efcc005d0dc971a8429fd1c7b31c4b59c62d6dc649685a8d583f89c9506275a6c6355bddb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/654a83322f3ea2793f92c376002b2925cf1b8b607895636005cf6559f862f0e3672d733cf54fbd34706cb6c533cda2dcff43a55540c91770c560802401dca20d"} 04:57:46 INFO - Running post-run listener: copy_logs_to_upload_dir 04:57:46 INFO - Copying logs to upload dir... 04:57:46 INFO - mkdir: /builds/slave/test/build/upload/logs 04:57:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.355174 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-10-17 04:57:46.201119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-17 04:57:46.205759) ========= 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=ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575 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/2646b8f524f05a8a852520f5ca66c56a63c31b9a0bf0b24282f4e4dbdad6337495c81608ad4b6cfd36f7b9a5efbc62a7e58402a774da17a018f44325b740c24d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c362829e9588d59e8f4376732318f2f5c2c16611c7c809178ec6dd711cb0354cdce07df5b497f30a98a83a51f7b32a3a897d3ff1937e2c3747cce3e3bb068873", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/44d2ed42dbb68326e7af36b244b7729b916b853393d51f686c55972efcc005d0dc971a8429fd1c7b31c4b59c62d6dc649685a8d583f89c9506275a6c6355bddb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/654a83322f3ea2793f92c376002b2925cf1b8b607895636005cf6559f862f0e3672d733cf54fbd34706cb6c533cda2dcff43a55540c91770c560802401dca20d"} build_url:https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011555 build_url: 'https://queue.taskcluster.net/v1/task/eyFwn2NRSNiePaal5ihiTw/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/2646b8f524f05a8a852520f5ca66c56a63c31b9a0bf0b24282f4e4dbdad6337495c81608ad4b6cfd36f7b9a5efbc62a7e58402a774da17a018f44325b740c24d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c362829e9588d59e8f4376732318f2f5c2c16611c7c809178ec6dd711cb0354cdce07df5b497f30a98a83a51f7b32a3a897d3ff1937e2c3747cce3e3bb068873", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/44d2ed42dbb68326e7af36b244b7729b916b853393d51f686c55972efcc005d0dc971a8429fd1c7b31c4b59c62d6dc649685a8d583f89c9506275a6c6355bddb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/654a83322f3ea2793f92c376002b2925cf1b8b607895636005cf6559f862f0e3672d733cf54fbd34706cb6c533cda2dcff43a55540c91770c560802401dca20d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-17 04:57:46.239301) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-17 04:57:46.239693) ========= 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=ca6c2627acea03e666270f68000001e0-1508240220.575062-731148575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004654 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-17 04:57:46.320230) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-17 04:57:46.323635) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-17 04:57:46.324002) ========= ========= Total master_lag: 0.22 =========