builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-037 starttime: 1505933057.89 results: success (0) revision: 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:17.885532) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:17.885936) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:17.886219) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:17.947775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:17.948050) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 11:44:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 93.3M=0s 2017-09-20 11:44:17 (93.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126497 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:18.130395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:18.130665) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017058 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:18.217253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-20 11:44:18.217581) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e --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=56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 11:44:18,189 truncating revision to first 12 chars 2017-09-20 11:44:18,189 Setting DEBUG logging. 2017-09-20 11:44:18,189 attempt 1/10 2017-09-20 11:44:18,189 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7b5664b73b5b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 11:44:18,904 unpacking tar archive at: mozilla-central-7b5664b73b5b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.988022 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-20 11:44:19.256710) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.256970) ========= script_repo_revision: 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.259360) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.259626) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.279393) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-20 11:44:19.279648) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:44:19 INFO - MultiFileLogger online at 20170920 11:44:19 in /builds/slave/test 11:44:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:44:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:44:19 INFO - {'append_to_log': False, 11:44:19 INFO - 'base_work_dir': '/builds/slave/test', 11:44:19 INFO - 'blob_upload_branch': 'Firefox', 11:44:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:44:19 INFO - 'branch': 'Firefox', 11:44:19 INFO - 'buildbot_json_path': 'buildprops.json', 11:44:19 INFO - 'code_coverage': False, 11:44:19 INFO - 'config_files': ('talos/linux_config.py',), 11:44:19 INFO - 'default_actions': ('clobber', 11:44:19 INFO - 'read-buildbot-config', 11:44:19 INFO - 'download-and-extract', 11:44:19 INFO - 'populate-webroot', 11:44:19 INFO - 'create-virtualenv', 11:44:19 INFO - 'install', 11:44:19 INFO - 'setup-mitmproxy', 11:44:19 INFO - 'run-tests'), 11:44:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:44:19 INFO - 'disable_ccov_upload': False, 11:44:19 INFO - 'disable_stylo': False, 11:44:19 INFO - 'download_minidump_stackwalk': True, 11:44:19 INFO - 'download_symbols': 'ondemand', 11:44:19 INFO - 'enable_stylo': False, 11:44:19 INFO - 'enable_webrender': False, 11:44:19 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:44:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:44:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:44:19 INFO - 'gecko_profile': False, 11:44:19 INFO - 'gecko_profile_interval': 0, 11:44:19 INFO - 'installer_path': 'installer.exe', 11:44:19 INFO - 'log_level': 'info', 11:44:19 INFO - 'log_name': 'talos', 11:44:19 INFO - 'log_to_console': True, 11:44:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:44:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:44:19 INFO - 'opt_config_files': (), 11:44:19 INFO - 'pip_index': False, 11:44:19 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:44:19 INFO - 'system_bits': '32', 11:44:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:44:19 INFO - 'title': 'talos-linux64-ix-037', 11:44:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:44:19 INFO - 'use_talos_json': True, 11:44:19 INFO - 'verify': 'False', 11:44:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:44:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:44:19 INFO - 'work_dir': 'build'} 11:44:19 INFO - [mozharness: 2017-09-20 18:44:19.374922Z] Running clobber step. 11:44:19 INFO - Running pre-action listener: _resource_record_pre_action 11:44:19 INFO - Running main action method: clobber 11:44:19 INFO - rmtree: /builds/slave/test/build 11:44:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:44:20 INFO - Running post-action listener: _resource_record_post_action 11:44:20 INFO - [mozharness: 2017-09-20 18:44:20.368477Z] Finished clobber step (success) 11:44:20 INFO - [mozharness: 2017-09-20 18:44:20.368573Z] Running read-buildbot-config step. 11:44:20 INFO - Running pre-action listener: _resource_record_pre_action 11:44:20 INFO - Running main action method: read_buildbot_config 11:44:20 INFO - Using buildbot properties: 11:44:20 INFO - { 11:44:20 INFO - "project": "", 11:44:20 INFO - "product": "firefox", 11:44:20 INFO - "who": "ffxbld@noreply.mozilla.org", 11:44:20 INFO - "installer_path": "public/build/target.tar.bz2", 11:44:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:44:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:44:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 11:44:20 INFO - "stage_platform": "linux64-pgo", 11:44:20 INFO - "basedir": "/builds/slave/test", 11:44:20 INFO - "buildnumber": 39, 11:44:20 INFO - "platform": "ubuntu64_hw", 11:44:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:44:20 INFO - "slavebuilddir": "test", 11:44:20 INFO - "taskId": "NnzChtiuRvWTVQuNF0jkow", 11:44:20 INFO - "branch": "mozilla-central", 11:44:20 INFO - "script_repo_revision": "production", 11:44:20 INFO - "revision": "7b5664b73b5bc700ee5c4befb10cdce2d9cff47e", 11:44:20 INFO - "slavename": "talos-linux64-ix-037", 11:44:20 INFO - "repo_path": "mozilla-central" 11:44:20 INFO - } 11:44:20 INFO - Finding installer, test and symbols from parent task. 11:44:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NnzChtiuRvWTVQuNF0jkow'}, attempt #1 11:44:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NnzChtiuRvWTVQuNF0jkow'}, attempt #1 11:44:21 INFO - Task dependencies: aIA_GDTzSB6yAt1pcYj2gA 11:44:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA'}, attempt #1 11:44:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2 11:44:21 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.test_packages.json 11:44:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.crashreporter-symbols.zip 11:44:21 INFO - Running post-action listener: _resource_record_post_action 11:44:21 INFO - [mozharness: 2017-09-20 18:44:21.803515Z] Finished read-buildbot-config step (success) 11:44:21 INFO - [mozharness: 2017-09-20 18:44:21.803732Z] Running download-and-extract step. 11:44:21 INFO - Running pre-action listener: _resource_record_pre_action 11:44:21 INFO - Running main action method: download_and_extract 11:44:21 INFO - mkdir: /builds/slave/test/build/tests 11:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:21 INFO - trying https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.test_packages.json 11:44:21 INFO - Downloading https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:44:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:44:22 INFO - Downloaded 989 bytes. 11:44:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:44:22 INFO - Using the following test package requirements: 11:44:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:44:22 INFO - u'common': [u'target.common.tests.zip'], 11:44:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:44:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:44:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:44:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:44:22 INFO - u'mozbase': [u'target.common.tests.zip'], 11:44:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:44:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:44:22 INFO - u'web-platform': [u'target.common.tests.zip', 11:44:22 INFO - u'target.web-platform.tests.tar.gz'], 11:44:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:44:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:44:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.common.tests.zip 11:44:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:44:22 INFO - Fetch https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.common.tests.zip into memory 11:44:25 INFO - Content-Length response header: 55323916 11:44:25 INFO - Bytes received: 55323916 11:44:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.talos.tests.zip 11:44:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:44:35 INFO - Fetch https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.talos.tests.zip into memory 11:44:37 INFO - Content-Length response header: 14508893 11:44:37 INFO - Bytes received: 14508893 11:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:37 INFO - trying https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2 11:44:37 INFO - Downloading https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:44:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:44:41 INFO - Downloaded 62280301 bytes. 11:44:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2 11:44:41 INFO - mkdir: /builds/slave/test/properties 11:44:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:44:41 INFO - Writing to file /builds/slave/test/properties/build_url 11:44:41 INFO - Contents: 11:44:41 INFO - build_url:https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2 11:44:41 INFO - Running post-action listener: _resource_record_post_action 11:44:41 INFO - Running post-action listener: find_tests_for_verification 11:44:41 INFO - Running post-action listener: set_extra_try_arguments 11:44:41 INFO - [mozharness: 2017-09-20 18:44:41.490958Z] Finished download-and-extract step (success) 11:44:41 INFO - [mozharness: 2017-09-20 18:44:41.491260Z] Running populate-webroot step. 11:44:41 INFO - Running pre-action listener: _resource_record_pre_action 11:44:41 INFO - Running main action method: populate_webroot 11:44:41 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:44:41 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['tresize', 11:44:41 INFO - 'tcanvasmark']}, 11:44:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:44:41 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['dromaeo_css', 11:44:41 INFO - 'kraken']}, 11:44:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:41 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'tests': ['damp', 'tps']}, 11:44:41 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['damp', 'tps']}, 11:44:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:44:41 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['dromaeo_dom']}, 11:44:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:44:41 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['basic_compositor_video', 11:44:41 INFO - 'glvideo']}, 11:44:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:44:41 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['ts_paint_webext', 11:44:41 INFO - 'tp5o_webext']}, 11:44:41 INFO - 'other-e10s': {'tests': ['a11yr', 11:44:41 INFO - 'ts_paint', 11:44:41 INFO - 'tpaint', 11:44:41 INFO - 'sessionrestore', 11:44:41 INFO - 'sessionrestore_many_windows', 11:44:41 INFO - 'sessionrestore_no_auto_restore', 11:44:41 INFO - 'tabpaint']}, 11:44:41 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['a11yr', 11:44:41 INFO - 'ts_paint', 11:44:41 INFO - 'tpaint', 11:44:41 INFO - 'sessionrestore', 11:44:41 INFO - 'sessionrestore_many_windows', 11:44:41 INFO - 'sessionrestore_no_auto_restore', 11:44:41 INFO - 'tabpaint']}, 11:44:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:44:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:44:42 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:42 INFO - 'tests': ['perf_reftest_singletons']}, 11:44:42 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:42 INFO - 'tests': ['bloom_basic']}, 11:44:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:44:42 INFO - 'tsvgr_opacity', 11:44:42 INFO - 'tart', 11:44:42 INFO - 'tscrollx', 11:44:42 INFO - 'tsvg_static']}, 11:44:42 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:42 INFO - 'tests': ['tsvgx', 11:44:42 INFO - 'tsvgr_opacity', 11:44:42 INFO - 'tart', 11:44:42 INFO - 'tscrollx', 11:44:42 INFO - 'tsvg_static']}, 11:44:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:44:42 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:44:42 INFO - 'talos_options': ['--disable-stylo'], 11:44:42 INFO - 'tests': ['tp5o']}, 11:44:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:44:42 INFO - 'talos_options': ['--mitmproxy', 11:44:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:44:42 INFO - '--firstNonBlankPaint'], 11:44:42 INFO - 'tests': ['tp6_google', 11:44:42 INFO - 'tp6_youtube', 11:44:42 INFO - 'tp6_amazon', 11:44:42 INFO - 'tp6_facebook']}, 11:44:42 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:44:42 INFO - 'talos_options': ['--disable-stylo', 11:44:42 INFO - '--mitmproxy', 11:44:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:44:42 INFO - '--firstNonBlankPaint'], 11:44:42 INFO - 'tests': ['tp6_google', 11:44:42 INFO - 'tp6_youtube', 11:44:42 INFO - 'tp6_amazon', 11:44:42 INFO - 'tp6_facebook']}, 11:44:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:44:42 INFO - 'talos_options': ['--stylo-threads=1', 11:44:42 INFO - '--mitmproxy', 11:44:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:44:42 INFO - '--firstNonBlankPaint'], 11:44:42 INFO - 'tests': ['tp6_google', 11:44:42 INFO - 'tp6_youtube', 11:44:42 INFO - 'tp6_amazon', 11:44:42 INFO - 'tp6_facebook']}, 11:44:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:44:42 INFO - 'talos_options': ['--xperf_path', 11:44:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:42 INFO - 'tests': ['tp5n']}, 11:44:42 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:44:42 INFO - 'talos_options': ['--disable-stylo', 11:44:42 INFO - '--xperf_path', 11:44:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:42 INFO - 'tests': ['tp5n']}}} 11:44:42 INFO - Running post-action listener: _resource_record_post_action 11:44:42 INFO - [mozharness: 2017-09-20 18:44:42.009894Z] Finished populate-webroot step (success) 11:44:42 INFO - [mozharness: 2017-09-20 18:44:42.009990Z] Running create-virtualenv step. 11:44:42 INFO - Running pre-action listener: _resource_record_pre_action 11:44:42 INFO - Running main action method: create_virtualenv 11:44:42 INFO - Creating virtualenv /builds/slave/test/build/venv 11:44:42 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:44:42 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:44:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:44:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:44:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:44:42 INFO - Installing distribute.............................................................................................................................................................................................done. 11:44:42 INFO - Installing pip...............done. 11:44:42 INFO - Return code: 0 11:44:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:44:42 INFO - Reading from file tmpfile_stdout 11:44:42 INFO - Output received: 11:44:42 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:44:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf00a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf04090>, '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 0xf04d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefef90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:44: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 pip>=1.5 11:44:43 INFO - Using env: {'DISPLAY': ':0', 11:44:43 INFO - 'HOME': '/home/cltbld', 11:44:43 INFO - 'LANG': 'en_US.UTF-8', 11:44:43 INFO - 'LANGUAGE': 'en_US:en', 11:44:43 INFO - 'LOGNAME': 'cltbld', 11:44:43 INFO - 'MAIL': '/var/mail/cltbld', 11:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:43 INFO - 'MOZ_NO_REMOTE': '1', 11:44:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:43 INFO - 'NO_EM_RESTART': '1', 11:44:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:43 INFO - 'PWD': '/builds/slave/test', 11:44:43 INFO - 'SHELL': '/bin/bash', 11:44:43 INFO - 'SHLVL': '1', 11:44:43 INFO - 'TERM': 'linux', 11:44:43 INFO - 'TMOUT': '86400', 11:44:43 INFO - 'USER': 'cltbld', 11:44:43 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 11:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:43 INFO - '_': '/tools/buildbot/bin/python'} 11:44:44 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:44:44 INFO - Downloading/unpacking pip>=1.5 11:44:44 INFO - Running setup.py egg_info for package pip 11:44:44 INFO - warning: no files found matching 'pip/cacert.pem' 11:44:44 INFO - warning: no files found matching '*.html' under directory 'docs' 11:44:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:44:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:44:44 INFO - Installing collected packages: pip 11:44:44 INFO - Found existing installation: pip 1.1 11:44:44 INFO - Uninstalling pip: 11:44:44 INFO - Successfully uninstalled pip 11:44:44 INFO - Running setup.py install for pip 11:44:44 INFO - warning: no files found matching 'pip/cacert.pem' 11:44:44 INFO - warning: no files found matching '*.html' under directory 'docs' 11:44:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:44:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:44:44 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:44:44 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:44:44 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:44:44 INFO - Successfully installed pip 11:44:44 INFO - Cleaning up... 11:44:44 INFO - Return code: 0 11:44:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf00a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf04090>, '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 0xf04d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefef90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:44:44 INFO - Using env: {'DISPLAY': ':0', 11:44:44 INFO - 'HOME': '/home/cltbld', 11:44:44 INFO - 'LANG': 'en_US.UTF-8', 11:44:44 INFO - 'LANGUAGE': 'en_US:en', 11:44:44 INFO - 'LOGNAME': 'cltbld', 11:44:44 INFO - 'MAIL': '/var/mail/cltbld', 11:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:44 INFO - 'MOZ_NO_REMOTE': '1', 11:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:44 INFO - 'NO_EM_RESTART': '1', 11:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:44 INFO - 'PWD': '/builds/slave/test', 11:44:44 INFO - 'SHELL': '/bin/bash', 11:44:44 INFO - 'SHLVL': '1', 11:44:44 INFO - 'TERM': 'linux', 11:44:44 INFO - 'TMOUT': '86400', 11:44:44 INFO - 'USER': 'cltbld', 11:44:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 11:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:44 INFO - '_': '/tools/buildbot/bin/python'} 11:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:44 INFO - Downloading/unpacking psutil>=3.1.1 11:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:44:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:45 INFO - Installing collected packages: psutil 11:44:45 INFO - Running setup.py install for psutil 11:44:45 INFO - building 'psutil._psutil_linux' extension 11:44:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:44:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:44:45 INFO - building 'psutil._psutil_posix' extension 11:44:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:44:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:44:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:46 INFO - Successfully installed psutil 11:44:46 INFO - Cleaning up... 11:44:46 INFO - Return code: 0 11:44:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf00a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf04090>, '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 0xf04d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefef90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:44:46 INFO - Using env: {'DISPLAY': ':0', 11:44:46 INFO - 'HOME': '/home/cltbld', 11:44:46 INFO - 'LANG': 'en_US.UTF-8', 11:44:46 INFO - 'LANGUAGE': 'en_US:en', 11:44:46 INFO - 'LOGNAME': 'cltbld', 11:44:46 INFO - 'MAIL': '/var/mail/cltbld', 11:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:46 INFO - 'MOZ_NO_REMOTE': '1', 11:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:46 INFO - 'NO_EM_RESTART': '1', 11:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:46 INFO - 'PWD': '/builds/slave/test', 11:44:46 INFO - 'SHELL': '/bin/bash', 11:44:46 INFO - 'SHLVL': '1', 11:44:46 INFO - 'TERM': 'linux', 11:44:46 INFO - 'TMOUT': '86400', 11:44:46 INFO - 'USER': 'cltbld', 11:44:46 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 11:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:46 INFO - '_': '/tools/buildbot/bin/python'} 11:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:44:47 INFO - Installing collected packages: mozsystemmonitor 11:44:47 INFO - Running setup.py install for mozsystemmonitor 11:44:47 INFO - Successfully installed mozsystemmonitor 11:44:47 INFO - Cleaning up... 11:44:48 INFO - Return code: 0 11:44:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf00a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf04090>, '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 0xf04d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefef90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:44:48 INFO - Using env: {'DISPLAY': ':0', 11:44:48 INFO - 'HOME': '/home/cltbld', 11:44:48 INFO - 'LANG': 'en_US.UTF-8', 11:44:48 INFO - 'LANGUAGE': 'en_US:en', 11:44:48 INFO - 'LOGNAME': 'cltbld', 11:44:48 INFO - 'MAIL': '/var/mail/cltbld', 11:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:48 INFO - 'MOZ_NO_REMOTE': '1', 11:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:48 INFO - 'NO_EM_RESTART': '1', 11:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:48 INFO - 'PWD': '/builds/slave/test', 11:44:48 INFO - 'SHELL': '/bin/bash', 11:44:48 INFO - 'SHLVL': '1', 11:44:48 INFO - 'TERM': 'linux', 11:44:48 INFO - 'TMOUT': '86400', 11:44:48 INFO - 'USER': 'cltbld', 11:44:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 11:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:48 INFO - '_': '/tools/buildbot/bin/python'} 11:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:48 INFO - Downloading/unpacking jsonschema==2.5.1 11:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:44:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:49 INFO - Downloading functools32-3.2.3-2.tar.gz 11:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:44:49 INFO - warning: no files found matching '*.txt' 11:44:49 INFO - no previously-included directories found matching 'build' 11:44:49 INFO - no previously-included directories found matching 'dist' 11:44:49 INFO - no previously-included directories found matching '.git*' 11:44:49 INFO - Installing collected packages: jsonschema, functools32 11:44:49 INFO - Running setup.py install for functools32 11:44:50 INFO - warning: no files found matching '*.txt' 11:44:50 INFO - no previously-included directories found matching 'build' 11:44:50 INFO - no previously-included directories found matching 'dist' 11:44:50 INFO - no previously-included directories found matching '.git*' 11:44:50 INFO - Successfully installed jsonschema functools32 11:44:50 INFO - Cleaning up... 11:44:50 INFO - Return code: 0 11:44:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:50 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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf00a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf04090>, '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 0xf04d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefef90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:44:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:44:50 INFO - Using env: {'DISPLAY': ':0', 11:44:50 INFO - 'HOME': '/home/cltbld', 11:44:50 INFO - 'LANG': 'en_US.UTF-8', 11:44:50 INFO - 'LANGUAGE': 'en_US:en', 11:44:50 INFO - 'LOGNAME': 'cltbld', 11:44:50 INFO - 'MAIL': '/var/mail/cltbld', 11:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:50 INFO - 'MOZ_NO_REMOTE': '1', 11:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:50 INFO - 'NO_EM_RESTART': '1', 11:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:50 INFO - 'PWD': '/builds/slave/test', 11:44:50 INFO - 'SHELL': '/bin/bash', 11:44:50 INFO - 'SHLVL': '1', 11:44:50 INFO - 'TERM': 'linux', 11:44:50 INFO - 'TMOUT': '86400', 11:44:50 INFO - 'USER': 'cltbld', 11:44:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 11:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:50 INFO - '_': '/tools/buildbot/bin/python'} 11:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:44:50 INFO - Cleaning up... 11:44:50 INFO - Return code: 0 11:44:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:50 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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf00a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf04090>, '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 0xf04d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefef90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:44:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:44:50 INFO - Using env: {'DISPLAY': ':0', 11:44:50 INFO - 'HOME': '/home/cltbld', 11:44:50 INFO - 'LANG': 'en_US.UTF-8', 11:44:50 INFO - 'LANGUAGE': 'en_US:en', 11:44:50 INFO - 'LOGNAME': 'cltbld', 11:44:50 INFO - 'MAIL': '/var/mail/cltbld', 11:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:50 INFO - 'MOZ_NO_REMOTE': '1', 11:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:50 INFO - 'NO_EM_RESTART': '1', 11:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:50 INFO - 'PWD': '/builds/slave/test', 11:44:50 INFO - 'SHELL': '/bin/bash', 11:44:50 INFO - 'SHLVL': '1', 11:44:50 INFO - 'TERM': 'linux', 11:44:50 INFO - 'TMOUT': '86400', 11:44:50 INFO - 'USER': 'cltbld', 11:44:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 11:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:50 INFO - '_': '/tools/buildbot/bin/python'} 11:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:50 INFO - Downloading/unpacking blobuploader==1.2.4 11:44: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 11:44: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 11:44: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 11:44: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 11:44:51 INFO - Downloading blobuploader-1.2.4.tar.gz 11:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:44:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:44:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:44: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 11:44: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 11:44: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 11:44: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 11:44:52 INFO - Downloading docopt-0.6.1.tar.gz 11:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:44:52 INFO - Installing collected packages: blobuploader, requests, docopt 11:44:52 INFO - Running setup.py install for blobuploader 11:44:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:44:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:44:52 INFO - Running setup.py install for requests 11:44:52 INFO - Running setup.py install for docopt 11:44:52 INFO - Successfully installed blobuploader requests docopt 11:44:52 INFO - Cleaning up... 11:44:52 INFO - Return code: 0 11:44:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:52 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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf00a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf04090>, '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 0xf04d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefef90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:44:52 INFO - Using env: {'DISPLAY': ':0', 11:44:52 INFO - 'HOME': '/home/cltbld', 11:44:52 INFO - 'LANG': 'en_US.UTF-8', 11:44:52 INFO - 'LANGUAGE': 'en_US:en', 11:44:52 INFO - 'LOGNAME': 'cltbld', 11:44:52 INFO - 'MAIL': '/var/mail/cltbld', 11:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:52 INFO - 'MOZ_NO_REMOTE': '1', 11:44:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:52 INFO - 'NO_EM_RESTART': '1', 11:44:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:52 INFO - 'PWD': '/builds/slave/test', 11:44:52 INFO - 'SHELL': '/bin/bash', 11:44:52 INFO - 'SHLVL': '1', 11:44:52 INFO - 'TERM': 'linux', 11:44:52 INFO - 'TMOUT': '86400', 11:44:52 INFO - 'USER': 'cltbld', 11:44:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 11:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:52 INFO - '_': '/tools/buildbot/bin/python'} 11:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:53 INFO - Running setup.py (path:/tmp/pip-HRPDcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:53 INFO - Running setup.py (path:/tmp/pip-CvrFDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:53 INFO - Running setup.py (path:/tmp/pip-yZm_nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:53 INFO - Running setup.py (path:/tmp/pip-t6O7FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:53 INFO - Running setup.py (path:/tmp/pip-Za526C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:53 INFO - Running setup.py (path:/tmp/pip-OWkXPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:53 INFO - Running setup.py (path:/tmp/pip-X16UdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:53 INFO - Running setup.py (path:/tmp/pip-2x8son-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:53 INFO - Running setup.py (path:/tmp/pip-Rq5jkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:53 INFO - Running setup.py (path:/tmp/pip-TgCWcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:53 INFO - Running setup.py (path:/tmp/pip-tfHkki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:53 INFO - Running setup.py (path:/tmp/pip-lEDywV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:53 INFO - Running setup.py (path:/tmp/pip-WUhmLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:53 INFO - Running setup.py (path:/tmp/pip-uydNmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:54 INFO - Running setup.py (path:/tmp/pip-qu2tEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:54 INFO - Running setup.py (path:/tmp/pip-8ooGiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:54 INFO - Running setup.py (path:/tmp/pip-DBozCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:44:54 INFO - Running setup.py install for manifestparser 11:44:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:44:54 INFO - Running setup.py install for mozcrash 11:44:54 INFO - Running setup.py install for mozdebug 11:44:54 INFO - Running setup.py install for mozdevice 11:44:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:44:54 INFO - Running setup.py install for mozfile 11:44:54 INFO - Running setup.py install for mozhttpd 11:44:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:44:54 INFO - Running setup.py install for mozinfo 11:44:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:44:54 INFO - Running setup.py install for mozInstall 11:44:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Running setup.py install for mozleak 11:44:55 INFO - Running setup.py install for mozlog 11:44:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Running setup.py install for moznetwork 11:44:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Running setup.py install for mozprocess 11:44:55 INFO - Running setup.py install for mozprofile 11:44:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Running setup.py install for mozrunner 11:44:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Running setup.py install for mozscreenshot 11:44:55 INFO - Running setup.py install for moztest 11:44:55 INFO - Running setup.py install for mozversion 11:44:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:44:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:44:56 INFO - Cleaning up... 11:44:56 INFO - Return code: 0 11:44:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:56 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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf00a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf04090>, '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 0xf04d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefef90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:44:56 INFO - Using env: {'DISPLAY': ':0', 11:44:56 INFO - 'HOME': '/home/cltbld', 11:44:56 INFO - 'LANG': 'en_US.UTF-8', 11:44:56 INFO - 'LANGUAGE': 'en_US:en', 11:44:56 INFO - 'LOGNAME': 'cltbld', 11:44:56 INFO - 'MAIL': '/var/mail/cltbld', 11:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:56 INFO - 'MOZ_NO_REMOTE': '1', 11:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:56 INFO - 'NO_EM_RESTART': '1', 11:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:56 INFO - 'PWD': '/builds/slave/test', 11:44:56 INFO - 'SHELL': '/bin/bash', 11:44:56 INFO - 'SHLVL': '1', 11:44:56 INFO - 'TERM': 'linux', 11:44:56 INFO - 'TMOUT': '86400', 11:44:56 INFO - 'USER': 'cltbld', 11:44:56 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 11:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:56 INFO - '_': '/tools/buildbot/bin/python'} 11:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:56 INFO - Running setup.py (path:/tmp/pip-wNvVIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:56 INFO - Running setup.py (path:/tmp/pip-7BPAyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:56 INFO - Running setup.py (path:/tmp/pip-wmetbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:56 INFO - Running setup.py (path:/tmp/pip-NNXVj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:56 INFO - Running setup.py (path:/tmp/pip-5FBL9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:56 INFO - Running setup.py (path:/tmp/pip-QlugoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:56 INFO - Running setup.py (path:/tmp/pip-kgePr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:56 INFO - Running setup.py (path:/tmp/pip-7Pq6xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:56 INFO - Running setup.py (path:/tmp/pip-uEHrHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:56 INFO - Running setup.py (path:/tmp/pip-kfRW_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:56 INFO - Running setup.py (path:/tmp/pip-PhC9ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:57 INFO - Running setup.py (path:/tmp/pip-_9Phe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:57 INFO - Running setup.py (path:/tmp/pip-Da0csa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:57 INFO - Running setup.py (path:/tmp/pip-x7PMrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:57 INFO - Running setup.py (path:/tmp/pip-GxeWSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:57 INFO - Running setup.py (path:/tmp/pip-Lhs_WO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:57 INFO - Running setup.py (path:/tmp/pip-fweW0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:44:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:58 INFO - Downloading blessings-1.6.tar.gz 11:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:44:58 INFO - Installing collected packages: blessings 11:44:58 INFO - Running setup.py install for blessings 11:44:58 INFO - Successfully installed blessings 11:44:58 INFO - Cleaning up... 11:44:58 INFO - Return code: 0 11:44:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:44:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:59 INFO - Reading from file tmpfile_stdout 11:44:59 INFO - Current package versions: 11:44:59 INFO - argparse == 1.2.1 11:44:59 INFO - blessings == 1.6 11:44:59 INFO - blobuploader == 1.2.4 11:44:59 INFO - docopt == 0.6.1 11:44:59 INFO - functools32 == 3.2.3-2 11:44:59 INFO - jsonschema == 2.5.1 11:44:59 INFO - manifestparser == 1.1 11:44:59 INFO - mozInstall == 1.13 11:44:59 INFO - mozcrash == 1.0 11:44:59 INFO - mozdebug == 0.1 11:44:59 INFO - mozdevice == 0.51 11:44:59 INFO - mozfile == 1.2 11:44:59 INFO - mozhttpd == 0.7 11:44:59 INFO - mozinfo == 0.10 11:44:59 INFO - mozleak == 0.1 11:44:59 INFO - mozlog == 3.5 11:44:59 INFO - moznetwork == 0.27 11:44:59 INFO - mozprocess == 0.25 11:44:59 INFO - mozprofile == 0.28 11:44:59 INFO - mozrunner == 6.13 11:44:59 INFO - mozscreenshot == 0.1 11:44:59 INFO - mozsystemmonitor == 0.3 11:44:59 INFO - moztest == 0.8 11:44:59 INFO - mozversion == 1.4 11:44:59 INFO - psutil == 3.1.1 11:44:59 INFO - requests == 1.2.3 11:44:59 INFO - wsgiref == 0.1.2 11:44:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:59 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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf00a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf04090>, '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 0xf04d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefef90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:44:59 INFO - Using env: {'DISPLAY': ':0', 11:44:59 INFO - 'HOME': '/home/cltbld', 11:44:59 INFO - 'LANG': 'en_US.UTF-8', 11:44:59 INFO - 'LANGUAGE': 'en_US:en', 11:44:59 INFO - 'LOGNAME': 'cltbld', 11:44:59 INFO - 'MAIL': '/var/mail/cltbld', 11:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:59 INFO - 'MOZ_NO_REMOTE': '1', 11:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:59 INFO - 'NO_EM_RESTART': '1', 11:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:59 INFO - 'PWD': '/builds/slave/test', 11:44:59 INFO - 'SHELL': '/bin/bash', 11:44:59 INFO - 'SHLVL': '1', 11:44:59 INFO - 'TERM': 'linux', 11:44:59 INFO - 'TMOUT': '86400', 11:44:59 INFO - 'USER': 'cltbld', 11:44:59 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 11:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:59 INFO - '_': '/tools/buildbot/bin/python'} 11:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:44:59 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:45:00 INFO - Installing collected packages: simplejson 11:45:00 INFO - Running setup.py install for simplejson 11:45:00 INFO - building 'simplejson._speedups' extension 11:45:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:45:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:45:01 INFO - Successfully installed simplejson 11:45:01 INFO - Cleaning up... 11:45:01 INFO - Return code: 0 11:45:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:01 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 0xb941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf00a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf04090>, '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 0xf04d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefef90>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:45:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:45:01 INFO - Using env: {'DISPLAY': ':0', 11:45:01 INFO - 'HOME': '/home/cltbld', 11:45:01 INFO - 'LANG': 'en_US.UTF-8', 11:45:01 INFO - 'LANGUAGE': 'en_US:en', 11:45:01 INFO - 'LOGNAME': 'cltbld', 11:45:01 INFO - 'MAIL': '/var/mail/cltbld', 11:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:01 INFO - 'MOZ_NO_REMOTE': '1', 11:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:01 INFO - 'NO_EM_RESTART': '1', 11:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:01 INFO - 'PWD': '/builds/slave/test', 11:45:01 INFO - 'SHELL': '/bin/bash', 11:45:01 INFO - 'SHLVL': '1', 11:45:01 INFO - 'TERM': 'linux', 11:45:01 INFO - 'TMOUT': '86400', 11:45:01 INFO - 'USER': 'cltbld', 11:45:01 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 11:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:01 INFO - '_': '/tools/buildbot/bin/python'} 11:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:45:01 INFO - Cleaning up... 11:45:01 INFO - Return code: 0 11:45:01 INFO - Running post-action listener: _resource_record_post_action 11:45:01 INFO - Running post-action listener: _start_resource_monitoring 11:45:01 INFO - Starting resource monitoring. 11:45:01 INFO - [mozharness: 2017-09-20 18:45:01.729307Z] Finished create-virtualenv step (success) 11:45:01 INFO - [mozharness: 2017-09-20 18:45:01.729875Z] Running install step. 11:45:01 INFO - Running pre-action listener: _resource_record_pre_action 11:45:01 INFO - Running main action method: install 11:45:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:45:01 INFO - Reading from file tmpfile_stdout 11:45:01 INFO - Detecting whether we're running mozinstall >=1.0... 11:45:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:45:02 INFO - Reading from file tmpfile_stdout 11:45:02 INFO - Output received: 11:45:02 INFO - Usage: mozinstall [options] installer 11:45:02 INFO - Options: 11:45:02 INFO - -h, --help show this help message and exit 11:45:02 INFO - -d DEST, --destination=DEST 11:45:02 INFO - Directory to install application into. [default: 11:45:02 INFO - "/builds/slave/test"] 11:45:02 INFO - --app=APP Application being installed. [default: firefox] 11:45:02 INFO - mkdir: /builds/slave/test/build/application 11:45:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:45:19 INFO - Reading from file tmpfile_stdout 11:45:19 INFO - Output received: 11:45:19 INFO - /builds/slave/test/build/application/firefox/firefox 11:45:19 INFO - Running post-action listener: _resource_record_post_action 11:45:19 INFO - [mozharness: 2017-09-20 18:45:19.665223Z] Finished install step (success) 11:45:19 INFO - [mozharness: 2017-09-20 18:45:19.665368Z] Running setup-mitmproxy step. 11:45:19 INFO - Running pre-action listener: _resource_record_pre_action 11:45:19 INFO - Running main action method: setup_mitmproxy 11:45:19 INFO - Skipping: mitmproxy is not required 11:45:19 INFO - Running post-action listener: _resource_record_post_action 11:45:19 INFO - [mozharness: 2017-09-20 18:45:19.666408Z] Finished setup-mitmproxy step (success) 11:45:19 INFO - [mozharness: 2017-09-20 18:45:19.666627Z] Running run-tests step. 11:45:19 INFO - Running pre-action listener: _resource_record_pre_action 11:45:19 INFO - Running pre-action listener: _set_gcov_prefix 11:45:19 INFO - Running main action method: run_tests 11:45:19 WARNING - Try message not found. 11:45:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:45:19 INFO - Python 2.7.3 11:45:19 INFO - Return code: 0 11:45:19 INFO - grabbing minidump binary from tooltool 11:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:19 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 0xf04090>, '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 0xf04d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:45:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:45:19 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:45:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:45:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:45:19 INFO - Return code: 0 11:45:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:45:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:45:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:45:19 INFO - ENV: RUST_BACKTRACE is now full 11:45:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:45:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:45:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 11:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 11:45:19 INFO - Using env: {'DISPLAY': ':0', 11:45:19 INFO - 'HOME': '/home/cltbld', 11:45:19 INFO - 'LANG': 'en_US.UTF-8', 11:45:19 INFO - 'LANGUAGE': 'en_US:en', 11:45:19 INFO - 'LOGNAME': 'cltbld', 11:45:19 INFO - 'MAIL': '/var/mail/cltbld', 11:45:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:45:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:19 INFO - 'MOZ_NO_REMOTE': '1', 11:45:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:19 INFO - 'NO_EM_RESTART': '1', 11:45:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:19 INFO - 'PWD': '/builds/slave/test', 11:45:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:45:19 INFO - 'RUST_BACKTRACE': 'full', 11:45:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:45:19 INFO - 'SHELL': '/bin/bash', 11:45:19 INFO - 'SHLVL': '1', 11:45:19 INFO - 'TERM': 'linux', 11:45:19 INFO - 'TMOUT': '86400', 11:45:19 INFO - 'USER': 'cltbld', 11:45:19 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 11:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:19 INFO - '_': '/tools/buildbot/bin/python'} 11:45:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 11:45:20 INFO - mozversion application_buildid: 20170920172637 11:45:20 INFO - mozversion application_changeset: 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e 11:45:20 INFO - mozversion application_display_name: Nightly 11:45:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:45:20 INFO - mozversion application_name: Firefox 11:45:20 INFO - mozversion application_remotingname: firefox 11:45:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:45:20 INFO - mozversion application_vendor: Mozilla 11:45:20 INFO - mozversion application_version: 57.0a1 11:45:20 INFO - mozversion platform_buildid: 20170920172637 11:45:20 INFO - mozversion platform_changeset: 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e 11:45:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:45:20 INFO - mozversion platform_version: 57.0a1 11:45:20 INFO - using testdate: 1505933120 11:45:20 INFO - actual date: 1505933120 11:45:20 INFO - starting webserver on 'localhost:39031' 11:45:20 INFO - SUITE-START | Running 2 tests 11:45:20 INFO - TEST-START | dromaeo_css 11:45:20 INFO - Initialising browser for dromaeo_css test... 11:45:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39031/getInfo.html -profile /tmp/tmp45Jjzs/profile 11:45:20 INFO - TEST-INFO | started process 30036 (/builds/slave/test/build/application/firefox/firefox http://localhost:39031/getInfo.html) 11:45:25 INFO - TEST-INFO | 30036: exit 0 11:45:25 INFO - Browser initialized. 11:45:25 INFO - Running cycle 1/1 for dromaeo_css test... 11:45:25 INFO - Using env: {'DISPLAY': ':0', 11:45:25 INFO - 'HOME': '/home/cltbld', 11:45:25 INFO - 'JSGC_DISABLE_POISONING': '1', 11:45:25 INFO - 'LANG': 'en_US.UTF-8', 11:45:25 INFO - 'LANGUAGE': 'en_US:en', 11:45:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:45:25 INFO - 'LOGNAME': 'cltbld', 11:45:25 INFO - 'MAIL': '/var/mail/cltbld', 11:45:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:45:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:45:25 INFO - 'MOZ_CRASHREPORTER': '1', 11:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:45:25 INFO - 'MOZ_NO_REMOTE': '1', 11:45:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:25 INFO - 'NO_EM_RESTART': '1', 11:45:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:25 INFO - 'PWD': '/builds/slave/test', 11:45:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:45:25 INFO - 'RUST_BACKTRACE': 'full', 11:45:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:45:25 INFO - 'SHELL': '/bin/bash', 11:45:25 INFO - 'SHLVL': '1', 11:45:25 INFO - 'STYLO_FORCE_DISABLED': '1', 11:45:25 INFO - 'TERM': 'linux', 11:45:25 INFO - 'TMOUT': '86400', 11:45:25 INFO - 'USER': 'cltbld', 11:45:25 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 11:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:25 INFO - '_': '/tools/buildbot/bin/python'} 11:45:25 INFO - TEST-INFO | started process 30273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp45Jjzs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:45:26 INFO - PID 30273 | 11:45:26 INFO - PID 30273 | (/builds/slave/test/build/application/firefox/firefox:30323): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:45:26 INFO - PID 30273 | 11:45:36 INFO - PID 30273 | RSS: Main: 147968000 11:45:36 INFO - PID 30273 | 11:48:34 INFO - PID 30273 | Cycle 1(1): loaded http://localhost:39031/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39031/tests/dromaeo/cssquery-ext.html) 11:48:35 INFO - PID 30273 | RSS: Main: 148926464 11:48:35 INFO - PID 30273 | 11:51:37 INFO - PID 30273 | Cycle 1(1): loaded http://localhost:39031/tests/dromaeo/cssquery-ext.html (next: http://localhost:39031/tests/dromaeo/cssquery-jquery.html) 11:51:37 INFO - PID 30273 | RSS: Main: 149569536 11:51:37 INFO - PID 30273 | 11:54:39 INFO - PID 30273 | Cycle 1(1): loaded http://localhost:39031/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39031/tests/dromaeo/cssquery-mootools.html) 11:54:40 INFO - PID 30273 | RSS: Main: 150884352 11:54:40 INFO - PID 30273 | 11:57:41 INFO - PID 30273 | Cycle 1(1): loaded http://localhost:39031/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39031/tests/dromaeo/cssquery-prototype.html) 11:57:42 INFO - PID 30273 | RSS: Main: 149962752 11:57:42 INFO - PID 30273 | 12:00:45 INFO - PID 30273 | Cycle 1(1): loaded http://localhost:39031/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39031/tests/dromaeo/cssquery-yui.html) 12:00:45 INFO - PID 30273 | RSS: Main: 150900736 12:00:45 INFO - PID 30273 | 12:03:47 INFO - PID 30273 | Cycle 1(1): loaded http://localhost:39031/tests/dromaeo/cssquery-yui.html (next: http://localhost:39031/tests/dromaeo/cssquery-dojo.html) 12:03:47 INFO - PID 30273 | RSS: Main: 153149440 12:03:47 INFO - PID 30273 | 12:03:47 INFO - PID 30273 | __start_tp_report 12:03:47 INFO - PID 30273 | _x_x_mozilla_page_load 12:03:47 INFO - PID 30273 | _x_x_mozilla_page_load_details 12:03:47 INFO - PID 30273 | |i|pagename|runs| 12:03:47 INFO - PID 30273 | |0;dojo.html;3842.3275926712818;3843.442700808383;3859.691224702024;3866.188100498895;3868.0523271798415;6246.063090536421;6304.369563043693;6345.206849143857;6349.0476428535685;6459.6447195404235;6300.991841305392;6326.810195694136;6338.841528961778;6340.619562826234;6364.968175159118;5622.269105016342;5645.560382102558;5649.887002259952;5656.915146272789;5703.258576385064;5728.914066289009;5759.798407055754;5769.394213607574;5798.478136967672;5814.098814683731;5723.627964182315;5762.798302059428;5844.736986835582;5847.5614328925285;5862.97068514659;5537;5643.971780141114;5666.178404131378;5743.8564035899435;5770.394108618577;5686.800961966353;5692.117721753135;5755.740991655385;5756.510696590794;5760.0207964646115;6203.286622038433;6304.117423560705;6318.620882747004;6343.714532846033;6423.293437721847;6768.221654509745;6773;6779.62712050837;6785.660716964181;6814.284500127515;6860.142482189726;6888.690008949609;6938.271481494471;6945.270746571588;6945.687444065029;6362;6438.323975982501;6442.452391546724;6451.83870403239;6458.547901646886;6960.129983752031;7045.92954070463;7100.360967512948;7115.359617634438;7117.217106118323;6656.334366563305;6732.730690772412;6743.696533655997;6763.830904227335;6797.93202067973;6908.1019467468905;6914.965425172842;6916.792496225121;6938.826529336706;6939.757108501179;6806.149231346082;6832.419244364285;6878;6884.483663725241;6915.170179578483;6813.386795188457;6821.590704557742;6905.37851593359;6908.205556360982;6914.170299564084;4883.731394773251;4884.096442158212;4892.168331383673;4906.55840974314;4914.975425122923;4544.97727511367;4551.8179272829375;4555.202839503074;4607.815687372535;4623.42207224097;6256.468200203034;6265.028920517327;6276.748930042839;6330.145430366933;6331.2085989251345;6811.557248778813;6864.931350686529;6873.175218973755;6971.372576468142;6972.163340399185;6282.277538083179;6319.020551814384;6335.461485773669;6337.809865704036;6340.3342649022115;5496.230527726121;5554.583406244547;5586.804461843816;5588.832335029955;5595.916061259084;7002.614856182959;7009.509334346547;7028.648567571601;7085.92914070863;7101.431885449152;6761.628110453972;6838.350356716104;6839.93160068393;6861.485388595976;6952.5480843745;7036.472264580279;7051.400630946427;7055.223925368308;7079.43364530826;7081.610511421921;6670.299618539983;6779.72881084751;6850.38346548813;6868.862622747617;6892.414144797748;6708.6310252936555;6798.558093723892;6830.726770929107;6862.897056544256;6938.444924405934;6492.707828147839;6493.610383377012;6504.089427480062;6551.672416379257;6584.341565843569;6642.734290628321;6655.966720166368;6657.3342665733035;6684.131062961784;6711.0940023096255;6492.675366231764;6523.380278873499;6558.1802274715665;6673.766418175341;6676.699548520425;6686.364795344434;6712.664366781543;6714.2278637955305;6723.2604413515455;6758.763443279461;6347.936520634735;6420.6789660517725;6450.838729031811;6452.161219041494;6517.348265173445 12:03:47 INFO - PID 30273 | |1;ext.html;935.4995077633467;960.8606752020961;962.1196605106327;968.6754937096073;974.6345120579782;42839.57160428395;43361.34957975629;43382.78308608461;43392.566074339244;43524.12951740963;40377;40547.18905621886;40573.59426405735;40842;40916.181676366454;7728.536287822734;7854.096778870417;7857.567833769141;7858.174891636381;7859.607019649024;7616.086069671647;7683.193264707209;7693.807654808618;7695.999520062384;7697.730579429721;7662.195469475709;7678.846423071535;8367.079621241659;8462.788430289262;8532.189442003;8452.15478452153;8490.872636910452;8505.064442911274;8522.190391912758;8524.659013639446;7917;8068.919310806876;8372.958135209285;8456.830863382698;8458.238758511701;39159;39270;39515.20969580593;39558.406623900664;39565;3699.4820725098507;3739.0652336915773;3743.0642339415144;3754.887353379403;3759.548854137521;32119.678803211904;32620.673793262;32693.836530817433;32789.344213115844;32833.343333133205;5496.80761173357;5525.557955363602;5533.612647114704;5537.750801213955;5576.665400075968;212214;212699;212838;212906;213176;50354.748226258635;50466.74766626217;50640;50658.74670626623;50667.493325067015;53616;53878.46121538813;54042.729786350814;54051.459485404645;54065.45934540683;15936.760948585781;16309.347626094823;16315.755263671055;16323.10222937726;16327.183640817912;13079.280639564726;13082;13086.2802545859;13098.279594622387;13118.672033199246;14526.782098268535;14645.121292722471;14709.411623535152;14815.777763333559;14902.627434314229;5700.061978927185;5703.857403564944;5741.913871291934;5805.332386775491;5924.911126333109;1101.3391964821203;1105.6959336182615;1108.7948729485072;1109.7392112853472;1117.932924024561;25138.748612514006;25362.873185634322;25462;25489.745102548735;25506.48987020249;1181.1082632612322;1196.2463647901766;1214.368528365245;1218.1959906461693;1220.6704189868685;13434.529791457253;13448.394822233024;13614.251216183206;13658.317084145752;13723.245221512912;265717;267611;268114;268295;269334;50469.24296135561;51699.483005170216;55577;55765.442345576834;57283;1512.5311153542436;1520.4374381478924;1537.48494254426;1540.4223416218917;1544.409258463784;30066.699333007266;30070.54894176633;30123;30328.696713032587;30404.5439318406;37210.25579488449;37230.44154337633;37567;37632;37687.81156094202;225688;226067;226810;227976;229165;34693;34945;35193.82403088071;35197.472037919964;35204.47193292154;42735.3589696161;44051;44058.11883762371;44431.11137777162;44515.10969780651;33548.83225583856;33617;33719.66280337263;33765.49351759676;33824.830875845466;33627.49558756572;33671.663283366855;33748.325033499685;33799.4930076054;34030.48954265738;38621.42067868928;38899;38953.61046389613;38954;39263;32694.67305326916;32719.345613087127;33126.17184570405;33215.83392083024;33623.83188084044;25000.249992500256;25043.624345635195;25078.49843003166;25637.615435768104;25944.8702756485 12:03:47 INFO - PID 30273 | |2;jquery.html;583.3787016827079;595.1727099331927;601.8344955137339;625.3308959413428;638.5817289675263;23175.536489270205;23835.642465363035;23875.403114922115;23988.1604143855;23999.64000539993;22727.54544909101;24198.63702044471;24205.39486512838;24206;24246.151384701538;6673.165854268216;6731.831704207385;6761.188657361124;6765.864682706343;6787.4909381796315;6575.901361479581;6843.65781710915;6858.417034552069;6859.554128981626;6873.690683919211;6825.795226143224;6836.521443498957;6837.350451707105;6842.9315706843045;6845.5892646441125;6812;6828.419584335337;6830.180378354579;6836.726530938757;6842.623655698934;6342.080398342215;6353.904691429586;6358.936410635881;6374.776882809126;6374.936250637481;30678.693213067807;30682.079537613907;31222.53166202509;31426.37147257065;31522.36955260905;2254.729432468098;2305.204704376987;2309.434188623781;2315.8610483371053;2318.374039009475;20546.79453205464;21049;21067.473313167295;21103.261385851576;21112.683309750213;2482.2429159106464;2534.746525347469;2581.354661334666;2651.111877521033;2659.188947371051;130866.345668272;138814.3059284707;158793;162950.1852490742;164672;15971.281292341873;16388.75416868748;16423.83576164223;16720.498385048468;17384.783814994265;26287;26324.21027369182;26347.20958371252;26375.20874373772;26413.73586264151;9893.75265618351;9987;10097.44464054484;10124.291299609104;10177.287589868638;8757.56212189388;8764.912350876537;8855.911440885637;8906.554672266491;8984.056674049261;9836.704898853046;9976.401415915068;10094.343867648578;10112.696619101438;10218.642347517949;2838.4181242845166;2842.630458040483;2890.6531216254184;2939.706029397043;2952.3652414730936;1031.3914790273775;1040.9895901040893;1043.5773511727762;1043.6555936540924;1057.619257067455;21321.25375611846;21544.676829847565;21569.352919412442;21710.565788684136;21964.341069767932;1105.0606984063481;1114.8885111488787;1120.6694025262568;1129.785340785248;1139.4986206069302;11527.437750044704;11825.172237943261;11896.88103118975;11960.15944215238;11969.16215864881;553016;570479;580539;586180;593552;122092;123234.38382808029;125422.3728881368;126647;126856.36571817081;1138.174823253135;1183;1216.5620376664394;1236.9876301237052;1288.2785640041607;22380.77619223787;22761.430964226027;22876.428089297235;22904.198353057564;23327.76672233256;60947;62740.68629657005;63462.682686586275;64083.3591664096;64276.678616606616;80214;80339.59830200812;80399.59800200962;81046;83067;15504.612384690474;15887.285072172011;15979.520614381587;15985.840141598435;16012.039277643378;24691.87654061718;24907;25367.492650146523;25386.873065634554;25527;20581.38255852327;20797.1681132753;20833.68749468729;21002.47493812667;21028;18103.909480452512;18296.359627412978;18493.352732654294;18805.529861753566;18880.43358699241;21124;21125;21396.465088372915;21457.785422146204;21483.14067437285;15272.618184545476;15808.76286855675;15868.127253001196;15883.682326353177;15883.920580397024;20306.593868122258;20348.491287717927;20377.286794962107;20519.589608207454;20530.58938821245 12:03:47 INFO - PID 30273 | |3;mootools.html;1383.6333371656513;1447.1606468248417;1458.4020551573853;1467.2590341877358;1468.772340287256;16610.169491525437;17361.82638173618;17366.739498907526;17381;17390.56523586911;16752.66494670109;16871.07209103499;16909.23908424121;16940.66118677626;16947.49157525273;2803.78971577132;2902.1873875314946;2909.3453972856046;2913.169746622213;2915.6646985596717;2844.7724182065385;2888.783341249404;2890.855457227141;2894.233028247516;2896.971030289702;2720.279126031603;2762.2541913683294;2770.2381844992688;2778.0832325332694;2780.652418447694;2666.733326667327;2705.4589082183643;2709.133077415228;2710.1598504463677;2711.173092206876;2643.70919198888;2664.107523979469;2673.1713168917504;2677.785777137844;2683.18162960297;16094.275757590936;16274.674506509804;16356.182190890408;16362.345506179738;16371.42700005506;8421.915780842175;8729.039805621376;8755.518446485441;8756.299496040365;8765.824683506295;5174.172132458826;5204.193350030751;5442.265294185314;5450.836474905759;5461.836144915659;2037.1953078533895;2059.773424923257;2083.333333333334;2099.9685004724943;2133.775953524873;26438.47123057528;27256.31859203516;29298.12105636834;29958.25104372408;29986;7709.691612335444;7710;7712.267334603203;7772.45592808498;7864.9606751965875;22446.55106897853;22517.32448026562;22563.09747610077;22590.661140082913;22603.321900343017;8853.02616712174;8874.068222836639;8878.822423551494;8903.510306933182;8903.643854245887;7485.588292643848;7532.246775322424;7542.019537460095;7546.849063018709;7589.1272503661685;5917.289925209003;6063.333033366326;6200.286966998763;6335.049742538656;6360.300366959631;1904.980950190508;1950.1809240119185;1968.1930408532432;1973.0627951723104;1986.9503262418555;938.8497840345649;952.8380175370204;954.4702690006974;959.9712008639752;963.633819148719;8855.778605534913;9062.456252624863;9068.727938161866;9196.310276729271;9280.39677420979;780.9492382995201;793.6587267475041;794.9903622399636;799.0690845165434;803.4737247103157;4991.376077990251;5000.949990500048;5010.398752149766;5015.448300686921;5116.513931176532;23021.539569208522;24506.264812055666;24677.876610616833;24702.25893223206;24787.504249914902;22850.657240141412;24032.279031629078;24085.7591424087;24110.276691699277;24301.75698242995;10370.792584148425;12221.450034748457;12447.813282800766;12601.306928119042;12628.368581571069;9270.953645231732;9285.07149285066;9299.30255230874;9339.813203735752;9434.339596228197;20293.391198264075;20813.375598732062;21112;21589.568208636054;21919.342419727433;21480.78519214788;21610.783892160878;22046.779532205113;22553.323400298017;22954;13090.345482726016;13310.600681979557;13332.466701331838;13347.799783003456;13354.131981421177;15533.533993980198;15581.688366232838;15623.375064997728;15735.842641573896;15776.684466310839;12261.448234829633;12308.815367769312;12528.812067818808;12697.746045079231;12863.678408039874;11816.645500634995;11906.702332441759;11922.701932451759;12238.938805305916;12332.50669973191;10490.213234007633;10572.84140737874;10574.154067674413;10611.363318200933;10613.575456981634;7870.527768333918;7993;8081.515109093473;8097.392695547976;8203.384746144182;7743.341815945708;7914.169012253861;7928.127905930228;7930.127685954656;7947.562884041433 12:03:47 INFO - PID 30273 | |4;prototype.html;552.1166134185306;564.187569899345;580.6690186593642;581.566732784076;590.8434264919797;6342.556021078526;6376.713047912844;6378.617282963014;6423.6788160591905;6429.164208652875;6248.406401391871;6257.62454252744;6268.890853954035;6289.371062893709;6309.1482649842255;4885.633577481685;5051.848444546669;5071.619628527857;5125.615578831584;5131.794728210876;4952.950470495285;4958.404991401037;5012.448630650625;5015.172496538085;5025.246213068051;4939.407271127469;4953.23224900141;4967.254911763228;4996.1756310208775;5016.3980322361185;4927.778249978742;4953.678010929278;4964.776585053682;5019.84940451787;5023.472535383768;4480.731156130642;4529.954700452986;4572.725636461823;4582.1064892346;4599.793009314589;6211.409916058013;6245.219347581552;6282.277538083134;6290.748370065192;6311.211098612674;5788.131780232957;5832.891750567421;5833.300003999505;5835.737391817336;5878.353381128072;6618.716542792728;6674.399304062657;6694.43097336727;6703.262641109474;6742.561733487308;4775.450823155312;5017.899642007176;5045.855511407637;5049.2173713074535;5078.984203159383;6819.624920629363;6852.417544508723;6853.725850965955;6916.23921368649;6981.603679264167;5148.613853960968;5159.58723302135;5172.19830926207;5181.766820493087;5183.3261675981885;5171.681221288547;5245.265662807134;5270.5256526912;5290.465764928204;5293.788248470095;5797.275340582427;5844.766209351664;5859.472647461749;5880.882382352329;5885.264341957255;6736.93263067363;6739.326067393222;6767.593944363255;6774.390304872585;6802.14973128359;1802.3511535847085;1811.5199472139893;1827.8301886792462;1828.6159906419534;1836.3848110882736;1211.763706077324;1267.8605353411117;1276.9744605107846;1294.3010774181837;1299.9740005199842;6059.333473317932;6080.787172448943;6099.207103076572;6159.5072394208355;6170.969145154335;6738.427233685094;6778.830529236809;6800.353966373186;6812.299513335783;6850.451963842881;5706.802880890887;5967.522598192134;5969.313528944227;5996.610220335751;6134.723937422737;3494.790312581253;3513.9648603514147;3566.965579981828;3569.6787289144104;3584.5877724061547;6740.258571557125;6823.692933817891;6918.135233095863;6929.237783843773;6950.826229344307;6685.298043705438;6763.864722705518;6786.76246331376;6851.9657401712675;6936.4797640176175;6795.592264464148;6875.828104297432;6876.17485901695;6905.620190889449;7011.404030657247;6638.867222655616;6707.798766037026;6730.754810360099;6781.457483401415;6811.659417029228;6746.434191791694;6758.256591774999;6768.492363072888;6785.253622101466;6796.898046529207;6824.146981627297;6829.965850170717;6842.315768423317;6960.468696886677;6978.581285122909;5077;5091.490850914879;5109.9744501277255;5143.948560514347;5220.608454366014;6317;6588.538802283986;6588.8023359299295;6795.52431329822;6799.660016999229;6151.292601350723;6433.5496515243485;6504.837379065372;6537.70580323877;6552.508561857784;6349.333320001333;6399.616023038632;6455.3221911700475;6455.57854337202;6548.541602087808;6447.548671592944;6482.2869484357625;6495.668387980359;6497.610143391412;6567.9671601641685;6620.900686489803;6623.172103487064;6624.768133115318;6637.800865974028;6647.135872336566;6318.936810631835;6431.324710905287;6464.834280515892;6521.478281737544;6536.281009088902 12:03:47 INFO - PID 30273 | |5;yui.html;948.933574649774;956.8469044952808;971.485112890168;986.4820968991284;991.0634450444328;23012.769872301273;23627.29118126457;23861.761382386172;23967.76032239677;24033.51932961342;17455.650886982254;19266.71099933502;19306.51733706658;19400.02999850009;19582.92293923837;1046.5865982936716;1065.8028264771003;1066.8559744434478;1067.6209945469363;1071.2073065931195;1068.732816795801;1082.2694681090272;1085.1264731890824;1085.207798307236;1092.2845536173818;1130.129800053958;1155.8844115588458;1157.2882677153575;1157.3981529604644;1157.4328578996315;1123.893230143135;1140.0879296562757;1140.8916152965455;1141.5034460009922;1143.8684551276542;836.9372297077743;847.8685803700437;850.0819115355401;850.7702920211508;850.8723691446271;18309.45071647853;20276.08757605911;20360.28738994128;20383.89808050965;20390.79609203904;22924.656130158062;22956.19653312126;23358.416039598975;23462.53074938509;23468.64797028046;18530.888146711106;18563.350282740175;18621.348252811087;18729.344472943383;18880.811191888042;3937.0944682723134;3976.224636195943;3980.5621381647998;3981.6416522512823;3981.820818063194;160532;162122;162630;163768.9999999988;164653;15906.840931590767;16479.670406592042;16644.417445389354;16880.409185678443;16940.152992350333;28835.85582072076;33366.16584585405;33459.66540334566;33552.32895342128;33583.32833343319;9700.805983880284;9793.314467987173;9939.204863610894;9950.45272510019;9977.151942084858;4604;4655.301704744248;4672.836450724209;4678.157931572282;4682.578567928903;6044.637321760709;6182.721777520022;6242;6242.843928901813;6253.093301471261;1142.9599964001386;1179.8348231247633;1181.5214837990627;1185.8458400408065;1188.8157335612993;731.3308322884501;734.313416955138;751.5678484871112;751.8796992481286;768.1051574915273;13331.66670833237;13429.992750543748;13723.931380343034;13985.021048526505;14138.08102473336;726.6548389514938;727.7343769524085;735.4704612678863;743.7285390832308;752.3379426104992;6252.437280644764;6312.715927783261;6314.8421289467215;6315.052742088632;6381.329960354189;150241;152081;153259;156577.2171139137;157106.21446892692;124748.37625811994;125675;128834;128879.35560322138;137765.31117344348;118348;119182;120341.56755108426;122427;124613;12000.219985700902;12052.0960927929;12053.879461205275;12152.513899443924;12273.754524909273;55300;56018.43981560295;56052;56973.43026569847;57587.1361929563;69204;70706;70812.64593676999;71269;71344;16974.74537881908;17170.656586867943;17186.828131719023;17544.298228070733;17746.29014839392;22481;22805;22841.31476055721;22854.42863928415;22935;18659.81340186581;18742.344017959305;18834.058297084815;18847.15187816579;18990.620187596447;17961.640767184323;18273.086345682397;18325.725114123565;18449.07754612237;18470.722939155654;18781.624367512846;18784.6243075135;18802.623947521246;19064.618707626047;19191.61616767629;13035.674108146994;13316.934645228164;13337.19976801395;13347.466101356225;13448.663783405493;12911.5480958166;13212.471501140231;13309.600711978655;13339.19964802115;13351.065425420127 12:03:47 INFO - PID 30273 | __end_tp_report 12:03:47 INFO - PID 30273 | __start_cc_report 12:03:47 INFO - PID 30273 | _x_x_mozilla_cycle_collect,274 12:03:47 INFO - PID 30273 | __end_cc_report 12:03:47 INFO - PID 30273 | __startTimestamp1505934227631__endTimestamp 12:03:47 INFO - PID 30273 | 12:03:47 INFO - PID 30273 | ------- Summary: start ------- 12:03:47 INFO - PID 30273 | Number of tests: 6 12:03:47 INFO - PID 30273 | 12:03:47 INFO - PID 30273 | [#0] dojo.html Cycles:165 Average:6308.27 Median:6504.09 stddev:749.57 (11.5%) stddev-sans-first:726.48 12:03:47 INFO - PID 30273 | Values: 3842.3 3843.4 3859.7 3866.2 3868.1 6246.1 6304.4 6345.2 6349.0 6459.6 6301.0 6326.8 6338.8 6340.6 6365.0 5622.3 5645.6 5649.9 5656.9 5703.3 5728.9 5759.8 5769.4 5798.5 5814.1 5723.6 5762.8 5844.7 5847.6 5863.0 5537.0 5644.0 5666.2 5743.9 5770.4 5686.8 5692.1 5755.7 5756.5 5760.0 6203.3 6304.1 6318.6 6343.7 6423.3 6768.2 6773.0 6779.6 6785.7 6814.3 6860.1 6888.7 6938.3 6945.3 6945.7 6362.0 6438.3 6442.5 6451.8 6458.5 6960.1 7045.9 7100.4 7115.4 7117.2 6656.3 6732.7 6743.7 6763.8 6797.9 6908.1 6915.0 6916.8 6938.8 6939.8 6806.1 6832.4 6878.0 6884.5 6915.2 6813.4 6821.6 6905.4 6908.2 6914.2 4883.7 4884.1 4892.2 4906.6 4915.0 4545.0 4551.8 4555.2 4607.8 4623.4 6256.5 6265.0 6276.7 6330.1 6331.2 6811.6 6864.9 6873.2 6971.4 6972.2 6282.3 6319.0 6335.5 6337.8 6340.3 5496.2 5554.6 5586.8 5588.8 5595.9 7002.6 7009.5 7028.6 7085.9 7101.4 6761.6 6838.4 6839.9 6861.5 6952.5 7036.5 7051.4 7055.2 7079.4 7081.6 6670.3 6779.7 6850.4 6868.9 6892.4 6708.6 6798.6 6830.7 6862.9 6938.4 6492.7 6493.6 6504.1 6551.7 6584.3 6642.7 6656.0 6657.3 6684.1 6711.1 6492.7 6523.4 6558.2 6673.8 6676.7 6686.4 6712.7 6714.2 6723.3 6758.8 6347.9 6420.7 6450.8 6452.2 6517.3 12:03:47 INFO - PID 30273 | 12:03:47 INFO - PID 30273 | [#1] ext.html Cycles:180 Average:41031.15 Median:20454.87 stddev:61505.59 (300.7%) stddev-sans-first:61604.45 12:03:47 INFO - PID 30273 | Values: 935.5 960.9 962.1 968.7 974.6 42839.6 43361.3 43382.8 43392.6 43524.1 40377.0 40547.2 40573.6 40842.0 40916.2 7728.5 7854.1 7857.6 7858.2 7859.6 7616.1 7683.2 7693.8 7696.0 7697.7 7662.2 7678.8 8367.1 8462.8 8532.2 8452.2 8490.9 8505.1 8522.2 8524.7 7917.0 8068.9 8373.0 8456.8 8458.2 39159.0 39270.0 39515.2 39558.4 39565.0 3699.5 3739.1 3743.1 3754.9 3759.5 32119.7 32620.7 32693.8 32789.3 32833.3 5496.8 5525.6 5533.6 5537.8 5576.7 212214.0 212699.0 212838.0 212906.0 213176.0 50354.7 50466.7 50640.0 50658.7 50667.5 53616.0 53878.5 54042.7 54051.5 54065.5 15936.8 16309.3 16315.8 16323.1 16327.2 13079.3 13082.0 13086.3 13098.3 13118.7 14526.8 14645.1 14709.4 14815.8 14902.6 5700.1 5703.9 5741.9 5805.3 5924.9 1101.3 1105.7 1108.8 1109.7 1117.9 25138.7 25362.9 25462.0 25489.7 25506.5 1181.1 1196.2 1214.4 1218.2 1220.7 13434.5 13448.4 13614.3 13658.3 13723.2 265717.0 267611.0 268114.0 268295.0 269334.0 50469.2 51699.5 55577.0 55765.4 57283.0 1512.5 1520.4 1537.5 1540.4 1544.4 30066.7 30070.5 30123.0 30328.7 30404.5 37210.3 37230.4 37567.0 37632.0 37687.8 225688.0 226067.0 226810.0 227976.0 229165.0 34693.0 34945.0 35193.8 35197.5 35204.5 42735.4 44051.0 44058.1 44431.1 44515.1 33548.8 33617.0 33719.7 33765.5 33824.8 33627.5 33671.7 33748.3 33799.5 34030.5 38621.4 38899.0 38953.6 38954.0 39263.0 32694.7 32719.3 33126.2 33215.8 33623.8 25000.2 25043.6 25078.5 25637.6 25944.9 12:03:47 INFO - PID 30273 | 12:03:47 INFO - PID 30273 | [#2] jquery.html Cycles:180 Average:39114.81 Median:12746.96 stddev:96722.26 (758.8%) stddev-sans-first:96950.33 12:03:47 INFO - PID 30273 | Values: 583.4 595.2 601.8 625.3 638.6 23175.5 23835.6 23875.4 23988.2 23999.6 22727.5 24198.6 24205.4 24206.0 24246.2 6673.2 6731.8 6761.2 6765.9 6787.5 6575.9 6843.7 6858.4 6859.6 6873.7 6825.8 6836.5 6837.4 6842.9 6845.6 6812.0 6828.4 6830.2 6836.7 6842.6 6342.1 6353.9 6358.9 6374.8 6374.9 30678.7 30682.1 31222.5 31426.4 31522.4 2254.7 2305.2 2309.4 2315.9 2318.4 20546.8 21049.0 21067.5 21103.3 21112.7 2482.2 2534.7 2581.4 2651.1 2659.2 130866.3 138814.3 158793.0 162950.2 164672.0 15971.3 16388.8 16423.8 16720.5 17384.8 26287.0 26324.2 26347.2 26375.2 26413.7 9893.8 9987.0 10097.4 10124.3 10177.3 8757.6 8764.9 8855.9 8906.6 8984.1 9836.7 9976.4 10094.3 10112.7 10218.6 2838.4 2842.6 2890.7 2939.7 2952.4 1031.4 1041.0 1043.6 1043.7 1057.6 21321.3 21544.7 21569.4 21710.6 21964.3 1105.1 1114.9 1120.7 1129.8 1139.5 11527.4 11825.2 11896.9 11960.2 11969.2 553016.0 570479.0 580539.0 586180.0 593552.0 122092.0 123234.4 125422.4 126647.0 126856.4 1138.2 1183.0 1216.6 1237.0 1288.3 22380.8 22761.4 22876.4 22904.2 23327.8 60947.0 62740.7 63462.7 64083.4 64276.7 80214.0 80339.6 80399.6 81046.0 83067.0 15504.6 15887.3 15979.5 15985.8 16012.0 24691.9 24907.0 25367.5 25386.9 25527.0 20581.4 20797.2 20833.7 21002.5 21028.0 18103.9 18296.4 18493.4 18805.5 18880.4 21124.0 21125.0 21396.5 21457.8 21483.1 15272.6 15808.8 15868.1 15883.7 15883.9 20306.6 20348.5 20377.3 20519.6 20530.6 12:03:47 INFO - PID 30273 | 12:03:47 INFO - PID 30273 | [#3] mootools.html Cycles:180 Average:10390.71 Median:2680.48 stddev:7623.86 (284.4%) stddev-sans-first:7615.21 12:03:47 INFO - PID 30273 | Values: 1383.6 1447.2 1458.4 1467.3 1468.8 16610.2 17361.8 17366.7 17381.0 17390.6 16752.7 16871.1 16909.2 16940.7 16947.5 2803.8 2902.2 2909.3 2913.2 2915.7 2844.8 2888.8 2890.9 2894.2 2897.0 2720.3 2762.3 2770.2 2778.1 2780.7 2666.7 2705.5 2709.1 2710.2 2711.2 2643.7 2664.1 2673.2 2677.8 2683.2 16094.3 16274.7 16356.2 16362.3 16371.4 8421.9 8729.0 8755.5 8756.3 8765.8 5174.2 5204.2 5442.3 5450.8 5461.8 2037.2 2059.8 2083.3 2100.0 2133.8 26438.5 27256.3 29298.1 29958.3 29986.0 7709.7 7710.0 7712.3 7772.5 7865.0 22446.6 22517.3 22563.1 22590.7 22603.3 8853.0 8874.1 8878.8 8903.5 8903.6 7485.6 7532.2 7542.0 7546.8 7589.1 5917.3 6063.3 6200.3 6335.0 6360.3 1905.0 1950.2 1968.2 1973.1 1987.0 938.8 952.8 954.5 960.0 963.6 8855.8 9062.5 9068.7 9196.3 9280.4 780.9 793.7 795.0 799.1 803.5 4991.4 5000.9 5010.4 5015.4 5116.5 23021.5 24506.3 24677.9 24702.3 24787.5 22850.7 24032.3 24085.8 24110.3 24301.8 10370.8 12221.5 12447.8 12601.3 12628.4 9271.0 9285.1 9299.3 9339.8 9434.3 20293.4 20813.4 21112.0 21589.6 21919.3 21480.8 21610.8 22046.8 22553.3 22954.0 13090.3 13310.6 13332.5 13347.8 13354.1 15533.5 15581.7 15623.4 15735.8 15776.7 12261.4 12308.8 12528.8 12697.7 12863.7 11816.6 11906.7 11922.7 12238.9 12332.5 10490.2 10572.8 10574.2 10611.4 10613.6 7870.5 7993.0 8081.5 8097.4 8203.4 7743.3 7914.2 7928.1 7930.1 7947.6 12:03:47 INFO - PID 30273 | 12:03:47 INFO - PID 30273 | [#4] prototype.html Cycles:180 Average:5615.86 Median:6275.58 stddev:1566.44 (25.0%) stddev-sans-first:1524.03 12:03:47 INFO - PID 30273 | Values: 552.1 564.2 580.7 581.6 590.8 6342.6 6376.7 6378.6 6423.7 6429.2 6248.4 6257.6 6268.9 6289.4 6309.1 4885.6 5051.8 5071.6 5125.6 5131.8 4953.0 4958.4 5012.4 5015.2 5025.2 4939.4 4953.2 4967.3 4996.2 5016.4 4927.8 4953.7 4964.8 5019.8 5023.5 4480.7 4530.0 4572.7 4582.1 4599.8 6211.4 6245.2 6282.3 6290.7 6311.2 5788.1 5832.9 5833.3 5835.7 5878.4 6618.7 6674.4 6694.4 6703.3 6742.6 4775.5 5017.9 5045.9 5049.2 5079.0 6819.6 6852.4 6853.7 6916.2 6981.6 5148.6 5159.6 5172.2 5181.8 5183.3 5171.7 5245.3 5270.5 5290.5 5293.8 5797.3 5844.8 5859.5 5880.9 5885.3 6736.9 6739.3 6767.6 6774.4 6802.1 1802.4 1811.5 1827.8 1828.6 1836.4 1211.8 1267.9 1277.0 1294.3 1300.0 6059.3 6080.8 6099.2 6159.5 6171.0 6738.4 6778.8 6800.4 6812.3 6850.5 5706.8 5967.5 5969.3 5996.6 6134.7 3494.8 3514.0 3567.0 3569.7 3584.6 6740.3 6823.7 6918.1 6929.2 6950.8 6685.3 6763.9 6786.8 6852.0 6936.5 6795.6 6875.8 6876.2 6905.6 7011.4 6638.9 6707.8 6730.8 6781.5 6811.7 6746.4 6758.3 6768.5 6785.3 6796.9 6824.1 6830.0 6842.3 6960.5 6978.6 5077.0 5091.5 5110.0 5143.9 5220.6 6317.0 6588.5 6588.8 6795.5 6799.7 6151.3 6433.5 6504.8 6537.7 6552.5 6349.3 6399.6 6455.3 6455.6 6548.5 6447.5 6482.3 6495.7 6497.6 6568.0 6620.9 6623.2 6624.8 6637.8 6647.1 6318.9 6431.3 6464.8 6521.5 6536.3 12:03:47 INFO - PID 30273 | 12:03:47 INFO - PID 30273 | [#5] yui.html Cycles:180 Average:28775.15 Median:18818.34 stddev:43003.50 (228.5%) stddev-sans-first:43073.37 12:03:47 INFO - PID 30273 | Values: 948.9 956.8 971.5 986.5 991.1 23012.8 23627.3 23861.8 23967.8 24033.5 17455.7 19266.7 19306.5 19400.0 19582.9 1046.6 1065.8 1066.9 1067.6 1071.2 1068.7 1082.3 1085.1 1085.2 1092.3 1130.1 1155.9 1157.3 1157.4 1157.4 1123.9 1140.1 1140.9 1141.5 1143.9 836.9 847.9 850.1 850.8 850.9 18309.5 20276.1 20360.3 20383.9 20390.8 22924.7 22956.2 23358.4 23462.5 23468.6 18530.9 18563.4 18621.3 18729.3 18880.8 3937.1 3976.2 3980.6 3981.6 3981.8 160532.0 162122.0 162630.0 163769.0 164653.0 15906.8 16479.7 16644.4 16880.4 16940.2 28835.9 33366.2 33459.7 33552.3 33583.3 9700.8 9793.3 9939.2 9950.5 9977.2 4604.0 4655.3 4672.8 4678.2 4682.6 6044.6 6182.7 6242.0 6242.8 6253.1 1143.0 1179.8 1181.5 1185.8 1188.8 731.3 734.3 751.6 751.9 768.1 13331.7 13430.0 13723.9 13985.0 14138.1 726.7 727.7 735.5 743.7 752.3 6252.4 6312.7 6314.8 6315.1 6381.3 150241.0 152081.0 153259.0 156577.2 157106.2 124748.4 125675.0 128834.0 128879.4 137765.3 118348.0 119182.0 120341.6 122427.0 124613.0 12000.2 12052.1 12053.9 12152.5 12273.8 55300.0 56018.4 56052.0 56973.4 57587.1 69204.0 70706.0 70812.6 71269.0 71344.0 16974.7 17170.7 17186.8 17544.3 17746.3 22481.0 22805.0 22841.3 22854.4 22935.0 18659.8 18742.3 18834.1 18847.2 18990.6 17961.6 18273.1 18325.7 18449.1 18470.7 18781.6 18784.6 18802.6 19064.6 19191.6 13035.7 13316.9 13337.2 13347.5 13448.7 12911.5 13212.5 13309.6 13339.2 13351.1 12:03:47 INFO - PID 30273 | -------- Summary: end -------- 12:03:47 INFO - PID 30273 | 12:03:48 INFO - TEST-INFO | 30273: exit 0 12:03:48 INFO - TEST-OK | dromaeo_css | took 1108246ms 12:03:48 INFO - TEST-START | kraken 12:03:48 INFO - Initialising browser for kraken test... 12:03:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39031/getInfo.html -profile /tmp/tmpmYkYF2/profile 12:03:48 INFO - TEST-INFO | started process 30641 (/builds/slave/test/build/application/firefox/firefox http://localhost:39031/getInfo.html) 12:03:53 INFO - TEST-INFO | 30641: exit 0 12:03:53 INFO - Browser initialized. 12:03:53 INFO - Running cycle 1/1 for kraken test... 12:03:53 INFO - Using env: {'DISPLAY': ':0', 12:03:53 INFO - 'HOME': '/home/cltbld', 12:03:53 INFO - 'JSGC_DISABLE_POISONING': '1', 12:03:53 INFO - 'LANG': 'en_US.UTF-8', 12:03:53 INFO - 'LANGUAGE': 'en_US:en', 12:03:53 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:03:53 INFO - 'LOGNAME': 'cltbld', 12:03:53 INFO - 'MAIL': '/var/mail/cltbld', 12:03:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:03:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:03:53 INFO - 'MOZ_CRASHREPORTER': '1', 12:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:53 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:03:53 INFO - 'MOZ_NO_REMOTE': '1', 12:03:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:53 INFO - 'NO_EM_RESTART': '1', 12:03:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:53 INFO - 'PWD': '/builds/slave/test', 12:03:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:03:53 INFO - 'RUST_BACKTRACE': 'full', 12:03:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:03:53 INFO - 'SHELL': '/bin/bash', 12:03:53 INFO - 'SHLVL': '1', 12:03:53 INFO - 'STYLO_FORCE_DISABLED': '1', 12:03:53 INFO - 'TERM': 'linux', 12:03:53 INFO - 'TMOUT': '86400', 12:03:53 INFO - 'USER': 'cltbld', 12:03:53 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206', 12:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:53 INFO - '_': '/tools/buildbot/bin/python'} 12:03:53 INFO - TEST-INFO | started process 30881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmYkYF2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:03:53 INFO - PID 30881 | 12:03:53 INFO - PID 30881 | (/builds/slave/test/build/application/firefox/firefox:30933): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:03:53 INFO - PID 30881 | 12:04:04 INFO - PID 30881 | RSS: Main: 147333120 12:04:04 INFO - PID 30881 | 12:04:06 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:39031/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39031/tests/kraken/driver.html?testName=audio-beat-detection) 12:04:07 INFO - PID 30881 | RSS: Main: 153018368 12:04:07 INFO - PID 30881 | 12:04:10 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:39031/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39031/tests/kraken/driver.html?testName=audio-dft) 12:04:10 INFO - PID 30881 | RSS: Main: 153620480 12:04:10 INFO - PID 30881 | 12:04:13 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:39031/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39031/tests/kraken/driver.html?testName=audio-fft) 12:04:14 INFO - PID 30881 | RSS: Main: 149803008 12:04:14 INFO - PID 30881 | 12:04:16 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:39031/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39031/tests/kraken/driver.html?testName=audio-oscillator) 12:04:17 INFO - PID 30881 | RSS: Main: 151072768 12:04:17 INFO - PID 30881 | 12:04:19 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:39031/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39031/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:04:19 INFO - PID 30881 | RSS: Main: 150667264 12:04:19 INFO - PID 30881 | 12:04:22 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:39031/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39031/tests/kraken/driver.html?testName=imaging-darkroom) 12:04:23 INFO - PID 30881 | RSS: Main: 151023616 12:04:23 INFO - PID 30881 | 12:04:26 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:39031/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39031/tests/kraken/driver.html?testName=imaging-desaturate) 12:04:27 INFO - PID 30881 | RSS: Main: 151793664 12:04:27 INFO - PID 30881 | 12:04:30 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:39031/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39031/tests/kraken/driver.html?testName=json-parse-financial) 12:04:31 INFO - PID 30881 | RSS: Main: 153489408 12:04:31 INFO - PID 30881 | 12:04:32 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:39031/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39031/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:04:33 INFO - PID 30881 | RSS: Main: 153477120 12:04:33 INFO - PID 30881 | 12:04:34 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:39031/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39031/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:04:35 INFO - PID 30881 | RSS: Main: 153313280 12:04:35 INFO - PID 30881 | 12:04:37 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:39031/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39031/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:04:38 INFO - PID 30881 | RSS: Main: 150171648 12:04:38 INFO - PID 30881 | 12:04:40 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:39031/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:04:41 INFO - PID 30881 | RSS: Main: 150581248 12:04:41 INFO - PID 30881 | 12:04:43 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:39031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:04:44 INFO - PID 30881 | RSS: Main: 151011328 12:04:44 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:39031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39031/tests/kraken/driver.html?testName=ai-astar) 12:04:46 INFO - PID 30881 | RSS: Main: 152768512 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | __start_tp_report 12:04:46 INFO - PID 30881 | _x_x_mozilla_page_load 12:04:46 INFO - PID 30881 | _x_x_mozilla_page_load_details 12:04:46 INFO - PID 30881 | |i|pagename|runs| 12:04:46 INFO - PID 30881 | |0;ai-astar;105;105;105;106;106;105;105;107;106;106 12:04:46 INFO - PID 30881 | |1;audio-beat-detection;112;117;112;111;111;135;114;112;111;115 12:04:46 INFO - PID 30881 | |2;audio-dft;164;162;162;160;160;161;163;163;160;164 12:04:46 INFO - PID 30881 | |3;audio-fft;74;74;73;71;75;74;73;73;74;74 12:04:46 INFO - PID 30881 | |4;audio-oscillator;77;78;77;77;78;77;77;78;78;77 12:04:46 INFO - PID 30881 | |5;imaging-gaussian-blur;113;113;113;110;113;113;113;114;114;115 12:04:46 INFO - PID 30881 | |6;imaging-darkroom;148;149;150;149;149;150;150;151;153;151 12:04:46 INFO - PID 30881 | |7;imaging-desaturate;93;95;94;93;93;94;95;94;93;94 12:04:46 INFO - PID 30881 | |8;json-parse-financial;46;45;42;43;48;43;45;43;43;44 12:04:46 INFO - PID 30881 | |9;json-stringify-tinderbox;36;36;36;36;37;36;37;37;36;36 12:04:46 INFO - PID 30881 | |10;stanford-crypto-aes;72;71;72;71;71;71;70;70;73;76 12:04:46 INFO - PID 30881 | |11;stanford-crypto-ccm;102;103;113;107;105;104;114;108;108;109 12:04:46 INFO - PID 30881 | |12;stanford-crypto-pbkdf2;155;159;153;163;156;157;159;156;155;165 12:04:46 INFO - PID 30881 | |13;stanford-crypto-sha256-iterative;61;61;61;61;63;60;62;61;60;60 12:04:46 INFO - PID 30881 | __end_tp_report 12:04:46 INFO - PID 30881 | __start_cc_report 12:04:46 INFO - PID 30881 | _x_x_mozilla_cycle_collect,730 12:04:46 INFO - PID 30881 | __end_cc_report 12:04:46 INFO - PID 30881 | __startTimestamp1505934286331__endTimestamp 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | ------- Summary: start ------- 12:04:46 INFO - PID 30881 | Number of tests: 14 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | [#0] ai-astar Cycles:10 Average:105.60 Median:106.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 12:04:46 INFO - PID 30881 | Values: 105.0 105.0 105.0 106.0 106.0 105.0 105.0 107.0 106.0 106.0 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | [#1] audio-beat-detection Cycles:10 Average:115.00 Median:113.00 stddev:7.30 (6.5%) stddev-sans-first:7.66 12:04:46 INFO - PID 30881 | Values: 112.0 117.0 112.0 111.0 111.0 135.0 114.0 112.0 111.0 115.0 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:1.60 (1.0%) stddev-sans-first:1.50 12:04:46 INFO - PID 30881 | Values: 164.0 162.0 162.0 160.0 160.0 161.0 163.0 163.0 160.0 164.0 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | [#3] audio-fft Cycles:10 Average:73.50 Median:74.00 stddev:1.08 (1.5%) stddev-sans-first:1.13 12:04:46 INFO - PID 30881 | Values: 74.0 74.0 73.0 71.0 75.0 74.0 73.0 73.0 74.0 74.0 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:77.50 stddev:0.52 (0.7%) stddev-sans-first:0.53 12:04:46 INFO - PID 30881 | Values: 77.0 78.0 77.0 77.0 78.0 77.0 77.0 78.0 78.0 77.0 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:1.29 (1.1%) stddev-sans-first:1.36 12:04:46 INFO - PID 30881 | Values: 113.0 113.0 113.0 110.0 113.0 113.0 113.0 114.0 114.0 115.0 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:1.41 (0.9%) stddev-sans-first:1.30 12:04:46 INFO - PID 30881 | Values: 148.0 149.0 150.0 149.0 149.0 150.0 150.0 151.0 153.0 151.0 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 12:04:46 INFO - PID 30881 | Values: 93.0 95.0 94.0 93.0 93.0 94.0 95.0 94.0 93.0 94.0 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | [#8] json-parse-financial Cycles:10 Average:44.20 Median:44.50 stddev:1.81 (4.1%) stddev-sans-first:1.80 12:04:46 INFO - PID 30881 | Values: 46.0 45.0 42.0 43.0 48.0 43.0 45.0 43.0 43.0 44.0 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | [#9] json-stringify-tinderbox Cycles:10 Average:36.30 Median:36.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 12:04:46 INFO - PID 30881 | Values: 36.0 36.0 36.0 36.0 37.0 36.0 37.0 37.0 36.0 36.0 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | [#10] stanford-crypto-aes Cycles:10 Average:71.70 Median:71.50 stddev:1.77 (2.5%) stddev-sans-first:1.87 12:04:46 INFO - PID 30881 | Values: 72.0 71.0 72.0 71.0 71.0 71.0 70.0 70.0 73.0 76.0 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | [#11] stanford-crypto-ccm Cycles:10 Average:107.30 Median:108.00 stddev:4.00 (3.7%) stddev-sans-first:3.76 12:04:46 INFO - PID 30881 | Values: 102.0 103.0 113.0 107.0 105.0 104.0 114.0 108.0 108.0 109.0 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.80 Median:158.00 stddev:3.77 (2.4%) stddev-sans-first:3.86 12:04:46 INFO - PID 30881 | Values: 155.0 159.0 153.0 163.0 156.0 157.0 159.0 156.0 155.0 165.0 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:61.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 12:04:46 INFO - PID 30881 | Values: 61.0 61.0 61.0 61.0 63.0 60.0 62.0 61.0 60.0 60.0 12:04:46 INFO - PID 30881 | -------- Summary: end -------- 12:04:46 INFO - PID 30881 | 12:04:46 INFO - PID 30881 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:04:46 INFO - TEST-INFO | 30881: exit 0 12:04:46 INFO - TEST-OK | kraken | took 58692ms 12:04:46 INFO - SUITE-END | took 1166s 12:04:47 INFO - Completed test suite (00:19:26) 12:04:47 INFO - javascript benchmark 12:04:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9074.908245351584, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3842.3275926712818, 3843.442700808383, 3859.691224702024, 3866.188100498895, 3868.0523271798415, 6246.063090536421, 6304.369563043693, 6345.206849143857, 6349.0476428535685, 6459.6447195404235, 6300.991841305392, 6326.810195694136, 6338.841528961778, 6340.619562826234, 6364.968175159118, 5622.269105016342, 5645.560382102558, 5649.887002259952, 5656.915146272789, 5703.258576385064, 5728.914066289009, 5759.798407055754, 5769.394213607574, 5798.478136967672, 5814.098814683731, 5723.627964182315, 5762.798302059428, 5844.736986835582, 5847.5614328925285, 5862.97068514659, 5537.0, 5643.971780141114, 5666.178404131378, 5743.8564035899435, 5770.394108618577, 5686.800961966353, 5692.117721753135, 5755.740991655385, 5756.510696590794, 5760.0207964646115, 6203.286622038433, 6304.117423560705, 6318.620882747004, 6343.714532846033, 6423.293437721847, 6768.221654509745, 6773.0, 6779.62712050837, 6785.660716964181, 6814.284500127515, 6860.142482189726, 6888.690008949609, 6938.271481494471, 6945.270746571588, 6945.687444065029, 6362.0, 6438.323975982501, 6442.452391546724, 6451.83870403239, 6458.547901646886, 6960.129983752031, 7045.92954070463, 7100.360967512948, 7115.359617634438, 7117.217106118323, 6656.334366563305, 6732.730690772412, 6743.696533655997, 6763.830904227335, 6797.93202067973, 6908.1019467468905, 6914.965425172842, 6916.792496225121, 6938.826529336706, 6939.757108501179, 6806.149231346082, 6832.419244364285, 6878.0, 6884.483663725241, 6915.170179578483, 6813.386795188457, 6821.590704557742, 6905.37851593359, 6908.205556360982, 6914.170299564084, 4883.731394773251, 4884.096442158212, 4892.168331383673, 4906.55840974314, 4914.975425122923, 4544.97727511367, 4551.8179272829375, 4555.202839503074, 4607.815687372535, 4623.42207224097, 6256.468200203034, 6265.028920517327, 6276.748930042839, 6330.145430366933, 6331.2085989251345, 6811.557248778813, 6864.931350686529, 6873.175218973755, 6971.372576468142, 6972.163340399185, 6282.277538083179, 6319.020551814384, 6335.461485773669, 6337.809865704036, 6340.3342649022115, 5496.230527726121, 5554.583406244547, 5586.804461843816, 5588.832335029955, 5595.916061259084, 7002.614856182959, 7009.509334346547, 7028.648567571601, 7085.92914070863, 7101.431885449152, 6761.628110453972, 6838.350356716104, 6839.93160068393, 6861.485388595976, 6952.5480843745, 7036.472264580279, 7051.400630946427, 7055.223925368308, 7079.43364530826, 7081.610511421921, 6670.299618539983, 6779.72881084751, 6850.38346548813, 6868.862622747617, 6892.414144797748, 6708.6310252936555, 6798.558093723892, 6830.726770929107, 6862.897056544256, 6938.444924405934, 6492.707828147839, 6493.610383377012, 6504.089427480062, 6551.672416379257, 6584.341565843569, 6642.734290628321, 6655.966720166368, 6657.3342665733035, 6684.131062961784, 6711.0940023096255, 6492.675366231764, 6523.380278873499, 6558.1802274715665, 6673.766418175341, 6676.699548520425, 6686.364795344434, 6712.664366781543, 6714.2278637955305, 6723.2604413515455, 6758.763443279461, 6347.936520634735, 6420.6789660517725, 6450.838729031811, 6452.161219041494, 6517.348265173445], "value": 6256.858774655571, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [935.4995077633467, 960.8606752020961, 962.1196605106327, 968.6754937096073, 974.6345120579782, 42839.57160428395, 43361.34957975629, 43382.78308608461, 43392.566074339244, 43524.12951740963, 40377.0, 40547.18905621886, 40573.59426405735, 40842.0, 40916.181676366454, 7728.536287822734, 7854.096778870417, 7857.567833769141, 7858.174891636381, 7859.607019649024, 7616.086069671647, 7683.193264707209, 7693.807654808618, 7695.999520062384, 7697.730579429721, 7662.195469475709, 7678.846423071535, 8367.079621241659, 8462.788430289262, 8532.189442003, 8452.15478452153, 8490.872636910452, 8505.064442911274, 8522.190391912758, 8524.659013639446, 7917.0, 8068.919310806876, 8372.958135209285, 8456.830863382698, 8458.238758511701, 39159.0, 39270.0, 39515.20969580593, 39558.406623900664, 39565.0, 3699.4820725098507, 3739.0652336915773, 3743.0642339415144, 3754.887353379403, 3759.548854137521, 32119.678803211904, 32620.673793262, 32693.836530817433, 32789.344213115844, 32833.343333133205, 5496.80761173357, 5525.557955363602, 5533.612647114704, 5537.750801213955, 5576.665400075968, 212214.0, 212699.0, 212838.0, 212906.0, 213176.0, 50354.748226258635, 50466.74766626217, 50640.0, 50658.74670626623, 50667.493325067015, 53616.0, 53878.46121538813, 54042.729786350814, 54051.459485404645, 54065.45934540683, 15936.760948585781, 16309.347626094823, 16315.755263671055, 16323.10222937726, 16327.183640817912, 13079.280639564726, 13082.0, 13086.2802545859, 13098.279594622387, 13118.672033199246, 14526.782098268535, 14645.121292722471, 14709.411623535152, 14815.777763333559, 14902.627434314229, 5700.061978927185, 5703.857403564944, 5741.913871291934, 5805.332386775491, 5924.911126333109, 1101.3391964821203, 1105.6959336182615, 1108.7948729485072, 1109.7392112853472, 1117.932924024561, 25138.748612514006, 25362.873185634322, 25462.0, 25489.745102548735, 25506.48987020249, 1181.1082632612322, 1196.2463647901766, 1214.368528365245, 1218.1959906461693, 1220.6704189868685, 13434.529791457253, 13448.394822233024, 13614.251216183206, 13658.317084145752, 13723.245221512912, 265717.0, 267611.0, 268114.0, 268295.0, 269334.0, 50469.24296135561, 51699.483005170216, 55577.0, 55765.442345576834, 57283.0, 1512.5311153542436, 1520.4374381478924, 1537.48494254426, 1540.4223416218917, 1544.409258463784, 30066.699333007266, 30070.54894176633, 30123.0, 30328.696713032587, 30404.5439318406, 37210.25579488449, 37230.44154337633, 37567.0, 37632.0, 37687.81156094202, 225688.0, 226067.0, 226810.0, 227976.0, 229165.0, 34693.0, 34945.0, 35193.82403088071, 35197.472037919964, 35204.47193292154, 42735.3589696161, 44051.0, 44058.11883762371, 44431.11137777162, 44515.10969780651, 33548.83225583856, 33617.0, 33719.66280337263, 33765.49351759676, 33824.830875845466, 33627.49558756572, 33671.663283366855, 33748.325033499685, 33799.4930076054, 34030.48954265738, 38621.42067868928, 38899.0, 38953.61046389613, 38954.0, 39263.0, 32694.67305326916, 32719.345613087127, 33126.17184570405, 33215.83392083024, 33623.83188084044, 25000.249992500256, 25043.624345635195, 25078.49843003166, 25637.615435768104, 25944.8702756485], "value": 18230.157689119555, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.3787016827079, 595.1727099331927, 601.8344955137339, 625.3308959413428, 638.5817289675263, 23175.536489270205, 23835.642465363035, 23875.403114922115, 23988.1604143855, 23999.64000539993, 22727.54544909101, 24198.63702044471, 24205.39486512838, 24206.0, 24246.151384701538, 6673.165854268216, 6731.831704207385, 6761.188657361124, 6765.864682706343, 6787.4909381796315, 6575.901361479581, 6843.65781710915, 6858.417034552069, 6859.554128981626, 6873.690683919211, 6825.795226143224, 6836.521443498957, 6837.350451707105, 6842.9315706843045, 6845.5892646441125, 6812.0, 6828.419584335337, 6830.180378354579, 6836.726530938757, 6842.623655698934, 6342.080398342215, 6353.904691429586, 6358.936410635881, 6374.776882809126, 6374.936250637481, 30678.693213067807, 30682.079537613907, 31222.53166202509, 31426.37147257065, 31522.36955260905, 2254.729432468098, 2305.204704376987, 2309.434188623781, 2315.8610483371053, 2318.374039009475, 20546.79453205464, 21049.0, 21067.473313167295, 21103.261385851576, 21112.683309750213, 2482.2429159106464, 2534.746525347469, 2581.354661334666, 2651.111877521033, 2659.188947371051, 130866.345668272, 138814.3059284707, 158793.0, 162950.1852490742, 164672.0, 15971.281292341873, 16388.75416868748, 16423.83576164223, 16720.498385048468, 17384.783814994265, 26287.0, 26324.21027369182, 26347.20958371252, 26375.20874373772, 26413.73586264151, 9893.75265618351, 9987.0, 10097.44464054484, 10124.291299609104, 10177.287589868638, 8757.56212189388, 8764.912350876537, 8855.911440885637, 8906.554672266491, 8984.056674049261, 9836.704898853046, 9976.401415915068, 10094.343867648578, 10112.696619101438, 10218.642347517949, 2838.4181242845166, 2842.630458040483, 2890.6531216254184, 2939.706029397043, 2952.3652414730936, 1031.3914790273775, 1040.9895901040893, 1043.5773511727762, 1043.6555936540924, 1057.619257067455, 21321.25375611846, 21544.676829847565, 21569.352919412442, 21710.565788684136, 21964.341069767932, 1105.0606984063481, 1114.8885111488787, 1120.6694025262568, 1129.785340785248, 1139.4986206069302, 11527.437750044704, 11825.172237943261, 11896.88103118975, 11960.15944215238, 11969.16215864881, 553016.0, 570479.0, 580539.0, 586180.0, 593552.0, 122092.0, 123234.38382808029, 125422.3728881368, 126647.0, 126856.36571817081, 1138.174823253135, 1183.0, 1216.5620376664394, 1236.9876301237052, 1288.2785640041607, 22380.77619223787, 22761.430964226027, 22876.428089297235, 22904.198353057564, 23327.76672233256, 60947.0, 62740.68629657005, 63462.682686586275, 64083.3591664096, 64276.678616606616, 80214.0, 80339.59830200812, 80399.59800200962, 81046.0, 83067.0, 15504.612384690474, 15887.285072172011, 15979.520614381587, 15985.840141598435, 16012.039277643378, 24691.87654061718, 24907.0, 25367.492650146523, 25386.873065634554, 25527.0, 20581.38255852327, 20797.1681132753, 20833.68749468729, 21002.47493812667, 21028.0, 18103.909480452512, 18296.359627412978, 18493.352732654294, 18805.529861753566, 18880.43358699241, 21124.0, 21125.0, 21396.465088372915, 21457.785422146204, 21483.14067437285, 15272.618184545476, 15808.76286855675, 15868.127253001196, 15883.682326353177, 15883.920580397024, 20306.593868122258, 20348.491287717927, 20377.286794962107, 20519.589608207454, 20530.58938821245], "value": 12920.5918414899, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.6333371656513, 1447.1606468248417, 1458.4020551573853, 1467.2590341877358, 1468.772340287256, 16610.169491525437, 17361.82638173618, 17366.739498907526, 17381.0, 17390.56523586911, 16752.66494670109, 16871.07209103499, 16909.23908424121, 16940.66118677626, 16947.49157525273, 2803.78971577132, 2902.1873875314946, 2909.3453972856046, 2913.169746622213, 2915.6646985596717, 2844.7724182065385, 2888.783341249404, 2890.855457227141, 2894.233028247516, 2896.971030289702, 2720.279126031603, 2762.2541913683294, 2770.2381844992688, 2778.0832325332694, 2780.652418447694, 2666.733326667327, 2705.4589082183643, 2709.133077415228, 2710.1598504463677, 2711.173092206876, 2643.70919198888, 2664.107523979469, 2673.1713168917504, 2677.785777137844, 2683.18162960297, 16094.275757590936, 16274.674506509804, 16356.182190890408, 16362.345506179738, 16371.42700005506, 8421.915780842175, 8729.039805621376, 8755.518446485441, 8756.299496040365, 8765.824683506295, 5174.172132458826, 5204.193350030751, 5442.265294185314, 5450.836474905759, 5461.836144915659, 2037.1953078533895, 2059.773424923257, 2083.333333333334, 2099.9685004724943, 2133.775953524873, 26438.47123057528, 27256.31859203516, 29298.12105636834, 29958.25104372408, 29986.0, 7709.691612335444, 7710.0, 7712.267334603203, 7772.45592808498, 7864.9606751965875, 22446.55106897853, 22517.32448026562, 22563.09747610077, 22590.661140082913, 22603.321900343017, 8853.02616712174, 8874.068222836639, 8878.822423551494, 8903.510306933182, 8903.643854245887, 7485.588292643848, 7532.246775322424, 7542.019537460095, 7546.849063018709, 7589.1272503661685, 5917.289925209003, 6063.333033366326, 6200.286966998763, 6335.049742538656, 6360.300366959631, 1904.980950190508, 1950.1809240119185, 1968.1930408532432, 1973.0627951723104, 1986.9503262418555, 938.8497840345649, 952.8380175370204, 954.4702690006974, 959.9712008639752, 963.633819148719, 8855.778605534913, 9062.456252624863, 9068.727938161866, 9196.310276729271, 9280.39677420979, 780.9492382995201, 793.6587267475041, 794.9903622399636, 799.0690845165434, 803.4737247103157, 4991.376077990251, 5000.949990500048, 5010.398752149766, 5015.448300686921, 5116.513931176532, 23021.539569208522, 24506.264812055666, 24677.876610616833, 24702.25893223206, 24787.504249914902, 22850.657240141412, 24032.279031629078, 24085.7591424087, 24110.276691699277, 24301.75698242995, 10370.792584148425, 12221.450034748457, 12447.813282800766, 12601.306928119042, 12628.368581571069, 9270.953645231732, 9285.07149285066, 9299.30255230874, 9339.813203735752, 9434.339596228197, 20293.391198264075, 20813.375598732062, 21112.0, 21589.568208636054, 21919.342419727433, 21480.78519214788, 21610.783892160878, 22046.779532205113, 22553.323400298017, 22954.0, 13090.345482726016, 13310.600681979557, 13332.466701331838, 13347.799783003456, 13354.131981421177, 15533.533993980198, 15581.688366232838, 15623.375064997728, 15735.842641573896, 15776.684466310839, 12261.448234829633, 12308.815367769312, 12528.812067818808, 12697.746045079231, 12863.678408039874, 11816.645500634995, 11906.702332441759, 11922.701932451759, 12238.938805305916, 12332.50669973191, 10490.213234007633, 10572.84140737874, 10574.154067674413, 10611.363318200933, 10613.575456981634, 7870.527768333918, 7993.0, 8081.515109093473, 8097.392695547976, 8203.384746144182, 7743.341815945708, 7914.169012253861, 7928.127905930228, 7930.127685954656, 7947.562884041433], "value": 7261.715785671449, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.1166134185306, 564.187569899345, 580.6690186593642, 581.566732784076, 590.8434264919797, 6342.556021078526, 6376.713047912844, 6378.617282963014, 6423.6788160591905, 6429.164208652875, 6248.406401391871, 6257.62454252744, 6268.890853954035, 6289.371062893709, 6309.1482649842255, 4885.633577481685, 5051.848444546669, 5071.619628527857, 5125.615578831584, 5131.794728210876, 4952.950470495285, 4958.404991401037, 5012.448630650625, 5015.172496538085, 5025.246213068051, 4939.407271127469, 4953.23224900141, 4967.254911763228, 4996.1756310208775, 5016.3980322361185, 4927.778249978742, 4953.678010929278, 4964.776585053682, 5019.84940451787, 5023.472535383768, 4480.731156130642, 4529.954700452986, 4572.725636461823, 4582.1064892346, 4599.793009314589, 6211.409916058013, 6245.219347581552, 6282.277538083134, 6290.748370065192, 6311.211098612674, 5788.131780232957, 5832.891750567421, 5833.300003999505, 5835.737391817336, 5878.353381128072, 6618.716542792728, 6674.399304062657, 6694.43097336727, 6703.262641109474, 6742.561733487308, 4775.450823155312, 5017.899642007176, 5045.855511407637, 5049.2173713074535, 5078.984203159383, 6819.624920629363, 6852.417544508723, 6853.725850965955, 6916.23921368649, 6981.603679264167, 5148.613853960968, 5159.58723302135, 5172.19830926207, 5181.766820493087, 5183.3261675981885, 5171.681221288547, 5245.265662807134, 5270.5256526912, 5290.465764928204, 5293.788248470095, 5797.275340582427, 5844.766209351664, 5859.472647461749, 5880.882382352329, 5885.264341957255, 6736.93263067363, 6739.326067393222, 6767.593944363255, 6774.390304872585, 6802.14973128359, 1802.3511535847085, 1811.5199472139893, 1827.8301886792462, 1828.6159906419534, 1836.3848110882736, 1211.763706077324, 1267.8605353411117, 1276.9744605107846, 1294.3010774181837, 1299.9740005199842, 6059.333473317932, 6080.787172448943, 6099.207103076572, 6159.5072394208355, 6170.969145154335, 6738.427233685094, 6778.830529236809, 6800.353966373186, 6812.299513335783, 6850.451963842881, 5706.802880890887, 5967.522598192134, 5969.313528944227, 5996.610220335751, 6134.723937422737, 3494.790312581253, 3513.9648603514147, 3566.965579981828, 3569.6787289144104, 3584.5877724061547, 6740.258571557125, 6823.692933817891, 6918.135233095863, 6929.237783843773, 6950.826229344307, 6685.298043705438, 6763.864722705518, 6786.76246331376, 6851.9657401712675, 6936.4797640176175, 6795.592264464148, 6875.828104297432, 6876.17485901695, 6905.620190889449, 7011.404030657247, 6638.867222655616, 6707.798766037026, 6730.754810360099, 6781.457483401415, 6811.659417029228, 6746.434191791694, 6758.256591774999, 6768.492363072888, 6785.253622101466, 6796.898046529207, 6824.146981627297, 6829.965850170717, 6842.315768423317, 6960.468696886677, 6978.581285122909, 5077.0, 5091.490850914879, 5109.9744501277255, 5143.948560514347, 5220.608454366014, 6317.0, 6588.538802283986, 6588.8023359299295, 6795.52431329822, 6799.660016999229, 6151.292601350723, 6433.5496515243485, 6504.837379065372, 6537.70580323877, 6552.508561857784, 6349.333320001333, 6399.616023038632, 6455.3221911700475, 6455.57854337202, 6548.541602087808, 6447.548671592944, 6482.2869484357625, 6495.668387980359, 6497.610143391412, 6567.9671601641685, 6620.900686489803, 6623.172103487064, 6624.768133115318, 6637.800865974028, 6647.135872336566, 6318.936810631835, 6431.324710905287, 6464.834280515892, 6521.478281737544, 6536.281009088902], "value": 5167.520678823859, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [948.933574649774, 956.8469044952808, 971.485112890168, 986.4820968991284, 991.0634450444328, 23012.769872301273, 23627.29118126457, 23861.761382386172, 23967.76032239677, 24033.51932961342, 17455.650886982254, 19266.71099933502, 19306.51733706658, 19400.02999850009, 19582.92293923837, 1046.5865982936716, 1065.8028264771003, 1066.8559744434478, 1067.6209945469363, 1071.2073065931195, 1068.732816795801, 1082.2694681090272, 1085.1264731890824, 1085.207798307236, 1092.2845536173818, 1130.129800053958, 1155.8844115588458, 1157.2882677153575, 1157.3981529604644, 1157.4328578996315, 1123.893230143135, 1140.0879296562757, 1140.8916152965455, 1141.5034460009922, 1143.8684551276542, 836.9372297077743, 847.8685803700437, 850.0819115355401, 850.7702920211508, 850.8723691446271, 18309.45071647853, 20276.08757605911, 20360.28738994128, 20383.89808050965, 20390.79609203904, 22924.656130158062, 22956.19653312126, 23358.416039598975, 23462.53074938509, 23468.64797028046, 18530.888146711106, 18563.350282740175, 18621.348252811087, 18729.344472943383, 18880.811191888042, 3937.0944682723134, 3976.224636195943, 3980.5621381647998, 3981.6416522512823, 3981.820818063194, 160532.0, 162122.0, 162630.0, 163768.9999999988, 164653.0, 15906.840931590767, 16479.670406592042, 16644.417445389354, 16880.409185678443, 16940.152992350333, 28835.85582072076, 33366.16584585405, 33459.66540334566, 33552.32895342128, 33583.32833343319, 9700.805983880284, 9793.314467987173, 9939.204863610894, 9950.45272510019, 9977.151942084858, 4604.0, 4655.301704744248, 4672.836450724209, 4678.157931572282, 4682.578567928903, 6044.637321760709, 6182.721777520022, 6242.0, 6242.843928901813, 6253.093301471261, 1142.9599964001386, 1179.8348231247633, 1181.5214837990627, 1185.8458400408065, 1188.8157335612993, 731.3308322884501, 734.313416955138, 751.5678484871112, 751.8796992481286, 768.1051574915273, 13331.66670833237, 13429.992750543748, 13723.931380343034, 13985.021048526505, 14138.08102473336, 726.6548389514938, 727.7343769524085, 735.4704612678863, 743.7285390832308, 752.3379426104992, 6252.437280644764, 6312.715927783261, 6314.8421289467215, 6315.052742088632, 6381.329960354189, 150241.0, 152081.0, 153259.0, 156577.2171139137, 157106.21446892692, 124748.37625811994, 125675.0, 128834.0, 128879.35560322138, 137765.31117344348, 118348.0, 119182.0, 120341.56755108426, 122427.0, 124613.0, 12000.219985700902, 12052.0960927929, 12053.879461205275, 12152.513899443924, 12273.754524909273, 55300.0, 56018.43981560295, 56052.0, 56973.43026569847, 57587.1361929563, 69204.0, 70706.0, 70812.64593676999, 71269.0, 71344.0, 16974.74537881908, 17170.656586867943, 17186.828131719023, 17544.298228070733, 17746.29014839392, 22481.0, 22805.0, 22841.31476055721, 22854.42863928415, 22935.0, 18659.81340186581, 18742.344017959305, 18834.058297084815, 18847.15187816579, 18990.620187596447, 17961.640767184323, 18273.086345682397, 18325.725114123565, 18449.07754612237, 18470.722939155654, 18781.624367512846, 18784.6243075135, 18802.623947521246, 19064.618707626047, 19191.61616767629, 13035.674108146994, 13316.934645228164, 13337.19976801395, 13347.466101356225, 13448.663783405493, 12911.5480958166, 13212.471501140231, 13309.600711978655, 13339.19964802115, 13351.065425420127], "value": 10098.950574580338, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1368.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 105.0, 106.0, 106.0, 105.0, 105.0, 107.0, 106.0, 106.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 112.0, 111.0, 111.0, 135.0, 114.0, 112.0, 111.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 160.0, 160.0, 161.0, 163.0, 163.0, 160.0, 164.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 71.0, 75.0, 74.0, 73.0, 73.0, 74.0, 74.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 77.0, 78.0, 77.0, 77.0, 78.0, 78.0, 77.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 110.0, 113.0, 113.0, 113.0, 114.0, 114.0, 115.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 150.0, 149.0, 149.0, 150.0, 150.0, 151.0, 153.0, 151.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 93.0, 93.0, 94.0, 95.0, 94.0, 93.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 45.0, 42.0, 43.0, 48.0, 43.0, 45.0, 43.0, 43.0, 44.0], "value": 44.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 36.0, 36.0, 37.0, 36.0, 37.0, 37.0, 36.0, 36.0], "value": 36.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 71.0, 71.0, 71.0, 70.0, 70.0, 73.0, 76.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 103.0, 113.0, 107.0, 105.0, 104.0, 114.0, 108.0, 108.0, 109.0], "value": 107.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 159.0, 153.0, 163.0, 156.0, 157.0, 159.0, 156.0, 155.0, 165.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 63.0, 60.0, 62.0, 61.0, 60.0, 60.0], "value": 61.0, "unit": "score"}]}]} 12:04:47 INFO - Return code: 0 12:04:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:04:47 INFO - # TBPL SUCCESS # 12:04:47 INFO - Running post-action listener: _package_coverage_data 12:04:47 INFO - Running post-action listener: _resource_record_post_action 12:04:47 INFO - [mozharness: 2017-09-20 19:04:47.137846Z] Finished run-tests step (success) 12:04:47 INFO - Running post-run listener: _resource_record_post_run 12:04:47 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 330674176; Read time: 16; Write time: 215856 12:04:47 INFO - TinderboxPrint: CPU usage
13.1% 12:04:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:04:47 INFO - TinderboxPrint: I/O write bytes / time
330,674,176 / 215,856 12:04:47 INFO - TinderboxPrint: CPU idle
8,213.9 (86.9%) 12:04:47 INFO - TinderboxPrint: CPU user
1,186.8 (12.6%) 12:04:47 INFO - TinderboxPrint: Swap in / out
0 / 0 12:04:47 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10858496; Read time: 0; Write time: 1536 12:04:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:04:47 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 4096; Write bytes: 317464576; Read time: 16; Write time: 214208 12:04:47 INFO - Running post-run listener: _upload_blobber_files 12:04:47 INFO - Blob upload gear active. 12:04:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:04:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:04:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:04:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:04:48 INFO - (blobuploader) - INFO - Open directory for files ... 12:04:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:04:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:04:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:55 INFO - (blobuploader) - INFO - Done attempting. 12:04:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:04:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:04:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:56 INFO - (blobuploader) - INFO - Done attempting. 12:04:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:04:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:04:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:57 INFO - (blobuploader) - INFO - Done attempting. 12:04:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:04:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:05:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:00 INFO - (blobuploader) - INFO - Done attempting. 12:05:00 INFO - (blobuploader) - INFO - Iteration through files over. 12:05:00 INFO - Return code: 0 12:05:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:05:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:05:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4f506b2c83c62db4a1e440a25343c6aca7c85d1c7ae9ad96fe7a6188bf0b52c94011b57ecee144b58de4a93049076df37a790ce4d089e26e2d92909067b581", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e76f717f1e6e4684b1c6486c951f8af47bc01543951899a8f2873afe34e24d81518f95fd97383719edad5f98c3fa774092cc2e9821c82d799d4180e942efb7b3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88886b6ec04f55944a1d6875f5ad701995f31f6d8fbddb6af81a5b8f292d5b07ca5ff673072e82ec040d79fec22ba8fa32c5ebf60b141a74110548ba83be7d6c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b72fb909a36565727dc4bb001456c7a1f5857ea7a4537056f0eec494b9fabb0f6c75ea7cc316fa55eac539aae2b5a7c1339aeca64a5ba92d6bcfd637cdebc65"} 12:05:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:05:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:05:00 INFO - Contents: 12:05:00 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4f506b2c83c62db4a1e440a25343c6aca7c85d1c7ae9ad96fe7a6188bf0b52c94011b57ecee144b58de4a93049076df37a790ce4d089e26e2d92909067b581", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e76f717f1e6e4684b1c6486c951f8af47bc01543951899a8f2873afe34e24d81518f95fd97383719edad5f98c3fa774092cc2e9821c82d799d4180e942efb7b3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88886b6ec04f55944a1d6875f5ad701995f31f6d8fbddb6af81a5b8f292d5b07ca5ff673072e82ec040d79fec22ba8fa32c5ebf60b141a74110548ba83be7d6c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b72fb909a36565727dc4bb001456c7a1f5857ea7a4537056f0eec494b9fabb0f6c75ea7cc316fa55eac539aae2b5a7c1339aeca64a5ba92d6bcfd637cdebc65"} 12:05:00 INFO - Running post-run listener: copy_logs_to_upload_dir 12:05:00 INFO - Copying logs to upload dir... 12:05:00 INFO - mkdir: /builds/slave/test/build/upload/logs 12:05:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.920577 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-20 12:05:00.326430) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-09-20 12:05:00.330525) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4f506b2c83c62db4a1e440a25343c6aca7c85d1c7ae9ad96fe7a6188bf0b52c94011b57ecee144b58de4a93049076df37a790ce4d089e26e2d92909067b581", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e76f717f1e6e4684b1c6486c951f8af47bc01543951899a8f2873afe34e24d81518f95fd97383719edad5f98c3fa774092cc2e9821c82d799d4180e942efb7b3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88886b6ec04f55944a1d6875f5ad701995f31f6d8fbddb6af81a5b8f292d5b07ca5ff673072e82ec040d79fec22ba8fa32c5ebf60b141a74110548ba83be7d6c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b72fb909a36565727dc4bb001456c7a1f5857ea7a4537056f0eec494b9fabb0f6c75ea7cc316fa55eac539aae2b5a7c1339aeca64a5ba92d6bcfd637cdebc65"} build_url:https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011410 build_url: 'https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4f506b2c83c62db4a1e440a25343c6aca7c85d1c7ae9ad96fe7a6188bf0b52c94011b57ecee144b58de4a93049076df37a790ce4d089e26e2d92909067b581", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e76f717f1e6e4684b1c6486c951f8af47bc01543951899a8f2873afe34e24d81518f95fd97383719edad5f98c3fa774092cc2e9821c82d799d4180e942efb7b3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88886b6ec04f55944a1d6875f5ad701995f31f6d8fbddb6af81a5b8f292d5b07ca5ff673072e82ec040d79fec22ba8fa32c5ebf60b141a74110548ba83be7d6c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b72fb909a36565727dc4bb001456c7a1f5857ea7a4537056f0eec494b9fabb0f6c75ea7cc316fa55eac539aae2b5a7c1339aeca64a5ba92d6bcfd637cdebc65"}' ========= master_lag: 1.87 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-09-20 12:05:02.212633) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 12:05:02.212977) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1505932515.822480-957038206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004694 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 12:05:02.244609) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 12:05:02.244929) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 12:05:02.245278) ========= ========= Total master_lag: 2.20 =========