builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-011 starttime: 1505344510.75 results: success (0) revision: 0b3646aa9cbf3f77ee574a553ade9685e9229ab5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 16:15:10.748688) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 16:15:10.749117) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 16:15:10.749401) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 16:15:10.767252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 16:15:10.767631) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 16:15:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 100M=0s 2017-09-13 16:15:11 (100 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.250197 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 16:15:11.034903) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 16:15:11.035221) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016380 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 16:15:11.091343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 16:15:11.091687) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b3646aa9cbf3f77ee574a553ade9685e9229ab5 --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 0b3646aa9cbf3f77ee574a553ade9685e9229ab5 --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=5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 16:15:11,177 truncating revision to first 12 chars 2017-09-13 16:15:11,177 Setting DEBUG logging. 2017-09-13 16:15:11,177 attempt 1/10 2017-09-13 16:15:11,177 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b3646aa9cbf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 16:15:11,749 unpacking tar archive at: mozilla-central-0b3646aa9cbf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.849674 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 16:15:11.960600) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 16:15:11.960937) ========= script_repo_revision: 0b3646aa9cbf3f77ee574a553ade9685e9229ab5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 16:15:11.961307) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 16:15:11.961580) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 16:15:11.975001) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-13 16:15:11.975323) ========= /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=5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:15:12 INFO - MultiFileLogger online at 20170913 16:15:12 in /builds/slave/test 16:15:12 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 16:15:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:15:12 INFO - {'append_to_log': False, 16:15:12 INFO - 'base_work_dir': '/builds/slave/test', 16:15:12 INFO - 'blob_upload_branch': 'Firefox', 16:15:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:15:12 INFO - 'branch': 'Firefox', 16:15:12 INFO - 'buildbot_json_path': 'buildprops.json', 16:15:12 INFO - 'code_coverage': False, 16:15:12 INFO - 'config_files': ('talos/linux_config.py',), 16:15:12 INFO - 'default_actions': ('clobber', 16:15:12 INFO - 'read-buildbot-config', 16:15:12 INFO - 'download-and-extract', 16:15:12 INFO - 'populate-webroot', 16:15:12 INFO - 'create-virtualenv', 16:15:12 INFO - 'install', 16:15:12 INFO - 'setup-mitmproxy', 16:15:12 INFO - 'run-tests'), 16:15:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:15:12 INFO - 'disable_ccov_upload': False, 16:15:12 INFO - 'disable_stylo': False, 16:15:12 INFO - 'download_minidump_stackwalk': True, 16:15:12 INFO - 'download_symbols': 'ondemand', 16:15:12 INFO - 'enable_stylo': False, 16:15:12 INFO - 'enable_webrender': False, 16:15:12 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:15:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:15:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:15:12 INFO - 'gecko_profile': False, 16:15:12 INFO - 'gecko_profile_interval': 0, 16:15:12 INFO - 'installer_path': 'installer.exe', 16:15:12 INFO - 'log_level': 'info', 16:15:12 INFO - 'log_name': 'talos', 16:15:12 INFO - 'log_to_console': True, 16:15:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:15:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:15:12 INFO - 'opt_config_files': (), 16:15:12 INFO - 'pip_index': False, 16:15:12 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 16:15:12 INFO - 'system_bits': '32', 16:15:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:15:12 INFO - 'title': 'talos-linux64-ix-011', 16:15:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:15:12 INFO - 'use_talos_json': True, 16:15:12 INFO - 'verify': 'False', 16:15:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:15:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:15:12 INFO - 'work_dir': 'build'} 16:15:12 INFO - [mozharness: 2017-09-13 23:15:12.390375Z] Running clobber step. 16:15:12 INFO - Running pre-action listener: _resource_record_pre_action 16:15:12 INFO - Running main action method: clobber 16:15:12 INFO - rmtree: /builds/slave/test/build 16:15:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:15:13 INFO - Running post-action listener: _resource_record_post_action 16:15:13 INFO - [mozharness: 2017-09-13 23:15:13.332235Z] Finished clobber step (success) 16:15:13 INFO - [mozharness: 2017-09-13 23:15:13.332332Z] Running read-buildbot-config step. 16:15:13 INFO - Running pre-action listener: _resource_record_pre_action 16:15:13 INFO - Running main action method: read_buildbot_config 16:15:13 INFO - Using buildbot properties: 16:15:13 INFO - { 16:15:13 INFO - "project": "", 16:15:13 INFO - "product": "firefox", 16:15:13 INFO - "who": "archaeopteryx@coole-files.de", 16:15:13 INFO - "installer_path": "public/build/target.tar.bz2", 16:15:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 16:15:13 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:15:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 16:15:13 INFO - "stage_platform": "linux64-pgo", 16:15:13 INFO - "basedir": "/builds/slave/test", 16:15:13 INFO - "buildnumber": 8, 16:15:13 INFO - "platform": "ubuntu64_hw", 16:15:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:15:13 INFO - "slavebuilddir": "test", 16:15:13 INFO - "taskId": "PXZHXV3TS9O1THlL5vKiAw", 16:15:13 INFO - "branch": "mozilla-central", 16:15:13 INFO - "script_repo_revision": "production", 16:15:13 INFO - "revision": "0b3646aa9cbf3f77ee574a553ade9685e9229ab5", 16:15:13 INFO - "slavename": "talos-linux64-ix-011", 16:15:13 INFO - "repo_path": "mozilla-central" 16:15:13 INFO - } 16:15:13 INFO - Finding installer, test and symbols from parent task. 16:15:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PXZHXV3TS9O1THlL5vKiAw'}, attempt #1 16:15:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PXZHXV3TS9O1THlL5vKiAw'}, attempt #1 16:15:14 INFO - Task dependencies: EE2T5AdfROa4pbnRYPTKTA 16:15:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA'}, attempt #1 16:15:14 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.tar.bz2 16:15:14 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.test_packages.json 16:15:14 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.crashreporter-symbols.zip 16:15:14 INFO - Running post-action listener: _resource_record_post_action 16:15:14 INFO - [mozharness: 2017-09-13 23:15:14.700700Z] Finished read-buildbot-config step (success) 16:15:14 INFO - [mozharness: 2017-09-13 23:15:14.700916Z] Running download-and-extract step. 16:15:14 INFO - Running pre-action listener: _resource_record_pre_action 16:15:14 INFO - Running main action method: download_and_extract 16:15:14 INFO - mkdir: /builds/slave/test/build/tests 16:15:14 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')]} 16:15:14 INFO - trying https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.test_packages.json 16:15:14 INFO - Downloading https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:15:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:15:15 INFO - Downloaded 989 bytes. 16:15:15 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:15:15 INFO - Using the following test package requirements: 16:15:15 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:15:15 INFO - u'common': [u'target.common.tests.zip'], 16:15:15 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:15:15 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:15:15 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:15:15 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:15:15 INFO - u'mozbase': [u'target.common.tests.zip'], 16:15:15 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:15:15 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:15:15 INFO - u'web-platform': [u'target.common.tests.zip', 16:15:15 INFO - u'target.web-platform.tests.tar.gz'], 16:15:15 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:15:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:15:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.common.tests.zip 16:15:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:15:15 INFO - Fetch https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.common.tests.zip into memory 16:15:16 INFO - Content-Length response header: 55174506 16:15:16 INFO - Bytes received: 55174506 16:15:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.talos.tests.zip 16:15:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:15:27 INFO - Fetch https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.talos.tests.zip into memory 16:15:28 INFO - Content-Length response header: 14499226 16:15:28 INFO - Bytes received: 14499226 16:15:28 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')]} 16:15:28 INFO - trying https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.tar.bz2 16:15:28 INFO - Downloading https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:15:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:15:29 INFO - Downloaded 62066042 bytes. 16:15:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.tar.bz2 16:15:29 INFO - mkdir: /builds/slave/test/properties 16:15:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:15:29 INFO - Writing to file /builds/slave/test/properties/build_url 16:15:29 INFO - Contents: 16:15:29 INFO - build_url:https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.tar.bz2 16:15:29 INFO - Running post-action listener: _resource_record_post_action 16:15:29 INFO - Running post-action listener: find_tests_for_verification 16:15:29 INFO - Running post-action listener: set_extra_try_arguments 16:15:29 INFO - [mozharness: 2017-09-13 23:15:29.529963Z] Finished download-and-extract step (success) 16:15:29 INFO - [mozharness: 2017-09-13 23:15:29.530059Z] Running populate-webroot step. 16:15:29 INFO - Running pre-action listener: _resource_record_pre_action 16:15:29 INFO - Running main action method: populate_webroot 16:15:29 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:15:29 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:15:29 INFO - 'tests': ['tresize', 16:15:29 INFO - 'tcanvasmark']}, 16:15:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:15:29 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:15:29 INFO - 'tests': ['dromaeo_css', 16:15:29 INFO - 'kraken']}, 16:15:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:15:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:29 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:15:29 INFO - 'talos_options': ['--disable-stylo'], 16:15:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:15:29 INFO - 'tests': ['damp', 'tps']}, 16:15:29 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:15:29 INFO - 'talos_options': ['--disable-stylo'], 16:15:29 INFO - 'tests': ['damp', 'tps']}, 16:15:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:15:29 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:15:29 INFO - 'tests': ['dromaeo_dom']}, 16:15:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:15:29 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:15:29 INFO - 'tests': ['basic_compositor_video', 16:15:29 INFO - 'glvideo']}, 16:15:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:15:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:15:29 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:15:29 INFO - 'talos_options': ['--disable-stylo'], 16:15:29 INFO - 'tests': ['ts_paint_webext', 16:15:29 INFO - 'tp5o_webext']}, 16:15:29 INFO - 'other-e10s': {'tests': ['a11yr', 16:15:29 INFO - 'ts_paint', 16:15:29 INFO - 'tpaint', 16:15:29 INFO - 'sessionrestore', 16:15:29 INFO - 'sessionrestore_many_windows', 16:15:29 INFO - 'sessionrestore_no_auto_restore', 16:15:29 INFO - 'tabpaint']}, 16:15:29 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:15:29 INFO - 'tests': ['a11yr', 16:15:29 INFO - 'ts_paint', 16:15:29 INFO - 'tpaint', 16:15:29 INFO - 'sessionrestore', 16:15:29 INFO - 'sessionrestore_many_windows', 16:15:29 INFO - 'sessionrestore_no_auto_restore', 16:15:29 INFO - 'tabpaint']}, 16:15:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:15:29 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:15:29 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:15:29 INFO - 'tests': ['bloom_basic_singleton']}, 16:15:29 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:15:29 INFO - 'tests': ['bloom_basic']}, 16:15:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:15:29 INFO - 'tsvgr_opacity', 16:15:29 INFO - 'tart', 16:15:29 INFO - 'tscrollx', 16:15:29 INFO - 'tsvg_static']}, 16:15:29 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:15:29 INFO - 'tests': ['tsvgx', 16:15:29 INFO - 'tsvgr_opacity', 16:15:29 INFO - 'tart', 16:15:29 INFO - 'tscrollx', 16:15:29 INFO - 'tsvg_static']}, 16:15:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:15:29 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:15:29 INFO - 'talos_options': ['--disable-stylo'], 16:15:29 INFO - 'tests': ['tp5o']}, 16:15:29 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:15:29 INFO - 'talos_options': ['--mitmproxy', 16:15:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:15:29 INFO - '--firstNonBlankPaint'], 16:15:29 INFO - 'tests': ['tp6_google', 16:15:29 INFO - 'tp6_youtube', 16:15:29 INFO - 'tp6_amazon', 16:15:29 INFO - 'tp6_facebook']}, 16:15:29 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:15:29 INFO - 'talos_options': ['--disable-stylo', 16:15:29 INFO - '--mitmproxy', 16:15:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:15:29 INFO - '--firstNonBlankPaint'], 16:15:29 INFO - 'tests': ['tp6_google', 16:15:29 INFO - 'tp6_youtube', 16:15:29 INFO - 'tp6_amazon', 16:15:29 INFO - 'tp6_facebook']}, 16:15:29 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:15:29 INFO - 'talos_options': ['--stylo-threads=1', 16:15:29 INFO - '--mitmproxy', 16:15:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:15:29 INFO - '--firstNonBlankPaint'], 16:15:29 INFO - 'tests': ['tp6_google', 16:15:29 INFO - 'tp6_youtube', 16:15:29 INFO - 'tp6_amazon', 16:15:29 INFO - 'tp6_facebook']}, 16:15:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:15:29 INFO - 'talos_options': ['--xperf_path', 16:15:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:29 INFO - 'tests': ['tp5n']}, 16:15:29 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:15:29 INFO - 'talos_options': ['--disable-stylo', 16:15:29 INFO - '--xperf_path', 16:15:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:29 INFO - 'tests': ['tp5n']}}} 16:15:29 INFO - Running post-action listener: _resource_record_post_action 16:15:29 INFO - [mozharness: 2017-09-13 23:15:29.545284Z] Finished populate-webroot step (success) 16:15:29 INFO - [mozharness: 2017-09-13 23:15:29.545373Z] Running create-virtualenv step. 16:15:29 INFO - Running pre-action listener: _resource_record_pre_action 16:15:29 INFO - Running main action method: create_virtualenv 16:15:29 INFO - Creating virtualenv /builds/slave/test/build/venv 16:15:29 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:15:29 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:15:29 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:15:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:15:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:15:31 INFO - Installing distribute.............................................................................................................................................................................................done. 16:15:31 INFO - Installing pip...............done. 16:15:32 INFO - Return code: 0 16:15:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:15:32 INFO - Reading from file tmpfile_stdout 16:15:32 INFO - Output received: 16:15:32 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:15:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:32 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 0x27671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7090>, '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 0x2ad7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', '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 16:15:32 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 16:15:32 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 16:15:32 INFO - Using env: {'DISPLAY': ':0', 16:15:32 INFO - 'HOME': '/home/cltbld', 16:15:32 INFO - 'LANG': 'en_US.UTF-8', 16:15:32 INFO - 'LANGUAGE': 'en_US:en', 16:15:32 INFO - 'LOGNAME': 'cltbld', 16:15:32 INFO - 'MAIL': '/var/mail/cltbld', 16:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:32 INFO - 'MOZ_NO_REMOTE': '1', 16:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:32 INFO - 'NO_EM_RESTART': '1', 16:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:32 INFO - 'PWD': '/builds/slave/test', 16:15:32 INFO - 'SHELL': '/bin/bash', 16:15:32 INFO - 'SHLVL': '1', 16:15:32 INFO - 'TERM': 'linux', 16:15:32 INFO - 'TMOUT': '86400', 16:15:32 INFO - 'USER': 'cltbld', 16:15:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', 16:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:32 INFO - '_': '/tools/buildbot/bin/python'} 16:15:33 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:15:33 INFO - Downloading/unpacking pip>=1.5 16:15:33 INFO - Running setup.py egg_info for package pip 16:15:33 INFO - warning: no files found matching 'pip/cacert.pem' 16:15:33 INFO - warning: no files found matching '*.html' under directory 'docs' 16:15:33 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:15:33 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:15:33 INFO - Installing collected packages: pip 16:15:33 INFO - Found existing installation: pip 1.1 16:15:33 INFO - Uninstalling pip: 16:15:33 INFO - Successfully uninstalled pip 16:15:33 INFO - Running setup.py install for pip 16:15:33 INFO - warning: no files found matching 'pip/cacert.pem' 16:15:33 INFO - warning: no files found matching '*.html' under directory 'docs' 16:15:33 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:15:33 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:15:33 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:15:33 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:15:33 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:15:33 INFO - Successfully installed pip 16:15:33 INFO - Cleaning up... 16:15:33 INFO - Return code: 0 16:15:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:15:33 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')]} 16:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:33 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')]} 16:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:33 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 0x27671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7090>, '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 0x2ad7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', '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 16:15:33 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 16:15:33 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 16:15:33 INFO - Using env: {'DISPLAY': ':0', 16:15:33 INFO - 'HOME': '/home/cltbld', 16:15:33 INFO - 'LANG': 'en_US.UTF-8', 16:15:33 INFO - 'LANGUAGE': 'en_US:en', 16:15:33 INFO - 'LOGNAME': 'cltbld', 16:15:33 INFO - 'MAIL': '/var/mail/cltbld', 16:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:33 INFO - 'MOZ_NO_REMOTE': '1', 16:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:33 INFO - 'NO_EM_RESTART': '1', 16:15:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:33 INFO - 'PWD': '/builds/slave/test', 16:15:33 INFO - 'SHELL': '/bin/bash', 16:15:33 INFO - 'SHLVL': '1', 16:15:33 INFO - 'TERM': 'linux', 16:15:33 INFO - 'TMOUT': '86400', 16:15:33 INFO - 'USER': 'cltbld', 16:15:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', 16:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:33 INFO - '_': '/tools/buildbot/bin/python'} 16:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:34 INFO - Downloading/unpacking psutil>=3.1.1 16:15:34 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 16:15:34 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 16:15:34 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 16:15:34 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 16:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:15:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:15:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:15:35 INFO - Installing collected packages: psutil 16:15:35 INFO - Running setup.py install for psutil 16:15:35 INFO - building 'psutil._psutil_linux' extension 16:15:35 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 16:15:36 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 16:15:36 INFO - building 'psutil._psutil_posix' extension 16:15:36 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 16:15:36 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 16:15:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:15:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:15:36 INFO - Successfully installed psutil 16:15:36 INFO - Cleaning up... 16:15:36 INFO - Return code: 0 16:15:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7090>, '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 0x2ad7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', '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 16:15:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:15:36 INFO - Using env: {'DISPLAY': ':0', 16:15:36 INFO - 'HOME': '/home/cltbld', 16:15:36 INFO - 'LANG': 'en_US.UTF-8', 16:15:36 INFO - 'LANGUAGE': 'en_US:en', 16:15:36 INFO - 'LOGNAME': 'cltbld', 16:15:36 INFO - 'MAIL': '/var/mail/cltbld', 16:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:36 INFO - 'MOZ_NO_REMOTE': '1', 16:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:36 INFO - 'NO_EM_RESTART': '1', 16:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:36 INFO - 'PWD': '/builds/slave/test', 16:15:36 INFO - 'SHELL': '/bin/bash', 16:15:36 INFO - 'SHLVL': '1', 16:15:36 INFO - 'TERM': 'linux', 16:15:36 INFO - 'TMOUT': '86400', 16:15:36 INFO - 'USER': 'cltbld', 16:15:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', 16:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:36 INFO - '_': '/tools/buildbot/bin/python'} 16:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:15:37 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 16:15:37 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 16:15:37 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 16:15:37 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 16:15:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:15:38 INFO - Installing collected packages: mozsystemmonitor 16:15:38 INFO - Running setup.py install for mozsystemmonitor 16:15:38 INFO - Successfully installed mozsystemmonitor 16:15:38 INFO - Cleaning up... 16:15:38 INFO - Return code: 0 16:15:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7090>, '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 0x2ad7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', '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 16:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:15:38 INFO - Using env: {'DISPLAY': ':0', 16:15:38 INFO - 'HOME': '/home/cltbld', 16:15:38 INFO - 'LANG': 'en_US.UTF-8', 16:15:38 INFO - 'LANGUAGE': 'en_US:en', 16:15:38 INFO - 'LOGNAME': 'cltbld', 16:15:38 INFO - 'MAIL': '/var/mail/cltbld', 16:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:38 INFO - 'MOZ_NO_REMOTE': '1', 16:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:38 INFO - 'NO_EM_RESTART': '1', 16:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:38 INFO - 'PWD': '/builds/slave/test', 16:15:38 INFO - 'SHELL': '/bin/bash', 16:15:38 INFO - 'SHLVL': '1', 16:15:38 INFO - 'TERM': 'linux', 16:15:38 INFO - 'TMOUT': '86400', 16:15:38 INFO - 'USER': 'cltbld', 16:15:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', 16:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:38 INFO - '_': '/tools/buildbot/bin/python'} 16:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:38 INFO - Downloading/unpacking jsonschema==2.5.1 16:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:15:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:39 INFO - Downloading functools32-3.2.3-2.tar.gz 16:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:15:39 INFO - warning: no files found matching '*.txt' 16:15:39 INFO - no previously-included directories found matching 'build' 16:15:39 INFO - no previously-included directories found matching 'dist' 16:15:39 INFO - no previously-included directories found matching '.git*' 16:15:39 INFO - Installing collected packages: jsonschema, functools32 16:15:39 INFO - Running setup.py install for functools32 16:15:40 INFO - warning: no files found matching '*.txt' 16:15:40 INFO - no previously-included directories found matching 'build' 16:15:40 INFO - no previously-included directories found matching 'dist' 16:15:40 INFO - no previously-included directories found matching '.git*' 16:15:40 INFO - Successfully installed jsonschema functools32 16:15:40 INFO - Cleaning up... 16:15:40 INFO - Return code: 0 16:15:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7090>, '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 0x2ad7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', '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 16:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:15:40 INFO - Using env: {'DISPLAY': ':0', 16:15:40 INFO - 'HOME': '/home/cltbld', 16:15:40 INFO - 'LANG': 'en_US.UTF-8', 16:15:40 INFO - 'LANGUAGE': 'en_US:en', 16:15:40 INFO - 'LOGNAME': 'cltbld', 16:15:40 INFO - 'MAIL': '/var/mail/cltbld', 16:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:40 INFO - 'MOZ_NO_REMOTE': '1', 16:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:40 INFO - 'NO_EM_RESTART': '1', 16:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:40 INFO - 'PWD': '/builds/slave/test', 16:15:40 INFO - 'SHELL': '/bin/bash', 16:15:40 INFO - 'SHLVL': '1', 16:15:40 INFO - 'TERM': 'linux', 16:15:40 INFO - 'TMOUT': '86400', 16:15:40 INFO - 'USER': 'cltbld', 16:15:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', 16:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:40 INFO - '_': '/tools/buildbot/bin/python'} 16:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:15:40 INFO - Cleaning up... 16:15:40 INFO - Return code: 0 16:15:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7090>, '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 0x2ad7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', '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 16:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:15:40 INFO - Using env: {'DISPLAY': ':0', 16:15:40 INFO - 'HOME': '/home/cltbld', 16:15:40 INFO - 'LANG': 'en_US.UTF-8', 16:15:40 INFO - 'LANGUAGE': 'en_US:en', 16:15:40 INFO - 'LOGNAME': 'cltbld', 16:15:40 INFO - 'MAIL': '/var/mail/cltbld', 16:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:40 INFO - 'MOZ_NO_REMOTE': '1', 16:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:40 INFO - 'NO_EM_RESTART': '1', 16:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:40 INFO - 'PWD': '/builds/slave/test', 16:15:40 INFO - 'SHELL': '/bin/bash', 16:15:40 INFO - 'SHLVL': '1', 16:15:40 INFO - 'TERM': 'linux', 16:15:40 INFO - 'TMOUT': '86400', 16:15:40 INFO - 'USER': 'cltbld', 16:15:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', 16:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:40 INFO - '_': '/tools/buildbot/bin/python'} 16:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:40 INFO - Downloading/unpacking blobuploader==1.2.4 16:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:41 INFO - Downloading blobuploader-1.2.4.tar.gz 16:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:15:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:15:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:42 INFO - Downloading docopt-0.6.1.tar.gz 16:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:15:42 INFO - Installing collected packages: blobuploader, requests, docopt 16:15:42 INFO - Running setup.py install for blobuploader 16:15:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:15:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:15:42 INFO - Running setup.py install for requests 16:15:42 INFO - Running setup.py install for docopt 16:15:42 INFO - Successfully installed blobuploader requests docopt 16:15:42 INFO - Cleaning up... 16:15:43 INFO - Return code: 0 16:15:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:43 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 0x27671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7090>, '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 0x2ad7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', '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 16:15:43 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 16:15:43 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 16:15:43 INFO - Using env: {'DISPLAY': ':0', 16:15:43 INFO - 'HOME': '/home/cltbld', 16:15:43 INFO - 'LANG': 'en_US.UTF-8', 16:15:43 INFO - 'LANGUAGE': 'en_US:en', 16:15:43 INFO - 'LOGNAME': 'cltbld', 16:15:43 INFO - 'MAIL': '/var/mail/cltbld', 16:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:43 INFO - 'MOZ_NO_REMOTE': '1', 16:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:43 INFO - 'NO_EM_RESTART': '1', 16:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:43 INFO - 'PWD': '/builds/slave/test', 16:15:43 INFO - 'SHELL': '/bin/bash', 16:15:43 INFO - 'SHLVL': '1', 16:15:43 INFO - 'TERM': 'linux', 16:15:43 INFO - 'TMOUT': '86400', 16:15:43 INFO - 'USER': 'cltbld', 16:15:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', 16:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:43 INFO - '_': '/tools/buildbot/bin/python'} 16:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:43 INFO - Running setup.py (path:/tmp/pip-GHKN09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:43 INFO - Running setup.py (path:/tmp/pip-wgImGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:43 INFO - Running setup.py (path:/tmp/pip-sKwXyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:43 INFO - Running setup.py (path:/tmp/pip-RcLqCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:43 INFO - Running setup.py (path:/tmp/pip-mRKq8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:43 INFO - Running setup.py (path:/tmp/pip-iYaaIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:43 INFO - Running setup.py (path:/tmp/pip-3Unf9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:43 INFO - Running setup.py (path:/tmp/pip-nPzKkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:43 INFO - Running setup.py (path:/tmp/pip-DaRk8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:43 INFO - Running setup.py (path:/tmp/pip-DuQ5ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:43 INFO - Running setup.py (path:/tmp/pip-vQYDZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:44 INFO - Running setup.py (path:/tmp/pip-7S1oWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:44 INFO - Running setup.py (path:/tmp/pip-wpwW3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:44 INFO - Running setup.py (path:/tmp/pip-MP1rcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:44 INFO - Running setup.py (path:/tmp/pip-PmqTx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:44 INFO - Running setup.py (path:/tmp/pip-sO8U5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:44 INFO - Running setup.py (path:/tmp/pip-pefa4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:15:44 INFO - Running setup.py install for manifestparser 16:15:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:15:44 INFO - Running setup.py install for mozcrash 16:15:44 INFO - Running setup.py install for mozdebug 16:15:44 INFO - Running setup.py install for mozdevice 16:15:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:15:44 INFO - Running setup.py install for mozfile 16:15:44 INFO - Running setup.py install for mozhttpd 16:15:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for mozinfo 16:15:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for mozInstall 16:15:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for mozleak 16:15:45 INFO - Running setup.py install for mozlog 16:15:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for moznetwork 16:15:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for mozprocess 16:15:45 INFO - Running setup.py install for mozprofile 16:15:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for mozrunner 16:15:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:15:45 INFO - Running setup.py install for mozscreenshot 16:15:45 INFO - Running setup.py install for moztest 16:15:46 INFO - Running setup.py install for mozversion 16:15:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:15:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:15:46 INFO - Cleaning up... 16:15:46 INFO - Return code: 0 16:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15: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')]} 16:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15: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')]} 16:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:46 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 0x27671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7090>, '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 0x2ad7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', '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 16:15:46 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 16:15:46 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 16:15:46 INFO - Using env: {'DISPLAY': ':0', 16:15:46 INFO - 'HOME': '/home/cltbld', 16:15:46 INFO - 'LANG': 'en_US.UTF-8', 16:15:46 INFO - 'LANGUAGE': 'en_US:en', 16:15:46 INFO - 'LOGNAME': 'cltbld', 16:15:46 INFO - 'MAIL': '/var/mail/cltbld', 16:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:46 INFO - 'MOZ_NO_REMOTE': '1', 16:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:46 INFO - 'NO_EM_RESTART': '1', 16:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:46 INFO - 'PWD': '/builds/slave/test', 16:15:46 INFO - 'SHELL': '/bin/bash', 16:15:46 INFO - 'SHLVL': '1', 16:15:46 INFO - 'TERM': 'linux', 16:15:46 INFO - 'TMOUT': '86400', 16:15:46 INFO - 'USER': 'cltbld', 16:15:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', 16:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:46 INFO - '_': '/tools/buildbot/bin/python'} 16:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:46 INFO - Running setup.py (path:/tmp/pip-mTABZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:46 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)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:46 INFO - Running setup.py (path:/tmp/pip-C4vV3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:46 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)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:46 INFO - Running setup.py (path:/tmp/pip-49tNvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15:46 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)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:46 INFO - Running setup.py (path:/tmp/pip-ACVu_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:46 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)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:46 INFO - Running setup.py (path:/tmp/pip-HYhs1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:46 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)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:46 INFO - Running setup.py (path:/tmp/pip-kDzpBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:46 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)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:46 INFO - Running setup.py (path:/tmp/pip-7yxfq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:46 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)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:46 INFO - Running setup.py (path:/tmp/pip-XgySo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:46 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)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:46 INFO - Running setup.py (path:/tmp/pip-YpigdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:46 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)) 16:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:46 INFO - Running setup.py (path:/tmp/pip-lQZSn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:47 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:47 INFO - Running setup.py (path:/tmp/pip-CntYuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:47 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:47 INFO - Running setup.py (path:/tmp/pip-h77uGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15:47 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:47 INFO - Running setup.py (path:/tmp/pip-30GSWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:47 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:47 INFO - Running setup.py (path:/tmp/pip-GcsLry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:47 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:47 INFO - Running setup.py (path:/tmp/pip-MWfHrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:47 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:47 INFO - Running setup.py (path:/tmp/pip-Xt7SsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:47 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)) 16:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:47 INFO - Running setup.py (path:/tmp/pip-0LOSM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:47 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)) 16:15:47 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)) 16:15:47 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)) 16:15:47 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)) 16:15:47 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)) 16:15:47 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)) 16:15:47 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)) 16:15:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:48 INFO - Downloading blessings-1.6.tar.gz 16:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:15:48 INFO - Installing collected packages: blessings 16:15:48 INFO - Running setup.py install for blessings 16:15:48 INFO - Successfully installed blessings 16:15:48 INFO - Cleaning up... 16:15:48 INFO - Return code: 0 16:15:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:15:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:15:49 INFO - Reading from file tmpfile_stdout 16:15:49 INFO - Current package versions: 16:15:49 INFO - argparse == 1.2.1 16:15:49 INFO - blessings == 1.6 16:15:49 INFO - blobuploader == 1.2.4 16:15:49 INFO - docopt == 0.6.1 16:15:49 INFO - functools32 == 3.2.3-2 16:15:49 INFO - jsonschema == 2.5.1 16:15:49 INFO - manifestparser == 1.1 16:15:49 INFO - mozInstall == 1.13 16:15:49 INFO - mozcrash == 1.0 16:15:49 INFO - mozdebug == 0.1 16:15:49 INFO - mozdevice == 0.51 16:15:49 INFO - mozfile == 1.2 16:15:49 INFO - mozhttpd == 0.7 16:15:49 INFO - mozinfo == 0.10 16:15:49 INFO - mozleak == 0.1 16:15:49 INFO - mozlog == 3.5 16:15:49 INFO - moznetwork == 0.27 16:15:49 INFO - mozprocess == 0.25 16:15:49 INFO - mozprofile == 0.28 16:15:49 INFO - mozrunner == 6.13 16:15:49 INFO - mozscreenshot == 0.1 16:15:49 INFO - mozsystemmonitor == 0.3 16:15:49 INFO - moztest == 0.8 16:15:49 INFO - mozversion == 1.4 16:15:49 INFO - psutil == 3.1.1 16:15:49 INFO - requests == 1.2.3 16:15:49 INFO - wsgiref == 0.1.2 16:15:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:49 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 0x27671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7090>, '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 0x2ad7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', '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 16:15:49 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 16:15:49 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 16:15:49 INFO - Using env: {'DISPLAY': ':0', 16:15:49 INFO - 'HOME': '/home/cltbld', 16:15:49 INFO - 'LANG': 'en_US.UTF-8', 16:15:49 INFO - 'LANGUAGE': 'en_US:en', 16:15:49 INFO - 'LOGNAME': 'cltbld', 16:15:49 INFO - 'MAIL': '/var/mail/cltbld', 16:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:49 INFO - 'MOZ_NO_REMOTE': '1', 16:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:49 INFO - 'NO_EM_RESTART': '1', 16:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:49 INFO - 'PWD': '/builds/slave/test', 16:15:49 INFO - 'SHELL': '/bin/bash', 16:15:49 INFO - 'SHLVL': '1', 16:15:49 INFO - 'TERM': 'linux', 16:15:49 INFO - 'TMOUT': '86400', 16:15:49 INFO - 'USER': 'cltbld', 16:15:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', 16:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:49 INFO - '_': '/tools/buildbot/bin/python'} 16:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:49 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)) 16:15:49 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)) 16:15:49 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)) 16:15:49 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)) 16:15:49 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)) 16:15:49 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)) 16:15:49 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)) 16:15:49 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)) 16:15:49 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)) 16:15:49 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:15: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 16:15: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 16:15: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 16:15: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 16:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:15:50 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)) 16:15:50 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)) 16:15:50 INFO - Installing collected packages: simplejson 16:15:50 INFO - Running setup.py install for simplejson 16:15:50 INFO - building 'simplejson._speedups' extension 16:15:50 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 16:15:51 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 16:15:51 INFO - Successfully installed simplejson 16:15:51 INFO - Cleaning up... 16:15:51 INFO - Return code: 0 16:15:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7090>, '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 0x2ad7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', '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 16:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:15:51 INFO - Using env: {'DISPLAY': ':0', 16:15:51 INFO - 'HOME': '/home/cltbld', 16:15:51 INFO - 'LANG': 'en_US.UTF-8', 16:15:51 INFO - 'LANGUAGE': 'en_US:en', 16:15:51 INFO - 'LOGNAME': 'cltbld', 16:15:51 INFO - 'MAIL': '/var/mail/cltbld', 16:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:51 INFO - 'MOZ_NO_REMOTE': '1', 16:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:51 INFO - 'NO_EM_RESTART': '1', 16:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:51 INFO - 'PWD': '/builds/slave/test', 16:15:51 INFO - 'SHELL': '/bin/bash', 16:15:51 INFO - 'SHLVL': '1', 16:15:51 INFO - 'TERM': 'linux', 16:15:51 INFO - 'TMOUT': '86400', 16:15:51 INFO - 'USER': 'cltbld', 16:15:51 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', 16:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:51 INFO - '_': '/tools/buildbot/bin/python'} 16:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:15:51 INFO - Cleaning up... 16:15:51 INFO - Return code: 0 16:15:51 INFO - Running post-action listener: _resource_record_post_action 16:15:51 INFO - Running post-action listener: _start_resource_monitoring 16:15:51 INFO - Starting resource monitoring. 16:15:51 INFO - [mozharness: 2017-09-13 23:15:51.851974Z] Finished create-virtualenv step (success) 16:15:51 INFO - [mozharness: 2017-09-13 23:15:51.852960Z] Running install step. 16:15:51 INFO - Running pre-action listener: _resource_record_pre_action 16:15:51 INFO - Running main action method: install 16:15:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:15:52 INFO - Reading from file tmpfile_stdout 16:15:52 INFO - Detecting whether we're running mozinstall >=1.0... 16:15:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:15:52 INFO - Reading from file tmpfile_stdout 16:15:52 INFO - Output received: 16:15:52 INFO - Usage: mozinstall [options] installer 16:15:52 INFO - Options: 16:15:52 INFO - -h, --help show this help message and exit 16:15:52 INFO - -d DEST, --destination=DEST 16:15:52 INFO - Directory to install application into. [default: 16:15:52 INFO - "/builds/slave/test"] 16:15:52 INFO - --app=APP Application being installed. [default: firefox] 16:15:52 INFO - mkdir: /builds/slave/test/build/application 16:15:52 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'] 16:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:16:09 INFO - Reading from file tmpfile_stdout 16:16:09 INFO - Output received: 16:16:09 INFO - /builds/slave/test/build/application/firefox/firefox 16:16:09 INFO - Running post-action listener: _resource_record_post_action 16:16:09 INFO - [mozharness: 2017-09-13 23:16:09.784581Z] Finished install step (success) 16:16:09 INFO - [mozharness: 2017-09-13 23:16:09.784833Z] Running setup-mitmproxy step. 16:16:09 INFO - Running pre-action listener: _resource_record_pre_action 16:16:09 INFO - Running main action method: setup_mitmproxy 16:16:09 INFO - Skipping: mitmproxy is not required 16:16:09 INFO - Running post-action listener: _resource_record_post_action 16:16:09 INFO - [mozharness: 2017-09-13 23:16:09.785976Z] Finished setup-mitmproxy step (success) 16:16:09 INFO - [mozharness: 2017-09-13 23:16:09.786197Z] Running run-tests step. 16:16:09 INFO - Running pre-action listener: _resource_record_pre_action 16:16:09 INFO - Running pre-action listener: _set_gcov_prefix 16:16:09 INFO - Running main action method: run_tests 16:16:09 WARNING - Try message not found. 16:16:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:16:09 INFO - Python 2.7.3 16:16:09 INFO - Return code: 0 16:16:09 INFO - grabbing minidump binary from tooltool 16:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:09 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7090>, '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 0x2ad7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:16:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:16:09 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:16:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:16:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:16:09 INFO - Return code: 0 16:16:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:16:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:16:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:16:09 INFO - ENV: RUST_BACKTRACE is now full 16:16:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:16:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:16:09 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/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 16:16:09 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/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 16:16:09 INFO - Using env: {'DISPLAY': ':0', 16:16:09 INFO - 'HOME': '/home/cltbld', 16:16:09 INFO - 'LANG': 'en_US.UTF-8', 16:16:09 INFO - 'LANGUAGE': 'en_US:en', 16:16:09 INFO - 'LOGNAME': 'cltbld', 16:16:09 INFO - 'MAIL': '/var/mail/cltbld', 16:16:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:16:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:09 INFO - 'MOZ_NO_REMOTE': '1', 16:16:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:09 INFO - 'NO_EM_RESTART': '1', 16:16:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:09 INFO - 'PWD': '/builds/slave/test', 16:16:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:16:09 INFO - 'RUST_BACKTRACE': 'full', 16:16:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:16:09 INFO - 'SHELL': '/bin/bash', 16:16:09 INFO - 'SHLVL': '1', 16:16:09 INFO - 'TERM': 'linux', 16:16:09 INFO - 'TMOUT': '86400', 16:16:09 INFO - 'USER': 'cltbld', 16:16:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', 16:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:09 INFO - '_': '/tools/buildbot/bin/python'} 16:16:09 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/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 16:16:10 INFO - mozversion application_buildid: 20170913215701 16:16:10 INFO - mozversion application_changeset: 0b3646aa9cbf3f77ee574a553ade9685e9229ab5 16:16:10 INFO - mozversion application_display_name: Nightly 16:16:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:16:10 INFO - mozversion application_name: Firefox 16:16:10 INFO - mozversion application_remotingname: firefox 16:16:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:16:10 INFO - mozversion application_vendor: Mozilla 16:16:10 INFO - mozversion application_version: 57.0a1 16:16:10 INFO - mozversion platform_buildid: 20170913215701 16:16:10 INFO - mozversion platform_changeset: 0b3646aa9cbf3f77ee574a553ade9685e9229ab5 16:16:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:16:10 INFO - mozversion platform_version: 57.0a1 16:16:10 INFO - using testdate: 1505344570 16:16:10 INFO - actual date: 1505344570 16:16:10 INFO - starting webserver on 'localhost:34139' 16:16:10 INFO - SUITE-START | Running 2 tests 16:16:10 INFO - TEST-START | dromaeo_css 16:16:10 INFO - Initialising browser for dromaeo_css test... 16:16:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34139/getInfo.html -profile /tmp/tmpyXaMDd/profile 16:16:10 INFO - TEST-INFO | started process 3540 (/builds/slave/test/build/application/firefox/firefox http://localhost:34139/getInfo.html) 16:16:20 INFO - TEST-INFO | 3540: exit 0 16:16:20 INFO - Browser initialized. 16:16:20 INFO - Running cycle 1/1 for dromaeo_css test... 16:16:20 INFO - Using env: {'DISPLAY': ':0', 16:16:20 INFO - 'HOME': '/home/cltbld', 16:16:20 INFO - 'JSGC_DISABLE_POISONING': '1', 16:16:20 INFO - 'LANG': 'en_US.UTF-8', 16:16:20 INFO - 'LANGUAGE': 'en_US:en', 16:16:20 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:16:20 INFO - 'LOGNAME': 'cltbld', 16:16:20 INFO - 'MAIL': '/var/mail/cltbld', 16:16:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:16:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:16:20 INFO - 'MOZ_CRASHREPORTER': '1', 16:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:20 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:16:20 INFO - 'MOZ_NO_REMOTE': '1', 16:16:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:20 INFO - 'NO_EM_RESTART': '1', 16:16:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:20 INFO - 'PWD': '/builds/slave/test', 16:16:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:16:21 INFO - 'RUST_BACKTRACE': 'full', 16:16:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:16:21 INFO - 'SHELL': '/bin/bash', 16:16:21 INFO - 'SHLVL': '1', 16:16:21 INFO - 'STYLO_FORCE_DISABLED': '1', 16:16:21 INFO - 'TERM': 'linux', 16:16:21 INFO - 'TMOUT': '86400', 16:16:21 INFO - 'USER': 'cltbld', 16:16:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', 16:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:21 INFO - '_': '/tools/buildbot/bin/python'} 16:16:21 INFO - TEST-INFO | started process 3777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyXaMDd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:16:21 INFO - PID 3777 | 16:16:21 INFO - PID 3777 | (/builds/slave/test/build/application/firefox/firefox:3828): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:16:21 INFO - PID 3777 | 16:16:32 INFO - PID 3777 | RSS: Main: 160833536 16:16:32 INFO - PID 3777 | 16:19:29 INFO - PID 3777 | Cycle 1(1): loaded http://localhost:34139/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34139/tests/dromaeo/cssquery-ext.html) 16:19:30 INFO - PID 3777 | RSS: Main: 166096896 16:19:30 INFO - PID 3777 | 16:22:32 INFO - PID 3777 | Cycle 1(1): loaded http://localhost:34139/tests/dromaeo/cssquery-ext.html (next: http://localhost:34139/tests/dromaeo/cssquery-jquery.html) 16:22:32 INFO - PID 3777 | RSS: Main: 164728832 16:22:32 INFO - PID 3777 | 16:25:34 INFO - PID 3777 | Cycle 1(1): loaded http://localhost:34139/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34139/tests/dromaeo/cssquery-mootools.html) 16:25:35 INFO - PID 3777 | RSS: Main: 165355520 16:25:35 INFO - PID 3777 | 16:28:36 INFO - PID 3777 | Cycle 1(1): loaded http://localhost:34139/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34139/tests/dromaeo/cssquery-prototype.html) 16:28:37 INFO - PID 3777 | RSS: Main: 165588992 16:28:37 INFO - PID 3777 | 16:31:40 INFO - PID 3777 | Cycle 1(1): loaded http://localhost:34139/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34139/tests/dromaeo/cssquery-yui.html) 16:31:40 INFO - PID 3777 | RSS: Main: 166883328 16:31:40 INFO - PID 3777 | 16:34:42 INFO - PID 3777 | Cycle 1(1): loaded http://localhost:34139/tests/dromaeo/cssquery-yui.html (next: http://localhost:34139/tests/dromaeo/cssquery-dojo.html) 16:34:42 INFO - PID 3777 | RSS: Main: 169463808 16:34:42 INFO - PID 3777 | 16:34:42 INFO - PID 3777 | __start_tp_report 16:34:42 INFO - PID 3777 | _x_x_mozilla_page_load 16:34:42 INFO - PID 3777 | _x_x_mozilla_page_load_details 16:34:42 INFO - PID 3777 | |i|pagename|runs| 16:34:42 INFO - PID 3777 | |0;dojo.html;3819.064329239336;3833.175867188554;3857.884263472095;3880.2045580655968;3892.82482288297;6148.84627884302;6224.968875155618;6251.09359142924;6280.026595877641;6290.528210384216;6346.777862774804;6348.58734182279;6353;6381.712822922968;6396.040593910904;5560.4161563035905;5638.746256418471;5669.518090962263;5680.488756011958;5691.260136182291;5722.084466485342;5744.856378590527;5761.625494342854;5769.913451298234;5790.420957904218;5656.688882111483;5688.687122208277;5746.0806270996645;5769.249997500319;5772.480476757091;5460.26286451328;5614.214010038598;5651.632643878134;5684.54523638108;5695.800646977336;5606.719664016783;5617.747201375907;5701.486866182022;5716.485516303553;5721.599488035839;6168.568200225986;6280.748770049193;6281;6287.402696743802;6357.07822365759;6794.694238759268;6857.622830744307;6882.311768823128;6884.242733299333;6915.827104322432;6925.930740692629;6948.409385202213;6976.5116441849095;7021.403180729644;7032;6401.391867772554;6434.517411194132;6474.093626892239;6502.252240992252;6522.804315870531;7058.858822823618;7085.645717714094;7086.397656199178;7123.7506687265695;7128.037714908524;6760.797176084725;6817.420519255819;6849.623270720059;6863.073485079451;6863.485238607124;6892.310768923067;6897.586144831326;6903.102596662402;6979.127609048869;7005.964970175219;6707.463402927754;6752;6800.591964482147;6880.724771009103;6927.168739751262;6826.146731658543;6890.655467226618;6903.102596662402;6931.410830079399;6931.722731090801;4972.7513624318635;5034.993001399735;5046.84859454217;5048.343715316985;5053.216751403538;4431.578999994996;4520.344550040226;4544.818207271672;4545.863624091283;4555.749433781174;6265.185525881698;6348.1430006949395;6372;6375.10748495211;6387.425131738166;6836.589804611739;6842.863142737117;6902.896456553156;6939.548929319578;6942.93057069433;6257.74969001244;6269.185005949197;6351.55539112267;6362.84092897672;6364.49084073273;5415.133578627479;5428.972855135699;5500.367457742411;5511.090670039479;5532.75102620375;7053.188883278386;7055.541389809749;7114.430845532345;7135.5361901476235;7139.571625702474;6787.2534021257625;6799.762008329685;6879.484038697017;6880.2431732508385;6883.65581720912;6974.407175390149;7042.542234754725;7056.400205982549;7062.752803651848;7145.535540190079;6819.795406137824;6845.0759147514445;6884.690188941609;6890.552114112566;6896.793096207121;6810.931890681228;6901.89647155283;6987.475939304471;7006.579605223703;7016.333448322402;6584.144061272004;6595.868082638224;6602.075709400784;6666.600003999775;6690.4647628190605;6604.735810567524;6623.701933412912;6633.668316584055;6635.303293154149;6659.034440006269;6516.967415162894;6526.151600292122;6605;6605.768798092044;6653;6657.866842663217;6673.899891501728;6686.063951046955;6765.797026089225;6788.9137737963665;6382.521310901608;6421.486281097595;6478.4169424752;6507.089007539043;6547.312532184243 16:34:42 INFO - PID 3777 | |1;ext.html;931.3108299858098;935.4901578639641;954.5465903695746;976.6679329028129;991.5637119667346;44100.77949610256;44788;44804.999999999956;44956.55043449564;44964.32553511696;42141.7892910535;42258.788706056424;42264;42273.57726422735;42581;7380.745273303524;7572.7349542766015;7574.280443357872;7575.128860181095;7580.279873412044;7464.440166987471;7489.850202995937;7525.887111693329;7578.65896034677;7582.203868593773;7538.698452061938;7538.9246107538775;7554.320111189992;7565.3947684185405;8157.877631835528;8252.628631711557;8257.545834979104;8275.95862020692;8280.089190189074;8286.04710458296;8170.714025009096;8233.217844304781;8266;8266.710665126751;8270.2556769891;42295.365569516485;42664.78667606673;42940;43057.13885722268;43069;3744.850205991757;3745.62543745626;3771.9057023574355;3775.716821238418;3776.093737503007;35046.299074018374;35309;35414.29171416557;35489.29021419583;35542;5406.351237851443;5428.212909128154;5428.5928555358505;5444.537214336786;5469.425710300441;215769;215871;216712;218853.90573047192;219378;53003;53270.467295327326;53328;53367.46632533702;53594.19608705873;56071.43928560744;56380.02669906533;56402.71798640981;56534.43465565374;56718;16945.915270423568;17293;17404.216810243568;17412.39056633012;17419.47741567755;14204.786928196085;14249.78625320621;14267;14272.857271427152;14277.357518911675;15416.61458463525;15590.376384944475;15600.375984960701;15623.687526249638;15730.29213685364;6078.513718902565;6136.570440069152;6144.969275153685;6181.381861813873;6309.053641953652;1079.63292480557;1090.8472813806075;1098.4507746126937;1107.429673718036;1112.471576001409;25497.107601233867;25607.87196064045;25710;25710;25926;1196.7546652936128;1204.163106640876;1215.1372525506988;1227.9386030698429;1228.4656174564093;13577.456901723821;13588.184708917497;13710.725785484434;13714.451421943011;13782.722252128326;292255;293037;293432;293571;293863;59146.40853591409;61493;65299;65400;65597;1533.1184568872943;1534.1792141204403;1545.5981444824201;1551.968960620804;1559.9220038998005;30466.08601741951;30723.539146913263;30741.8462907693;30779.53830692586;30911.381772363977;41568;42030.36954445747;42270.365944511475;42353.364699530146;42435.575644244396;247070;247502;247579;247662;248062;35293.82353088321;36412.635873640924;36589.81705091458;36594.26811463809;36670;48004;48011.279830803265;48210;48499.27251091307;48583.27125093197;34123.65876341205;34769.30461390808;35037.82481087578;35420.46869297014;35539.11152221215;35115.64884351226;35180;35396.646033539335;35401.468977965866;35513.82243088768;39493.80253098716;41741.37387939123;41768.373474397304;41796;42169.78915105405;33757.32485350328;33758.83120584382;34252.31495370129;34283.485747713305;34632.307353853284;25158.119465818607;25216.62175067339;25780;25979.350516237246;26026.869865651308 16:34:42 INFO - PID 3777 | |2;jquery.html;589.687465643209;591.7218907113655;592.7954855574828;596.5704692621312;599.8410421238372;22897;23614.346995710308;23700.5259894802;23707.76292237077;23711.288661340164;25242.242732718;25691.61462578058;26889.86555067222;26971.32571685709;27105.593416098774;6449.742010319582;6573.737050517973;6588.538802283842;6605.108310378086;6609.933900661004;6473.546851720382;6523.249826269992;6630.502712296597;6747.966260168717;6748.561343512681;6661.766838160665;6706.295838936914;6716.59700417974;6718.05947167397;6723.159605049369;6502.317256688074;6697.799066028027;6705.664716764142;6732.091167692348;6753.797386078377;6296.716647750863;6322.778702745381;6325.620462772248;6325.9051114233325;6337;32004.359912801847;32245.677543224738;32474.675253247402;32615.51076733851;32617.51073733896;2232.732072151336;2256.593813113639;2258.1870526610405;2262.2760716570706;2268.9319320420414;20655.277065302642;22020;22138.22516211941;22149.224777132724;22178.778212217832;2553.4127150755244;2557.565213913639;2644.1010056580662;2644.7487488688544;2647.2455350225096;137993;143225;151372.2431387836;157671;157990;15401.922990384975;16042.871640030315;16096.597585060466;16214.51356459308;16743.581410464834;25484;25579.744202558108;25599;25608.871955640476;25610.743892560837;10406.635767748092;10521.158307335394;10687.572497100184;10733.51699173539;10957.616483423202;9501.667441639647;9677.129058384779;9677.951610241904;9684.370515916444;9913.752156196153;9587.712368628952;9632.27757918159;9710.854337184948;9871.703848884545;10241.539130739135;2845.2744550139996;2868.4836729388494;2898.087102562686;2901.8403987780453;3043.25440267136;989.9455529945922;1026.9435181065114;1032.2774058159318;1032.5921261101823;1043.400044974143;21184.470388240108;21239.8938005309;21380.786192138192;21459.463513411978;21780.673289900664;1103.100972707241;1107.1585594947737;1110.6168371911679;1119.4011204005817;1134.5631931706353;11563.190576659721;11850.466728997217;11987.880121198676;12050.216735912138;12105.878941210474;607798;623516;626543;652180;662014;131056.68943310445;132260.3386983059;133641.33179334042;137824;137858;1103.1671088328421;1160.825876118589;1211.6304527119314;1221.4991853340266;1263.5388083349512;22113.668294975265;22221.666674999564;22375.837922699164;22519.66220506661;22595.096196152626;60368.39631603804;62057;63531.729365411506;63714;63978.76074337376;79629.20370796218;80223;80498.59750701209;80765;81013.59493202496;15285.235738213267;15577.688446230784;15589.376424942875;15680.529584112495;15755.44855930037;24311.63532546978;24492.87753561292;24797.752022479544;24872.875635621705;25030.874845625654;19831.801681982997;20044.799552004293;20088.59822803565;20394.388168354973;20437.182512699324;17450.82549174492;17676.646467070328;18223.81776182221;18263.726044109615;18372.540686482946;20539.794602054386;20556.588868222254;20691.172353105707;20882.37352879416;21003.264885728928;15143.469978550698;15225.6193595161;15257.313420896307;15285.847141528888;15360;19866.304679336154;19979.800201997794;20182.39452816418;20214.292499762436;20369 16:34:42 INFO - PID 3777 | |3;mootools.html;1441.949531766388;1481.9481318153867;1488.2261224163435;1489.627593101724;1490.5528341497547;16253.83746162538;16858.32566697334;16927.492175234747;16959.83040169598;16967.06681132537;16294.42969496068;16489.257983390748;16576.502704918843;16587.336506539723;16600.25298861551;2821.957670634942;2857.8713957871946;2872.095289983659;2878.0358579875765;2879.9712002879915;2733.316670832292;2866.2261189478827;2869.5552189410673;2880.467113583983;2881.5533592293227;2690.1660485249536;2880.467113583983;2881.697421770715;2889.696581858906;2890.537513997761;2876.3815779607276;2907.912762617125;2908.796384253103;2929.209113539343;2936.045785119834;2730.3447172678416;2845.5447128459555;2917.081119447367;2921.8246905185756;2923.63454568179;16974.830251697447;17064.317427302893;17080.743788843178;17095;17114.48656540306;8638.740837774876;8941.955290223572;8972.327075469366;8977.640894364218;8984.730458086202;5417.485338892799;5549.472800084026;5575.470330318613;5652.74562644682;5673.404292549264;1896.5353488395294;1897.8956157411337;1936.4190742777112;1950.570874407628;1957.4714826996774;29127;29984.8500757497;30091.247718806986;30092.398152037054;30118.698813012026;7077.5753454792875;7205.099362579677;7220.022144859263;7227.421806255487;7283.963580182171;19530.511737206685;19591.412257632295;19601.31395401154;19608.3137090204;19625;8349.791255218668;8495.532745698922;8498.617562209716;8500.787480312918;8503.319734421231;7626.084869815658;7732.922670773332;7768.805779855549;7791.727289544839;7793.10379306387;5486.61593688438;5627.662340259516;5632.239647647597;5646.2942132233475;5730.169125476783;1566.0447127252366;1567.6472793621344;1571.2929181868205;1582.723023470888;1599.4881637876001;920.5949382271913;922.8292765838341;929.8047410043831;931.3340961212765;940.844760614491;8025.117237103914;8149.551774652333;8170.509769413854;8203.220694034057;8223.629936652746;772.8763397856316;777.8211011467395;784.5880912520972;786.6460092958192;788.9289963903276;5181.948180518222;5401.378841433207;5445.809396671098;5461.01701693691;5648.15277708347;23799.52400951971;25047.248582542554;25101.24696259115;25140.497190056096;25143.371415714388;23502.177423790086;24197.516049678907;24586;24736.381590460383;24765.62851557228;12251.264924104404;12263.877361226452;12264.141510094387;12384.256944583354;12506.937465312798;8299.253067223979;8373.790655233668;8460.957695211484;8602.569871506525;9047.728568142966;21238.25666101679;21416.464588385414;21612.351629450513;21821.454463638536;22099.779002209772;21452.591781912124;21553.784462155178;21652.24217152392;21727.456813579785;22285.331440056823;12343.074269430008;12392;12431.31627760482;12458.43937022818;12668.176568523017;15186.46847360337;15424.151671657717;15431;15442.45951391696;15449;12675.873241267838;12809.8078528824;12819.679508012374;12874.485020599072;12995.350232488148;12287.324197169242;12548.686282843002;12687.492500299884;12761.744765104831;12835.743285134431;10635.89364106349;10880.891191088305;10887.945560272148;10889.183311251529;10893.128549715846;7904.486208396436;8000.239977202156;8099.959500202462;8141.14517975604;8195.95902020486;8059.879101813361;8077.515349079074;8125;8236.752897413087;8262.215089566482 16:34:42 INFO - PID 3777 | |4;prototype.html;527.2960597602204;538.5960529602797;566.3373852592466;570.6775671745467;573.9282589676291;6365.267994180665;6392.20097487814;6395.424411802936;6446.194225721785;6514.44627206688;6274.654893980829;6336.398042185985;6353.3646635336445;6369.554131210817;6405.565884963719;5146.6911985281;5150.459201783806;5165.870853228681;5183.714895680736;5196.168613021917;5092.770825312869;5104.77028533715;5145.871353216162;5165.7158856262895;5214.296070030554;4815.5906747926465;4839.419269687624;5115.360579927509;5129.102407078765;5135.794568217286;4861.829835955742;4891.5353041461;4913.26301054841;4940.333055037596;4961.8511444656715;4434.556544345572;4438.489573699034;4467.353951890031;4471.843485478025;4481.170983368087;6097.847553811146;6104.175936248638;6125.479334256594;6139.355367686418;6188.350223226586;5779.711014449261;5784.248047753807;5794.188813566104;5814.156947242668;5823.330317013555;6495.220573531159;6533.811173256965;6534.93465065348;6609.768658096991;6630.602163870183;4864.635152363551;4968.378952630921;4977.402711674622;4980.651354405193;5010.824621138279;6718.160229971254;6850.349216824394;6859.55412898165;6983.755568555127;7013.929860701379;5530.446955304518;5557.555395568425;5587.972060139673;5611.354694210218;5623.522000629992;5642.786800837757;5682.886342273131;5694.202811606378;5706.801571669913;5729.5702822288495;6085.148079268906;6133.447989680861;6152.692365381713;6153.98459254227;6182.783602573888;6728.158980127484;6779.830504237433;6802.183737951477;6802.863942721118;6804.183497980274;1947.3807728605004;1991.73111629931;1998.331393286622;2001.8698784578955;2006.5084054406764;1434.512265829623;1478.5712143478486;1501.3919362658141;1508.4795745467795;1528.6025633335412;5966;6043.8791224175275;6055.850957502074;6058.878822423615;6121.602095863844;6612.537122401482;6629.502787290972;6726.730930762813;6734.9326506734305;6876.656167191621;6103.206583144163;6133.3866613338305;6179.980303250003;6206.565540412218;6242.250929888442;3520.2431477232517;3526.3828829954655;3538.929221415609;3564.6435356464144;3569.3218288525095;6963.860722785617;6975.8604827903155;7002;7005.159380874327;7031.191412987469;6832.0870156356295;6843.452523798183;6939.861202775916;6944.270851560615;7042.753503627451;6935.791926242221;6973.4072603829245;7033.366996970297;7084.893726594105;7095.574265544084;6622.801315960529;6742.157230346207;6774.796756097325;6787.796366109024;6836.658167091725;6664.666766661744;6698.497612678971;6753.763618273337;6779.864402712017;6849.897251541331;6786.185657721105;6984.4063254623925;7013.158420989514;7033.824154396181;7099.296168919525;5056.84829455117;5106.872328191825;5123.410807757006;5133.768980395966;5169.457206993212;6338.841528961812;6558.344165583403;6761;6812.00271880371;6842.1789385272095;6395.776147834804;6467.156860294794;6502.6748662567625;6540.934590654033;6565.967170164118;6417.2299324081405;6433.228012638513;6469.256035555972;6476.514261430318;6482.222133344029;6385.904211436925;6415.358464153547;6472.255690595453;6476.319986401549;6484.660399894153;6575.605463672195;6635.108993936705;6646.966765166337;6657.1345725055435;6680.6993685283305;6428.325025872216;6471.094046833541;6474.730261218243;6484.24925270165;6502.601940582797 16:34:42 INFO - PID 3777 | |5;yui.html;949.4682977532578;983.4689267795388;997.5909876950452;1005.4269066632019;1015.7354094152781;18384.172712227948;18661.16024778885;18680.15939282732;18724;18799.248030078816;17431.73852392215;17553.210105545248;18025;19474.221031158773;19621.509462263413;1048.9475526223678;1071.7052810477142;1072.5012869015907;1072.6031368393706;1073.62423151897;1053.6259627832123;1086.5490821309147;1086.9076128529084;1096.7203363142428;1096.983545246822;1149.5516748468103;1150.0454622663212;1150.0512077536025;1150.4075401168404;1150.5742875136211;1088.755030118221;1128.4132251229314;1128.7347473343757;1128.7911736328806;1131.4455916600848;823.7693445835175;824.0934971531327;824.505296821908;824.814416756231;830.2652152844776;19126.617467650707;19154.138063787163;19182.328618498424;19218.903905480383;19366.70949935752;19909.80090199094;20243.797562024338;20267.087981040742;20279.391618251477;20299;18319.816801831945;18817.435476935712;18921.71617425726;18921.81078189214;18929;4068.7558746475306;4084.244414783275;4089.0595163112353;4098.73358231717;4100.979495102535;152885.23557382255;153199.23400382928;155588.22205889013;156143.21928390398;157969.21015394965;17095.57261068483;17184.1407929603;17445;17473.126343682765;17478.650426991644;33809.661903381144;33833.492497612555;33884;34157.65842341545;34272;8883.33374996865;8981.101889811098;8984.8652270216;8999.550022498848;9020.909790902138;4328.394024836525;4430.357598148251;4436.201483732959;4443.911121777611;4450.2434586120435;5833.941660583425;5969.462748352669;6009.639421634629;6012.458878700938;6023.909641355383;1047.659510659039;1067.5889782433665;1082.6968448834182;1086.0931122512632;1087.6410784441116;734.5739471106746;751.4138971602159;753.8341564855723;771.3096778383316;772.2702046565942;13163.934180329228;13344.06591538583;13358.732825343439;13521.32393380327;13572.93213533926;747.6299231880254;763.5838468034934;767.3554214459768;783.0251337085251;788.2669117720575;6352.65060421672;6444.645544495098;6468.320826313264;6531.510136739668;6556.967215163893;148972.25513872362;149360;149731.2513437426;149909.2504537492;158456.20771896298;103881.48059259655;105268;127357.36321318334;129655.35172324267;135897.3205133968;108861.45569272104;109082;114299.42850285696;115566.42216788862;118110;14358;14520.491782787552;14732.705345892808;14810.111393316436;14888.553343399715;57058.14412783895;57162.42837571571;57603;57885.71057144687;58363.4163658358;72670;73367.63316183384;73466.63266683632;73929;73930.26069739234;20073.397798066082;20417.48956276105;20451.590968180255;20644.896775516027;20732.58534829325;22893.656595150755;23121;23218.883905580366;23313.650295245923;23354.18260360879;21186.04662790209;21441.89279053595;21526.246581369578;21645.783542164376;21788.673169902147;19771.110300036245;19810.50473738168;19847.00764961775;19892.30376936858;20199.8990005049;19904.303349382702;20048.39854804358;20123.295684650966;20213.292534761214;20478.590428191652;13212.735745284848;13356;13404.865951340362;13436.596902092953;13631.522896698569;14860.777088343468;15056.774148387563;15218.619534511727;15376.846231537542;15411.075335479907 16:34:42 INFO - PID 3777 | __end_tp_report 16:34:42 INFO - PID 3777 | __start_cc_report 16:34:42 INFO - PID 3777 | _x_x_mozilla_cycle_collect,369 16:34:42 INFO - PID 3777 | __end_cc_report 16:34:42 INFO - PID 3777 | __startTimestamp1505345682401__endTimestamp 16:34:42 INFO - PID 3777 | 16:34:42 INFO - PID 3777 | ------- Summary: start ------- 16:34:42 INFO - PID 3777 | Number of tests: 6 16:34:42 INFO - PID 3777 | 16:34:42 INFO - PID 3777 | [#0] dojo.html Cycles:165 Average:6317.55 Median:6584.14 stddev:766.13 (11.6%) stddev-sans-first:742.99 16:34:42 INFO - PID 3777 | Values: 3819.1 3833.2 3857.9 3880.2 3892.8 6148.8 6225.0 6251.1 6280.0 6290.5 6346.8 6348.6 6353.0 6381.7 6396.0 5560.4 5638.7 5669.5 5680.5 5691.3 5722.1 5744.9 5761.6 5769.9 5790.4 5656.7 5688.7 5746.1 5769.2 5772.5 5460.3 5614.2 5651.6 5684.5 5695.8 5606.7 5617.7 5701.5 5716.5 5721.6 6168.6 6280.7 6281.0 6287.4 6357.1 6794.7 6857.6 6882.3 6884.2 6915.8 6925.9 6948.4 6976.5 7021.4 7032.0 6401.4 6434.5 6474.1 6502.3 6522.8 7058.9 7085.6 7086.4 7123.8 7128.0 6760.8 6817.4 6849.6 6863.1 6863.5 6892.3 6897.6 6903.1 6979.1 7006.0 6707.5 6752.0 6800.6 6880.7 6927.2 6826.1 6890.7 6903.1 6931.4 6931.7 4972.8 5035.0 5046.8 5048.3 5053.2 4431.6 4520.3 4544.8 4545.9 4555.7 6265.2 6348.1 6372.0 6375.1 6387.4 6836.6 6842.9 6902.9 6939.5 6942.9 6257.7 6269.2 6351.6 6362.8 6364.5 5415.1 5429.0 5500.4 5511.1 5532.8 7053.2 7055.5 7114.4 7135.5 7139.6 6787.3 6799.8 6879.5 6880.2 6883.7 6974.4 7042.5 7056.4 7062.8 7145.5 6819.8 6845.1 6884.7 6890.6 6896.8 6810.9 6901.9 6987.5 7006.6 7016.3 6584.1 6595.9 6602.1 6666.6 6690.5 6604.7 6623.7 6633.7 6635.3 6659.0 6517.0 6526.2 6605.0 6605.8 6653.0 6657.9 6673.9 6686.1 6765.8 6788.9 6382.5 6421.5 6478.4 6507.1 6547.3 16:34:42 INFO - PID 3777 | 16:34:42 INFO - PID 3777 | [#1] ext.html Cycles:180 Average:43646.29 Median:3745.24 stddev:66268.26 (1769.4%) stddev-sans-first:66376.55 16:34:42 INFO - PID 3777 | Values: 931.3 935.5 954.5 976.7 991.6 44100.8 44788.0 44805.0 44956.6 44964.3 42141.8 42258.8 42264.0 42273.6 42581.0 7380.7 7572.7 7574.3 7575.1 7580.3 7464.4 7489.9 7525.9 7578.7 7582.2 7538.7 7538.9 7554.3 7565.4 8157.9 8252.6 8257.5 8276.0 8280.1 8286.0 8170.7 8233.2 8266.0 8266.7 8270.3 42295.4 42664.8 42940.0 43057.1 43069.0 3744.9 3745.6 3771.9 3775.7 3776.1 35046.3 35309.0 35414.3 35489.3 35542.0 5406.4 5428.2 5428.6 5444.5 5469.4 215769.0 215871.0 216712.0 218853.9 219378.0 53003.0 53270.5 53328.0 53367.5 53594.2 56071.4 56380.0 56402.7 56534.4 56718.0 16945.9 17293.0 17404.2 17412.4 17419.5 14204.8 14249.8 14267.0 14272.9 14277.4 15416.6 15590.4 15600.4 15623.7 15730.3 6078.5 6136.6 6145.0 6181.4 6309.1 1079.6 1090.8 1098.5 1107.4 1112.5 25497.1 25607.9 25710.0 25710.0 25926.0 1196.8 1204.2 1215.1 1227.9 1228.5 13577.5 13588.2 13710.7 13714.5 13782.7 292255.0 293037.0 293432.0 293571.0 293863.0 59146.4 61493.0 65299.0 65400.0 65597.0 1533.1 1534.2 1545.6 1552.0 1559.9 30466.1 30723.5 30741.8 30779.5 30911.4 41568.0 42030.4 42270.4 42353.4 42435.6 247070.0 247502.0 247579.0 247662.0 248062.0 35293.8 36412.6 36589.8 36594.3 36670.0 48004.0 48011.3 48210.0 48499.3 48583.3 34123.7 34769.3 35037.8 35420.5 35539.1 35115.6 35180.0 35396.6 35401.5 35513.8 39493.8 41741.4 41768.4 41796.0 42169.8 33757.3 33758.8 34252.3 34283.5 34632.3 25158.1 25216.6 25780.0 25979.4 26026.9 16:34:42 INFO - PID 3777 | 16:34:42 INFO - PID 3777 | [#2] jquery.html Cycles:180 Average:40903.86 Median:23255.67 stddev:105913.49 (455.4%) stddev-sans-first:106167.35 16:34:42 INFO - PID 3777 | Values: 589.7 591.7 592.8 596.6 599.8 22897.0 23614.3 23700.5 23707.8 23711.3 25242.2 25691.6 26889.9 26971.3 27105.6 6449.7 6573.7 6588.5 6605.1 6609.9 6473.5 6523.2 6630.5 6748.0 6748.6 6661.8 6706.3 6716.6 6718.1 6723.2 6502.3 6697.8 6705.7 6732.1 6753.8 6296.7 6322.8 6325.6 6325.9 6337.0 32004.4 32245.7 32474.7 32615.5 32617.5 2232.7 2256.6 2258.2 2262.3 2268.9 20655.3 22020.0 22138.2 22149.2 22178.8 2553.4 2557.6 2644.1 2644.7 2647.2 137993.0 143225.0 151372.2 157671.0 157990.0 15401.9 16042.9 16096.6 16214.5 16743.6 25484.0 25579.7 25599.0 25608.9 25610.7 10406.6 10521.2 10687.6 10733.5 10957.6 9501.7 9677.1 9678.0 9684.4 9913.8 9587.7 9632.3 9710.9 9871.7 10241.5 2845.3 2868.5 2898.1 2901.8 3043.3 989.9 1026.9 1032.3 1032.6 1043.4 21184.5 21239.9 21380.8 21459.5 21780.7 1103.1 1107.2 1110.6 1119.4 1134.6 11563.2 11850.5 11987.9 12050.2 12105.9 607798.0 623516.0 626543.0 652180.0 662014.0 131056.7 132260.3 133641.3 137824.0 137858.0 1103.2 1160.8 1211.6 1221.5 1263.5 22113.7 22221.7 22375.8 22519.7 22595.1 60368.4 62057.0 63531.7 63714.0 63978.8 79629.2 80223.0 80498.6 80765.0 81013.6 15285.2 15577.7 15589.4 15680.5 15755.4 24311.6 24492.9 24797.8 24872.9 25030.9 19831.8 20044.8 20088.6 20394.4 20437.2 17450.8 17676.6 18223.8 18263.7 18372.5 20539.8 20556.6 20691.2 20882.4 21003.3 15143.5 15225.6 15257.3 15285.8 15360.0 19866.3 19979.8 20182.4 20214.3 20369.0 16:34:42 INFO - PID 3777 | 16:34:42 INFO - PID 3777 | [#3] mootools.html Cycles:180 Average:10327.77 Median:2862.05 stddev:7655.32 (267.5%) stddev-sans-first:7647.68 16:34:42 INFO - PID 3777 | Values: 1441.9 1481.9 1488.2 1489.6 1490.6 16253.8 16858.3 16927.5 16959.8 16967.1 16294.4 16489.3 16576.5 16587.3 16600.3 2822.0 2857.9 2872.1 2878.0 2880.0 2733.3 2866.2 2869.6 2880.5 2881.6 2690.2 2880.5 2881.7 2889.7 2890.5 2876.4 2907.9 2908.8 2929.2 2936.0 2730.3 2845.5 2917.1 2921.8 2923.6 16974.8 17064.3 17080.7 17095.0 17114.5 8638.7 8942.0 8972.3 8977.6 8984.7 5417.5 5549.5 5575.5 5652.7 5673.4 1896.5 1897.9 1936.4 1950.6 1957.5 29127.0 29984.9 30091.2 30092.4 30118.7 7077.6 7205.1 7220.0 7227.4 7284.0 19530.5 19591.4 19601.3 19608.3 19625.0 8349.8 8495.5 8498.6 8500.8 8503.3 7626.1 7732.9 7768.8 7791.7 7793.1 5486.6 5627.7 5632.2 5646.3 5730.2 1566.0 1567.6 1571.3 1582.7 1599.5 920.6 922.8 929.8 931.3 940.8 8025.1 8149.6 8170.5 8203.2 8223.6 772.9 777.8 784.6 786.6 788.9 5181.9 5401.4 5445.8 5461.0 5648.2 23799.5 25047.2 25101.2 25140.5 25143.4 23502.2 24197.5 24586.0 24736.4 24765.6 12251.3 12263.9 12264.1 12384.3 12506.9 8299.3 8373.8 8461.0 8602.6 9047.7 21238.3 21416.5 21612.4 21821.5 22099.8 21452.6 21553.8 21652.2 21727.5 22285.3 12343.1 12392.0 12431.3 12458.4 12668.2 15186.5 15424.2 15431.0 15442.5 15449.0 12675.9 12809.8 12819.7 12874.5 12995.4 12287.3 12548.7 12687.5 12761.7 12835.7 10635.9 10880.9 10887.9 10889.2 10893.1 7904.5 8000.2 8100.0 8141.1 8196.0 8059.9 8077.5 8125.0 8236.8 8262.2 16:34:42 INFO - PID 3777 | 16:34:42 INFO - PID 3777 | [#4] prototype.html Cycles:180 Average:5673.08 Median:6305.53 stddev:1548.38 (24.6%) stddev-sans-first:1503.78 16:34:42 INFO - PID 3777 | Values: 527.3 538.6 566.3 570.7 573.9 6365.3 6392.2 6395.4 6446.2 6514.4 6274.7 6336.4 6353.4 6369.6 6405.6 5146.7 5150.5 5165.9 5183.7 5196.2 5092.8 5104.8 5145.9 5165.7 5214.3 4815.6 4839.4 5115.4 5129.1 5135.8 4861.8 4891.5 4913.3 4940.3 4961.9 4434.6 4438.5 4467.4 4471.8 4481.2 6097.8 6104.2 6125.5 6139.4 6188.4 5779.7 5784.2 5794.2 5814.2 5823.3 6495.2 6533.8 6534.9 6609.8 6630.6 4864.6 4968.4 4977.4 4980.7 5010.8 6718.2 6850.3 6859.6 6983.8 7013.9 5530.4 5557.6 5588.0 5611.4 5623.5 5642.8 5682.9 5694.2 5706.8 5729.6 6085.1 6133.4 6152.7 6154.0 6182.8 6728.2 6779.8 6802.2 6802.9 6804.2 1947.4 1991.7 1998.3 2001.9 2006.5 1434.5 1478.6 1501.4 1508.5 1528.6 5966.0 6043.9 6055.9 6058.9 6121.6 6612.5 6629.5 6726.7 6734.9 6876.7 6103.2 6133.4 6180.0 6206.6 6242.3 3520.2 3526.4 3538.9 3564.6 3569.3 6963.9 6975.9 7002.0 7005.2 7031.2 6832.1 6843.5 6939.9 6944.3 7042.8 6935.8 6973.4 7033.4 7084.9 7095.6 6622.8 6742.2 6774.8 6787.8 6836.7 6664.7 6698.5 6753.8 6779.9 6849.9 6786.2 6984.4 7013.2 7033.8 7099.3 5056.8 5106.9 5123.4 5133.8 5169.5 6338.8 6558.3 6761.0 6812.0 6842.2 6395.8 6467.2 6502.7 6540.9 6566.0 6417.2 6433.2 6469.3 6476.5 6482.2 6385.9 6415.4 6472.3 6476.3 6484.7 6575.6 6635.1 6647.0 6657.1 6680.7 6428.3 6471.1 6474.7 6484.2 6502.6 16:34:42 INFO - PID 3777 | 16:34:42 INFO - PID 3777 | [#5] yui.html Cycles:180 Average:28287.31 Median:19547.87 stddev:41241.66 (211.0%) stddev-sans-first:41306.27 16:34:42 INFO - PID 3777 | Values: 949.5 983.5 997.6 1005.4 1015.7 18384.2 18661.2 18680.2 18724.0 18799.2 17431.7 17553.2 18025.0 19474.2 19621.5 1048.9 1071.7 1072.5 1072.6 1073.6 1053.6 1086.5 1086.9 1096.7 1097.0 1149.6 1150.0 1150.1 1150.4 1150.6 1088.8 1128.4 1128.7 1128.8 1131.4 823.8 824.1 824.5 824.8 830.3 19126.6 19154.1 19182.3 19218.9 19366.7 19909.8 20243.8 20267.1 20279.4 20299.0 18319.8 18817.4 18921.7 18921.8 18929.0 4068.8 4084.2 4089.1 4098.7 4101.0 152885.2 153199.2 155588.2 156143.2 157969.2 17095.6 17184.1 17445.0 17473.1 17478.7 33809.7 33833.5 33884.0 34157.7 34272.0 8883.3 8981.1 8984.9 8999.6 9020.9 4328.4 4430.4 4436.2 4443.9 4450.2 5833.9 5969.5 6009.6 6012.5 6023.9 1047.7 1067.6 1082.7 1086.1 1087.6 734.6 751.4 753.8 771.3 772.3 13163.9 13344.1 13358.7 13521.3 13572.9 747.6 763.6 767.4 783.0 788.3 6352.7 6444.6 6468.3 6531.5 6557.0 148972.3 149360.0 149731.3 149909.3 158456.2 103881.5 105268.0 127357.4 129655.4 135897.3 108861.5 109082.0 114299.4 115566.4 118110.0 14358.0 14520.5 14732.7 14810.1 14888.6 57058.1 57162.4 57603.0 57885.7 58363.4 72670.0 73367.6 73466.6 73929.0 73930.3 20073.4 20417.5 20451.6 20644.9 20732.6 22893.7 23121.0 23218.9 23313.7 23354.2 21186.0 21441.9 21526.2 21645.8 21788.7 19771.1 19810.5 19847.0 19892.3 20199.9 19904.3 20048.4 20123.3 20213.3 20478.6 13212.7 13356.0 13404.9 13436.6 13631.5 14860.8 15056.8 15218.6 15376.8 15411.1 16:34:42 INFO - PID 3777 | -------- Summary: end -------- 16:34:42 INFO - PID 3777 | 16:34:42 INFO - PID 3777 | 16:34:42 INFO - PID 3777 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 16:34:42 INFO - PID 3777 | 16:34:43 INFO - TEST-INFO | 3777: exit 0 16:34:43 INFO - TEST-OK | dromaeo_css | took 1112918ms 16:34:43 INFO - TEST-START | kraken 16:34:43 INFO - Initialising browser for kraken test... 16:34:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34139/getInfo.html -profile /tmp/tmpyl82lc/profile 16:34:43 INFO - TEST-INFO | started process 4142 (/builds/slave/test/build/application/firefox/firefox http://localhost:34139/getInfo.html) 16:34:48 INFO - TEST-INFO | 4142: exit 0 16:34:48 INFO - Browser initialized. 16:34:48 INFO - Running cycle 1/1 for kraken test... 16:34:48 INFO - Using env: {'DISPLAY': ':0', 16:34:48 INFO - 'HOME': '/home/cltbld', 16:34:48 INFO - 'JSGC_DISABLE_POISONING': '1', 16:34:48 INFO - 'LANG': 'en_US.UTF-8', 16:34:48 INFO - 'LANGUAGE': 'en_US:en', 16:34:48 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:34:48 INFO - 'LOGNAME': 'cltbld', 16:34:48 INFO - 'MAIL': '/var/mail/cltbld', 16:34:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:34:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:34:48 INFO - 'MOZ_CRASHREPORTER': '1', 16:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:48 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:34:48 INFO - 'MOZ_NO_REMOTE': '1', 16:34:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:48 INFO - 'NO_EM_RESTART': '1', 16:34:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:48 INFO - 'PWD': '/builds/slave/test', 16:34:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:34:48 INFO - 'RUST_BACKTRACE': 'full', 16:34:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:34:48 INFO - 'SHELL': '/bin/bash', 16:34:48 INFO - 'SHLVL': '1', 16:34:48 INFO - 'STYLO_FORCE_DISABLED': '1', 16:34:48 INFO - 'TERM': 'linux', 16:34:48 INFO - 'TMOUT': '86400', 16:34:48 INFO - 'USER': 'cltbld', 16:34:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191', 16:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:48 INFO - '_': '/tools/buildbot/bin/python'} 16:34:48 INFO - TEST-INFO | started process 4378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyl82lc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:34:49 INFO - PID 4378 | 16:34:49 INFO - PID 4378 | (/builds/slave/test/build/application/firefox/firefox:4429): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:34:49 INFO - PID 4378 | 16:35:00 INFO - PID 4378 | RSS: Main: 164249600 16:35:00 INFO - PID 4378 | 16:35:02 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:34139/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34139/tests/kraken/driver.html?testName=audio-beat-detection) 16:35:03 INFO - PID 4378 | RSS: Main: 169504768 16:35:03 INFO - PID 4378 | 16:35:06 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:34139/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34139/tests/kraken/driver.html?testName=audio-dft) 16:35:06 INFO - PID 4378 | RSS: Main: 169709568 16:35:06 INFO - PID 4378 | 16:35:09 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:34139/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34139/tests/kraken/driver.html?testName=audio-fft) 16:35:10 INFO - PID 4378 | RSS: Main: 164962304 16:35:10 INFO - PID 4378 | 16:35:12 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:34139/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34139/tests/kraken/driver.html?testName=audio-oscillator) 16:35:12 INFO - PID 4378 | RSS: Main: 166498304 16:35:12 INFO - PID 4378 | 16:35:14 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:34139/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34139/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:35:15 INFO - PID 4378 | RSS: Main: 166707200 16:35:15 INFO - PID 4378 | 16:35:18 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:34139/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34139/tests/kraken/driver.html?testName=imaging-darkroom) 16:35:19 INFO - PID 4378 | RSS: Main: 167546880 16:35:19 INFO - PID 4378 | 16:35:22 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:34139/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34139/tests/kraken/driver.html?testName=imaging-desaturate) 16:35:23 INFO - PID 4378 | RSS: Main: 169373696 16:35:23 INFO - PID 4378 | 16:35:26 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:34139/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34139/tests/kraken/driver.html?testName=json-parse-financial) 16:35:27 INFO - PID 4378 | RSS: Main: 169091072 16:35:27 INFO - PID 4378 | 16:35:28 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:34139/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34139/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:35:29 INFO - PID 4378 | RSS: Main: 169287680 16:35:29 INFO - PID 4378 | 16:35:30 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:34139/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34139/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:35:31 INFO - PID 4378 | RSS: Main: 169467904 16:35:31 INFO - PID 4378 | 16:35:33 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:34139/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34139/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:35:33 INFO - PID 4378 | RSS: Main: 166096896 16:35:33 INFO - PID 4378 | 16:35:36 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:34139/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:35:37 INFO - PID 4378 | RSS: Main: 166268928 16:35:37 INFO - PID 4378 | 16:35:39 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:34139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:35:40 INFO - PID 4378 | RSS: Main: 167038976 16:35:40 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:34139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34139/tests/kraken/driver.html?testName=ai-astar) 16:35:42 INFO - PID 4378 | RSS: Main: 168628224 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | __start_tp_report 16:35:42 INFO - PID 4378 | _x_x_mozilla_page_load 16:35:42 INFO - PID 4378 | _x_x_mozilla_page_load_details 16:35:42 INFO - PID 4378 | |i|pagename|runs| 16:35:42 INFO - PID 4378 | |0;ai-astar;108;106;106;106;106;106;95;106;105;106 16:35:42 INFO - PID 4378 | |1;audio-beat-detection;114;114;111;111;113;110;112;146;110;113 16:35:42 INFO - PID 4378 | |2;audio-dft;161;163;161;160;161;161;163;161;163;164 16:35:42 INFO - PID 4378 | |3;audio-fft;73;73;73;77;73;74;73;75;73;76 16:35:42 INFO - PID 4378 | |4;audio-oscillator;77;77;78;78;77;77;78;77;78;78 16:35:42 INFO - PID 4378 | |5;imaging-gaussian-blur;113;114;115;117;113;116;116;116;115;116 16:35:42 INFO - PID 4378 | |6;imaging-darkroom;152;149;148;150;149;149;150;149;150;149 16:35:42 INFO - PID 4378 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;96 16:35:42 INFO - PID 4378 | |8;json-parse-financial;46;48;45;45;43;48;45;45;44;46 16:35:42 INFO - PID 4378 | |9;json-stringify-tinderbox;36;37;36;36;38;36;36;36;37;37 16:35:42 INFO - PID 4378 | |10;stanford-crypto-aes;71;71;70;70;70;72;71;70;71;70 16:35:42 INFO - PID 4378 | |11;stanford-crypto-ccm;106;107;102;104;104;112;111;102;109;106 16:35:42 INFO - PID 4378 | |12;stanford-crypto-pbkdf2;155;151;155;152;150;154;157;158;152;150 16:35:42 INFO - PID 4378 | |13;stanford-crypto-sha256-iterative;63;64;59;59;62;63;59;58;59;58 16:35:42 INFO - PID 4378 | __end_tp_report 16:35:42 INFO - PID 4378 | __start_cc_report 16:35:42 INFO - PID 4378 | _x_x_mozilla_cycle_collect,885 16:35:42 INFO - PID 4378 | __end_cc_report 16:35:42 INFO - PID 4378 | __startTimestamp1505345742411__endTimestamp 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | ------- Summary: start ------- 16:35:42 INFO - PID 4378 | Number of tests: 14 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | [#0] ai-astar Cycles:10 Average:105.00 Median:106.00 stddev:3.59 (3.4%) stddev-sans-first:3.64 16:35:42 INFO - PID 4378 | Values: 108.0 106.0 106.0 106.0 106.0 106.0 95.0 106.0 105.0 106.0 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | [#1] audio-beat-detection Cycles:10 Average:115.40 Median:113.00 stddev:10.85 (9.6%) stddev-sans-first:11.50 16:35:42 INFO - PID 4378 | Values: 114.0 114.0 111.0 111.0 113.0 110.0 112.0 146.0 110.0 113.0 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.32 (0.8%) stddev-sans-first:1.36 16:35:42 INFO - PID 4378 | Values: 161.0 163.0 161.0 160.0 161.0 161.0 163.0 161.0 163.0 164.0 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | [#3] audio-fft Cycles:10 Average:74.00 Median:73.50 stddev:1.49 (2.0%) stddev-sans-first:1.54 16:35:42 INFO - PID 4378 | Values: 73.0 73.0 73.0 77.0 73.0 74.0 73.0 75.0 73.0 76.0 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:78.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 16:35:42 INFO - PID 4378 | Values: 77.0 77.0 78.0 78.0 77.0 77.0 78.0 77.0 78.0 78.0 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:116.00 stddev:1.37 (1.2%) stddev-sans-first:1.22 16:35:42 INFO - PID 4378 | Values: 113.0 114.0 115.0 117.0 113.0 116.0 116.0 116.0 115.0 116.0 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.50 stddev:1.08 (0.7%) stddev-sans-first:0.67 16:35:42 INFO - PID 4378 | Values: 152.0 149.0 148.0 150.0 149.0 149.0 150.0 149.0 150.0 149.0 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 16:35:42 INFO - PID 4378 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 96.0 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | [#8] json-parse-financial Cycles:10 Average:45.50 Median:45.50 stddev:1.58 (3.5%) stddev-sans-first:1.67 16:35:42 INFO - PID 4378 | Values: 46.0 48.0 45.0 45.0 43.0 48.0 45.0 45.0 44.0 46.0 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | [#9] json-stringify-tinderbox Cycles:10 Average:36.50 Median:36.50 stddev:0.71 (1.9%) stddev-sans-first:0.73 16:35:42 INFO - PID 4378 | Values: 36.0 37.0 36.0 36.0 38.0 36.0 36.0 36.0 37.0 37.0 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | [#10] stanford-crypto-aes Cycles:10 Average:70.60 Median:71.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 16:35:42 INFO - PID 4378 | Values: 71.0 71.0 70.0 70.0 70.0 72.0 71.0 70.0 71.0 70.0 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | [#11] stanford-crypto-ccm Cycles:10 Average:106.30 Median:106.50 stddev:3.50 (3.3%) stddev-sans-first:3.71 16:35:42 INFO - PID 4378 | Values: 106.0 107.0 102.0 104.0 104.0 112.0 111.0 102.0 109.0 106.0 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:154.50 stddev:2.84 (1.8%) stddev-sans-first:2.95 16:35:42 INFO - PID 4378 | Values: 155.0 151.0 155.0 152.0 150.0 154.0 157.0 158.0 152.0 150.0 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:60.50 stddev:2.32 (3.8%) stddev-sans-first:2.26 16:35:42 INFO - PID 4378 | Values: 63.0 64.0 59.0 59.0 62.0 63.0 59.0 58.0 59.0 58.0 16:35:42 INFO - PID 4378 | -------- Summary: end -------- 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 16:35:42 INFO - PID 4378 | 16:35:42 INFO - PID 4378 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:35:43 INFO - TEST-INFO | 4378: exit 0 16:35:43 INFO - TEST-OK | kraken | took 59996ms 16:35:43 INFO - SUITE-END | took 1172s 16:35:43 INFO - Completed test suite (00:19:33) 16:35:43 INFO - javascript benchmark 16:35:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9140.505161985093, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3819.064329239336, 3833.175867188554, 3857.884263472095, 3880.2045580655968, 3892.82482288297, 6148.84627884302, 6224.968875155618, 6251.09359142924, 6280.026595877641, 6290.528210384216, 6346.777862774804, 6348.58734182279, 6353.0, 6381.712822922968, 6396.040593910904, 5560.4161563035905, 5638.746256418471, 5669.518090962263, 5680.488756011958, 5691.260136182291, 5722.084466485342, 5744.856378590527, 5761.625494342854, 5769.913451298234, 5790.420957904218, 5656.688882111483, 5688.687122208277, 5746.0806270996645, 5769.249997500319, 5772.480476757091, 5460.26286451328, 5614.214010038598, 5651.632643878134, 5684.54523638108, 5695.800646977336, 5606.719664016783, 5617.747201375907, 5701.486866182022, 5716.485516303553, 5721.599488035839, 6168.568200225986, 6280.748770049193, 6281.0, 6287.402696743802, 6357.07822365759, 6794.694238759268, 6857.622830744307, 6882.311768823128, 6884.242733299333, 6915.827104322432, 6925.930740692629, 6948.409385202213, 6976.5116441849095, 7021.403180729644, 7032.0, 6401.391867772554, 6434.517411194132, 6474.093626892239, 6502.252240992252, 6522.804315870531, 7058.858822823618, 7085.645717714094, 7086.397656199178, 7123.7506687265695, 7128.037714908524, 6760.797176084725, 6817.420519255819, 6849.623270720059, 6863.073485079451, 6863.485238607124, 6892.310768923067, 6897.586144831326, 6903.102596662402, 6979.127609048869, 7005.964970175219, 6707.463402927754, 6752.0, 6800.591964482147, 6880.724771009103, 6927.168739751262, 6826.146731658543, 6890.655467226618, 6903.102596662402, 6931.410830079399, 6931.722731090801, 4972.7513624318635, 5034.993001399735, 5046.84859454217, 5048.343715316985, 5053.216751403538, 4431.578999994996, 4520.344550040226, 4544.818207271672, 4545.863624091283, 4555.749433781174, 6265.185525881698, 6348.1430006949395, 6372.0, 6375.10748495211, 6387.425131738166, 6836.589804611739, 6842.863142737117, 6902.896456553156, 6939.548929319578, 6942.93057069433, 6257.74969001244, 6269.185005949197, 6351.55539112267, 6362.84092897672, 6364.49084073273, 5415.133578627479, 5428.972855135699, 5500.367457742411, 5511.090670039479, 5532.75102620375, 7053.188883278386, 7055.541389809749, 7114.430845532345, 7135.5361901476235, 7139.571625702474, 6787.2534021257625, 6799.762008329685, 6879.484038697017, 6880.2431732508385, 6883.65581720912, 6974.407175390149, 7042.542234754725, 7056.400205982549, 7062.752803651848, 7145.535540190079, 6819.795406137824, 6845.0759147514445, 6884.690188941609, 6890.552114112566, 6896.793096207121, 6810.931890681228, 6901.89647155283, 6987.475939304471, 7006.579605223703, 7016.333448322402, 6584.144061272004, 6595.868082638224, 6602.075709400784, 6666.600003999775, 6690.4647628190605, 6604.735810567524, 6623.701933412912, 6633.668316584055, 6635.303293154149, 6659.034440006269, 6516.967415162894, 6526.151600292122, 6605.0, 6605.768798092044, 6653.0, 6657.866842663217, 6673.899891501728, 6686.063951046955, 6765.797026089225, 6788.9137737963665, 6382.521310901608, 6421.486281097595, 6478.4169424752, 6507.089007539043, 6547.312532184243], "value": 6264.177244376764, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [931.3108299858098, 935.4901578639641, 954.5465903695746, 976.6679329028129, 991.5637119667346, 44100.77949610256, 44788.0, 44804.999999999956, 44956.55043449564, 44964.32553511696, 42141.7892910535, 42258.788706056424, 42264.0, 42273.57726422735, 42581.0, 7380.745273303524, 7572.7349542766015, 7574.280443357872, 7575.128860181095, 7580.279873412044, 7464.440166987471, 7489.850202995937, 7525.887111693329, 7578.65896034677, 7582.203868593773, 7538.698452061938, 7538.9246107538775, 7554.320111189992, 7565.3947684185405, 8157.877631835528, 8252.628631711557, 8257.545834979104, 8275.95862020692, 8280.089190189074, 8286.04710458296, 8170.714025009096, 8233.217844304781, 8266.0, 8266.710665126751, 8270.2556769891, 42295.365569516485, 42664.78667606673, 42940.0, 43057.13885722268, 43069.0, 3744.850205991757, 3745.62543745626, 3771.9057023574355, 3775.716821238418, 3776.093737503007, 35046.299074018374, 35309.0, 35414.29171416557, 35489.29021419583, 35542.0, 5406.351237851443, 5428.212909128154, 5428.5928555358505, 5444.537214336786, 5469.425710300441, 215769.0, 215871.0, 216712.0, 218853.90573047192, 219378.0, 53003.0, 53270.467295327326, 53328.0, 53367.46632533702, 53594.19608705873, 56071.43928560744, 56380.02669906533, 56402.71798640981, 56534.43465565374, 56718.0, 16945.915270423568, 17293.0, 17404.216810243568, 17412.39056633012, 17419.47741567755, 14204.786928196085, 14249.78625320621, 14267.0, 14272.857271427152, 14277.357518911675, 15416.61458463525, 15590.376384944475, 15600.375984960701, 15623.687526249638, 15730.29213685364, 6078.513718902565, 6136.570440069152, 6144.969275153685, 6181.381861813873, 6309.053641953652, 1079.63292480557, 1090.8472813806075, 1098.4507746126937, 1107.429673718036, 1112.471576001409, 25497.107601233867, 25607.87196064045, 25710.0, 25710.0, 25926.0, 1196.7546652936128, 1204.163106640876, 1215.1372525506988, 1227.9386030698429, 1228.4656174564093, 13577.456901723821, 13588.184708917497, 13710.725785484434, 13714.451421943011, 13782.722252128326, 292255.0, 293037.0, 293432.0, 293571.0, 293863.0, 59146.40853591409, 61493.0, 65299.0, 65400.0, 65597.0, 1533.1184568872943, 1534.1792141204403, 1545.5981444824201, 1551.968960620804, 1559.9220038998005, 30466.08601741951, 30723.539146913263, 30741.8462907693, 30779.53830692586, 30911.381772363977, 41568.0, 42030.36954445747, 42270.365944511475, 42353.364699530146, 42435.575644244396, 247070.0, 247502.0, 247579.0, 247662.0, 248062.0, 35293.82353088321, 36412.635873640924, 36589.81705091458, 36594.26811463809, 36670.0, 48004.0, 48011.279830803265, 48210.0, 48499.27251091307, 48583.27125093197, 34123.65876341205, 34769.30461390808, 35037.82481087578, 35420.46869297014, 35539.11152221215, 35115.64884351226, 35180.0, 35396.646033539335, 35401.468977965866, 35513.82243088768, 39493.80253098716, 41741.37387939123, 41768.373474397304, 41796.0, 42169.78915105405, 33757.32485350328, 33758.83120584382, 34252.31495370129, 34283.485747713305, 34632.307353853284, 25158.119465818607, 25216.62175067339, 25780.0, 25979.350516237246, 26026.869865651308], "value": 18887.343378353384, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.687465643209, 591.7218907113655, 592.7954855574828, 596.5704692621312, 599.8410421238372, 22897.0, 23614.346995710308, 23700.5259894802, 23707.76292237077, 23711.288661340164, 25242.242732718, 25691.61462578058, 26889.86555067222, 26971.32571685709, 27105.593416098774, 6449.742010319582, 6573.737050517973, 6588.538802283842, 6605.108310378086, 6609.933900661004, 6473.546851720382, 6523.249826269992, 6630.502712296597, 6747.966260168717, 6748.561343512681, 6661.766838160665, 6706.295838936914, 6716.59700417974, 6718.05947167397, 6723.159605049369, 6502.317256688074, 6697.799066028027, 6705.664716764142, 6732.091167692348, 6753.797386078377, 6296.716647750863, 6322.778702745381, 6325.620462772248, 6325.9051114233325, 6337.0, 32004.359912801847, 32245.677543224738, 32474.675253247402, 32615.51076733851, 32617.51073733896, 2232.732072151336, 2256.593813113639, 2258.1870526610405, 2262.2760716570706, 2268.9319320420414, 20655.277065302642, 22020.0, 22138.22516211941, 22149.224777132724, 22178.778212217832, 2553.4127150755244, 2557.565213913639, 2644.1010056580662, 2644.7487488688544, 2647.2455350225096, 137993.0, 143225.0, 151372.2431387836, 157671.0, 157990.0, 15401.922990384975, 16042.871640030315, 16096.597585060466, 16214.51356459308, 16743.581410464834, 25484.0, 25579.744202558108, 25599.0, 25608.871955640476, 25610.743892560837, 10406.635767748092, 10521.158307335394, 10687.572497100184, 10733.51699173539, 10957.616483423202, 9501.667441639647, 9677.129058384779, 9677.951610241904, 9684.370515916444, 9913.752156196153, 9587.712368628952, 9632.27757918159, 9710.854337184948, 9871.703848884545, 10241.539130739135, 2845.2744550139996, 2868.4836729388494, 2898.087102562686, 2901.8403987780453, 3043.25440267136, 989.9455529945922, 1026.9435181065114, 1032.2774058159318, 1032.5921261101823, 1043.400044974143, 21184.470388240108, 21239.8938005309, 21380.786192138192, 21459.463513411978, 21780.673289900664, 1103.100972707241, 1107.1585594947737, 1110.6168371911679, 1119.4011204005817, 1134.5631931706353, 11563.190576659721, 11850.466728997217, 11987.880121198676, 12050.216735912138, 12105.878941210474, 607798.0, 623516.0, 626543.0, 652180.0, 662014.0, 131056.68943310445, 132260.3386983059, 133641.33179334042, 137824.0, 137858.0, 1103.1671088328421, 1160.825876118589, 1211.6304527119314, 1221.4991853340266, 1263.5388083349512, 22113.668294975265, 22221.666674999564, 22375.837922699164, 22519.66220506661, 22595.096196152626, 60368.39631603804, 62057.0, 63531.729365411506, 63714.0, 63978.76074337376, 79629.20370796218, 80223.0, 80498.59750701209, 80765.0, 81013.59493202496, 15285.235738213267, 15577.688446230784, 15589.376424942875, 15680.529584112495, 15755.44855930037, 24311.63532546978, 24492.87753561292, 24797.752022479544, 24872.875635621705, 25030.874845625654, 19831.801681982997, 20044.799552004293, 20088.59822803565, 20394.388168354973, 20437.182512699324, 17450.82549174492, 17676.646467070328, 18223.81776182221, 18263.726044109615, 18372.540686482946, 20539.794602054386, 20556.588868222254, 20691.172353105707, 20882.37352879416, 21003.264885728928, 15143.469978550698, 15225.6193595161, 15257.313420896307, 15285.847141528888, 15360.0, 19866.304679336154, 19979.800201997794, 20182.39452816418, 20214.292499762436, 20369.0], "value": 12924.74832903361, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.949531766388, 1481.9481318153867, 1488.2261224163435, 1489.627593101724, 1490.5528341497547, 16253.83746162538, 16858.32566697334, 16927.492175234747, 16959.83040169598, 16967.06681132537, 16294.42969496068, 16489.257983390748, 16576.502704918843, 16587.336506539723, 16600.25298861551, 2821.957670634942, 2857.8713957871946, 2872.095289983659, 2878.0358579875765, 2879.9712002879915, 2733.316670832292, 2866.2261189478827, 2869.5552189410673, 2880.467113583983, 2881.5533592293227, 2690.1660485249536, 2880.467113583983, 2881.697421770715, 2889.696581858906, 2890.537513997761, 2876.3815779607276, 2907.912762617125, 2908.796384253103, 2929.209113539343, 2936.045785119834, 2730.3447172678416, 2845.5447128459555, 2917.081119447367, 2921.8246905185756, 2923.63454568179, 16974.830251697447, 17064.317427302893, 17080.743788843178, 17095.0, 17114.48656540306, 8638.740837774876, 8941.955290223572, 8972.327075469366, 8977.640894364218, 8984.730458086202, 5417.485338892799, 5549.472800084026, 5575.470330318613, 5652.74562644682, 5673.404292549264, 1896.5353488395294, 1897.8956157411337, 1936.4190742777112, 1950.570874407628, 1957.4714826996774, 29127.0, 29984.8500757497, 30091.247718806986, 30092.398152037054, 30118.698813012026, 7077.5753454792875, 7205.099362579677, 7220.022144859263, 7227.421806255487, 7283.963580182171, 19530.511737206685, 19591.412257632295, 19601.31395401154, 19608.3137090204, 19625.0, 8349.791255218668, 8495.532745698922, 8498.617562209716, 8500.787480312918, 8503.319734421231, 7626.084869815658, 7732.922670773332, 7768.805779855549, 7791.727289544839, 7793.10379306387, 5486.61593688438, 5627.662340259516, 5632.239647647597, 5646.2942132233475, 5730.169125476783, 1566.0447127252366, 1567.6472793621344, 1571.2929181868205, 1582.723023470888, 1599.4881637876001, 920.5949382271913, 922.8292765838341, 929.8047410043831, 931.3340961212765, 940.844760614491, 8025.117237103914, 8149.551774652333, 8170.509769413854, 8203.220694034057, 8223.629936652746, 772.8763397856316, 777.8211011467395, 784.5880912520972, 786.6460092958192, 788.9289963903276, 5181.948180518222, 5401.378841433207, 5445.809396671098, 5461.01701693691, 5648.15277708347, 23799.52400951971, 25047.248582542554, 25101.24696259115, 25140.497190056096, 25143.371415714388, 23502.177423790086, 24197.516049678907, 24586.0, 24736.381590460383, 24765.62851557228, 12251.264924104404, 12263.877361226452, 12264.141510094387, 12384.256944583354, 12506.937465312798, 8299.253067223979, 8373.790655233668, 8460.957695211484, 8602.569871506525, 9047.728568142966, 21238.25666101679, 21416.464588385414, 21612.351629450513, 21821.454463638536, 22099.779002209772, 21452.591781912124, 21553.784462155178, 21652.24217152392, 21727.456813579785, 22285.331440056823, 12343.074269430008, 12392.0, 12431.31627760482, 12458.43937022818, 12668.176568523017, 15186.46847360337, 15424.151671657717, 15431.0, 15442.45951391696, 15449.0, 12675.873241267838, 12809.8078528824, 12819.679508012374, 12874.485020599072, 12995.350232488148, 12287.324197169242, 12548.686282843002, 12687.492500299884, 12761.744765104831, 12835.743285134431, 10635.89364106349, 10880.891191088305, 10887.945560272148, 10889.183311251529, 10893.128549715846, 7904.486208396436, 8000.239977202156, 8099.959500202462, 8141.14517975604, 8195.95902020486, 8059.879101813361, 8077.515349079074, 8125.0, 8236.752897413087, 8262.215089566482], "value": 7186.187818513954, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.2960597602204, 538.5960529602797, 566.3373852592466, 570.6775671745467, 573.9282589676291, 6365.267994180665, 6392.20097487814, 6395.424411802936, 6446.194225721785, 6514.44627206688, 6274.654893980829, 6336.398042185985, 6353.3646635336445, 6369.554131210817, 6405.565884963719, 5146.6911985281, 5150.459201783806, 5165.870853228681, 5183.714895680736, 5196.168613021917, 5092.770825312869, 5104.77028533715, 5145.871353216162, 5165.7158856262895, 5214.296070030554, 4815.5906747926465, 4839.419269687624, 5115.360579927509, 5129.102407078765, 5135.794568217286, 4861.829835955742, 4891.5353041461, 4913.26301054841, 4940.333055037596, 4961.8511444656715, 4434.556544345572, 4438.489573699034, 4467.353951890031, 4471.843485478025, 4481.170983368087, 6097.847553811146, 6104.175936248638, 6125.479334256594, 6139.355367686418, 6188.350223226586, 5779.711014449261, 5784.248047753807, 5794.188813566104, 5814.156947242668, 5823.330317013555, 6495.220573531159, 6533.811173256965, 6534.93465065348, 6609.768658096991, 6630.602163870183, 4864.635152363551, 4968.378952630921, 4977.402711674622, 4980.651354405193, 5010.824621138279, 6718.160229971254, 6850.349216824394, 6859.55412898165, 6983.755568555127, 7013.929860701379, 5530.446955304518, 5557.555395568425, 5587.972060139673, 5611.354694210218, 5623.522000629992, 5642.786800837757, 5682.886342273131, 5694.202811606378, 5706.801571669913, 5729.5702822288495, 6085.148079268906, 6133.447989680861, 6152.692365381713, 6153.98459254227, 6182.783602573888, 6728.158980127484, 6779.830504237433, 6802.183737951477, 6802.863942721118, 6804.183497980274, 1947.3807728605004, 1991.73111629931, 1998.331393286622, 2001.8698784578955, 2006.5084054406764, 1434.512265829623, 1478.5712143478486, 1501.3919362658141, 1508.4795745467795, 1528.6025633335412, 5966.0, 6043.8791224175275, 6055.850957502074, 6058.878822423615, 6121.602095863844, 6612.537122401482, 6629.502787290972, 6726.730930762813, 6734.9326506734305, 6876.656167191621, 6103.206583144163, 6133.3866613338305, 6179.980303250003, 6206.565540412218, 6242.250929888442, 3520.2431477232517, 3526.3828829954655, 3538.929221415609, 3564.6435356464144, 3569.3218288525095, 6963.860722785617, 6975.8604827903155, 7002.0, 7005.159380874327, 7031.191412987469, 6832.0870156356295, 6843.452523798183, 6939.861202775916, 6944.270851560615, 7042.753503627451, 6935.791926242221, 6973.4072603829245, 7033.366996970297, 7084.893726594105, 7095.574265544084, 6622.801315960529, 6742.157230346207, 6774.796756097325, 6787.796366109024, 6836.658167091725, 6664.666766661744, 6698.497612678971, 6753.763618273337, 6779.864402712017, 6849.897251541331, 6786.185657721105, 6984.4063254623925, 7013.158420989514, 7033.824154396181, 7099.296168919525, 5056.84829455117, 5106.872328191825, 5123.410807757006, 5133.768980395966, 5169.457206993212, 6338.841528961812, 6558.344165583403, 6761.0, 6812.00271880371, 6842.1789385272095, 6395.776147834804, 6467.156860294794, 6502.6748662567625, 6540.934590654033, 6565.967170164118, 6417.2299324081405, 6433.228012638513, 6469.256035555972, 6476.514261430318, 6482.222133344029, 6385.904211436925, 6415.358464153547, 6472.255690595453, 6476.319986401549, 6484.660399894153, 6575.605463672195, 6635.108993936705, 6646.966765166337, 6657.1345725055435, 6680.6993685283305, 6428.325025872216, 6471.094046833541, 6474.730261218243, 6484.24925270165, 6502.601940582797], "value": 5240.194317687048, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [949.4682977532578, 983.4689267795388, 997.5909876950452, 1005.4269066632019, 1015.7354094152781, 18384.172712227948, 18661.16024778885, 18680.15939282732, 18724.0, 18799.248030078816, 17431.73852392215, 17553.210105545248, 18025.0, 19474.221031158773, 19621.509462263413, 1048.9475526223678, 1071.7052810477142, 1072.5012869015907, 1072.6031368393706, 1073.62423151897, 1053.6259627832123, 1086.5490821309147, 1086.9076128529084, 1096.7203363142428, 1096.983545246822, 1149.5516748468103, 1150.0454622663212, 1150.0512077536025, 1150.4075401168404, 1150.5742875136211, 1088.755030118221, 1128.4132251229314, 1128.7347473343757, 1128.7911736328806, 1131.4455916600848, 823.7693445835175, 824.0934971531327, 824.505296821908, 824.814416756231, 830.2652152844776, 19126.617467650707, 19154.138063787163, 19182.328618498424, 19218.903905480383, 19366.70949935752, 19909.80090199094, 20243.797562024338, 20267.087981040742, 20279.391618251477, 20299.0, 18319.816801831945, 18817.435476935712, 18921.71617425726, 18921.81078189214, 18929.0, 4068.7558746475306, 4084.244414783275, 4089.0595163112353, 4098.73358231717, 4100.979495102535, 152885.23557382255, 153199.23400382928, 155588.22205889013, 156143.21928390398, 157969.21015394965, 17095.57261068483, 17184.1407929603, 17445.0, 17473.126343682765, 17478.650426991644, 33809.661903381144, 33833.492497612555, 33884.0, 34157.65842341545, 34272.0, 8883.33374996865, 8981.101889811098, 8984.8652270216, 8999.550022498848, 9020.909790902138, 4328.394024836525, 4430.357598148251, 4436.201483732959, 4443.911121777611, 4450.2434586120435, 5833.941660583425, 5969.462748352669, 6009.639421634629, 6012.458878700938, 6023.909641355383, 1047.659510659039, 1067.5889782433665, 1082.6968448834182, 1086.0931122512632, 1087.6410784441116, 734.5739471106746, 751.4138971602159, 753.8341564855723, 771.3096778383316, 772.2702046565942, 13163.934180329228, 13344.06591538583, 13358.732825343439, 13521.32393380327, 13572.93213533926, 747.6299231880254, 763.5838468034934, 767.3554214459768, 783.0251337085251, 788.2669117720575, 6352.65060421672, 6444.645544495098, 6468.320826313264, 6531.510136739668, 6556.967215163893, 148972.25513872362, 149360.0, 149731.2513437426, 149909.2504537492, 158456.20771896298, 103881.48059259655, 105268.0, 127357.36321318334, 129655.35172324267, 135897.3205133968, 108861.45569272104, 109082.0, 114299.42850285696, 115566.42216788862, 118110.0, 14358.0, 14520.491782787552, 14732.705345892808, 14810.111393316436, 14888.553343399715, 57058.14412783895, 57162.42837571571, 57603.0, 57885.71057144687, 58363.4163658358, 72670.0, 73367.63316183384, 73466.63266683632, 73929.0, 73930.26069739234, 20073.397798066082, 20417.48956276105, 20451.590968180255, 20644.896775516027, 20732.58534829325, 22893.656595150755, 23121.0, 23218.883905580366, 23313.650295245923, 23354.18260360879, 21186.04662790209, 21441.89279053595, 21526.246581369578, 21645.783542164376, 21788.673169902147, 19771.110300036245, 19810.50473738168, 19847.00764961775, 19892.30376936858, 20199.8990005049, 19904.303349382702, 20048.39854804358, 20123.295684650966, 20213.292534761214, 20478.590428191652, 13212.735745284848, 13356.0, 13404.865951340362, 13436.596902092953, 13631.522896698569, 14860.777088343468, 15056.774148387563, 15218.619534511727, 15376.846231537542, 15411.075335479907], "value": 10127.242017115112, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1365.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 106.0, 106.0, 106.0, 106.0, 95.0, 106.0, 105.0, 106.0], "value": 105.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 111.0, 111.0, 113.0, 110.0, 112.0, 146.0, 110.0, 113.0], "value": 115.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 160.0, 161.0, 161.0, 163.0, 161.0, 163.0, 164.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 77.0, 73.0, 74.0, 73.0, 75.0, 73.0, 76.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 78.0, 77.0, 77.0, 78.0, 77.0, 78.0, 78.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 117.0, 113.0, 116.0, 116.0, 116.0, 115.0, 116.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 148.0, 150.0, 149.0, 149.0, 150.0, 149.0, 150.0, 149.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 96.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 48.0, 45.0, 45.0, 43.0, 48.0, 45.0, 45.0, 44.0, 46.0], "value": 45.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 37.0, 36.0, 36.0, 38.0, 36.0, 36.0, 36.0, 37.0, 37.0], "value": 36.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 70.0, 70.0, 70.0, 72.0, 71.0, 70.0, 71.0, 70.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 107.0, 102.0, 104.0, 104.0, 112.0, 111.0, 102.0, 109.0, 106.0], "value": 106.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 151.0, 155.0, 152.0, 150.0, 154.0, 157.0, 158.0, 152.0, 150.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 59.0, 59.0, 62.0, 63.0, 59.0, 58.0, 59.0, 58.0], "value": 60.4, "unit": "score"}]}]} 16:35:43 INFO - Return code: 0 16:35:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:35:43 INFO - # TBPL SUCCESS # 16:35:43 INFO - Running post-action listener: _package_coverage_data 16:35:43 INFO - Running post-action listener: _resource_record_post_action 16:35:43 INFO - [mozharness: 2017-09-13 23:35:43.714790Z] Finished run-tests step (success) 16:35:43 INFO - Running post-run listener: _resource_record_post_run 16:35:43 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 9424896; Write bytes: 527048704; Read time: 3956; Write time: 767856 16:35:43 INFO - TinderboxPrint: CPU usage
13.1% 16:35:43 INFO - TinderboxPrint: I/O read bytes / time
9,424,896 / 3,956 16:35:43 INFO - TinderboxPrint: I/O write bytes / time
527,048,704 / 767,856 16:35:43 INFO - TinderboxPrint: CPU idle
8,248.6 (86.9%) 16:35:43 INFO - TinderboxPrint: CPU user
1,186.5 (12.5%) 16:35:43 INFO - TinderboxPrint: Swap in / out
0 / 0 16:35:43 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 81174528; Read time: 0; Write time: 65848 16:35:43 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:35:43 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 9191424; Write bytes: 445874176; Read time: 3928; Write time: 702008 16:35:44 INFO - Running post-run listener: _upload_blobber_files 16:35:44 INFO - Blob upload gear active. 16:35:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:35:44 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 16:35:44 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'] 16:35:44 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 16:35:44 INFO - (blobuploader) - INFO - Open directory for files ... 16:35:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:35:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:35:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:45 INFO - (blobuploader) - INFO - Done attempting. 16:35:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:35:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:35:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:46 INFO - (blobuploader) - INFO - Done attempting. 16:35:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:35:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:35:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:53 INFO - (blobuploader) - INFO - Done attempting. 16:35:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:35:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:35:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:54 INFO - (blobuploader) - INFO - Done attempting. 16:35:54 INFO - (blobuploader) - INFO - Iteration through files over. 16:35:54 INFO - Return code: 0 16:35:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:35:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:35:54 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b97f101559b4f987010c939618780b6a51f4fdf657750d14f88cc8b6468a864580019fb13e7c25e9502dc1a7f43b36bb6342e8722421211996a87012b4423181", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3f5f8aa624e415e0c0527b8e1409d1a1e2c8a57967ec87fc09d40ec80f3ff33eec844988444bae4bd9b32baf902fab8be743b6d9cb0a740db8bf6ca719dd1c3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcaf66ec794e8acd2860aae135983e64c95e93d28b5bdef37247963a97fcf33a3ed0cfed891723a146c6f95ff4014f7a00b76cf19c60e88d3d093011d70fd2e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8a891aa5572f57fd7088aded83f10f51f486d9ec6de532b14e498eb1d6873efa1e28134d48a6ff8f309bf0e27790b1521a587eb2a38a4671fd16ea1841c4678"} 16:35:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:35:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:35:54 INFO - Contents: 16:35:54 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b97f101559b4f987010c939618780b6a51f4fdf657750d14f88cc8b6468a864580019fb13e7c25e9502dc1a7f43b36bb6342e8722421211996a87012b4423181", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3f5f8aa624e415e0c0527b8e1409d1a1e2c8a57967ec87fc09d40ec80f3ff33eec844988444bae4bd9b32baf902fab8be743b6d9cb0a740db8bf6ca719dd1c3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcaf66ec794e8acd2860aae135983e64c95e93d28b5bdef37247963a97fcf33a3ed0cfed891723a146c6f95ff4014f7a00b76cf19c60e88d3d093011d70fd2e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8a891aa5572f57fd7088aded83f10f51f486d9ec6de532b14e498eb1d6873efa1e28134d48a6ff8f309bf0e27790b1521a587eb2a38a4671fd16ea1841c4678"} 16:35:54 INFO - Running post-run listener: copy_logs_to_upload_dir 16:35:54 INFO - Copying logs to upload dir... 16:35:54 INFO - mkdir: /builds/slave/test/build/upload/logs 16:35:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.570080 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-13 16:35:54.593185) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 16:35:54.597805) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191 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/b97f101559b4f987010c939618780b6a51f4fdf657750d14f88cc8b6468a864580019fb13e7c25e9502dc1a7f43b36bb6342e8722421211996a87012b4423181", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3f5f8aa624e415e0c0527b8e1409d1a1e2c8a57967ec87fc09d40ec80f3ff33eec844988444bae4bd9b32baf902fab8be743b6d9cb0a740db8bf6ca719dd1c3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcaf66ec794e8acd2860aae135983e64c95e93d28b5bdef37247963a97fcf33a3ed0cfed891723a146c6f95ff4014f7a00b76cf19c60e88d3d093011d70fd2e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8a891aa5572f57fd7088aded83f10f51f486d9ec6de532b14e498eb1d6873efa1e28134d48a6ff8f309bf0e27790b1521a587eb2a38a4671fd16ea1841c4678"} build_url:https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/EE2T5AdfROa4pbnRYPTKTA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b97f101559b4f987010c939618780b6a51f4fdf657750d14f88cc8b6468a864580019fb13e7c25e9502dc1a7f43b36bb6342e8722421211996a87012b4423181", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3f5f8aa624e415e0c0527b8e1409d1a1e2c8a57967ec87fc09d40ec80f3ff33eec844988444bae4bd9b32baf902fab8be743b6d9cb0a740db8bf6ca719dd1c3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcaf66ec794e8acd2860aae135983e64c95e93d28b5bdef37247963a97fcf33a3ed0cfed891723a146c6f95ff4014f7a00b76cf19c60e88d3d093011d70fd2e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8a891aa5572f57fd7088aded83f10f51f486d9ec6de532b14e498eb1d6873efa1e28134d48a6ff8f309bf0e27790b1521a587eb2a38a4671fd16ea1841c4678"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 16:35:54.629384) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 16:35:54.629773) ========= 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=5cf47e208febbcd81da23b2e0000026f-1505344509.129984-421236191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 16:35:54.714251) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 16:35:54.714817) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 16:35:54.718414) ========= ========= Total master_lag: 0.22 =========