builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1506336627.57 results: success (0) revision: 13ce77b78e364cc952d51b959f22202502be2941 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 03:50:27.570791) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 03:50:27.571245) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 03:50:27.571551) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 03:50:27.589022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:50:27.589274) ========= 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=745a4373a2a16df560f216e000000264-1506336627.251848-1682386081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 03:50:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2017-09-25 03:50:28 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106028 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:50:27.714804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:50:27.715110) ========= 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=745a4373a2a16df560f216e000000264-1506336627.251848-1682386081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015745 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 03:50:27.764131) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 03:50:27.764427) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 13ce77b78e364cc952d51b959f22202502be2941 --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 13ce77b78e364cc952d51b959f22202502be2941 --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=745a4373a2a16df560f216e000000264-1506336627.251848-1682386081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 03:50:28,644 truncating revision to first 12 chars 2017-09-25 03:50:28,644 Setting DEBUG logging. 2017-09-25 03:50:28,644 attempt 1/10 2017-09-25 03:50:28,644 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/13ce77b78e36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 03:50:29,234 unpacking tar archive at: mozilla-central-13ce77b78e36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.910232 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 03:50:28.792052) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 03:50:28.792329) ========= script_repo_revision: 13ce77b78e364cc952d51b959f22202502be2941 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 03:50:28.792704) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 03:50:28.792959) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 03:50:28.818855) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-25 03:50:28.819110) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1506336627.251848-1682386081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:50:29 INFO - MultiFileLogger online at 20170925 03:50:29 in /builds/slave/test 03:50:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:50:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:50:29 INFO - {'append_to_log': False, 03:50:29 INFO - 'base_work_dir': '/builds/slave/test', 03:50:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:50:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:50:29 INFO - 'branch': 'Firefox-Non-PGO', 03:50:29 INFO - 'buildbot_json_path': 'buildprops.json', 03:50:29 INFO - 'code_coverage': False, 03:50:29 INFO - 'config_files': ('talos/linux_config.py',), 03:50:29 INFO - 'default_actions': ('clobber', 03:50:29 INFO - 'read-buildbot-config', 03:50:29 INFO - 'download-and-extract', 03:50:29 INFO - 'populate-webroot', 03:50:29 INFO - 'create-virtualenv', 03:50:29 INFO - 'install', 03:50:29 INFO - 'setup-mitmproxy', 03:50:29 INFO - 'run-tests'), 03:50:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:50:29 INFO - 'disable_ccov_upload': False, 03:50:29 INFO - 'disable_stylo': False, 03:50:29 INFO - 'download_minidump_stackwalk': True, 03:50:29 INFO - 'download_symbols': 'ondemand', 03:50:29 INFO - 'enable_stylo': False, 03:50:29 INFO - 'enable_webrender': False, 03:50:29 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:50:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:50:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:50:29 INFO - 'gecko_profile': False, 03:50:29 INFO - 'gecko_profile_interval': 0, 03:50:29 INFO - 'installer_path': 'installer.exe', 03:50:29 INFO - 'log_level': 'info', 03:50:29 INFO - 'log_name': 'talos', 03:50:29 INFO - 'log_to_console': True, 03:50:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:50:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:50:29 INFO - 'opt_config_files': (), 03:50:29 INFO - 'pip_index': False, 03:50:29 INFO - 'suite': 'dromaeojs-e10s', 03:50:29 INFO - 'system_bits': '32', 03:50:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:50:29 INFO - 'title': 'talos-linux64-ix-032', 03:50:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:50:29 INFO - 'use_talos_json': True, 03:50:29 INFO - 'verify': 'False', 03:50:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:50:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:50:29 INFO - 'work_dir': 'build'} 03:50:29 INFO - [mozharness: 2017-09-25 10:50:29.842722Z] Running clobber step. 03:50:29 INFO - Running pre-action listener: _resource_record_pre_action 03:50:29 INFO - Running main action method: clobber 03:50:29 INFO - rmtree: /builds/slave/test/build 03:50:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:50:31 INFO - Running post-action listener: _resource_record_post_action 03:50:31 INFO - [mozharness: 2017-09-25 10:50:31.415581Z] Finished clobber step (success) 03:50:31 INFO - [mozharness: 2017-09-25 10:50:31.415680Z] Running read-buildbot-config step. 03:50:31 INFO - Running pre-action listener: _resource_record_pre_action 03:50:31 INFO - Running main action method: read_buildbot_config 03:50:31 INFO - Using buildbot properties: 03:50:31 INFO - { 03:50:31 INFO - "project": "", 03:50:31 INFO - "product": "firefox", 03:50:31 INFO - "who": "archaeopteryx@coole-files.de", 03:50:31 INFO - "installer_path": "public/build/target.tar.bz2", 03:50:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:50:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:50:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:50:31 INFO - "stage_platform": "linux64", 03:50:31 INFO - "basedir": "/builds/slave/test", 03:50:31 INFO - "buildnumber": 863, 03:50:31 INFO - "platform": "ubuntu64_hw", 03:50:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:50:31 INFO - "slavebuilddir": "test", 03:50:31 INFO - "taskId": "Ww7bTUDwSrGzugdafU2_sg", 03:50:31 INFO - "branch": "mozilla-central", 03:50:31 INFO - "script_repo_revision": "production", 03:50:31 INFO - "revision": "13ce77b78e364cc952d51b959f22202502be2941", 03:50:31 INFO - "slavename": "talos-linux64-ix-032", 03:50:31 INFO - "repo_path": "mozilla-central" 03:50:31 INFO - } 03:50:31 INFO - Finding installer, test and symbols from parent task. 03:50:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ww7bTUDwSrGzugdafU2_sg'}, attempt #1 03:50:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ww7bTUDwSrGzugdafU2_sg'}, attempt #1 03:50:32 INFO - Task dependencies: JwN-TpclSCu1HPYGslnjhA 03:50:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA'}, attempt #1 03:50:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 03:50:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.test_packages.json 03:50:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.crashreporter-symbols.zip 03:50:32 INFO - Running post-action listener: _resource_record_post_action 03:50:32 INFO - [mozharness: 2017-09-25 10:50:32.722223Z] Finished read-buildbot-config step (success) 03:50:32 INFO - [mozharness: 2017-09-25 10:50:32.722442Z] Running download-and-extract step. 03:50:32 INFO - Running pre-action listener: _resource_record_pre_action 03:50:32 INFO - Running main action method: download_and_extract 03:50:32 INFO - mkdir: /builds/slave/test/build/tests 03:50: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')]} 03:50:32 INFO - trying https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.test_packages.json 03:50:32 INFO - Downloading https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:50:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:50:33 INFO - Downloaded 989 bytes. 03:50:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:50:33 INFO - Using the following test package requirements: 03:50:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:50:33 INFO - u'common': [u'target.common.tests.zip'], 03:50:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:50:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:50:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:50:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:50:33 INFO - u'mozbase': [u'target.common.tests.zip'], 03:50:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:50:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:50:33 INFO - u'web-platform': [u'target.common.tests.zip', 03:50:33 INFO - u'target.web-platform.tests.tar.gz'], 03:50:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:50:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:50:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.common.tests.zip 03:50:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:50:33 INFO - Fetch https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.common.tests.zip into memory 03:50:34 INFO - Content-Length response header: 54943883 03:50:34 INFO - Bytes received: 54943883 03:50:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.talos.tests.zip 03:50:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:50:45 INFO - Fetch https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.talos.tests.zip into memory 03:50:45 INFO - Content-Length response header: 14513823 03:50:45 INFO - Bytes received: 14513823 03:50: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')]} 03:50:46 INFO - trying https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 03:50:46 INFO - Downloading https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:50:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:50:47 INFO - Downloaded 61752580 bytes. 03:50:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 03:50:47 INFO - mkdir: /builds/slave/test/properties 03:50:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:50:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:50:47 INFO - Contents: 03:50:47 INFO - build_url:https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 03:50:47 INFO - Running post-action listener: _resource_record_post_action 03:50:47 INFO - Running post-action listener: find_tests_for_verification 03:50:47 INFO - Running post-action listener: set_extra_try_arguments 03:50:47 INFO - [mozharness: 2017-09-25 10:50:47.634216Z] Finished download-and-extract step (success) 03:50:47 INFO - [mozharness: 2017-09-25 10:50:47.634371Z] Running populate-webroot step. 03:50:47 INFO - Running pre-action listener: _resource_record_pre_action 03:50:47 INFO - Running main action method: populate_webroot 03:50:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:50:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:50:47 INFO - 'tests': ['tresize', 03:50:47 INFO - 'tcanvasmark']}, 03:50:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:50:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:50:47 INFO - 'tests': ['dromaeo_css', 03:50:47 INFO - 'kraken']}, 03:50:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:50:47 INFO - 'talos_options': ['--disable-stylo'], 03:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:50:47 INFO - 'tests': ['damp', 'tps']}, 03:50:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:50:47 INFO - 'talos_options': ['--disable-stylo'], 03:50:47 INFO - 'tests': ['damp', 'tps']}, 03:50:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:50:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:50:47 INFO - 'tests': ['dromaeo_dom']}, 03:50:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:50:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:50:47 INFO - 'tests': ['basic_compositor_video', 03:50:47 INFO - 'glvideo']}, 03:50:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:50:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:50:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:50:47 INFO - 'talos_options': ['--disable-stylo'], 03:50:47 INFO - 'tests': ['ts_paint_webext', 03:50:47 INFO - 'tp5o_webext']}, 03:50:47 INFO - 'other-e10s': {'tests': ['a11yr', 03:50:47 INFO - 'ts_paint', 03:50:47 INFO - 'tpaint', 03:50:47 INFO - 'sessionrestore', 03:50:47 INFO - 'sessionrestore_many_windows', 03:50:47 INFO - 'sessionrestore_no_auto_restore', 03:50:47 INFO - 'tabpaint']}, 03:50:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:50:47 INFO - 'tests': ['a11yr', 03:50:47 INFO - 'ts_paint', 03:50:47 INFO - 'tpaint', 03:50:47 INFO - 'sessionrestore', 03:50:47 INFO - 'sessionrestore_many_windows', 03:50:47 INFO - 'sessionrestore_no_auto_restore', 03:50:47 INFO - 'tabpaint']}, 03:50:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:50:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:50:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:50:47 INFO - 'tests': ['perf_reftest_singletons']}, 03:50:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:50:47 INFO - 'tests': ['perf_reftest']}, 03:50:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:50:47 INFO - 'tsvgr_opacity', 03:50:47 INFO - 'tart', 03:50:47 INFO - 'tscrollx', 03:50:47 INFO - 'tsvg_static']}, 03:50:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:50:47 INFO - 'tests': ['tsvgx', 03:50:47 INFO - 'tsvgr_opacity', 03:50:47 INFO - 'tart', 03:50:47 INFO - 'tscrollx', 03:50:47 INFO - 'tsvg_static']}, 03:50:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:50:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:50:47 INFO - 'talos_options': ['--disable-stylo'], 03:50:47 INFO - 'tests': ['tp5o']}, 03:50:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:50:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:50:47 INFO - 'talos_options': ['--mitmproxy', 03:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:50:47 INFO - '--firstNonBlankPaint'], 03:50:47 INFO - 'tests': ['tp6_google', 03:50:47 INFO - 'tp6_youtube', 03:50:47 INFO - 'tp6_amazon', 03:50:47 INFO - 'tp6_facebook']}, 03:50:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:50:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:50:47 INFO - 'talos_options': ['--disable-stylo', 03:50:47 INFO - '--mitmproxy', 03:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:50:47 INFO - '--firstNonBlankPaint'], 03:50:47 INFO - 'tests': ['tp6_google', 03:50:47 INFO - 'tp6_youtube', 03:50:47 INFO - 'tp6_amazon', 03:50:47 INFO - 'tp6_facebook']}, 03:50:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:50:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:50:47 INFO - 'talos_options': ['--stylo-threads=1', 03:50:47 INFO - '--mitmproxy', 03:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:50:47 INFO - '--firstNonBlankPaint'], 03:50:47 INFO - 'tests': ['tp6_google', 03:50:47 INFO - 'tp6_youtube', 03:50:47 INFO - 'tp6_amazon', 03:50:47 INFO - 'tp6_facebook']}, 03:50:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:50:47 INFO - 'talos_options': ['--xperf_path', 03:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:47 INFO - 'tests': ['tp5n']}, 03:50:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:50:47 INFO - 'talos_options': ['--disable-stylo', 03:50:47 INFO - '--xperf_path', 03:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:47 INFO - 'tests': ['tp5n']}}} 03:50:47 INFO - Running post-action listener: _resource_record_post_action 03:50:47 INFO - [mozharness: 2017-09-25 10:50:47.658390Z] Finished populate-webroot step (success) 03:50:47 INFO - [mozharness: 2017-09-25 10:50:47.658498Z] Running create-virtualenv step. 03:50:47 INFO - Running pre-action listener: _resource_record_pre_action 03:50:47 INFO - Running main action method: create_virtualenv 03:50:47 INFO - Creating virtualenv /builds/slave/test/build/venv 03:50:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:50:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:50:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:50:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:50:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:50:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:50:49 INFO - Installing pip...............done. 03:50:49 INFO - Return code: 0 03:50:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:50:49 INFO - Reading from file tmpfile_stdout 03:50:49 INFO - Output received: 03:50:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:50:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:50: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')]} 03:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50: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')]} 03:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:49 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 0x157d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7d60>, '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 0x18e8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e8ef0>, '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': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', '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 03:50:49 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 03:50:49 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 03:50:49 INFO - Using env: {'DISPLAY': ':0', 03:50:49 INFO - 'HOME': '/home/cltbld', 03:50:49 INFO - 'LANG': 'en_US.UTF-8', 03:50:49 INFO - 'LANGUAGE': 'en_US:en', 03:50:49 INFO - 'LOGNAME': 'cltbld', 03:50:49 INFO - 'MAIL': '/var/mail/cltbld', 03:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:49 INFO - 'MOZ_NO_REMOTE': '1', 03:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:49 INFO - 'NO_EM_RESTART': '1', 03:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:49 INFO - 'PWD': '/builds/slave/test', 03:50:49 INFO - 'SHELL': '/bin/bash', 03:50:49 INFO - 'SHLVL': '1', 03:50:49 INFO - 'TERM': 'linux', 03:50:49 INFO - 'TMOUT': '86400', 03:50:49 INFO - 'USER': 'cltbld', 03:50:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', 03:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:49 INFO - '_': '/tools/buildbot/bin/python'} 03:50:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:50:50 INFO - Downloading/unpacking pip>=1.5 03:50:50 INFO - Running setup.py egg_info for package pip 03:50:50 INFO - warning: no files found matching 'pip/cacert.pem' 03:50:50 INFO - warning: no files found matching '*.html' under directory 'docs' 03:50:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:50:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:50:50 INFO - Installing collected packages: pip 03:50:50 INFO - Found existing installation: pip 1.1 03:50:50 INFO - Uninstalling pip: 03:50:50 INFO - Successfully uninstalled pip 03:50:50 INFO - Running setup.py install for pip 03:50:50 INFO - warning: no files found matching 'pip/cacert.pem' 03:50:50 INFO - warning: no files found matching '*.html' under directory 'docs' 03:50:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:50:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:50:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Successfully installed pip 03:50:50 INFO - Cleaning up... 03:50:50 INFO - Return code: 0 03:50:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x157d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7d60>, '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 0x18e8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e8ef0>, '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': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', '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 03:50:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:50:50 INFO - Using env: {'DISPLAY': ':0', 03:50:50 INFO - 'HOME': '/home/cltbld', 03:50:50 INFO - 'LANG': 'en_US.UTF-8', 03:50:50 INFO - 'LANGUAGE': 'en_US:en', 03:50:50 INFO - 'LOGNAME': 'cltbld', 03:50:50 INFO - 'MAIL': '/var/mail/cltbld', 03:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:50 INFO - 'MOZ_NO_REMOTE': '1', 03:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:50 INFO - 'NO_EM_RESTART': '1', 03:50:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:50 INFO - 'PWD': '/builds/slave/test', 03:50:50 INFO - 'SHELL': '/bin/bash', 03:50:50 INFO - 'SHLVL': '1', 03:50:50 INFO - 'TERM': 'linux', 03:50:50 INFO - 'TMOUT': '86400', 03:50:50 INFO - 'USER': 'cltbld', 03:50:50 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', 03:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:50 INFO - '_': '/tools/buildbot/bin/python'} 03:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:51 INFO - Downloading/unpacking psutil>=3.1.1 03:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:50:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:52 INFO - Installing collected packages: psutil 03:50:52 INFO - Running setup.py install for psutil 03:50:52 INFO - building 'psutil._psutil_linux' extension 03:50:52 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 03:50:52 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 03:50:52 INFO - building 'psutil._psutil_posix' extension 03:50:52 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 03:50:52 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 03:50:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:52 INFO - Successfully installed psutil 03:50:52 INFO - Cleaning up... 03:50:52 INFO - Return code: 0 03:50:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:52 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 0x157d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7d60>, '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 0x18e8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e8ef0>, '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': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', '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 03:50:52 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 03:50:52 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 03:50:52 INFO - Using env: {'DISPLAY': ':0', 03:50:52 INFO - 'HOME': '/home/cltbld', 03:50:52 INFO - 'LANG': 'en_US.UTF-8', 03:50:52 INFO - 'LANGUAGE': 'en_US:en', 03:50:52 INFO - 'LOGNAME': 'cltbld', 03:50:52 INFO - 'MAIL': '/var/mail/cltbld', 03:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:52 INFO - 'MOZ_NO_REMOTE': '1', 03:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:52 INFO - 'NO_EM_RESTART': '1', 03:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:52 INFO - 'PWD': '/builds/slave/test', 03:50:52 INFO - 'SHELL': '/bin/bash', 03:50:52 INFO - 'SHLVL': '1', 03:50:52 INFO - 'TERM': 'linux', 03:50:52 INFO - 'TMOUT': '86400', 03:50:52 INFO - 'USER': 'cltbld', 03:50:52 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', 03:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:52 INFO - '_': '/tools/buildbot/bin/python'} 03:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:50:54 INFO - Installing collected packages: mozsystemmonitor 03:50:54 INFO - Running setup.py install for mozsystemmonitor 03:50:54 INFO - Successfully installed mozsystemmonitor 03:50:54 INFO - Cleaning up... 03:50:55 INFO - Return code: 0 03:50:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:55 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 0x157d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7d60>, '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 0x18e8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e8ef0>, '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': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', '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 03:50:55 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 03:50:55 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 03:50:55 INFO - Using env: {'DISPLAY': ':0', 03:50:55 INFO - 'HOME': '/home/cltbld', 03:50:55 INFO - 'LANG': 'en_US.UTF-8', 03:50:55 INFO - 'LANGUAGE': 'en_US:en', 03:50:55 INFO - 'LOGNAME': 'cltbld', 03:50:55 INFO - 'MAIL': '/var/mail/cltbld', 03:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:55 INFO - 'MOZ_NO_REMOTE': '1', 03:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:55 INFO - 'NO_EM_RESTART': '1', 03:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:55 INFO - 'PWD': '/builds/slave/test', 03:50:55 INFO - 'SHELL': '/bin/bash', 03:50:55 INFO - 'SHLVL': '1', 03:50:55 INFO - 'TERM': 'linux', 03:50:55 INFO - 'TMOUT': '86400', 03:50:55 INFO - 'USER': 'cltbld', 03:50:55 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', 03:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:55 INFO - '_': '/tools/buildbot/bin/python'} 03:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:57 INFO - Downloading/unpacking jsonschema==2.5.1 03:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:50:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:50:58 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 03:50:58 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 03:50:58 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 03:50:58 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 03:50:58 INFO - Downloading functools32-3.2.3-2.tar.gz 03:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:50:58 INFO - warning: no files found matching '*.txt' 03:50:58 INFO - no previously-included directories found matching 'build' 03:50:58 INFO - no previously-included directories found matching 'dist' 03:50:58 INFO - no previously-included directories found matching '.git*' 03:50:58 INFO - Installing collected packages: jsonschema, functools32 03:50:58 INFO - Running setup.py install for functools32 03:50:58 INFO - warning: no files found matching '*.txt' 03:50:58 INFO - no previously-included directories found matching 'build' 03:50:58 INFO - no previously-included directories found matching 'dist' 03:50:58 INFO - no previously-included directories found matching '.git*' 03:50:58 INFO - Successfully installed jsonschema functools32 03:50:58 INFO - Cleaning up... 03:50:58 INFO - Return code: 0 03:50:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:58 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 0x157d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7d60>, '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 0x18e8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e8ef0>, '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': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', '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 03:50:58 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 03:50:58 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 03:50:58 INFO - Using env: {'DISPLAY': ':0', 03:50:58 INFO - 'HOME': '/home/cltbld', 03:50:58 INFO - 'LANG': 'en_US.UTF-8', 03:50:58 INFO - 'LANGUAGE': 'en_US:en', 03:50:58 INFO - 'LOGNAME': 'cltbld', 03:50:58 INFO - 'MAIL': '/var/mail/cltbld', 03:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:58 INFO - 'MOZ_NO_REMOTE': '1', 03:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:58 INFO - 'NO_EM_RESTART': '1', 03:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:58 INFO - 'PWD': '/builds/slave/test', 03:50:58 INFO - 'SHELL': '/bin/bash', 03:50:58 INFO - 'SHLVL': '1', 03:50:58 INFO - 'TERM': 'linux', 03:50:58 INFO - 'TMOUT': '86400', 03:50:58 INFO - 'USER': 'cltbld', 03:50:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', 03:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:58 INFO - '_': '/tools/buildbot/bin/python'} 03:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:50:58 INFO - Cleaning up... 03:50:58 INFO - Return code: 0 03:50:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:58 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 0x157d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7d60>, '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 0x18e8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e8ef0>, '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': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', '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 03:50:58 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 03:50:58 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 03:50:58 INFO - Using env: {'DISPLAY': ':0', 03:50:58 INFO - 'HOME': '/home/cltbld', 03:50:58 INFO - 'LANG': 'en_US.UTF-8', 03:50:58 INFO - 'LANGUAGE': 'en_US:en', 03:50:58 INFO - 'LOGNAME': 'cltbld', 03:50:58 INFO - 'MAIL': '/var/mail/cltbld', 03:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:58 INFO - 'MOZ_NO_REMOTE': '1', 03:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:58 INFO - 'NO_EM_RESTART': '1', 03:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:58 INFO - 'PWD': '/builds/slave/test', 03:50:58 INFO - 'SHELL': '/bin/bash', 03:50:58 INFO - 'SHLVL': '1', 03:50:58 INFO - 'TERM': 'linux', 03:50:58 INFO - 'TMOUT': '86400', 03:50:58 INFO - 'USER': 'cltbld', 03:50:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', 03:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:58 INFO - '_': '/tools/buildbot/bin/python'} 03:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:00 INFO - Downloading blobuploader-1.2.4.tar.gz 03:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:51:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:51:00 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 03:51:00 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 03:51:00 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 03:51:00 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 03:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:51:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:51:00 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 03:51:00 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 03:51:00 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 03:51:00 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 03:51:00 INFO - Downloading docopt-0.6.1.tar.gz 03:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:51:00 INFO - Installing collected packages: blobuploader, requests, docopt 03:51:00 INFO - Running setup.py install for blobuploader 03:51:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:51:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:51:01 INFO - Running setup.py install for requests 03:51:01 INFO - Running setup.py install for docopt 03:51:01 INFO - Successfully installed blobuploader requests docopt 03:51:01 INFO - Cleaning up... 03:51:01 INFO - Return code: 0 03:51:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:01 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 0x157d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7d60>, '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 0x18e8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e8ef0>, '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': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', '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 03:51:01 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 03:51:01 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 03:51:01 INFO - Using env: {'DISPLAY': ':0', 03:51:01 INFO - 'HOME': '/home/cltbld', 03:51:01 INFO - 'LANG': 'en_US.UTF-8', 03:51:01 INFO - 'LANGUAGE': 'en_US:en', 03:51:01 INFO - 'LOGNAME': 'cltbld', 03:51:01 INFO - 'MAIL': '/var/mail/cltbld', 03:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:01 INFO - 'MOZ_NO_REMOTE': '1', 03:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:01 INFO - 'NO_EM_RESTART': '1', 03:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:01 INFO - 'PWD': '/builds/slave/test', 03:51:01 INFO - 'SHELL': '/bin/bash', 03:51:01 INFO - 'SHLVL': '1', 03:51:01 INFO - 'TERM': 'linux', 03:51:01 INFO - 'TMOUT': '86400', 03:51:01 INFO - 'USER': 'cltbld', 03:51:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', 03:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:01 INFO - '_': '/tools/buildbot/bin/python'} 03:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:01 INFO - Running setup.py (path:/tmp/pip-YlVSTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:01 INFO - Running setup.py (path:/tmp/pip-nk0Eyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:01 INFO - Running setup.py (path:/tmp/pip-Pek4ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:01 INFO - Running setup.py (path:/tmp/pip-TR0wYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:01 INFO - Running setup.py (path:/tmp/pip-bK2Ud0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:02 INFO - Running setup.py (path:/tmp/pip-yXzO64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:02 INFO - Running setup.py (path:/tmp/pip-ukhBIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:02 INFO - Running setup.py (path:/tmp/pip-BvlSug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:02 INFO - Running setup.py (path:/tmp/pip-3WibYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:02 INFO - Running setup.py (path:/tmp/pip-74WMec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:02 INFO - Running setup.py (path:/tmp/pip-XfWeGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:02 INFO - Running setup.py (path:/tmp/pip-JEyZVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:02 INFO - Running setup.py (path:/tmp/pip-luR5lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:02 INFO - Running setup.py (path:/tmp/pip-Jm6xs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:02 INFO - Running setup.py (path:/tmp/pip-OsHn8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:02 INFO - Running setup.py (path:/tmp/pip-DjsWPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:02 INFO - Running setup.py (path:/tmp/pip-0IEACa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:51:02 INFO - Running setup.py install for manifestparser 03:51:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:51:03 INFO - Running setup.py install for mozcrash 03:51:03 INFO - Running setup.py install for mozdebug 03:51:03 INFO - Running setup.py install for mozdevice 03:51:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:51:03 INFO - Running setup.py install for mozfile 03:51:03 INFO - Running setup.py install for mozhttpd 03:51:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:51:03 INFO - Running setup.py install for mozinfo 03:51:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:51:03 INFO - Running setup.py install for mozInstall 03:51:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:51:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:51:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:51:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:51:03 INFO - Running setup.py install for mozleak 03:51:03 INFO - Running setup.py install for mozlog 03:51:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:51:03 INFO - Running setup.py install for moznetwork 03:51:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:51:04 INFO - Running setup.py install for mozprocess 03:51:04 INFO - Running setup.py install for mozprofile 03:51:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:51:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:51:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:51:04 INFO - Running setup.py install for mozrunner 03:51:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:51:04 INFO - Running setup.py install for mozscreenshot 03:51:04 INFO - Running setup.py install for moztest 03:51:04 INFO - Running setup.py install for mozversion 03:51:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:51:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:51:04 INFO - Cleaning up... 03:51:04 INFO - Return code: 0 03:51:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:04 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')]} 03:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:04 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')]} 03:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:04 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 0x157d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7d60>, '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 0x18e8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e8ef0>, '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': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', '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 03:51:04 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 03:51:04 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 03:51:04 INFO - Using env: {'DISPLAY': ':0', 03:51:04 INFO - 'HOME': '/home/cltbld', 03:51:04 INFO - 'LANG': 'en_US.UTF-8', 03:51:04 INFO - 'LANGUAGE': 'en_US:en', 03:51:04 INFO - 'LOGNAME': 'cltbld', 03:51:04 INFO - 'MAIL': '/var/mail/cltbld', 03:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:04 INFO - 'MOZ_NO_REMOTE': '1', 03:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:04 INFO - 'NO_EM_RESTART': '1', 03:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:04 INFO - 'PWD': '/builds/slave/test', 03:51:04 INFO - 'SHELL': '/bin/bash', 03:51:04 INFO - 'SHLVL': '1', 03:51:04 INFO - 'TERM': 'linux', 03:51:04 INFO - 'TMOUT': '86400', 03:51:04 INFO - 'USER': 'cltbld', 03:51:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', 03:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:04 INFO - '_': '/tools/buildbot/bin/python'} 03:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:51:04 INFO - Running setup.py (path:/tmp/pip-rBcnvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:51:04 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)) 03:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:51:04 INFO - Running setup.py (path:/tmp/pip-yOUmkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:51:05 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)) 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:51:05 INFO - Running setup.py (path:/tmp/pip-j7L36L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:51:05 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)) 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:51:05 INFO - Running setup.py (path:/tmp/pip-GBXBD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:51:05 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)) 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:51:05 INFO - Running setup.py (path:/tmp/pip-VuqkdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:51:05 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)) 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:51:05 INFO - Running setup.py (path:/tmp/pip-j6ZcFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:51:05 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)) 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:51:05 INFO - Running setup.py (path:/tmp/pip-tRmetz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:51:05 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)) 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:51:05 INFO - Running setup.py (path:/tmp/pip-lbarJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:51:05 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)) 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:51:05 INFO - Running setup.py (path:/tmp/pip-xpEN7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:51:05 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)) 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:51:05 INFO - Running setup.py (path:/tmp/pip-siCpzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:51:05 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)) 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:51:05 INFO - Running setup.py (path:/tmp/pip-_wZ5EZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:51:05 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)) 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:51:05 INFO - Running setup.py (path:/tmp/pip-oxD0qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:51:05 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)) 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:51:05 INFO - Running setup.py (path:/tmp/pip-PXRuY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:51:05 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)) 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:51:05 INFO - Running setup.py (path:/tmp/pip-57bQW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:51:05 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)) 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:05 INFO - Running setup.py (path:/tmp/pip-DkTZQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:51:05 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)) 03:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:51:05 INFO - Running setup.py (path:/tmp/pip-ZJdmZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:51:06 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)) 03:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:51:06 INFO - Running setup.py (path:/tmp/pip-udyx7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:51:06 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)) 03:51:06 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)) 03:51:06 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)) 03:51:06 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)) 03:51:06 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)) 03:51:06 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)) 03:51:06 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)) 03:51:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:51:06 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 03:51:06 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 03:51:06 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 03:51:06 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 03:51:07 INFO - Downloading blessings-1.6.tar.gz 03:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:51:07 INFO - Installing collected packages: blessings 03:51:07 INFO - Running setup.py install for blessings 03:51:07 INFO - Successfully installed blessings 03:51:07 INFO - Cleaning up... 03:51:07 INFO - Return code: 0 03:51:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:51:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:07 INFO - Reading from file tmpfile_stdout 03:51:07 INFO - Current package versions: 03:51:07 INFO - argparse == 1.2.1 03:51:07 INFO - blessings == 1.6 03:51:07 INFO - blobuploader == 1.2.4 03:51:07 INFO - docopt == 0.6.1 03:51:07 INFO - functools32 == 3.2.3-2 03:51:07 INFO - jsonschema == 2.5.1 03:51:07 INFO - manifestparser == 1.1 03:51:07 INFO - mozInstall == 1.13 03:51:07 INFO - mozcrash == 1.0 03:51:07 INFO - mozdebug == 0.1 03:51:07 INFO - mozdevice == 0.51 03:51:07 INFO - mozfile == 1.2 03:51:07 INFO - mozhttpd == 0.7 03:51:07 INFO - mozinfo == 0.10 03:51:07 INFO - mozleak == 0.1 03:51:07 INFO - mozlog == 3.5 03:51:07 INFO - moznetwork == 0.27 03:51:07 INFO - mozprocess == 0.25 03:51:07 INFO - mozprofile == 0.28 03:51:07 INFO - mozrunner == 6.13 03:51:07 INFO - mozscreenshot == 0.1 03:51:07 INFO - mozsystemmonitor == 0.3 03:51:07 INFO - moztest == 0.8 03:51:07 INFO - mozversion == 1.4 03:51:07 INFO - psutil == 3.1.1 03:51:07 INFO - requests == 1.2.3 03:51:07 INFO - wsgiref == 0.1.2 03:51:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:51:07 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')]} 03:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:07 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')]} 03:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:07 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 0x157d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7d60>, '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 0x18e8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e8ef0>, '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': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', '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 03:51:07 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 03:51:07 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 03:51:07 INFO - Using env: {'DISPLAY': ':0', 03:51:07 INFO - 'HOME': '/home/cltbld', 03:51:07 INFO - 'LANG': 'en_US.UTF-8', 03:51:07 INFO - 'LANGUAGE': 'en_US:en', 03:51:07 INFO - 'LOGNAME': 'cltbld', 03:51:07 INFO - 'MAIL': '/var/mail/cltbld', 03:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:07 INFO - 'MOZ_NO_REMOTE': '1', 03:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:07 INFO - 'NO_EM_RESTART': '1', 03:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:07 INFO - 'PWD': '/builds/slave/test', 03:51:07 INFO - 'SHELL': '/bin/bash', 03:51:07 INFO - 'SHLVL': '1', 03:51:07 INFO - 'TERM': 'linux', 03:51:07 INFO - 'TMOUT': '86400', 03:51:07 INFO - 'USER': 'cltbld', 03:51:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', 03:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:07 INFO - '_': '/tools/buildbot/bin/python'} 03:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:07 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)) 03:51:07 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)) 03:51:07 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)) 03:51:07 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)) 03:51:07 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)) 03:51:07 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)) 03:51:07 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)) 03:51:07 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)) 03:51:07 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)) 03:51:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:51:07 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 03:51:07 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 03:51:07 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 03:51:07 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 03:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:51:09 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)) 03:51:09 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)) 03:51:09 INFO - Installing collected packages: simplejson 03:51:09 INFO - Running setup.py install for simplejson 03:51:09 INFO - building 'simplejson._speedups' extension 03:51:09 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 03:51:10 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 03:51:10 INFO - Successfully installed simplejson 03:51:10 INFO - Cleaning up... 03:51:10 INFO - Return code: 0 03:51:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:51:10 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')]} 03:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:10 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')]} 03:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:10 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 0x157d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7d60>, '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 0x18e8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e8ef0>, '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': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', '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 03:51:10 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 03:51:10 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 03:51:10 INFO - Using env: {'DISPLAY': ':0', 03:51:10 INFO - 'HOME': '/home/cltbld', 03:51:10 INFO - 'LANG': 'en_US.UTF-8', 03:51:10 INFO - 'LANGUAGE': 'en_US:en', 03:51:10 INFO - 'LOGNAME': 'cltbld', 03:51:10 INFO - 'MAIL': '/var/mail/cltbld', 03:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:10 INFO - 'MOZ_NO_REMOTE': '1', 03:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:10 INFO - 'NO_EM_RESTART': '1', 03:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:10 INFO - 'PWD': '/builds/slave/test', 03:51:10 INFO - 'SHELL': '/bin/bash', 03:51:10 INFO - 'SHLVL': '1', 03:51:10 INFO - 'TERM': 'linux', 03:51:10 INFO - 'TMOUT': '86400', 03:51:10 INFO - 'USER': 'cltbld', 03:51:10 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', 03:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:10 INFO - '_': '/tools/buildbot/bin/python'} 03:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:51:10 INFO - Cleaning up... 03:51:10 INFO - Return code: 0 03:51:10 INFO - Running post-action listener: _resource_record_post_action 03:51:10 INFO - Running post-action listener: _start_resource_monitoring 03:51:10 INFO - Starting resource monitoring. 03:51:10 INFO - [mozharness: 2017-09-25 10:51:10.386241Z] Finished create-virtualenv step (success) 03:51:10 INFO - [mozharness: 2017-09-25 10:51:10.386756Z] Running install step. 03:51:10 INFO - Running pre-action listener: _resource_record_pre_action 03:51:10 INFO - Running main action method: install 03:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:10 INFO - Reading from file tmpfile_stdout 03:51:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:51:10 INFO - Reading from file tmpfile_stdout 03:51:10 INFO - Output received: 03:51:10 INFO - Usage: mozinstall [options] installer 03:51:10 INFO - Options: 03:51:10 INFO - -h, --help show this help message and exit 03:51:10 INFO - -d DEST, --destination=DEST 03:51:10 INFO - Directory to install application into. [default: 03:51:10 INFO - "/builds/slave/test"] 03:51:10 INFO - --app=APP Application being installed. [default: firefox] 03:51:10 INFO - mkdir: /builds/slave/test/build/application 03:51:10 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'] 03:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:51:28 INFO - Reading from file tmpfile_stdout 03:51:28 INFO - Output received: 03:51:28 INFO - /builds/slave/test/build/application/firefox/firefox 03:51:28 INFO - Running post-action listener: _resource_record_post_action 03:51:28 INFO - [mozharness: 2017-09-25 10:51:28.638982Z] Finished install step (success) 03:51:28 INFO - [mozharness: 2017-09-25 10:51:28.639131Z] Running setup-mitmproxy step. 03:51:28 INFO - Running pre-action listener: _resource_record_pre_action 03:51:28 INFO - Running main action method: setup_mitmproxy 03:51:28 INFO - Skipping: mitmproxy is not required 03:51:28 INFO - Running post-action listener: _resource_record_post_action 03:51:28 INFO - [mozharness: 2017-09-25 10:51:28.639661Z] Finished setup-mitmproxy step (success) 03:51:28 INFO - [mozharness: 2017-09-25 10:51:28.639765Z] Running run-tests step. 03:51:28 INFO - Running pre-action listener: _resource_record_pre_action 03:51:28 INFO - Running pre-action listener: _set_gcov_prefix 03:51:28 INFO - Running main action method: run_tests 03:51:28 WARNING - Try message not found. 03:51:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:51:28 INFO - Python 2.7.3 03:51:28 INFO - Return code: 0 03:51:28 INFO - grabbing minidump binary from tooltool 03:51: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')]} 03:51:28 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 0x18e7d60>, '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 0x18e8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e8ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:51:28 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 03:51:28 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 03:51:28 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 03:51:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:51:28 INFO - Return code: 0 03:51:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:51:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:51:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:51:28 INFO - ENV: RUST_BACKTRACE is now full 03:51:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:51:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:51:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:51:28 INFO - Using env: {'DISPLAY': ':0', 03:51:28 INFO - 'HOME': '/home/cltbld', 03:51:28 INFO - 'LANG': 'en_US.UTF-8', 03:51:28 INFO - 'LANGUAGE': 'en_US:en', 03:51:28 INFO - 'LOGNAME': 'cltbld', 03:51:28 INFO - 'MAIL': '/var/mail/cltbld', 03:51:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:51:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:28 INFO - 'MOZ_NO_REMOTE': '1', 03:51:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:28 INFO - 'NO_EM_RESTART': '1', 03:51:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:28 INFO - 'PWD': '/builds/slave/test', 03:51:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:51:28 INFO - 'RUST_BACKTRACE': 'full', 03:51:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:51:28 INFO - 'SHELL': '/bin/bash', 03:51:28 INFO - 'SHLVL': '1', 03:51:28 INFO - 'TERM': 'linux', 03:51:28 INFO - 'TMOUT': '86400', 03:51:28 INFO - 'USER': 'cltbld', 03:51:28 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', 03:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:28 INFO - '_': '/tools/buildbot/bin/python'} 03:51:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:51:29 INFO - mozversion application_buildid: 20170925095628 03:51:29 INFO - mozversion application_changeset: 13ce77b78e364cc952d51b959f22202502be2941 03:51:29 INFO - mozversion application_display_name: Nightly 03:51:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:51:29 INFO - mozversion application_name: Firefox 03:51:29 INFO - mozversion application_remotingname: firefox 03:51:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:51:29 INFO - mozversion application_vendor: Mozilla 03:51:29 INFO - mozversion application_version: 58.0a1 03:51:29 INFO - mozversion platform_buildid: 20170925095628 03:51:29 INFO - mozversion platform_changeset: 13ce77b78e364cc952d51b959f22202502be2941 03:51:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:51:29 INFO - mozversion platform_version: 58.0a1 03:51:29 INFO - using testdate: 1506336688 03:51:29 INFO - actual date: 1506336688 03:51:29 INFO - starting webserver on 'localhost:52822' 03:51:29 INFO - SUITE-START | Running 2 tests 03:51:29 INFO - TEST-START | dromaeo_css 03:51:29 INFO - Initialising browser for dromaeo_css test... 03:51:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52822/getInfo.html -profile /tmp/tmp407Hhy/profile 03:51:29 INFO - TEST-INFO | started process 10782 (/builds/slave/test/build/application/firefox/firefox http://localhost:52822/getInfo.html) 03:51:34 INFO - TEST-INFO | 10782: exit 0 03:51:35 INFO - Browser initialized. 03:51:35 INFO - Running cycle 1/1 for dromaeo_css test... 03:51:35 INFO - Using env: {'DISPLAY': ':0', 03:51:35 INFO - 'HOME': '/home/cltbld', 03:51:35 INFO - 'JSGC_DISABLE_POISONING': '1', 03:51:35 INFO - 'LANG': 'en_US.UTF-8', 03:51:35 INFO - 'LANGUAGE': 'en_US:en', 03:51:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:51:35 INFO - 'LOGNAME': 'cltbld', 03:51:35 INFO - 'MAIL': '/var/mail/cltbld', 03:51:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:51:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:51:35 INFO - 'MOZ_CRASHREPORTER': '1', 03:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:51:35 INFO - 'MOZ_NO_REMOTE': '1', 03:51:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:35 INFO - 'NO_EM_RESTART': '1', 03:51:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:35 INFO - 'PWD': '/builds/slave/test', 03:51:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:51:35 INFO - 'RUST_BACKTRACE': 'full', 03:51:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:51:35 INFO - 'SHELL': '/bin/bash', 03:51:35 INFO - 'SHLVL': '1', 03:51:35 INFO - 'TERM': 'linux', 03:51:35 INFO - 'TMOUT': '86400', 03:51:35 INFO - 'USER': 'cltbld', 03:51:35 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', 03:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:35 INFO - '_': '/tools/buildbot/bin/python'} 03:51:35 INFO - TEST-INFO | started process 11018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp407Hhy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:35 INFO - PID 11018 | 03:51:35 INFO - PID 11018 | (/builds/slave/test/build/application/firefox/firefox:11067): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:51:35 INFO - PID 11018 | 03:51:46 INFO - PID 11018 | RSS: Main: 152076288 03:51:46 INFO - PID 11018 | 03:54:43 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:52822/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52822/tests/dromaeo/cssquery-ext.html) 03:54:44 INFO - PID 11018 | RSS: Main: 153427968 03:54:44 INFO - PID 11018 | 03:57:46 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:52822/tests/dromaeo/cssquery-ext.html (next: http://localhost:52822/tests/dromaeo/cssquery-jquery.html) 03:57:47 INFO - PID 11018 | RSS: Main: 152940544 03:57:47 INFO - PID 11018 | 04:00:48 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:52822/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52822/tests/dromaeo/cssquery-mootools.html) 04:00:49 INFO - PID 11018 | RSS: Main: 155410432 04:00:49 INFO - PID 11018 | 04:03:51 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:52822/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52822/tests/dromaeo/cssquery-prototype.html) 04:03:51 INFO - PID 11018 | RSS: Main: 154316800 04:03:51 INFO - PID 11018 | 04:06:55 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:52822/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52822/tests/dromaeo/cssquery-yui.html) 04:06:55 INFO - PID 11018 | RSS: Main: 154521600 04:06:55 INFO - PID 11018 | 04:09:57 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:52822/tests/dromaeo/cssquery-yui.html (next: http://localhost:52822/tests/dromaeo/cssquery-dojo.html) 04:09:57 INFO - PID 11018 | RSS: Main: 157290496 04:09:57 INFO - PID 11018 | 04:09:57 INFO - PID 11018 | __start_tp_report 04:09:57 INFO - PID 11018 | _x_x_mozilla_page_load 04:09:57 INFO - PID 11018 | _x_x_mozilla_page_load_details 04:09:57 INFO - PID 11018 | |i|pagename|runs| 04:09:57 INFO - PID 11018 | |0;dojo.html;3112.330848867493;3134.5454909038176;3167.8891238806646;3179.8092114473125;3192.3455691583226;6107.3587273336325;6198.78304259351;6225.533085018625;6261.217347831521;6326.810195694131;6197.349278325779;6235.469985051276;6261.780837670683;6357.268914074883;6379.202599675041;5687.488126068653;5700.600957932947;5768.798092066779;5782.9421705782825;5840.474357307841;5546.223528705985;5680.488756011958;5783.9710801445935;5813.9418605814035;5833.3874943130995;5726.255586773693;5745.368009518949;5792.247007888968;5796.188533605298;5811.593188476787;5735.168400581934;5777.422257774231;5826.417358264182;5836.88326233473;5856.0630299151935;5610.579206559524;5668.404817494186;5721.799737009184;5788.305403351583;5809.970950145223;6225.937740622581;6242.375762423767;6294.653794041325;6303.747850085991;6358.618482891041;6610.173728283965;6623.437007854338;6668.533202675766;6708.664566771642;6738.696758645872;6515.315891831337;6601.570897891622;6632.336766323378;6644.302348253412;6762.695678694421;6174.043023331391;6175.7529698811995;6177.876442471125;6183.876322473526;6202.317745048041;6802.591844489347;6815.2843951385385;6816.386525212754;6821.2155602106395;6963.572467644222;6587.670616469158;6595.505337099737;6675.9332406676285;6681.699323530453;6684.665766711645;6724.193096828412;6740.528163028639;6795.946628272625;6817.181938167451;6825.5222134451105;6484.773032943825;6603.075569420285;6613.107230523818;6622.834429139214;6667.266600673922;6607.900881486781;6618.371254730793;6645.634490103091;6649.667516624149;6764.458843292525;5278.551323137576;5310.389305229948;5313.282706834528;5329.227262046981;5333.253344531769;4567.657425693086;4618;4643.955110100201;4673.018666080094;4686.250199968057;5650.74571644277;5759.798407055733;5824.796132135355;5825.912611310834;5857.736401861926;6667.133272674619;6667.933320666828;6679.198496180489;6684.532082754161;6695.564788288746;5759.798407055817;5762.538996880324;5834.620749651259;5835.2414186156375;5857.941420585825;5773.422657734193;5815.214945982323;5837.503812175928;5847.181394604759;5849.444302791228;6485.67571621417;6505.284418713938;6580.80257592273;6581.934180658132;6621.933780662228;6453.838654033687;6564.868702626016;6699.129113215446;6775.762848300285;6784.76253331131;6418.326075762165;6486.837829054311;6543.149390579194;6561.639109849004;6566.409023187936;6614.173228346457;6620.768273110418;6684.131062961784;6690.899636505554;6714;6729;6754.615303862598;6755;6810.5913645181445;6848.554843935129;6378;6449.806505804833;6470.158879345843;6472.964325707864;6475.7733479328;6456.386643268882;6459.418652321314;6464.709088090953;6478.708458119301;6481.708323125565;6440.8389790255615;6449.96775016122;6452.096706461193;6471.838204044937;6475.384838440341;6466.0947467355545;6541.803745887631;6592.208934927839;6611.07444957716;6643.1031810704935;6202.627842329474;6327.810165695037;6329.746810127727;6419.35806419373;6422.678866056585 04:09:57 INFO - PID 11018 | |1;ext.html;860.8923884514436;862.168007872403;870.1559487297327;879.7536689726875;894.2890402130306;39666;40815.387769183486;40834.795826020905;40838.795806020964;40904.18191636165;37442;37747;37851.432228516525;37864;37960.62039379605;7132.643367831613;7163.749268775594;7192.820179495502;7252.601106939116;7276.417886569062;7146.071010768619;7244.746433874815;7244.746433874815;7254.673539690727;7267.418606511493;7729.149793522708;7903.881441778349;7903.920960790405;7912.604369781517;7920.247576480254;7818;7829.804254893673;7837.098733645618;7862.764117076496;7867.999999999972;7680.078390593108;7758.340541054017;7872.5670088145125;7874.330681892046;7880.0937892142565;37404;37733.245335093416;38020;38076.04809879775;38099.80950095259;3504.8422820972864;3506.7720598161036;3534.7172226222096;3548;3557.3774589446743;30925.22686932822;31030.37939241225;31231.84384078088;31234.219144521343;31275;5142.922856157161;5166.9224961625605;5184.818531351422;5199.298094757197;5215.869603259949;186960;188165;188446;188865;189077;47065.76467117711;47115.76442117767;47430.76284618555;47485;47571;47518.76240618775;47815.282770758466;47997.280040798716;48030.75984620055;48066;15360.462383816737;15686.05883646962;15721;15743.842561574238;15746.527604171893;12551.058670599741;12610.747785044248;12614.621561352991;12648.494060237672;12658.367081645882;13721.656958575915;13855.96080293982;13947.86052139486;14047.438102475991;14281.357338919774;5652.2652055233375;5723.942760572424;5788.942110578841;5794.797182098607;5831.79588714393;985.6747273399761;1000.9299349045497;1003.1874181912674;1004.2468148888333;1031.5358088859894;21855.672164917538;22040.44898877541;22297;22306.888465557568;22692.65961010586;1112.8759952448086;1116.9609063682894;1120.4845770945456;1121.5401685309148;1128.0468004536153;11816.231944923553;11845.644630661094;11854.466549005316;11924.224925379822;12016.218945768496;212675;214490;214501;215054;215482;52215.73892130515;52307;55161.448385516436;55182;55513;1391.1583491987403;1439.2875526614393;1442.834074081473;1445.4940770730161;1446.7540518111946;26183;26186.476270474865;26239;26357.604635930093;26411.73588264093;36004.819975899954;36162.09594760152;36239;36254;36263;182937;183759;184214;184989;185225;32155.196120097185;32259.516107258878;32282.83858580786;32442;32511.18722031968;38936.80531597324;40253.1949361017;40706.185876281714;40955.18089638131;41002.1799564013;30532.694673052985;31113.688863111078;31185;31231.531527027568;31246;30710;30891.382172356876;30891.69108308888;31063.0681079568;31574.210644734067;34267;34747.82626086853;34751.826240868635;34810.65189348074;34819.12952176115;30651.54022689706;30936.69063309338;31070.689293107684;31107.37785244328;31256.843715781277;22478.662820058038;22643.886780566652;22850.885745571166;22883.427914302276;23234.767652323262 04:09:57 INFO - PID 11018 | |2;jquery.html;575.2866445607448;581.7091454272863;587.7355190164425;594.2571785268415;610.5024405109835;22124.55750884981;22956.08175672971;22985.310440686786;23117.422064448398;23234.535309293806;23381.532369352604;24448.388790280253;24740.25779226626;25065.373365665866;25104.12135575255;6446.419822215999;6629.502787290949;6630.502712296573;6634.170728658918;6640.037194606779;6311.053341998691;6363.4272915437605;6475.190601174853;6556.27880933097;6576.342365763409;6536.934630653704;6542.1495205623205;6542.214934207902;6549.508786840982;6552.7378904843745;6123.295820980599;6490.286068532458;6492.480601551864;6521.119648847416;6525.804225873231;5893.469587737124;5927.614705044159;5932.0508718604815;5932.614380065282;5934.228550288478;27592;28091.719082809115;28103.156905292875;28114.578281325797;28239.15282541527;2036.1244664794133;2047.4164863013968;2052.958940821175;2063.8555301128927;2070.3064473401278;18625.81374186268;19329.613407731766;19546.51133721668;19649.607007859762;19761.703574446394;2423.212455951823;2451.7670821272127;2472.344828620417;2491.501699660057;2497.2383423055962;123677;129415;132324.3383783075;134707;137434.999999999;14731.04248223862;14803.555893323217;14818.703625927421;15097.24513774307;15124.621884452758;23726.881365593406;23890.283291501284;23901.326907116334;23960;23982.28053158408;10292.125169360688;10343.534540945675;10388.532516036645;10476.947615261875;10566.418846963337;9429.104235097655;9547.188488978514;9586.089321514444;9658.130768230892;9777.804443911082;9037.683681071263;9106.772330691652;9296.209822165056;9343.813123737487;9355.251579873593;2831.3487897783625;2867.1541895140986;2868.469333173328;2879.6832348441653;2961.748251398655;913.830941275866;944.414463032924;944.8063147054837;947.209080417845;956.2159029595665;18631.44105676832;18785;18865.24539018424;19256.807431925783;19302.13140408657;1021.8569400283966;1021.9882316506754;1024.4877561219391;1025.4565080507343;1032.5250384822916;10504.369737815756;10612.840807387895;10612.840807387895;10697.625583104555;10720.303180293256;435698;442839;445677;445682;448625;107992;108662;112224;113199;114384;1127.8590176227972;1130.2370899642708;1143.382573410349;1165.0854079547514;1166.8949794518364;16692.749608756123;16711.247993840065;16918.492445226664;16978.06620635877;17011.65976680484;53430.4656953441;53472.73263633657;54020;54322;56325;69803;70224;70629.29370706227;70915;71252.28747712664;14140.363683634467;14338.283085845458;14396.064255823338;14542.127472351693;14583.927080364954;22166;22207;22353.217637382615;22441.663375049713;22500.549989000454;17391.130443477523;17613.559661008578;17626.647467050843;17750.20124094393;17768.55578610545;15786.92106539506;15998.760018599498;16608.916955415145;16671.749923751395;16695.66608667844;18270.086495674896;18288.542786430447;18293.17680704345;18365.081745912918;18463.630727385647;14087.084339517898;14127.704622513664;14192.077514961495;14201.573952781433;14288.142711437347;17178.141092945054;17324.826751732322;17370.652586948443;17662.293508259525;17861.73207401864 04:09:57 INFO - PID 11018 | |3;mootools.html;1337.5184933423968;1434.0606902478874;1442.9494967676133;1443.155753883978;1443.3216388297496;16161.75757363639;16801;16848.073355965418;16865.325386984536;16934.83065169348;16325.83674163258;16396.426125085625;16439.58901027475;16443.753343699853;16448.177591120428;2575.497777933299;2581.7805486533666;2624.475104979012;2632.8420294782372;2638.14260365382;2861.1130549529607;2863.742263196312;2866.641669791276;2867.5985362049328;2868.641419822522;2766.61267422561;2807.087696498636;2876.3240638449947;2890.5519644455144;2890.5519644455144;2820.576913462997;2846.117703511918;2877.8704958276926;2887.7978541502207;2888.6822449530537;2475.5667758142254;2689.7041325454184;2722.4555088982083;2722.754952054325;2724.141895302993;15642.217889105614;15759.97560158586;15781.28984195714;15791.92104039484;15798.368065277375;8353.916460835375;8641.179087986631;8650.697225597138;8655.740327790176;8660.740177794676;5362.8123015694655;5450.100733378988;5519.641223320471;5586.385497595261;5603.943960560424;1912.1586501939103;1915.205189846212;1948.795376485477;1960.6078784243066;1967.5376286572643;27217.591736123974;27386.589201161998;27424.862875685692;27460.45079098427;27564.586531202047;7210.783676489714;7286.854262914818;7351.448641351813;7437.181909989897;7494.5128566643;17724.113794310233;17725.202365893565;17730;17767;17787.46637600874;7992.760217193493;8125.228103330174;8130.715424960098;8132.5933703314595;8138.633761480747;7482.513636613603;7483.8877416838795;7607.885881711779;7779.649915753805;7782;5369.624126311199;5522;5542.584306176972;5570.442955704397;5583.855115124587;1554.2228885557222;1579.1314776872673;1601.0873801932787;1603.711331960235;1609.235613083776;915.6108653822099;923.0769230769231;936.1200471556715;936.1901954809177;943.6602822983721;7828.882566761503;7868.331191848642;7886.487378320391;7889.132195458495;7904.288614024766;714.5962531169872;729.6935287179398;742.3281929853491;755.6750597243238;761.455559275121;5358.544523715528;5495.670259784426;5501.862453438696;5524;5566.165075238747;22191.11235550592;22888.65667014996;23057.42356441069;23112.306630801104;23322.883385582965;22170.778292217194;22685.092596296294;22879.313620591078;23082;23133.306000819666;11638.592649257236;11689.707757305965;11716.472758725879;11737.413129343498;11816.231944923553;8385.622646981023;8640;8650.480971141751;8671.176238257356;8774.692885748967;18364.81635183631;19070.618587628447;19278.614427711087;19474.221031158595;19559;18829.623407532046;19638.803611963696;19757.308494202633;19961.401157965283;20170.89914550418;11471.254368466023;11541.942290288494;11582.42087895585;11672.241304315192;11675.474603643026;14306.356213970605;14493.420263189355;14497.420103196177;14519.201443920685;14557.85442145565;11208.495617697386;11474.368909710047;11499.310041397543;11574.652760416864;11808.468618911998;11562.364069976233;11658.242214256046;11686.415679216176;11771.587994420153;11922.284662919905;10234;10364.170866330825;10459.372437653765;10488.160947124365;10501.422421766876;7527.284907933957;7567.9243207567215;7585.179556906413;7679.654415551202;7743.341815945482;7607.923920760722;7658.463907526642;7739.3034626883855;7743.612819359122;7757.72847950319 04:09:57 INFO - PID 11018 | |4;prototype.html;511.91809310510325;513.6430181024188;538.8087229033694;542.0487045235611;549.5548605629441;6320.399562041604;6321.6207027578375;6346.2067241594805;6398.904016439751;6418.165638466993;6043.758249670019;6194.163787888634;6245.219347581552;6283.465905398035;6295;5002.899942001158;5027.371578552672;5058.2159765236265;5066.620003499752;5080.263361812535;4807.1587472192405;4997.575206107485;5032.144535428967;5063.74681265937;5064.620153488503;4971.726555039471;4974.651774375795;4998.350544320384;5016.172331565287;5018.498150184971;4970.950290497085;4974.179260422026;4977.228529577885;5039.31969184161;5043.924341134886;4457.420535330419;4502.369668246448;4527.4114365132655;4533.161365147458;4535.251683472223;6026.578139530235;6072.089186621998;6125.326214116443;6163.630182189083;6168.0439531872635;5778.8266352009505;5803.129530570406;5809.622374545641;5815.882023819012;5838.678872662002;6461.418472337512;6475.158229430191;6485.546011779177;6528.477721782246;6554.442872355856;4876.171050921352;4893.4617192108835;4923.507649235084;4949.851504454872;4953.628477864175;6789.830254243634;6827.146606674166;6857.314268573153;6905.654717264167;6927.549709268932;4971.850844474671;5068.6451948363265;5069.188929771219;5081.74591270435;5101.0818052750865;5047.662369472093;5050.696958182521;5065.696058236517;5082.847514574569;5144.459831717691;5698.515626171739;5723.284589426322;5761.423857614205;5814.796482123105;5821.825345239649;6630.6353150576215;6635.966820165965;6660.666966651648;6714.194296684429;6745.898811517831;1636.4681478519528;1707.1805533344063;1727.8941477454189;1745.5636090977255;1760.243095468935;1139.3221033485063;1227.245244174826;1233.6237447578574;1234.703671118943;1243.2851110611255;5634.408387119375;5657.462541058593;5660.490555849993;5690.743916523684;5728.713564321767;6430.7106180222;6505.837354066186;6588.571742836701;6617.338266173344;6617.371349721769;5615.943840561624;5769.9711501442225;5793.420657934257;5800.274965629296;5833.970830145822;3521.5245941798044;3546.964530354715;3550.520679708258;3552.2717842842158;3556.448750443685;6503.349665033554;6510.381513756186;6536.8365790855605;6576.736930522726;6632.303608121078;6857.177138743283;6951.16586009682;6968.163820341591;6998.935314082256;7022.92977070233;6474.77338293148;6481.222253329536;6577.14497115372;6578.440832529289;6588.8023359299295;6787.185537735503;6802.319768023158;6818.386345228953;6834.1457317835275;6863.450923925974;6680.432163265982;6697.330266973264;6733.192016957996;6734.494912881455;6761.628110453776;6454.867875518183;6480.125183100221;6516.837079073061;6563;6614.206295244601;5022.146235140108;5027.522385373383;5046.697198168122;5051.797928082982;5087.211482220262;6718.630475323904;6765.733479284495;6794.728210871707;6803.387695107464;6819.965900170468;6479.4816414685765;6481.546291759531;6494.285628580947;6603;6644.634545100066;6477.275566549159;6586.9460886259885;6602.306757790363;6610.305917878553;6632.721894378003;6161.476274516716;6229.96885015572;6375.968120159369;6403.8719225614295;6424.804219274442;6486.5729539501235;6533.18335208099;6588.637624930483;6606.372394622503;6610.933890661032;6272.529560282906;6326.588771729823;6351.666150108529;6356.078368636614;6362.681865906594 04:09:57 INFO - PID 11018 | |5;yui.html;903.6566104880145;913;914.7575892388514;926.3793258516793;938.5635679409075;18933.715994260096;19047.2381104756;19171.13729882155;19450.221991120357;19590.706139407885;18989.810101898976;18993.52516187096;19196.520086997833;19206.711899321523;19214.135363908623;957.6839642917838;983.3853841349156;986.3342243985317;986.5412583148834;987.8715766950287;949.1125797379437;985.5762022330395;990.8067926754286;992.0625009366152;992.4591097851652;1041.3543602966172;1045.5974449836829;1054.1882750282277;1055.5777688924454;1056.3081181825917;985.2905907746411;1027.6557353286657;1038.428864124736;1041.1150522056266;1043.9634612788516;734.6143274780783;747.4692967992731;748.3265061444689;753.7927070055724;754.1817128415676;19919.90040049805;20029.09869055896;20134.093965771575;20153.899230503754;20169.697454538193;18896.811031889643;18901.243950241973;19558.51103722404;19578.412647620593;19684;17530;17543.385981490588;17624.91187544054;17775.111244437856;17897.105144742713;3713.9628603713886;3769.754965927206;3772.0569857535615;3773.3585290500682;3780.3762379207396;140736.29631851777;141687;141842;142757.28621356827;144613.2769336157;16679.249433775265;16718.99686018843;17071.146442677815;17154.828451715322;17155.313787448613;30435.847820760755;31357.686423135932;31590.684093158776;31829.52255716166;31857.362852742815;8814.382993190544;8835.469871807712;8922.152395522415;8923.196912277926;8930.776730581787;4367.388565600819;4404.0971600822395;4435.733855968652;4468.061707041493;4468.798904049326;5569.637973531708;5609.691466969356;5626.127950167731;5635;5647.604667673223;984.6849008317413;1002.5037606384886;1018.8930162332997;1020.505055048301;1030.0677886512717;705.6542294275768;719.8884172953201;721.5526373648372;736.0872518077546;737.3363972424861;11162.386068766296;12358.814617780741;12665.936670316589;12929.806052909214;13029.348532573333;681.8363592737807;683.2006552333781;687.4775170870174;697.6407150317591;701.2531653788699;5629.493345598916;5671.319441666944;5700.4299570043495;5715.514181294553;5762.798302059407;116735;116759;117503.41248293874;118343;120747;100273.49863250637;101262;101406.4929675347;102257;103017.48491257646;86206.56896715476;88639.55680221686;89201;90062.54968725245;90366.54816725875;10533.736656583647;10538.262321637412;10651.254412191072;10657.20070994663;10876.18428617841;42762;43860.561394386925;44639.77680111579;44844.32733509065;46324;53727.46272537224;56065.43934560602;56539.43460565342;56980;57080.714596426755;14112;14327.28363581796;14349.282535873373;14422.278886055445;14537.273136343352;16621.916890415472;16640.916795415946;16665.416710415077;16677;16875.156242187597;14908.956373053783;14944.103353798806;15163;15225.847741522886;15404.537863864101;14483.348249329016;14519.709605808035;14531;14621.488247911271;14623.561293161221;13893.652658683613;14025.649358766112;14227;14243.786343205067;14298.57104286873;11479.483423246142;11640.883591164318;11687.415629218674;11921.940390297994;11939.403029848647;12477.438515267017;12722.61832145037;12726.68183295425;12802.850829169298;12841.550545730855 04:09:57 INFO - PID 11018 | __end_tp_report 04:09:57 INFO - PID 11018 | __start_cc_report 04:09:57 INFO - PID 11018 | _x_x_mozilla_cycle_collect,289 04:09:57 INFO - PID 11018 | __end_cc_report 04:09:57 INFO - PID 11018 | __startTimestamp1506337797746__endTimestamp 04:09:57 INFO - PID 11018 | 04:09:57 INFO - PID 11018 | ------- Summary: start ------- 04:09:57 INFO - PID 11018 | Number of tests: 6 04:09:57 INFO - PID 11018 | 04:09:57 INFO - PID 11018 | [#0] dojo.html Cycles:165 Average:6159.24 Median:6440.84 stddev:726.22 (11.3%) stddev-sans-first:687.99 04:09:57 INFO - PID 11018 | Values: 3112.3 3134.5 3167.9 3179.8 3192.3 6107.4 6198.8 6225.5 6261.2 6326.8 6197.3 6235.5 6261.8 6357.3 6379.2 5687.5 5700.6 5768.8 5782.9 5840.5 5546.2 5680.5 5784.0 5813.9 5833.4 5726.3 5745.4 5792.2 5796.2 5811.6 5735.2 5777.4 5826.4 5836.9 5856.1 5610.6 5668.4 5721.8 5788.3 5810.0 6225.9 6242.4 6294.7 6303.7 6358.6 6610.2 6623.4 6668.5 6708.7 6738.7 6515.3 6601.6 6632.3 6644.3 6762.7 6174.0 6175.8 6177.9 6183.9 6202.3 6802.6 6815.3 6816.4 6821.2 6963.6 6587.7 6595.5 6675.9 6681.7 6684.7 6724.2 6740.5 6795.9 6817.2 6825.5 6484.8 6603.1 6613.1 6622.8 6667.3 6607.9 6618.4 6645.6 6649.7 6764.5 5278.6 5310.4 5313.3 5329.2 5333.3 4567.7 4618.0 4644.0 4673.0 4686.3 5650.7 5759.8 5824.8 5825.9 5857.7 6667.1 6667.9 6679.2 6684.5 6695.6 5759.8 5762.5 5834.6 5835.2 5857.9 5773.4 5815.2 5837.5 5847.2 5849.4 6485.7 6505.3 6580.8 6581.9 6621.9 6453.8 6564.9 6699.1 6775.8 6784.8 6418.3 6486.8 6543.1 6561.6 6566.4 6614.2 6620.8 6684.1 6690.9 6714.0 6729.0 6754.6 6755.0 6810.6 6848.6 6378.0 6449.8 6470.2 6473.0 6475.8 6456.4 6459.4 6464.7 6478.7 6481.7 6440.8 6450.0 6452.1 6471.8 6475.4 6466.1 6541.8 6592.2 6611.1 6643.1 6202.6 6327.8 6329.7 6419.4 6422.7 04:09:57 INFO - PID 11018 | 04:09:57 INFO - PID 11018 | [#1] ext.html Cycles:180 Average:36184.48 Median:34749.83 stddev:50714.89 (145.9%) stddev-sans-first:50787.80 04:09:57 INFO - PID 11018 | Values: 860.9 862.2 870.2 879.8 894.3 39666.0 40815.4 40834.8 40838.8 40904.2 37442.0 37747.0 37851.4 37864.0 37960.6 7132.6 7163.7 7192.8 7252.6 7276.4 7146.1 7244.7 7244.7 7254.7 7267.4 7729.1 7903.9 7903.9 7912.6 7920.2 7818.0 7829.8 7837.1 7862.8 7868.0 7680.1 7758.3 7872.6 7874.3 7880.1 37404.0 37733.2 38020.0 38076.0 38099.8 3504.8 3506.8 3534.7 3548.0 3557.4 30925.2 31030.4 31231.8 31234.2 31275.0 5142.9 5166.9 5184.8 5199.3 5215.9 186960.0 188165.0 188446.0 188865.0 189077.0 47065.8 47115.8 47430.8 47485.0 47571.0 47518.8 47815.3 47997.3 48030.8 48066.0 15360.5 15686.1 15721.0 15743.8 15746.5 12551.1 12610.7 12614.6 12648.5 12658.4 13721.7 13856.0 13947.9 14047.4 14281.4 5652.3 5723.9 5788.9 5794.8 5831.8 985.7 1000.9 1003.2 1004.2 1031.5 21855.7 22040.4 22297.0 22306.9 22692.7 1112.9 1117.0 1120.5 1121.5 1128.0 11816.2 11845.6 11854.5 11924.2 12016.2 212675.0 214490.0 214501.0 215054.0 215482.0 52215.7 52307.0 55161.4 55182.0 55513.0 1391.2 1439.3 1442.8 1445.5 1446.8 26183.0 26186.5 26239.0 26357.6 26411.7 36004.8 36162.1 36239.0 36254.0 36263.0 182937.0 183759.0 184214.0 184989.0 185225.0 32155.2 32259.5 32282.8 32442.0 32511.2 38936.8 40253.2 40706.2 40955.2 41002.2 30532.7 31113.7 31185.0 31231.5 31246.0 30710.0 30891.4 30891.7 31063.1 31574.2 34267.0 34747.8 34751.8 34810.7 34819.1 30651.5 30936.7 31070.7 31107.4 31256.8 22478.7 22643.9 22850.9 22883.4 23234.8 04:09:57 INFO - PID 11018 | 04:09:57 INFO - PID 11018 | [#2] jquery.html Cycles:180 Average:32902.97 Median:22728.32 stddev:75123.47 (330.5%) stddev-sans-first:75295.00 04:09:57 INFO - PID 11018 | Values: 575.3 581.7 587.7 594.3 610.5 22124.6 22956.1 22985.3 23117.4 23234.5 23381.5 24448.4 24740.3 25065.4 25104.1 6446.4 6629.5 6630.5 6634.2 6640.0 6311.1 6363.4 6475.2 6556.3 6576.3 6536.9 6542.1 6542.2 6549.5 6552.7 6123.3 6490.3 6492.5 6521.1 6525.8 5893.5 5927.6 5932.1 5932.6 5934.2 27592.0 28091.7 28103.2 28114.6 28239.2 2036.1 2047.4 2053.0 2063.9 2070.3 18625.8 19329.6 19546.5 19649.6 19761.7 2423.2 2451.8 2472.3 2491.5 2497.2 123677.0 129415.0 132324.3 134707.0 137435.0 14731.0 14803.6 14818.7 15097.2 15124.6 23726.9 23890.3 23901.3 23960.0 23982.3 10292.1 10343.5 10388.5 10476.9 10566.4 9429.1 9547.2 9586.1 9658.1 9777.8 9037.7 9106.8 9296.2 9343.8 9355.3 2831.3 2867.2 2868.5 2879.7 2961.7 913.8 944.4 944.8 947.2 956.2 18631.4 18785.0 18865.2 19256.8 19302.1 1021.9 1022.0 1024.5 1025.5 1032.5 10504.4 10612.8 10612.8 10697.6 10720.3 435698.0 442839.0 445677.0 445682.0 448625.0 107992.0 108662.0 112224.0 113199.0 114384.0 1127.9 1130.2 1143.4 1165.1 1166.9 16692.7 16711.2 16918.5 16978.1 17011.7 53430.5 53472.7 54020.0 54322.0 56325.0 69803.0 70224.0 70629.3 70915.0 71252.3 14140.4 14338.3 14396.1 14542.1 14583.9 22166.0 22207.0 22353.2 22441.7 22500.5 17391.1 17613.6 17626.6 17750.2 17768.6 15786.9 15998.8 16608.9 16671.7 16695.7 18270.1 18288.5 18293.2 18365.1 18463.6 14087.1 14127.7 14192.1 14201.6 14288.1 17178.1 17324.8 17370.7 17662.3 17861.7 04:09:57 INFO - PID 11018 | 04:09:57 INFO - PID 11018 | [#3] mootools.html Cycles:180 Average:9735.71 Median:2663.92 stddev:7000.36 (262.8%) stddev-sans-first:6991.56 04:09:57 INFO - PID 11018 | Values: 1337.5 1434.1 1442.9 1443.2 1443.3 16161.8 16801.0 16848.1 16865.3 16934.8 16325.8 16396.4 16439.6 16443.8 16448.2 2575.5 2581.8 2624.5 2632.8 2638.1 2861.1 2863.7 2866.6 2867.6 2868.6 2766.6 2807.1 2876.3 2890.6 2890.6 2820.6 2846.1 2877.9 2887.8 2888.7 2475.6 2689.7 2722.5 2722.8 2724.1 15642.2 15760.0 15781.3 15791.9 15798.4 8353.9 8641.2 8650.7 8655.7 8660.7 5362.8 5450.1 5519.6 5586.4 5603.9 1912.2 1915.2 1948.8 1960.6 1967.5 27217.6 27386.6 27424.9 27460.5 27564.6 7210.8 7286.9 7351.4 7437.2 7494.5 17724.1 17725.2 17730.0 17767.0 17787.5 7992.8 8125.2 8130.7 8132.6 8138.6 7482.5 7483.9 7607.9 7779.6 7782.0 5369.6 5522.0 5542.6 5570.4 5583.9 1554.2 1579.1 1601.1 1603.7 1609.2 915.6 923.1 936.1 936.2 943.7 7828.9 7868.3 7886.5 7889.1 7904.3 714.6 729.7 742.3 755.7 761.5 5358.5 5495.7 5501.9 5524.0 5566.2 22191.1 22888.7 23057.4 23112.3 23322.9 22170.8 22685.1 22879.3 23082.0 23133.3 11638.6 11689.7 11716.5 11737.4 11816.2 8385.6 8640.0 8650.5 8671.2 8774.7 18364.8 19070.6 19278.6 19474.2 19559.0 18829.6 19638.8 19757.3 19961.4 20170.9 11471.3 11541.9 11582.4 11672.2 11675.5 14306.4 14493.4 14497.4 14519.2 14557.9 11208.5 11474.4 11499.3 11574.7 11808.5 11562.4 11658.2 11686.4 11771.6 11922.3 10234.0 10364.2 10459.4 10488.2 10501.4 7527.3 7567.9 7585.2 7679.7 7743.3 7607.9 7658.5 7739.3 7743.6 7757.7 04:09:57 INFO - PID 11018 | 04:09:57 INFO - PID 11018 | [#4] prototype.html Cycles:180 Average:5532.98 Median:6165.84 stddev:1552.93 (25.2%) stddev-sans-first:1510.87 04:09:57 INFO - PID 11018 | Values: 511.9 513.6 538.8 542.0 549.6 6320.4 6321.6 6346.2 6398.9 6418.2 6043.8 6194.2 6245.2 6283.5 6295.0 5002.9 5027.4 5058.2 5066.6 5080.3 4807.2 4997.6 5032.1 5063.7 5064.6 4971.7 4974.7 4998.4 5016.2 5018.5 4971.0 4974.2 4977.2 5039.3 5043.9 4457.4 4502.4 4527.4 4533.2 4535.3 6026.6 6072.1 6125.3 6163.6 6168.0 5778.8 5803.1 5809.6 5815.9 5838.7 6461.4 6475.2 6485.5 6528.5 6554.4 4876.2 4893.5 4923.5 4949.9 4953.6 6789.8 6827.1 6857.3 6905.7 6927.5 4971.9 5068.6 5069.2 5081.7 5101.1 5047.7 5050.7 5065.7 5082.8 5144.5 5698.5 5723.3 5761.4 5814.8 5821.8 6630.6 6636.0 6660.7 6714.2 6745.9 1636.5 1707.2 1727.9 1745.6 1760.2 1139.3 1227.2 1233.6 1234.7 1243.3 5634.4 5657.5 5660.5 5690.7 5728.7 6430.7 6505.8 6588.6 6617.3 6617.4 5615.9 5770.0 5793.4 5800.3 5834.0 3521.5 3547.0 3550.5 3552.3 3556.4 6503.3 6510.4 6536.8 6576.7 6632.3 6857.2 6951.2 6968.2 6998.9 7022.9 6474.8 6481.2 6577.1 6578.4 6588.8 6787.2 6802.3 6818.4 6834.1 6863.5 6680.4 6697.3 6733.2 6734.5 6761.6 6454.9 6480.1 6516.8 6563.0 6614.2 5022.1 5027.5 5046.7 5051.8 5087.2 6718.6 6765.7 6794.7 6803.4 6820.0 6479.5 6481.5 6494.3 6603.0 6644.6 6477.3 6586.9 6602.3 6610.3 6632.7 6161.5 6230.0 6376.0 6403.9 6424.8 6486.6 6533.2 6588.6 6606.4 6610.9 6272.5 6326.6 6351.7 6356.1 6362.7 04:09:57 INFO - PID 11018 | 04:09:57 INFO - PID 11018 | [#5] yui.html Cycles:180 Average:23727.10 Median:19201.62 stddev:34358.66 (178.9%) stddev-sans-first:34412.31 04:09:57 INFO - PID 11018 | Values: 903.7 913.0 914.8 926.4 938.6 18933.7 19047.2 19171.1 19450.2 19590.7 18989.8 18993.5 19196.5 19206.7 19214.1 957.7 983.4 986.3 986.5 987.9 949.1 985.6 990.8 992.1 992.5 1041.4 1045.6 1054.2 1055.6 1056.3 985.3 1027.7 1038.4 1041.1 1044.0 734.6 747.5 748.3 753.8 754.2 19919.9 20029.1 20134.1 20153.9 20169.7 18896.8 18901.2 19558.5 19578.4 19684.0 17530.0 17543.4 17624.9 17775.1 17897.1 3714.0 3769.8 3772.1 3773.4 3780.4 140736.3 141687.0 141842.0 142757.3 144613.3 16679.2 16719.0 17071.1 17154.8 17155.3 30435.8 31357.7 31590.7 31829.5 31857.4 8814.4 8835.5 8922.2 8923.2 8930.8 4367.4 4404.1 4435.7 4468.1 4468.8 5569.6 5609.7 5626.1 5635.0 5647.6 984.7 1002.5 1018.9 1020.5 1030.1 705.7 719.9 721.6 736.1 737.3 11162.4 12358.8 12665.9 12929.8 13029.3 681.8 683.2 687.5 697.6 701.3 5629.5 5671.3 5700.4 5715.5 5762.8 116735.0 116759.0 117503.4 118343.0 120747.0 100273.5 101262.0 101406.5 102257.0 103017.5 86206.6 88639.6 89201.0 90062.5 90366.5 10533.7 10538.3 10651.3 10657.2 10876.2 42762.0 43860.6 44639.8 44844.3 46324.0 53727.5 56065.4 56539.4 56980.0 57080.7 14112.0 14327.3 14349.3 14422.3 14537.3 16621.9 16640.9 16665.4 16677.0 16875.2 14909.0 14944.1 15163.0 15225.8 15404.5 14483.3 14519.7 14531.0 14621.5 14623.6 13893.7 14025.6 14227.0 14243.8 14298.6 11479.5 11640.9 11687.4 11921.9 11939.4 12477.4 12722.6 12726.7 12802.9 12841.6 04:09:57 INFO - PID 11018 | -------- Summary: end -------- 04:09:57 INFO - PID 11018 | 04:09:58 INFO - TEST-INFO | 11018: exit 0 04:09:58 INFO - TEST-OK | dromaeo_css | took 1109430ms 04:09:58 INFO - TEST-START | kraken 04:09:58 INFO - Initialising browser for kraken test... 04:09:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52822/getInfo.html -profile /tmp/tmpqtKrZt/profile 04:09:58 INFO - TEST-INFO | started process 11385 (/builds/slave/test/build/application/firefox/firefox http://localhost:52822/getInfo.html) 04:10:03 INFO - TEST-INFO | 11385: exit 0 04:10:03 INFO - Browser initialized. 04:10:03 INFO - Running cycle 1/1 for kraken test... 04:10:03 INFO - Using env: {'DISPLAY': ':0', 04:10:03 INFO - 'HOME': '/home/cltbld', 04:10:03 INFO - 'JSGC_DISABLE_POISONING': '1', 04:10:03 INFO - 'LANG': 'en_US.UTF-8', 04:10:03 INFO - 'LANGUAGE': 'en_US:en', 04:10:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:10:03 INFO - 'LOGNAME': 'cltbld', 04:10:03 INFO - 'MAIL': '/var/mail/cltbld', 04:10:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:10:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:10:03 INFO - 'MOZ_CRASHREPORTER': '1', 04:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:10:03 INFO - 'MOZ_NO_REMOTE': '1', 04:10:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:03 INFO - 'NO_EM_RESTART': '1', 04:10:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:03 INFO - 'PWD': '/builds/slave/test', 04:10:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:10:03 INFO - 'RUST_BACKTRACE': 'full', 04:10:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:10:03 INFO - 'SHELL': '/bin/bash', 04:10:03 INFO - 'SHLVL': '1', 04:10:03 INFO - 'TERM': 'linux', 04:10:03 INFO - 'TMOUT': '86400', 04:10:03 INFO - 'USER': 'cltbld', 04:10:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506336627.251848-1682386081', 04:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:03 INFO - '_': '/tools/buildbot/bin/python'} 04:10:03 INFO - TEST-INFO | started process 11616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqtKrZt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:04 INFO - PID 11616 | 04:10:04 INFO - PID 11616 | (/builds/slave/test/build/application/firefox/firefox:11666): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:10:04 INFO - PID 11616 | 04:10:14 INFO - PID 11616 | RSS: Main: 153124864 04:10:14 INFO - PID 11616 | 04:10:17 INFO - PID 11616 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52822/tests/kraken/driver.html?testName=audio-beat-detection) 04:10:18 INFO - PID 11616 | RSS: Main: 158896128 04:10:18 INFO - PID 11616 | 04:10:20 INFO - PID 11616 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52822/tests/kraken/driver.html?testName=audio-dft) 04:10:21 INFO - PID 11616 | RSS: Main: 159657984 04:10:21 INFO - PID 11616 | 04:10:24 INFO - PID 11616 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52822/tests/kraken/driver.html?testName=audio-fft) 04:10:25 INFO - PID 11616 | RSS: Main: 156168192 04:10:25 INFO - PID 11616 | 04:10:27 INFO - PID 11616 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52822/tests/kraken/driver.html?testName=audio-oscillator) 04:10:27 INFO - PID 11616 | RSS: Main: 156315648 04:10:27 INFO - PID 11616 | 04:10:29 INFO - PID 11616 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52822/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:10:30 INFO - PID 11616 | RSS: Main: 156545024 04:10:30 INFO - PID 11616 | 04:10:33 INFO - PID 11616 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52822/tests/kraken/driver.html?testName=imaging-darkroom) 04:10:34 INFO - PID 11616 | RSS: Main: 158633984 04:10:34 INFO - PID 11616 | 04:10:37 INFO - PID 11616 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52822/tests/kraken/driver.html?testName=imaging-desaturate) 04:10:38 INFO - PID 11616 | RSS: Main: 159264768 04:10:38 INFO - PID 11616 | 04:10:41 INFO - PID 11616 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52822/tests/kraken/driver.html?testName=json-parse-financial) 04:10:42 INFO - PID 11616 | RSS: Main: 159203328 04:10:42 INFO - PID 11616 | 04:10:43 INFO - PID 11616 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52822/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:10:44 INFO - PID 11616 | RSS: Main: 159068160 04:10:44 INFO - PID 11616 | 04:10:46 INFO - PID 11616 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:10:46 INFO - PID 11616 | RSS: Main: 159535104 04:10:46 INFO - PID 11616 | 04:10:48 INFO - PID 11616 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:10:49 INFO - PID 11616 | RSS: Main: 156094464 04:10:49 INFO - PID 11616 | 04:10:52 INFO - PID 11616 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:10:52 INFO - PID 11616 | RSS: Main: 156794880 04:10:52 INFO - PID 11616 | 04:10:55 INFO - PID 11616 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:10:56 INFO - PID 11616 | RSS: Main: 156459008 04:10:56 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52822/tests/kraken/driver.html?testName=ai-astar) 04:10:58 INFO - PID 11616 | RSS: Main: 158093312 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | __start_tp_report 04:10:58 INFO - PID 11616 | _x_x_mozilla_page_load 04:10:58 INFO - PID 11616 | _x_x_mozilla_page_load_details 04:10:58 INFO - PID 11616 | |i|pagename|runs| 04:10:58 INFO - PID 11616 | |0;ai-astar;107;108;107;108;109;107;106;109;108;107 04:10:58 INFO - PID 11616 | |1;audio-beat-detection;126;115;119;118;116;119;118;147;122;118 04:10:58 INFO - PID 11616 | |2;audio-dft;163;162;162;164;163;162;161;164;172;165 04:10:58 INFO - PID 11616 | |3;audio-fft;74;75;74;80;74;74;75;75;76;79 04:10:58 INFO - PID 11616 | |4;audio-oscillator;79;82;78;79;80;80;80;80;79;80 04:10:58 INFO - PID 11616 | |5;imaging-gaussian-blur;111;114;113;114;115;114;113;114;115;114 04:10:58 INFO - PID 11616 | |6;imaging-darkroom;152;148;147;149;148;148;148;148;150;152 04:10:58 INFO - PID 11616 | |7;imaging-desaturate;95;96;94;94;95;94;94;94;94;94 04:10:58 INFO - PID 11616 | |8;json-parse-financial;54;53;53;53;54;53;53;53;55;53 04:10:58 INFO - PID 11616 | |9;json-stringify-tinderbox;38;38;38;38;38;39;38;39;38;38 04:10:58 INFO - PID 11616 | |10;stanford-crypto-aes;78;77;74;75;80;79;75;74;73;75 04:10:58 INFO - PID 11616 | |11;stanford-crypto-ccm;113;120;116;116;112;115;119;114;112;110 04:10:58 INFO - PID 11616 | |12;stanford-crypto-pbkdf2;171;176;171;172;171;169;166;169;180;188 04:10:58 INFO - PID 11616 | |13;stanford-crypto-sha256-iterative;67;67;68;68;72;65;64;66;65;69 04:10:58 INFO - PID 11616 | __end_tp_report 04:10:58 INFO - PID 11616 | __start_cc_report 04:10:58 INFO - PID 11616 | _x_x_mozilla_cycle_collect,756 04:10:58 INFO - PID 11616 | __end_cc_report 04:10:58 INFO - PID 11616 | __startTimestamp1506337858333__endTimestamp 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | ------- Summary: start ------- 04:10:58 INFO - PID 11616 | Number of tests: 14 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | [#0] ai-astar Cycles:10 Average:107.60 Median:108.00 stddev:0.97 (0.9%) stddev-sans-first:1.00 04:10:58 INFO - PID 11616 | Values: 107.0 108.0 107.0 108.0 109.0 107.0 106.0 109.0 108.0 107.0 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | [#1] audio-beat-detection Cycles:10 Average:121.80 Median:119.00 stddev:9.38 (7.9%) stddev-sans-first:9.82 04:10:58 INFO - PID 11616 | Values: 126.0 115.0 119.0 118.0 116.0 119.0 118.0 147.0 122.0 118.0 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:3.12 (1.9%) stddev-sans-first:3.30 04:10:58 INFO - PID 11616 | Values: 163.0 162.0 162.0 164.0 163.0 162.0 161.0 164.0 172.0 165.0 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | [#3] audio-fft Cycles:10 Average:75.60 Median:75.00 stddev:2.17 (2.9%) stddev-sans-first:2.22 04:10:58 INFO - PID 11616 | Values: 74.0 75.0 74.0 80.0 74.0 74.0 75.0 75.0 76.0 79.0 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | [#4] audio-oscillator Cycles:10 Average:79.70 Median:80.00 stddev:1.06 (1.3%) stddev-sans-first:1.09 04:10:58 INFO - PID 11616 | Values: 79.0 82.0 78.0 79.0 80.0 80.0 80.0 80.0 79.0 80.0 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:0.71 04:10:58 INFO - PID 11616 | Values: 111.0 114.0 113.0 114.0 115.0 114.0 113.0 114.0 115.0 114.0 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:148.50 stddev:1.76 (1.2%) stddev-sans-first:1.50 04:10:58 INFO - PID 11616 | Values: 152.0 148.0 147.0 149.0 148.0 148.0 148.0 148.0 150.0 152.0 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 04:10:58 INFO - PID 11616 | Values: 95.0 96.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 04:10:58 INFO - PID 11616 | Values: 54.0 53.0 53.0 53.0 54.0 53.0 53.0 53.0 55.0 53.0 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 04:10:58 INFO - PID 11616 | Values: 38.0 38.0 38.0 38.0 38.0 39.0 38.0 39.0 38.0 38.0 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.00 stddev:2.36 (3.1%) stddev-sans-first:2.39 04:10:58 INFO - PID 11616 | Values: 78.0 77.0 74.0 75.0 80.0 79.0 75.0 74.0 73.0 75.0 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | [#11] stanford-crypto-ccm Cycles:10 Average:114.70 Median:115.50 stddev:3.16 (2.7%) stddev-sans-first:3.30 04:10:58 INFO - PID 11616 | Values: 113.0 120.0 116.0 116.0 112.0 115.0 119.0 114.0 112.0 110.0 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:171.50 stddev:6.46 (3.8%) stddev-sans-first:6.80 04:10:58 INFO - PID 11616 | Values: 171.0 176.0 171.0 172.0 171.0 169.0 166.0 169.0 180.0 188.0 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:2.33 (3.5%) stddev-sans-first:2.47 04:10:58 INFO - PID 11616 | Values: 67.0 67.0 68.0 68.0 72.0 65.0 64.0 66.0 65.0 69.0 04:10:58 INFO - PID 11616 | -------- Summary: end -------- 04:10:58 INFO - PID 11616 | 04:10:58 INFO - PID 11616 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:10:58 INFO - TEST-INFO | 11616: exit 0 04:10:58 INFO - TEST-OK | kraken | took 60527ms 04:10:58 INFO - SUITE-END | took 1169s 04:10:58 INFO - Completed test suite (00:19:29) 04:10:58 INFO - javascript benchmark 04:10:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8490.027845960345, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.330848867493, 3134.5454909038176, 3167.8891238806646, 3179.8092114473125, 3192.3455691583226, 6107.3587273336325, 6198.78304259351, 6225.533085018625, 6261.217347831521, 6326.810195694131, 6197.349278325779, 6235.469985051276, 6261.780837670683, 6357.268914074883, 6379.202599675041, 5687.488126068653, 5700.600957932947, 5768.798092066779, 5782.9421705782825, 5840.474357307841, 5546.223528705985, 5680.488756011958, 5783.9710801445935, 5813.9418605814035, 5833.3874943130995, 5726.255586773693, 5745.368009518949, 5792.247007888968, 5796.188533605298, 5811.593188476787, 5735.168400581934, 5777.422257774231, 5826.417358264182, 5836.88326233473, 5856.0630299151935, 5610.579206559524, 5668.404817494186, 5721.799737009184, 5788.305403351583, 5809.970950145223, 6225.937740622581, 6242.375762423767, 6294.653794041325, 6303.747850085991, 6358.618482891041, 6610.173728283965, 6623.437007854338, 6668.533202675766, 6708.664566771642, 6738.696758645872, 6515.315891831337, 6601.570897891622, 6632.336766323378, 6644.302348253412, 6762.695678694421, 6174.043023331391, 6175.7529698811995, 6177.876442471125, 6183.876322473526, 6202.317745048041, 6802.591844489347, 6815.2843951385385, 6816.386525212754, 6821.2155602106395, 6963.572467644222, 6587.670616469158, 6595.505337099737, 6675.9332406676285, 6681.699323530453, 6684.665766711645, 6724.193096828412, 6740.528163028639, 6795.946628272625, 6817.181938167451, 6825.5222134451105, 6484.773032943825, 6603.075569420285, 6613.107230523818, 6622.834429139214, 6667.266600673922, 6607.900881486781, 6618.371254730793, 6645.634490103091, 6649.667516624149, 6764.458843292525, 5278.551323137576, 5310.389305229948, 5313.282706834528, 5329.227262046981, 5333.253344531769, 4567.657425693086, 4618.0, 4643.955110100201, 4673.018666080094, 4686.250199968057, 5650.74571644277, 5759.798407055733, 5824.796132135355, 5825.912611310834, 5857.736401861926, 6667.133272674619, 6667.933320666828, 6679.198496180489, 6684.532082754161, 6695.564788288746, 5759.798407055817, 5762.538996880324, 5834.620749651259, 5835.2414186156375, 5857.941420585825, 5773.422657734193, 5815.214945982323, 5837.503812175928, 5847.181394604759, 5849.444302791228, 6485.67571621417, 6505.284418713938, 6580.80257592273, 6581.934180658132, 6621.933780662228, 6453.838654033687, 6564.868702626016, 6699.129113215446, 6775.762848300285, 6784.76253331131, 6418.326075762165, 6486.837829054311, 6543.149390579194, 6561.639109849004, 6566.409023187936, 6614.173228346457, 6620.768273110418, 6684.131062961784, 6690.899636505554, 6714.0, 6729.0, 6754.615303862598, 6755.0, 6810.5913645181445, 6848.554843935129, 6378.0, 6449.806505804833, 6470.158879345843, 6472.964325707864, 6475.7733479328, 6456.386643268882, 6459.418652321314, 6464.709088090953, 6478.708458119301, 6481.708323125565, 6440.8389790255615, 6449.96775016122, 6452.096706461193, 6471.838204044937, 6475.384838440341, 6466.0947467355545, 6541.803745887631, 6592.208934927839, 6611.07444957716, 6643.1031810704935, 6202.627842329474, 6327.810165695037, 6329.746810127727, 6419.35806419373, 6422.678866056585], "value": 6104.662113484693, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [860.8923884514436, 862.168007872403, 870.1559487297327, 879.7536689726875, 894.2890402130306, 39666.0, 40815.387769183486, 40834.795826020905, 40838.795806020964, 40904.18191636165, 37442.0, 37747.0, 37851.432228516525, 37864.0, 37960.62039379605, 7132.643367831613, 7163.749268775594, 7192.820179495502, 7252.601106939116, 7276.417886569062, 7146.071010768619, 7244.746433874815, 7244.746433874815, 7254.673539690727, 7267.418606511493, 7729.149793522708, 7903.881441778349, 7903.920960790405, 7912.604369781517, 7920.247576480254, 7818.0, 7829.804254893673, 7837.098733645618, 7862.764117076496, 7867.999999999972, 7680.078390593108, 7758.340541054017, 7872.5670088145125, 7874.330681892046, 7880.0937892142565, 37404.0, 37733.245335093416, 38020.0, 38076.04809879775, 38099.80950095259, 3504.8422820972864, 3506.7720598161036, 3534.7172226222096, 3548.0, 3557.3774589446743, 30925.22686932822, 31030.37939241225, 31231.84384078088, 31234.219144521343, 31275.0, 5142.922856157161, 5166.9224961625605, 5184.818531351422, 5199.298094757197, 5215.869603259949, 186960.0, 188165.0, 188446.0, 188865.0, 189077.0, 47065.76467117711, 47115.76442117767, 47430.76284618555, 47485.0, 47571.0, 47518.76240618775, 47815.282770758466, 47997.280040798716, 48030.75984620055, 48066.0, 15360.462383816737, 15686.05883646962, 15721.0, 15743.842561574238, 15746.527604171893, 12551.058670599741, 12610.747785044248, 12614.621561352991, 12648.494060237672, 12658.367081645882, 13721.656958575915, 13855.96080293982, 13947.86052139486, 14047.438102475991, 14281.357338919774, 5652.2652055233375, 5723.942760572424, 5788.942110578841, 5794.797182098607, 5831.79588714393, 985.6747273399761, 1000.9299349045497, 1003.1874181912674, 1004.2468148888333, 1031.5358088859894, 21855.672164917538, 22040.44898877541, 22297.0, 22306.888465557568, 22692.65961010586, 1112.8759952448086, 1116.9609063682894, 1120.4845770945456, 1121.5401685309148, 1128.0468004536153, 11816.231944923553, 11845.644630661094, 11854.466549005316, 11924.224925379822, 12016.218945768496, 212675.0, 214490.0, 214501.0, 215054.0, 215482.0, 52215.73892130515, 52307.0, 55161.448385516436, 55182.0, 55513.0, 1391.1583491987403, 1439.2875526614393, 1442.834074081473, 1445.4940770730161, 1446.7540518111946, 26183.0, 26186.476270474865, 26239.0, 26357.604635930093, 26411.73588264093, 36004.819975899954, 36162.09594760152, 36239.0, 36254.0, 36263.0, 182937.0, 183759.0, 184214.0, 184989.0, 185225.0, 32155.196120097185, 32259.516107258878, 32282.83858580786, 32442.0, 32511.18722031968, 38936.80531597324, 40253.1949361017, 40706.185876281714, 40955.18089638131, 41002.1799564013, 30532.694673052985, 31113.688863111078, 31185.0, 31231.531527027568, 31246.0, 30710.0, 30891.382172356876, 30891.69108308888, 31063.0681079568, 31574.210644734067, 34267.0, 34747.82626086853, 34751.826240868635, 34810.65189348074, 34819.12952176115, 30651.54022689706, 30936.69063309338, 31070.689293107684, 31107.37785244328, 31256.843715781277, 22478.662820058038, 22643.886780566652, 22850.885745571166, 22883.427914302276, 23234.767652323262], "value": 16810.917407330755, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.2866445607448, 581.7091454272863, 587.7355190164425, 594.2571785268415, 610.5024405109835, 22124.55750884981, 22956.08175672971, 22985.310440686786, 23117.422064448398, 23234.535309293806, 23381.532369352604, 24448.388790280253, 24740.25779226626, 25065.373365665866, 25104.12135575255, 6446.419822215999, 6629.502787290949, 6630.502712296573, 6634.170728658918, 6640.037194606779, 6311.053341998691, 6363.4272915437605, 6475.190601174853, 6556.27880933097, 6576.342365763409, 6536.934630653704, 6542.1495205623205, 6542.214934207902, 6549.508786840982, 6552.7378904843745, 6123.295820980599, 6490.286068532458, 6492.480601551864, 6521.119648847416, 6525.804225873231, 5893.469587737124, 5927.614705044159, 5932.0508718604815, 5932.614380065282, 5934.228550288478, 27592.0, 28091.719082809115, 28103.156905292875, 28114.578281325797, 28239.15282541527, 2036.1244664794133, 2047.4164863013968, 2052.958940821175, 2063.8555301128927, 2070.3064473401278, 18625.81374186268, 19329.613407731766, 19546.51133721668, 19649.607007859762, 19761.703574446394, 2423.212455951823, 2451.7670821272127, 2472.344828620417, 2491.501699660057, 2497.2383423055962, 123677.0, 129415.0, 132324.3383783075, 134707.0, 137434.999999999, 14731.04248223862, 14803.555893323217, 14818.703625927421, 15097.24513774307, 15124.621884452758, 23726.881365593406, 23890.283291501284, 23901.326907116334, 23960.0, 23982.28053158408, 10292.125169360688, 10343.534540945675, 10388.532516036645, 10476.947615261875, 10566.418846963337, 9429.104235097655, 9547.188488978514, 9586.089321514444, 9658.130768230892, 9777.804443911082, 9037.683681071263, 9106.772330691652, 9296.209822165056, 9343.813123737487, 9355.251579873593, 2831.3487897783625, 2867.1541895140986, 2868.469333173328, 2879.6832348441653, 2961.748251398655, 913.830941275866, 944.414463032924, 944.8063147054837, 947.209080417845, 956.2159029595665, 18631.44105676832, 18785.0, 18865.24539018424, 19256.807431925783, 19302.13140408657, 1021.8569400283966, 1021.9882316506754, 1024.4877561219391, 1025.4565080507343, 1032.5250384822916, 10504.369737815756, 10612.840807387895, 10612.840807387895, 10697.625583104555, 10720.303180293256, 435698.0, 442839.0, 445677.0, 445682.0, 448625.0, 107992.0, 108662.0, 112224.0, 113199.0, 114384.0, 1127.8590176227972, 1130.2370899642708, 1143.382573410349, 1165.0854079547514, 1166.8949794518364, 16692.749608756123, 16711.247993840065, 16918.492445226664, 16978.06620635877, 17011.65976680484, 53430.4656953441, 53472.73263633657, 54020.0, 54322.0, 56325.0, 69803.0, 70224.0, 70629.29370706227, 70915.0, 71252.28747712664, 14140.363683634467, 14338.283085845458, 14396.064255823338, 14542.127472351693, 14583.927080364954, 22166.0, 22207.0, 22353.217637382615, 22441.663375049713, 22500.549989000454, 17391.130443477523, 17613.559661008578, 17626.647467050843, 17750.20124094393, 17768.55578610545, 15786.92106539506, 15998.760018599498, 16608.916955415145, 16671.749923751395, 16695.66608667844, 18270.086495674896, 18288.542786430447, 18293.17680704345, 18365.081745912918, 18463.630727385647, 14087.084339517898, 14127.704622513664, 14192.077514961495, 14201.573952781433, 14288.142711437347, 17178.141092945054, 17324.826751732322, 17370.652586948443, 17662.293508259525, 17861.73207401864], "value": 11779.769757171473, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.5184933423968, 1434.0606902478874, 1442.9494967676133, 1443.155753883978, 1443.3216388297496, 16161.75757363639, 16801.0, 16848.073355965418, 16865.325386984536, 16934.83065169348, 16325.83674163258, 16396.426125085625, 16439.58901027475, 16443.753343699853, 16448.177591120428, 2575.497777933299, 2581.7805486533666, 2624.475104979012, 2632.8420294782372, 2638.14260365382, 2861.1130549529607, 2863.742263196312, 2866.641669791276, 2867.5985362049328, 2868.641419822522, 2766.61267422561, 2807.087696498636, 2876.3240638449947, 2890.5519644455144, 2890.5519644455144, 2820.576913462997, 2846.117703511918, 2877.8704958276926, 2887.7978541502207, 2888.6822449530537, 2475.5667758142254, 2689.7041325454184, 2722.4555088982083, 2722.754952054325, 2724.141895302993, 15642.217889105614, 15759.97560158586, 15781.28984195714, 15791.92104039484, 15798.368065277375, 8353.916460835375, 8641.179087986631, 8650.697225597138, 8655.740327790176, 8660.740177794676, 5362.8123015694655, 5450.100733378988, 5519.641223320471, 5586.385497595261, 5603.943960560424, 1912.1586501939103, 1915.205189846212, 1948.795376485477, 1960.6078784243066, 1967.5376286572643, 27217.591736123974, 27386.589201161998, 27424.862875685692, 27460.45079098427, 27564.586531202047, 7210.783676489714, 7286.854262914818, 7351.448641351813, 7437.181909989897, 7494.5128566643, 17724.113794310233, 17725.202365893565, 17730.0, 17767.0, 17787.46637600874, 7992.760217193493, 8125.228103330174, 8130.715424960098, 8132.5933703314595, 8138.633761480747, 7482.513636613603, 7483.8877416838795, 7607.885881711779, 7779.649915753805, 7782.0, 5369.624126311199, 5522.0, 5542.584306176972, 5570.442955704397, 5583.855115124587, 1554.2228885557222, 1579.1314776872673, 1601.0873801932787, 1603.711331960235, 1609.235613083776, 915.6108653822099, 923.0769230769231, 936.1200471556715, 936.1901954809177, 943.6602822983721, 7828.882566761503, 7868.331191848642, 7886.487378320391, 7889.132195458495, 7904.288614024766, 714.5962531169872, 729.6935287179398, 742.3281929853491, 755.6750597243238, 761.455559275121, 5358.544523715528, 5495.670259784426, 5501.862453438696, 5524.0, 5566.165075238747, 22191.11235550592, 22888.65667014996, 23057.42356441069, 23112.306630801104, 23322.883385582965, 22170.778292217194, 22685.092596296294, 22879.313620591078, 23082.0, 23133.306000819666, 11638.592649257236, 11689.707757305965, 11716.472758725879, 11737.413129343498, 11816.231944923553, 8385.622646981023, 8640.0, 8650.480971141751, 8671.176238257356, 8774.692885748967, 18364.81635183631, 19070.618587628447, 19278.614427711087, 19474.221031158595, 19559.0, 18829.623407532046, 19638.803611963696, 19757.308494202633, 19961.401157965283, 20170.89914550418, 11471.254368466023, 11541.942290288494, 11582.42087895585, 11672.241304315192, 11675.474603643026, 14306.356213970605, 14493.420263189355, 14497.420103196177, 14519.201443920685, 14557.85442145565, 11208.495617697386, 11474.368909710047, 11499.310041397543, 11574.652760416864, 11808.468618911998, 11562.364069976233, 11658.242214256046, 11686.415679216176, 11771.587994420153, 11922.284662919905, 10234.0, 10364.170866330825, 10459.372437653765, 10488.160947124365, 10501.422421766876, 7527.284907933957, 7567.9243207567215, 7585.179556906413, 7679.654415551202, 7743.341815945482, 7607.923920760722, 7658.463907526642, 7739.3034626883855, 7743.612819359122, 7757.72847950319], "value": 6885.252504723666, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.91809310510325, 513.6430181024188, 538.8087229033694, 542.0487045235611, 549.5548605629441, 6320.399562041604, 6321.6207027578375, 6346.2067241594805, 6398.904016439751, 6418.165638466993, 6043.758249670019, 6194.163787888634, 6245.219347581552, 6283.465905398035, 6295.0, 5002.899942001158, 5027.371578552672, 5058.2159765236265, 5066.620003499752, 5080.263361812535, 4807.1587472192405, 4997.575206107485, 5032.144535428967, 5063.74681265937, 5064.620153488503, 4971.726555039471, 4974.651774375795, 4998.350544320384, 5016.172331565287, 5018.498150184971, 4970.950290497085, 4974.179260422026, 4977.228529577885, 5039.31969184161, 5043.924341134886, 4457.420535330419, 4502.369668246448, 4527.4114365132655, 4533.161365147458, 4535.251683472223, 6026.578139530235, 6072.089186621998, 6125.326214116443, 6163.630182189083, 6168.0439531872635, 5778.8266352009505, 5803.129530570406, 5809.622374545641, 5815.882023819012, 5838.678872662002, 6461.418472337512, 6475.158229430191, 6485.546011779177, 6528.477721782246, 6554.442872355856, 4876.171050921352, 4893.4617192108835, 4923.507649235084, 4949.851504454872, 4953.628477864175, 6789.830254243634, 6827.146606674166, 6857.314268573153, 6905.654717264167, 6927.549709268932, 4971.850844474671, 5068.6451948363265, 5069.188929771219, 5081.74591270435, 5101.0818052750865, 5047.662369472093, 5050.696958182521, 5065.696058236517, 5082.847514574569, 5144.459831717691, 5698.515626171739, 5723.284589426322, 5761.423857614205, 5814.796482123105, 5821.825345239649, 6630.6353150576215, 6635.966820165965, 6660.666966651648, 6714.194296684429, 6745.898811517831, 1636.4681478519528, 1707.1805533344063, 1727.8941477454189, 1745.5636090977255, 1760.243095468935, 1139.3221033485063, 1227.245244174826, 1233.6237447578574, 1234.703671118943, 1243.2851110611255, 5634.408387119375, 5657.462541058593, 5660.490555849993, 5690.743916523684, 5728.713564321767, 6430.7106180222, 6505.837354066186, 6588.571742836701, 6617.338266173344, 6617.371349721769, 5615.943840561624, 5769.9711501442225, 5793.420657934257, 5800.274965629296, 5833.970830145822, 3521.5245941798044, 3546.964530354715, 3550.520679708258, 3552.2717842842158, 3556.448750443685, 6503.349665033554, 6510.381513756186, 6536.8365790855605, 6576.736930522726, 6632.303608121078, 6857.177138743283, 6951.16586009682, 6968.163820341591, 6998.935314082256, 7022.92977070233, 6474.77338293148, 6481.222253329536, 6577.14497115372, 6578.440832529289, 6588.8023359299295, 6787.185537735503, 6802.319768023158, 6818.386345228953, 6834.1457317835275, 6863.450923925974, 6680.432163265982, 6697.330266973264, 6733.192016957996, 6734.494912881455, 6761.628110453776, 6454.867875518183, 6480.125183100221, 6516.837079073061, 6563.0, 6614.206295244601, 5022.146235140108, 5027.522385373383, 5046.697198168122, 5051.797928082982, 5087.211482220262, 6718.630475323904, 6765.733479284495, 6794.728210871707, 6803.387695107464, 6819.965900170468, 6479.4816414685765, 6481.546291759531, 6494.285628580947, 6603.0, 6644.634545100066, 6477.275566549159, 6586.9460886259885, 6602.306757790363, 6610.305917878553, 6632.721894378003, 6161.476274516716, 6229.96885015572, 6375.968120159369, 6403.8719225614295, 6424.804219274442, 6486.5729539501235, 6533.18335208099, 6588.637624930483, 6606.372394622503, 6610.933890661032, 6272.529560282906, 6326.588771729823, 6351.666150108529, 6356.078368636614, 6362.681865906594], "value": 5076.711439705247, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [903.6566104880145, 913.0, 914.7575892388514, 926.3793258516793, 938.5635679409075, 18933.715994260096, 19047.2381104756, 19171.13729882155, 19450.221991120357, 19590.706139407885, 18989.810101898976, 18993.52516187096, 19196.520086997833, 19206.711899321523, 19214.135363908623, 957.6839642917838, 983.3853841349156, 986.3342243985317, 986.5412583148834, 987.8715766950287, 949.1125797379437, 985.5762022330395, 990.8067926754286, 992.0625009366152, 992.4591097851652, 1041.3543602966172, 1045.5974449836829, 1054.1882750282277, 1055.5777688924454, 1056.3081181825917, 985.2905907746411, 1027.6557353286657, 1038.428864124736, 1041.1150522056266, 1043.9634612788516, 734.6143274780783, 747.4692967992731, 748.3265061444689, 753.7927070055724, 754.1817128415676, 19919.90040049805, 20029.09869055896, 20134.093965771575, 20153.899230503754, 20169.697454538193, 18896.811031889643, 18901.243950241973, 19558.51103722404, 19578.412647620593, 19684.0, 17530.0, 17543.385981490588, 17624.91187544054, 17775.111244437856, 17897.105144742713, 3713.9628603713886, 3769.754965927206, 3772.0569857535615, 3773.3585290500682, 3780.3762379207396, 140736.29631851777, 141687.0, 141842.0, 142757.28621356827, 144613.2769336157, 16679.249433775265, 16718.99686018843, 17071.146442677815, 17154.828451715322, 17155.313787448613, 30435.847820760755, 31357.686423135932, 31590.684093158776, 31829.52255716166, 31857.362852742815, 8814.382993190544, 8835.469871807712, 8922.152395522415, 8923.196912277926, 8930.776730581787, 4367.388565600819, 4404.0971600822395, 4435.733855968652, 4468.061707041493, 4468.798904049326, 5569.637973531708, 5609.691466969356, 5626.127950167731, 5635.0, 5647.604667673223, 984.6849008317413, 1002.5037606384886, 1018.8930162332997, 1020.505055048301, 1030.0677886512717, 705.6542294275768, 719.8884172953201, 721.5526373648372, 736.0872518077546, 737.3363972424861, 11162.386068766296, 12358.814617780741, 12665.936670316589, 12929.806052909214, 13029.348532573333, 681.8363592737807, 683.2006552333781, 687.4775170870174, 697.6407150317591, 701.2531653788699, 5629.493345598916, 5671.319441666944, 5700.4299570043495, 5715.514181294553, 5762.798302059407, 116735.0, 116759.0, 117503.41248293874, 118343.0, 120747.0, 100273.49863250637, 101262.0, 101406.4929675347, 102257.0, 103017.48491257646, 86206.56896715476, 88639.55680221686, 89201.0, 90062.54968725245, 90366.54816725875, 10533.736656583647, 10538.262321637412, 10651.254412191072, 10657.20070994663, 10876.18428617841, 42762.0, 43860.561394386925, 44639.77680111579, 44844.32733509065, 46324.0, 53727.46272537224, 56065.43934560602, 56539.43460565342, 56980.0, 57080.714596426755, 14112.0, 14327.28363581796, 14349.282535873373, 14422.278886055445, 14537.273136343352, 16621.916890415472, 16640.916795415946, 16665.416710415077, 16677.0, 16875.156242187597, 14908.956373053783, 14944.103353798806, 15163.0, 15225.847741522886, 15404.537863864101, 14483.348249329016, 14519.709605808035, 14531.0, 14621.488247911271, 14623.561293161221, 13893.652658683613, 14025.649358766112, 14227.0, 14243.786343205067, 14298.57104286873, 11479.483423246142, 11640.883591164318, 11687.415629218674, 11921.940390297994, 11939.403029848647, 12477.438515267017, 12722.61832145037, 12726.68183295425, 12802.850829169298, 12841.550545730855], "value": 8862.126499054139, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1428.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 108.0, 107.0, 108.0, 109.0, 107.0, 106.0, 109.0, 108.0, 107.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 115.0, 119.0, 118.0, 116.0, 119.0, 118.0, 147.0, 122.0, 118.0], "value": 121.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 164.0, 163.0, 162.0, 161.0, 164.0, 172.0, 165.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 80.0, 74.0, 74.0, 75.0, 75.0, 76.0, 79.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 78.0, 79.0, 80.0, 80.0, 80.0, 80.0, 79.0, 80.0], "value": 79.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 114.0, 115.0, 114.0, 113.0, 114.0, 115.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 148.0, 147.0, 149.0, 148.0, 148.0, 148.0, 148.0, 150.0, 152.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 55.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 39.0, 38.0, 38.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 74.0, 75.0, 80.0, 79.0, 75.0, 74.0, 73.0, 75.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 120.0, 116.0, 116.0, 112.0, 115.0, 119.0, 114.0, 112.0, 110.0], "value": 114.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 176.0, 171.0, 172.0, 171.0, 169.0, 166.0, 169.0, 180.0, 188.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 68.0, 72.0, 65.0, 64.0, 66.0, 65.0, 69.0], "value": 67.1, "unit": "score"}]}]} 04:10:59 INFO - Return code: 0 04:10:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:10:59 INFO - # TBPL SUCCESS # 04:10:59 INFO - Running post-action listener: _package_coverage_data 04:10:59 INFO - Running post-action listener: _resource_record_post_action 04:10:59 INFO - [mozharness: 2017-09-25 11:10:59.128668Z] Finished run-tests step (success) 04:10:59 INFO - Running post-run listener: _resource_record_post_run 04:10:59 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 339509248; Read time: 20; Write time: 243836 04:10:59 INFO - TinderboxPrint: CPU usage
13.1% 04:10:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 04:10:59 INFO - TinderboxPrint: I/O write bytes / time
339,509,248 / 243,836 04:10:59 INFO - TinderboxPrint: CPU idle
8,228.3 (86.9%) 04:10:59 INFO - TinderboxPrint: CPU user
1,192.8 (12.6%) 04:10:59 INFO - TinderboxPrint: Swap in / out
0 / 0 04:10:59 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13344768; Read time: 0; Write time: 2880 04:10:59 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:10:59 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 326164480; Read time: 0; Write time: 240956 04:10:59 INFO - Running post-run listener: _upload_blobber_files 04:10:59 INFO - Blob upload gear active. 04:10:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:10:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:10:59 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:10:59 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:11:00 INFO - (blobuploader) - INFO - Open directory for files ... 04:11:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:11:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:11:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:01 INFO - (blobuploader) - INFO - Done attempting. 04:11:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:11:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:11:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:07 INFO - (blobuploader) - INFO - Done attempting. 04:11:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:11:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:11:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:08 INFO - (blobuploader) - INFO - Done attempting. 04:11:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:11:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:11:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:09 INFO - (blobuploader) - INFO - Done attempting. 04:11:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:11:09 INFO - Return code: 0 04:11:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:11:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:11:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/50b212dc4c2202d9f386fea60571981ffa91001cc24e24b027993a38c08deb87c9a0ca299a91766b23030123f50b7efdadb0a0a31d1a8a4c0f27f0c76b91a49f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8589e35c4de9c8c57f51d7be469a399cfb42c4c22247020e01305a317903e61b1dcabcf65068404855bb5ee2de7c90f328b10c540c7c1d5d325159f576c7ebe3", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a3814ddccc10d4775ec26d2279c48ade6f9ba3dd82ec45b94becb3f31759f5bee7199aef821b3cfe167ac3a49fe0717e642b40276cbd501a047b211c8d725f8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f46a138483460bea15fa1ec4babaef72ab281362eed77f087052778c7e2fe166ca702aacb22b39fd93f50392612dd785cc972731b30df8fde07101fc6a8d094"} 04:11:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:11:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:11:09 INFO - Contents: 04:11:09 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/50b212dc4c2202d9f386fea60571981ffa91001cc24e24b027993a38c08deb87c9a0ca299a91766b23030123f50b7efdadb0a0a31d1a8a4c0f27f0c76b91a49f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8589e35c4de9c8c57f51d7be469a399cfb42c4c22247020e01305a317903e61b1dcabcf65068404855bb5ee2de7c90f328b10c540c7c1d5d325159f576c7ebe3", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a3814ddccc10d4775ec26d2279c48ade6f9ba3dd82ec45b94becb3f31759f5bee7199aef821b3cfe167ac3a49fe0717e642b40276cbd501a047b211c8d725f8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f46a138483460bea15fa1ec4babaef72ab281362eed77f087052778c7e2fe166ca702aacb22b39fd93f50392612dd785cc972731b30df8fde07101fc6a8d094"} 04:11:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:11:09 INFO - Copying logs to upload dir... 04:11:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:11:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.072521 ========= master_lag: 0.85 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-25 04:11:09.737028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 04:11:09.744013) ========= 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=745a4373a2a16df560f216e000000264-1506336627.251848-1682386081 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-Non-PGO/sha512/50b212dc4c2202d9f386fea60571981ffa91001cc24e24b027993a38c08deb87c9a0ca299a91766b23030123f50b7efdadb0a0a31d1a8a4c0f27f0c76b91a49f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8589e35c4de9c8c57f51d7be469a399cfb42c4c22247020e01305a317903e61b1dcabcf65068404855bb5ee2de7c90f328b10c540c7c1d5d325159f576c7ebe3", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a3814ddccc10d4775ec26d2279c48ade6f9ba3dd82ec45b94becb3f31759f5bee7199aef821b3cfe167ac3a49fe0717e642b40276cbd501a047b211c8d725f8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f46a138483460bea15fa1ec4babaef72ab281362eed77f087052778c7e2fe166ca702aacb22b39fd93f50392612dd785cc972731b30df8fde07101fc6a8d094"} build_url:https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/JwN-TpclSCu1HPYGslnjhA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/50b212dc4c2202d9f386fea60571981ffa91001cc24e24b027993a38c08deb87c9a0ca299a91766b23030123f50b7efdadb0a0a31d1a8a4c0f27f0c76b91a49f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8589e35c4de9c8c57f51d7be469a399cfb42c4c22247020e01305a317903e61b1dcabcf65068404855bb5ee2de7c90f328b10c540c7c1d5d325159f576c7ebe3", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5a3814ddccc10d4775ec26d2279c48ade6f9ba3dd82ec45b94becb3f31759f5bee7199aef821b3cfe167ac3a49fe0717e642b40276cbd501a047b211c8d725f8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f46a138483460bea15fa1ec4babaef72ab281362eed77f087052778c7e2fe166ca702aacb22b39fd93f50392612dd785cc972731b30df8fde07101fc6a8d094"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 04:11:09.771466) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:11:09.771921) ========= 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=745a4373a2a16df560f216e000000264-1506336627.251848-1682386081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 04:11:09.825520) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 04:11:09.827974) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 04:11:09.828457) ========= ========= Total master_lag: 1.08 =========