builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1506387280.14 results: success (0) revision: 641bfddb87113b45ee3df9849345dbcf821ef3da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:40.142254) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:40.142672) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:40.142954) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:40.160556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:40.160903) ========= 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=8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 17:54:40-- 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% 41.7M=0s 2017-09-25 17:54:40 (41.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135631 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:40.315517) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:40.315887) ========= 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=8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020358 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:40.369790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 17:54:40.370134) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 641bfddb87113b45ee3df9849345dbcf821ef3da --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 641bfddb87113b45ee3df9849345dbcf821ef3da --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=8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 17:54:40,383 truncating revision to first 12 chars 2017-09-25 17:54:40,383 Setting DEBUG logging. 2017-09-25 17:54:40,383 attempt 1/10 2017-09-25 17:54:40,383 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/641bfddb8711?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 17:54:41,673 unpacking tar archive at: mozilla-central-641bfddb8711/testing/mozharness/ program finished with exit code 0 elapsedTime=1.572049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 17:54:41.958439) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:41.958785) ========= script_repo_revision: 641bfddb87113b45ee3df9849345dbcf821ef3da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:41.959177) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:41.959438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:41.977317) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-25 17:54:41.977684) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:54:42 INFO - MultiFileLogger online at 20170925 17:54:42 in /builds/slave/test 17:54:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:54:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:54:42 INFO - {'append_to_log': False, 17:54:42 INFO - 'base_work_dir': '/builds/slave/test', 17:54:42 INFO - 'blob_upload_branch': 'Firefox', 17:54:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:54:42 INFO - 'branch': 'Firefox', 17:54:42 INFO - 'buildbot_json_path': 'buildprops.json', 17:54:42 INFO - 'code_coverage': False, 17:54:42 INFO - 'config_files': ('talos/linux_config.py',), 17:54:42 INFO - 'default_actions': ('clobber', 17:54:42 INFO - 'read-buildbot-config', 17:54:42 INFO - 'download-and-extract', 17:54:42 INFO - 'populate-webroot', 17:54:42 INFO - 'create-virtualenv', 17:54:42 INFO - 'install', 17:54:42 INFO - 'setup-mitmproxy', 17:54:42 INFO - 'run-tests'), 17:54:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:54:42 INFO - 'disable_ccov_upload': False, 17:54:42 INFO - 'disable_stylo': False, 17:54:42 INFO - 'download_minidump_stackwalk': True, 17:54:42 INFO - 'download_symbols': 'ondemand', 17:54:42 INFO - 'enable_stylo': False, 17:54:42 INFO - 'enable_webrender': False, 17:54:42 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:54:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:54:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:54:42 INFO - 'gecko_profile': False, 17:54:42 INFO - 'gecko_profile_interval': 0, 17:54:42 INFO - 'installer_path': 'installer.exe', 17:54:42 INFO - 'log_level': 'info', 17:54:42 INFO - 'log_name': 'talos', 17:54:42 INFO - 'log_to_console': True, 17:54:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:54:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:54:42 INFO - 'opt_config_files': (), 17:54:42 INFO - 'pip_index': False, 17:54:42 INFO - 'suite': 'dromaeojs-e10s', 17:54:42 INFO - 'system_bits': '32', 17:54:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:54:42 INFO - 'title': 'talos-linux64-ix-038', 17:54:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:54:42 INFO - 'use_talos_json': True, 17:54:42 INFO - 'verify': 'False', 17:54:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:54:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:54:42 INFO - 'work_dir': 'build'} 17:54:42 INFO - [mozharness: 2017-09-26 00:54:42.138418Z] Running clobber step. 17:54:42 INFO - Running pre-action listener: _resource_record_pre_action 17:54:42 INFO - Running main action method: clobber 17:54:42 INFO - rmtree: /builds/slave/test/build 17:54:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:54:43 INFO - Running post-action listener: _resource_record_post_action 17:54:43 INFO - [mozharness: 2017-09-26 00:54:43.134519Z] Finished clobber step (success) 17:54:43 INFO - [mozharness: 2017-09-26 00:54:43.134615Z] Running read-buildbot-config step. 17:54:43 INFO - Running pre-action listener: _resource_record_pre_action 17:54:43 INFO - Running main action method: read_buildbot_config 17:54:43 INFO - Using buildbot properties: 17:54:43 INFO - { 17:54:43 INFO - "project": "", 17:54:43 INFO - "product": "firefox", 17:54:43 INFO - "who": "kwierso@gmail.com", 17:54:43 INFO - "installer_path": "public/build/target.tar.bz2", 17:54:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:54:43 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:54:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 17:54:43 INFO - "stage_platform": "linux64-pgo", 17:54:43 INFO - "basedir": "/builds/slave/test", 17:54:43 INFO - "buildnumber": 207, 17:54:43 INFO - "platform": "ubuntu64_hw", 17:54:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:54:43 INFO - "slavebuilddir": "test", 17:54:43 INFO - "taskId": "fRPQNPyyQ8KB2xm3bcITFg", 17:54:43 INFO - "branch": "mozilla-central", 17:54:43 INFO - "script_repo_revision": "production", 17:54:43 INFO - "revision": "641bfddb87113b45ee3df9849345dbcf821ef3da", 17:54:43 INFO - "slavename": "talos-linux64-ix-038", 17:54:43 INFO - "repo_path": "mozilla-central" 17:54:43 INFO - } 17:54:43 INFO - Finding installer, test and symbols from parent task. 17:54:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fRPQNPyyQ8KB2xm3bcITFg'}, attempt #1 17:54:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fRPQNPyyQ8KB2xm3bcITFg'}, attempt #1 17:54:44 INFO - Task dependencies: NrQ6614BRL-Ibp7ZFNvHoA 17:54:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA'}, attempt #1 17:54:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2 17:54:44 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.test_packages.json 17:54:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.crashreporter-symbols.zip 17:54:44 INFO - Running post-action listener: _resource_record_post_action 17:54:44 INFO - [mozharness: 2017-09-26 00:54:44.462568Z] Finished read-buildbot-config step (success) 17:54:44 INFO - [mozharness: 2017-09-26 00:54:44.462785Z] Running download-and-extract step. 17:54:44 INFO - Running pre-action listener: _resource_record_pre_action 17:54:44 INFO - Running main action method: download_and_extract 17:54:44 INFO - mkdir: /builds/slave/test/build/tests 17:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:44 INFO - trying https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.test_packages.json 17:54:44 INFO - Downloading https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:54:45 INFO - Downloaded 989 bytes. 17:54:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:54:45 INFO - Using the following test package requirements: 17:54:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:54:45 INFO - u'common': [u'target.common.tests.zip'], 17:54:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:54:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:54:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:54:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:54:45 INFO - u'mozbase': [u'target.common.tests.zip'], 17:54:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:54:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:54:45 INFO - u'web-platform': [u'target.common.tests.zip', 17:54:45 INFO - u'target.web-platform.tests.tar.gz'], 17:54:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:54:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:54:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.common.tests.zip 17:54:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:54:45 INFO - Fetch https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.common.tests.zip into memory 17:54:46 INFO - Content-Length response header: 55342467 17:54:46 INFO - Bytes received: 55342467 17:54:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.talos.tests.zip 17:54:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:54:57 INFO - Fetch https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.talos.tests.zip into memory 17:54:58 INFO - Content-Length response header: 14513823 17:54:58 INFO - Bytes received: 14513823 17:54: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')]} 17:54:58 INFO - trying https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2 17:54:58 INFO - Downloading https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:54:59 INFO - Downloaded 62422160 bytes. 17:55:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2 17:55:00 INFO - mkdir: /builds/slave/test/properties 17:55:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:55:00 INFO - Writing to file /builds/slave/test/properties/build_url 17:55:00 INFO - Contents: 17:55:00 INFO - build_url:https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2 17:55:00 INFO - Running post-action listener: _resource_record_post_action 17:55:00 INFO - Running post-action listener: find_tests_for_verification 17:55:00 INFO - Running post-action listener: set_extra_try_arguments 17:55:00 INFO - [mozharness: 2017-09-26 00:55:00.036644Z] Finished download-and-extract step (success) 17:55:00 INFO - [mozharness: 2017-09-26 00:55:00.036797Z] Running populate-webroot step. 17:55:00 INFO - Running pre-action listener: _resource_record_pre_action 17:55:00 INFO - Running main action method: populate_webroot 17:55:00 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:55:00 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:00 INFO - 'tests': ['tresize', 17:55:00 INFO - 'tcanvasmark']}, 17:55:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:55:00 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:00 INFO - 'tests': ['dromaeo_css', 17:55:00 INFO - 'kraken']}, 17:55:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:55:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:00 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:55:00 INFO - 'talos_options': ['--disable-stylo'], 17:55:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:55:00 INFO - 'tests': ['damp', 'tps']}, 17:55:00 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:55:00 INFO - 'talos_options': ['--disable-stylo'], 17:55:00 INFO - 'tests': ['damp', 'tps']}, 17:55:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:55:00 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:00 INFO - 'tests': ['dromaeo_dom']}, 17:55:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:55:00 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:00 INFO - 'tests': ['basic_compositor_video', 17:55:00 INFO - 'glvideo']}, 17:55:00 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:55:00 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:55:00 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:55:00 INFO - 'talos_options': ['--disable-stylo'], 17:55:00 INFO - 'tests': ['ts_paint_webext', 17:55:00 INFO - 'tp5o_webext']}, 17:55:00 INFO - 'other-e10s': {'tests': ['a11yr', 17:55:00 INFO - 'ts_paint', 17:55:00 INFO - 'tpaint', 17:55:00 INFO - 'sessionrestore', 17:55:00 INFO - 'sessionrestore_many_windows', 17:55:00 INFO - 'sessionrestore_no_auto_restore', 17:55:00 INFO - 'tabpaint']}, 17:55:00 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:00 INFO - 'tests': ['a11yr', 17:55:00 INFO - 'ts_paint', 17:55:00 INFO - 'tpaint', 17:55:00 INFO - 'sessionrestore', 17:55:00 INFO - 'sessionrestore_many_windows', 17:55:00 INFO - 'sessionrestore_no_auto_restore', 17:55:00 INFO - 'tabpaint']}, 17:55:00 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:55:00 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:55:00 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:00 INFO - 'tests': ['perf_reftest_singletons']}, 17:55:00 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:00 INFO - 'tests': ['perf_reftest']}, 17:55:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:55:00 INFO - 'tsvgr_opacity', 17:55:00 INFO - 'tart', 17:55:00 INFO - 'tscrollx', 17:55:00 INFO - 'tsvg_static']}, 17:55:00 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:00 INFO - 'tests': ['tsvgx', 17:55:00 INFO - 'tsvgr_opacity', 17:55:00 INFO - 'tart', 17:55:00 INFO - 'tscrollx', 17:55:00 INFO - 'tsvg_static']}, 17:55:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:55:00 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:55:00 INFO - 'talos_options': ['--disable-stylo'], 17:55:00 INFO - 'tests': ['tp5o']}, 17:55:00 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:55:00 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:55:00 INFO - 'talos_options': ['--mitmproxy', 17:55:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:55:00 INFO - '--firstNonBlankPaint'], 17:55:00 INFO - 'tests': ['tp6_google', 17:55:00 INFO - 'tp6_youtube', 17:55:00 INFO - 'tp6_amazon', 17:55:00 INFO - 'tp6_facebook']}, 17:55:00 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:55:00 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:55:00 INFO - 'talos_options': ['--disable-stylo', 17:55:00 INFO - '--mitmproxy', 17:55:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:55:00 INFO - '--firstNonBlankPaint'], 17:55:00 INFO - 'tests': ['tp6_google', 17:55:00 INFO - 'tp6_youtube', 17:55:00 INFO - 'tp6_amazon', 17:55:00 INFO - 'tp6_facebook']}, 17:55:00 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:55:00 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:55:00 INFO - 'talos_options': ['--stylo-threads=1', 17:55:00 INFO - '--mitmproxy', 17:55:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:55:00 INFO - '--firstNonBlankPaint'], 17:55:00 INFO - 'tests': ['tp6_google', 17:55:00 INFO - 'tp6_youtube', 17:55:00 INFO - 'tp6_amazon', 17:55:00 INFO - 'tp6_facebook']}, 17:55:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:55:00 INFO - 'talos_options': ['--xperf_path', 17:55:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:00 INFO - 'tests': ['tp5n']}, 17:55:00 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:55:00 INFO - 'talos_options': ['--disable-stylo', 17:55:00 INFO - '--xperf_path', 17:55:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:00 INFO - 'tests': ['tp5n']}}} 17:55:00 INFO - Running post-action listener: _resource_record_post_action 17:55:00 INFO - [mozharness: 2017-09-26 00:55:00.054110Z] Finished populate-webroot step (success) 17:55:00 INFO - [mozharness: 2017-09-26 00:55:00.054199Z] Running create-virtualenv step. 17:55:00 INFO - Running pre-action listener: _resource_record_pre_action 17:55:00 INFO - Running main action method: create_virtualenv 17:55:00 INFO - Creating virtualenv /builds/slave/test/build/venv 17:55:00 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:55:00 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:55:00 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:55:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:55:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:55:04 INFO - Installing distribute.............................................................................................................................................................................................done. 17:55:05 INFO - Installing pip...............done. 17:55:05 INFO - Return code: 0 17:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:55:05 INFO - Reading from file tmpfile_stdout 17:55:05 INFO - Output received: 17:55:05 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:55:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:05 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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afd60>, '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 0x27b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ef0>, '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': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', '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 17:55:05 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 17:55:05 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 17:55:05 INFO - Using env: {'DISPLAY': ':0', 17:55:05 INFO - 'HOME': '/home/cltbld', 17:55:05 INFO - 'LANG': 'en_US.UTF-8', 17:55:05 INFO - 'LANGUAGE': 'en_US:en', 17:55:05 INFO - 'LOGNAME': 'cltbld', 17:55:05 INFO - 'MAIL': '/var/mail/cltbld', 17:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:05 INFO - 'MOZ_NO_REMOTE': '1', 17:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:05 INFO - 'NO_EM_RESTART': '1', 17:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:05 INFO - 'PWD': '/builds/slave/test', 17:55:05 INFO - 'SHELL': '/bin/bash', 17:55:05 INFO - 'SHLVL': '1', 17:55:05 INFO - 'TERM': 'linux', 17:55:05 INFO - 'TMOUT': '86400', 17:55:05 INFO - 'USER': 'cltbld', 17:55:05 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', 17:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:05 INFO - '_': '/tools/buildbot/bin/python'} 17:55:06 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:55:06 INFO - Downloading/unpacking pip>=1.5 17:55:06 INFO - Running setup.py egg_info for package pip 17:55:06 INFO - warning: no files found matching 'pip/cacert.pem' 17:55:06 INFO - warning: no files found matching '*.html' under directory 'docs' 17:55:06 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:55:06 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:55:06 INFO - Installing collected packages: pip 17:55:06 INFO - Found existing installation: pip 1.1 17:55:06 INFO - Uninstalling pip: 17:55:06 INFO - Successfully uninstalled pip 17:55:06 INFO - Running setup.py install for pip 17:55:06 INFO - warning: no files found matching 'pip/cacert.pem' 17:55:06 INFO - warning: no files found matching '*.html' under directory 'docs' 17:55:06 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:55:06 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:55:06 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:55:06 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:55:06 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:55:06 INFO - Successfully installed pip 17:55:06 INFO - Cleaning up... 17:55:06 INFO - Return code: 0 17:55:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:55:06 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')]} 17:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:06 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')]} 17:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:06 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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afd60>, '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 0x27b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ef0>, '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': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', '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 17:55:06 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 17:55:06 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 17:55:06 INFO - Using env: {'DISPLAY': ':0', 17:55:06 INFO - 'HOME': '/home/cltbld', 17:55:06 INFO - 'LANG': 'en_US.UTF-8', 17:55:06 INFO - 'LANGUAGE': 'en_US:en', 17:55:06 INFO - 'LOGNAME': 'cltbld', 17:55:06 INFO - 'MAIL': '/var/mail/cltbld', 17:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:06 INFO - 'MOZ_NO_REMOTE': '1', 17:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:06 INFO - 'NO_EM_RESTART': '1', 17:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:06 INFO - 'PWD': '/builds/slave/test', 17:55:06 INFO - 'SHELL': '/bin/bash', 17:55:06 INFO - 'SHLVL': '1', 17:55:06 INFO - 'TERM': 'linux', 17:55:06 INFO - 'TMOUT': '86400', 17:55:06 INFO - 'USER': 'cltbld', 17:55:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', 17:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:06 INFO - '_': '/tools/buildbot/bin/python'} 17:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:07 INFO - Downloading/unpacking psutil>=3.1.1 17:55: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 17:55: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 17:55: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 17:55: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 17:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:55:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:55:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:55:08 INFO - Installing collected packages: psutil 17:55:08 INFO - Running setup.py install for psutil 17:55:08 INFO - building 'psutil._psutil_linux' extension 17:55:08 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 17:55:08 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 17:55:08 INFO - building 'psutil._psutil_posix' extension 17:55:08 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 17:55:08 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 17:55:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:55:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:55:08 INFO - Successfully installed psutil 17:55:08 INFO - Cleaning up... 17:55:08 INFO - Return code: 0 17:55:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:55:08 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')]} 17:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:08 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')]} 17:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:08 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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afd60>, '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 0x27b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ef0>, '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': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', '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 17:55:08 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 17:55:08 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 17:55:08 INFO - Using env: {'DISPLAY': ':0', 17:55:08 INFO - 'HOME': '/home/cltbld', 17:55:08 INFO - 'LANG': 'en_US.UTF-8', 17:55:08 INFO - 'LANGUAGE': 'en_US:en', 17:55:08 INFO - 'LOGNAME': 'cltbld', 17:55:08 INFO - 'MAIL': '/var/mail/cltbld', 17:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:08 INFO - 'MOZ_NO_REMOTE': '1', 17:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:08 INFO - 'NO_EM_RESTART': '1', 17:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:08 INFO - 'PWD': '/builds/slave/test', 17:55:08 INFO - 'SHELL': '/bin/bash', 17:55:08 INFO - 'SHLVL': '1', 17:55:08 INFO - 'TERM': 'linux', 17:55:08 INFO - 'TMOUT': '86400', 17:55:08 INFO - 'USER': 'cltbld', 17:55:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', 17:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:08 INFO - '_': '/tools/buildbot/bin/python'} 17:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:55:08 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 17:55:08 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 17:55:08 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 17:55:08 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 17:55:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:55:10 INFO - Installing collected packages: mozsystemmonitor 17:55:10 INFO - Running setup.py install for mozsystemmonitor 17:55:10 INFO - Successfully installed mozsystemmonitor 17:55:10 INFO - Cleaning up... 17:55:10 INFO - Return code: 0 17:55:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:55: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')]} 17:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55: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')]} 17:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afd60>, '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 0x27b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ef0>, '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': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', '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 17:55: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==2.5.1'] in /builds/slave/test/build 17:55: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==2.5.1 17:55:10 INFO - Using env: {'DISPLAY': ':0', 17:55:10 INFO - 'HOME': '/home/cltbld', 17:55:10 INFO - 'LANG': 'en_US.UTF-8', 17:55:10 INFO - 'LANGUAGE': 'en_US:en', 17:55:10 INFO - 'LOGNAME': 'cltbld', 17:55:10 INFO - 'MAIL': '/var/mail/cltbld', 17:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:10 INFO - 'MOZ_NO_REMOTE': '1', 17:55:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:10 INFO - 'NO_EM_RESTART': '1', 17:55:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:10 INFO - 'PWD': '/builds/slave/test', 17:55:10 INFO - 'SHELL': '/bin/bash', 17:55:10 INFO - 'SHLVL': '1', 17:55:10 INFO - 'TERM': 'linux', 17:55:10 INFO - 'TMOUT': '86400', 17:55:10 INFO - 'USER': 'cltbld', 17:55:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', 17:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:10 INFO - '_': '/tools/buildbot/bin/python'} 17:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:10 INFO - Downloading/unpacking jsonschema==2.5.1 17:55:10 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 17:55:10 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 17:55:10 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 17:55:10 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 17:55:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:55:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:55:11 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 17:55:11 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 17:55:11 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 17:55:11 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 17:55:11 INFO - Downloading functools32-3.2.3-2.tar.gz 17:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:55:11 INFO - warning: no files found matching '*.txt' 17:55:11 INFO - no previously-included directories found matching 'build' 17:55:11 INFO - no previously-included directories found matching 'dist' 17:55:11 INFO - no previously-included directories found matching '.git*' 17:55:11 INFO - Installing collected packages: jsonschema, functools32 17:55:11 INFO - Running setup.py install for functools32 17:55:12 INFO - warning: no files found matching '*.txt' 17:55:12 INFO - no previously-included directories found matching 'build' 17:55:12 INFO - no previously-included directories found matching 'dist' 17:55:12 INFO - no previously-included directories found matching '.git*' 17:55:12 INFO - Successfully installed jsonschema functools32 17:55:12 INFO - Cleaning up... 17:55:12 INFO - Return code: 0 17:55:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:55:12 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')]} 17:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:12 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')]} 17:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:12 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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afd60>, '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 0x27b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ef0>, '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': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', '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 17:55:12 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 17:55:12 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 17:55:12 INFO - Using env: {'DISPLAY': ':0', 17:55:12 INFO - 'HOME': '/home/cltbld', 17:55:12 INFO - 'LANG': 'en_US.UTF-8', 17:55:12 INFO - 'LANGUAGE': 'en_US:en', 17:55:12 INFO - 'LOGNAME': 'cltbld', 17:55:12 INFO - 'MAIL': '/var/mail/cltbld', 17:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:12 INFO - 'MOZ_NO_REMOTE': '1', 17:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:12 INFO - 'NO_EM_RESTART': '1', 17:55:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:12 INFO - 'PWD': '/builds/slave/test', 17:55:12 INFO - 'SHELL': '/bin/bash', 17:55:12 INFO - 'SHLVL': '1', 17:55:12 INFO - 'TERM': 'linux', 17:55:12 INFO - 'TMOUT': '86400', 17:55:12 INFO - 'USER': 'cltbld', 17:55:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', 17:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:12 INFO - '_': '/tools/buildbot/bin/python'} 17:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:55:12 INFO - Cleaning up... 17:55:12 INFO - Return code: 0 17:55:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:55:12 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')]} 17:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:12 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')]} 17:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:12 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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afd60>, '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 0x27b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ef0>, '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': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', '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 17:55:12 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 17:55:12 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 17:55:12 INFO - Using env: {'DISPLAY': ':0', 17:55:12 INFO - 'HOME': '/home/cltbld', 17:55:12 INFO - 'LANG': 'en_US.UTF-8', 17:55:12 INFO - 'LANGUAGE': 'en_US:en', 17:55:12 INFO - 'LOGNAME': 'cltbld', 17:55:12 INFO - 'MAIL': '/var/mail/cltbld', 17:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:12 INFO - 'MOZ_NO_REMOTE': '1', 17:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:12 INFO - 'NO_EM_RESTART': '1', 17:55:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:12 INFO - 'PWD': '/builds/slave/test', 17:55:12 INFO - 'SHELL': '/bin/bash', 17:55:12 INFO - 'SHLVL': '1', 17:55:12 INFO - 'TERM': 'linux', 17:55:12 INFO - 'TMOUT': '86400', 17:55:12 INFO - 'USER': 'cltbld', 17:55:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', 17:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:12 INFO - '_': '/tools/buildbot/bin/python'} 17:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:12 INFO - Downloading/unpacking blobuploader==1.2.4 17:55:12 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 17:55:12 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 17:55:12 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 17:55:12 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 17:55:15 INFO - Downloading blobuploader-1.2.4.tar.gz 17:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:55:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:55:15 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 17:55:15 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 17:55:15 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 17:55:15 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 17:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:55:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:55:15 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 17:55:15 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 17:55:15 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 17:55:15 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 17:55:15 INFO - Downloading docopt-0.6.1.tar.gz 17:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:55:15 INFO - Installing collected packages: blobuploader, requests, docopt 17:55:15 INFO - Running setup.py install for blobuploader 17:55:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:55:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:55:16 INFO - Running setup.py install for requests 17:55:16 INFO - Running setup.py install for docopt 17:55:16 INFO - Successfully installed blobuploader requests docopt 17:55:16 INFO - Cleaning up... 17:55:17 INFO - Return code: 0 17:55:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55:17 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')]} 17:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:17 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')]} 17:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:17 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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afd60>, '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 0x27b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ef0>, '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': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', '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 17:55:17 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 17:55:17 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 17:55:17 INFO - Using env: {'DISPLAY': ':0', 17:55:17 INFO - 'HOME': '/home/cltbld', 17:55:17 INFO - 'LANG': 'en_US.UTF-8', 17:55:17 INFO - 'LANGUAGE': 'en_US:en', 17:55:17 INFO - 'LOGNAME': 'cltbld', 17:55:17 INFO - 'MAIL': '/var/mail/cltbld', 17:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:17 INFO - 'MOZ_NO_REMOTE': '1', 17:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:17 INFO - 'NO_EM_RESTART': '1', 17:55:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:17 INFO - 'PWD': '/builds/slave/test', 17:55:17 INFO - 'SHELL': '/bin/bash', 17:55:17 INFO - 'SHLVL': '1', 17:55:17 INFO - 'TERM': 'linux', 17:55:17 INFO - 'TMOUT': '86400', 17:55:17 INFO - 'USER': 'cltbld', 17:55:17 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', 17:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:17 INFO - '_': '/tools/buildbot/bin/python'} 17:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:55:17 INFO - Running setup.py (path:/tmp/pip-r0VVZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:55:17 INFO - Running setup.py (path:/tmp/pip-OnrrlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:55:17 INFO - Running setup.py (path:/tmp/pip-hxwHDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:55:17 INFO - Running setup.py (path:/tmp/pip-X9BWnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:55:17 INFO - Running setup.py (path:/tmp/pip-o44_vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:55:17 INFO - Running setup.py (path:/tmp/pip-GpTkxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:55:17 INFO - Running setup.py (path:/tmp/pip-dqmBYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:55:17 INFO - Running setup.py (path:/tmp/pip-p767g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:55:17 INFO - Running setup.py (path:/tmp/pip-XsqMyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:55:17 INFO - Running setup.py (path:/tmp/pip-bSuGNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:55:18 INFO - Running setup.py (path:/tmp/pip-87EmZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:55:18 INFO - Running setup.py (path:/tmp/pip-xEexPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:55:18 INFO - Running setup.py (path:/tmp/pip-Wri8oU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:55:18 INFO - Running setup.py (path:/tmp/pip-pJJ28g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:18 INFO - Running setup.py (path:/tmp/pip-GpFjf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:55:18 INFO - Running setup.py (path:/tmp/pip-eMM3c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:55:18 INFO - Running setup.py (path:/tmp/pip-iRuMYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:55:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:55:18 INFO - Running setup.py install for manifestparser 17:55:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:55:18 INFO - Running setup.py install for mozcrash 17:55:18 INFO - Running setup.py install for mozdebug 17:55:18 INFO - Running setup.py install for mozdevice 17:55:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:55:18 INFO - Running setup.py install for mozfile 17:55:19 INFO - Running setup.py install for mozhttpd 17:55:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:55:19 INFO - Running setup.py install for mozinfo 17:55:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:55:19 INFO - Running setup.py install for mozInstall 17:55:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:55:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:55:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:55:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:55:19 INFO - Running setup.py install for mozleak 17:55:19 INFO - Running setup.py install for mozlog 17:55:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:55:19 INFO - Running setup.py install for moznetwork 17:55:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:55:19 INFO - Running setup.py install for mozprocess 17:55:19 INFO - Running setup.py install for mozprofile 17:55:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:55:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:55:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:55:19 INFO - Running setup.py install for mozrunner 17:55:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:55:19 INFO - Running setup.py install for mozscreenshot 17:55:20 INFO - Running setup.py install for moztest 17:55:20 INFO - Running setup.py install for mozversion 17:55:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:55:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:55:20 INFO - Cleaning up... 17:55:20 INFO - Return code: 0 17:55:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:20 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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afd60>, '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 0x27b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ef0>, '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': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', '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 17:55:20 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 17:55:20 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 17:55:20 INFO - Using env: {'DISPLAY': ':0', 17:55:20 INFO - 'HOME': '/home/cltbld', 17:55:20 INFO - 'LANG': 'en_US.UTF-8', 17:55:20 INFO - 'LANGUAGE': 'en_US:en', 17:55:20 INFO - 'LOGNAME': 'cltbld', 17:55:20 INFO - 'MAIL': '/var/mail/cltbld', 17:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:20 INFO - 'MOZ_NO_REMOTE': '1', 17:55:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:20 INFO - 'NO_EM_RESTART': '1', 17:55:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:20 INFO - 'PWD': '/builds/slave/test', 17:55:20 INFO - 'SHELL': '/bin/bash', 17:55:20 INFO - 'SHLVL': '1', 17:55:20 INFO - 'TERM': 'linux', 17:55:20 INFO - 'TMOUT': '86400', 17:55:20 INFO - 'USER': 'cltbld', 17:55:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', 17:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:20 INFO - '_': '/tools/buildbot/bin/python'} 17:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:55:20 INFO - Running setup.py (path:/tmp/pip-SB9J4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:55:20 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)) 17:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:55:20 INFO - Running setup.py (path:/tmp/pip-1WB7K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:55:20 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)) 17:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:55:20 INFO - Running setup.py (path:/tmp/pip-j2Dg9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:55:20 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)) 17:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:55:20 INFO - Running setup.py (path:/tmp/pip-gXbWjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:55:20 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)) 17:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:55:20 INFO - Running setup.py (path:/tmp/pip-fUqvHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:55:20 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)) 17:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:55:20 INFO - Running setup.py (path:/tmp/pip-wiavsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:55:20 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)) 17:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:55:20 INFO - Running setup.py (path:/tmp/pip-Czarwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:55:20 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)) 17:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:55:20 INFO - Running setup.py (path:/tmp/pip-oROOUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:55:21 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)) 17:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:55:21 INFO - Running setup.py (path:/tmp/pip-ZIuiYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:55:21 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)) 17:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:55:21 INFO - Running setup.py (path:/tmp/pip-xxjimj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:55:21 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)) 17:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:55:21 INFO - Running setup.py (path:/tmp/pip-lkkZyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:55:21 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)) 17:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:55:21 INFO - Running setup.py (path:/tmp/pip-eKFpEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:55:21 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)) 17:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:55:21 INFO - Running setup.py (path:/tmp/pip-0f_Yb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:55:21 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)) 17:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:55:21 INFO - Running setup.py (path:/tmp/pip-FVpnXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:55:21 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)) 17:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:21 INFO - Running setup.py (path:/tmp/pip-yw7BWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:21 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)) 17:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:55:21 INFO - Running setup.py (path:/tmp/pip-sQYYmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:55:21 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)) 17:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:55:21 INFO - Running setup.py (path:/tmp/pip-iO4JEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:55:21 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)) 17:55:21 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)) 17:55:21 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)) 17:55:21 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)) 17:55:21 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)) 17:55:21 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)) 17:55:21 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)) 17:55:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:55:21 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 17:55:21 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 17:55:21 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 17:55:21 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 17:55:22 INFO - Downloading blessings-1.6.tar.gz 17:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:55:22 INFO - Installing collected packages: blessings 17:55:22 INFO - Running setup.py install for blessings 17:55:23 INFO - Successfully installed blessings 17:55:23 INFO - Cleaning up... 17:55:23 INFO - Return code: 0 17:55:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:55:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:55:23 INFO - Reading from file tmpfile_stdout 17:55:23 INFO - Current package versions: 17:55:23 INFO - argparse == 1.2.1 17:55:23 INFO - blessings == 1.6 17:55:23 INFO - blobuploader == 1.2.4 17:55:23 INFO - docopt == 0.6.1 17:55:23 INFO - functools32 == 3.2.3-2 17:55:23 INFO - jsonschema == 2.5.1 17:55:23 INFO - manifestparser == 1.1 17:55:23 INFO - mozInstall == 1.13 17:55:23 INFO - mozcrash == 1.0 17:55:23 INFO - mozdebug == 0.1 17:55:23 INFO - mozdevice == 0.51 17:55:23 INFO - mozfile == 1.2 17:55:23 INFO - mozhttpd == 0.7 17:55:23 INFO - mozinfo == 0.10 17:55:23 INFO - mozleak == 0.1 17:55:23 INFO - mozlog == 3.5 17:55:23 INFO - moznetwork == 0.27 17:55:23 INFO - mozprocess == 0.25 17:55:23 INFO - mozprofile == 0.28 17:55:23 INFO - mozrunner == 6.13 17:55:23 INFO - mozscreenshot == 0.1 17:55:23 INFO - mozsystemmonitor == 0.3 17:55:23 INFO - moztest == 0.8 17:55:23 INFO - mozversion == 1.4 17:55:23 INFO - psutil == 3.1.1 17:55:23 INFO - requests == 1.2.3 17:55:23 INFO - wsgiref == 0.1.2 17:55:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:23 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 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afd60>, '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 0x27b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ef0>, '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': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', '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 17:55:23 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 17:55:23 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 17:55:23 INFO - Using env: {'DISPLAY': ':0', 17:55:23 INFO - 'HOME': '/home/cltbld', 17:55:23 INFO - 'LANG': 'en_US.UTF-8', 17:55:23 INFO - 'LANGUAGE': 'en_US:en', 17:55:23 INFO - 'LOGNAME': 'cltbld', 17:55:23 INFO - 'MAIL': '/var/mail/cltbld', 17:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:23 INFO - 'MOZ_NO_REMOTE': '1', 17:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:23 INFO - 'NO_EM_RESTART': '1', 17:55:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:23 INFO - 'PWD': '/builds/slave/test', 17:55:23 INFO - 'SHELL': '/bin/bash', 17:55:23 INFO - 'SHLVL': '1', 17:55:23 INFO - 'TERM': 'linux', 17:55:23 INFO - 'TMOUT': '86400', 17:55:23 INFO - 'USER': 'cltbld', 17:55:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', 17:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:23 INFO - '_': '/tools/buildbot/bin/python'} 17:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:23 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)) 17:55:23 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)) 17:55:23 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)) 17:55:23 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)) 17:55:23 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)) 17:55:23 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)) 17:55:23 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)) 17:55:23 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)) 17:55:23 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)) 17:55:23 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:55:23 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 17:55:23 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 17:55:23 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 17:55:23 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 17:55:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:55:24 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)) 17:55:24 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)) 17:55:24 INFO - Installing collected packages: simplejson 17:55:24 INFO - Running setup.py install for simplejson 17:55:24 INFO - building 'simplejson._speedups' extension 17:55:24 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 17:55:25 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 17:55:25 INFO - Successfully installed simplejson 17:55:25 INFO - Cleaning up... 17:55:25 INFO - Return code: 0 17:55:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27afd60>, '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 0x27b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ef0>, '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': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', '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 17:55:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:55:25 INFO - Using env: {'DISPLAY': ':0', 17:55:25 INFO - 'HOME': '/home/cltbld', 17:55:25 INFO - 'LANG': 'en_US.UTF-8', 17:55:25 INFO - 'LANGUAGE': 'en_US:en', 17:55:25 INFO - 'LOGNAME': 'cltbld', 17:55:25 INFO - 'MAIL': '/var/mail/cltbld', 17:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:25 INFO - 'MOZ_NO_REMOTE': '1', 17:55:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:25 INFO - 'NO_EM_RESTART': '1', 17:55:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:25 INFO - 'PWD': '/builds/slave/test', 17:55:25 INFO - 'SHELL': '/bin/bash', 17:55:25 INFO - 'SHLVL': '1', 17:55:25 INFO - 'TERM': 'linux', 17:55:25 INFO - 'TMOUT': '86400', 17:55:25 INFO - 'USER': 'cltbld', 17:55:25 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', 17:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:25 INFO - '_': '/tools/buildbot/bin/python'} 17:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:55:25 INFO - Cleaning up... 17:55:25 INFO - Return code: 0 17:55:25 INFO - Running post-action listener: _resource_record_post_action 17:55:25 INFO - Running post-action listener: _start_resource_monitoring 17:55:25 INFO - Starting resource monitoring. 17:55:25 INFO - [mozharness: 2017-09-26 00:55:25.978611Z] Finished create-virtualenv step (success) 17:55:25 INFO - [mozharness: 2017-09-26 00:55:25.979127Z] Running install step. 17:55:25 INFO - Running pre-action listener: _resource_record_pre_action 17:55:25 INFO - Running main action method: install 17:55:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:55:26 INFO - Reading from file tmpfile_stdout 17:55:26 INFO - Detecting whether we're running mozinstall >=1.0... 17:55:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:55:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:55:26 INFO - Reading from file tmpfile_stdout 17:55:26 INFO - Output received: 17:55:26 INFO - Usage: mozinstall [options] installer 17:55:26 INFO - Options: 17:55:26 INFO - -h, --help show this help message and exit 17:55:26 INFO - -d DEST, --destination=DEST 17:55:26 INFO - Directory to install application into. [default: 17:55:26 INFO - "/builds/slave/test"] 17:55:26 INFO - --app=APP Application being installed. [default: firefox] 17:55:26 INFO - mkdir: /builds/slave/test/build/application 17:55:26 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'] 17:55:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:55:43 INFO - Reading from file tmpfile_stdout 17:55:43 INFO - Output received: 17:55:43 INFO - /builds/slave/test/build/application/firefox/firefox 17:55:43 INFO - Running post-action listener: _resource_record_post_action 17:55:43 INFO - [mozharness: 2017-09-26 00:55:43.963191Z] Finished install step (success) 17:55:43 INFO - [mozharness: 2017-09-26 00:55:43.963529Z] Running setup-mitmproxy step. 17:55:43 INFO - Running pre-action listener: _resource_record_pre_action 17:55:43 INFO - Running main action method: setup_mitmproxy 17:55:43 INFO - Skipping: mitmproxy is not required 17:55:43 INFO - Running post-action listener: _resource_record_post_action 17:55:43 INFO - [mozharness: 2017-09-26 00:55:43.965200Z] Finished setup-mitmproxy step (success) 17:55:43 INFO - [mozharness: 2017-09-26 00:55:43.965516Z] Running run-tests step. 17:55:43 INFO - Running pre-action listener: _resource_record_pre_action 17:55:43 INFO - Running pre-action listener: _set_gcov_prefix 17:55:43 INFO - Running main action method: run_tests 17:55:43 WARNING - Try message not found. 17:55:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:55:43 INFO - Python 2.7.3 17:55:43 INFO - Return code: 0 17:55:43 INFO - grabbing minidump binary from tooltool 17:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:43 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 0x27afd60>, '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 0x27b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b0ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:55:43 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 17:55:43 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 17:55:43 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 17:55:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:55:44 INFO - Return code: 0 17:55:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:55:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:55:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:55:44 INFO - ENV: RUST_BACKTRACE is now full 17:55:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:55:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:55:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 17:55:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 17:55:44 INFO - Using env: {'DISPLAY': ':0', 17:55:44 INFO - 'HOME': '/home/cltbld', 17:55:44 INFO - 'LANG': 'en_US.UTF-8', 17:55:44 INFO - 'LANGUAGE': 'en_US:en', 17:55:44 INFO - 'LOGNAME': 'cltbld', 17:55:44 INFO - 'MAIL': '/var/mail/cltbld', 17:55:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:55:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:44 INFO - 'MOZ_NO_REMOTE': '1', 17:55:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:55:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:44 INFO - 'NO_EM_RESTART': '1', 17:55:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:44 INFO - 'PWD': '/builds/slave/test', 17:55:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:55:44 INFO - 'RUST_BACKTRACE': 'full', 17:55:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:55:44 INFO - 'SHELL': '/bin/bash', 17:55:44 INFO - 'SHLVL': '1', 17:55:44 INFO - 'TERM': 'linux', 17:55:44 INFO - 'TMOUT': '86400', 17:55:44 INFO - 'USER': 'cltbld', 17:55:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', 17:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:44 INFO - '_': '/tools/buildbot/bin/python'} 17:55:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 17:55:44 INFO - mozversion application_buildid: 20170925232538 17:55:44 INFO - mozversion application_changeset: 641bfddb87113b45ee3df9849345dbcf821ef3da 17:55:44 INFO - mozversion application_display_name: Nightly 17:55:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:55:44 INFO - mozversion application_name: Firefox 17:55:44 INFO - mozversion application_remotingname: firefox 17:55:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:55:44 INFO - mozversion application_vendor: Mozilla 17:55:44 INFO - mozversion application_version: 58.0a1 17:55:44 INFO - mozversion platform_buildid: 20170925232538 17:55:44 INFO - mozversion platform_changeset: 641bfddb87113b45ee3df9849345dbcf821ef3da 17:55:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:55:44 INFO - mozversion platform_version: 58.0a1 17:55:44 INFO - using testdate: 1506387344 17:55:44 INFO - actual date: 1506387344 17:55:44 INFO - starting webserver on 'localhost:59957' 17:55:44 INFO - SUITE-START | Running 2 tests 17:55:44 INFO - TEST-START | dromaeo_css 17:55:44 INFO - Initialising browser for dromaeo_css test... 17:55:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59957/getInfo.html -profile /tmp/tmpoqNPTt/profile 17:55:44 INFO - TEST-INFO | started process 5809 (/builds/slave/test/build/application/firefox/firefox http://localhost:59957/getInfo.html) 17:55:51 INFO - TEST-INFO | 5809: exit 0 17:55:51 INFO - Browser initialized. 17:55:51 INFO - Running cycle 1/1 for dromaeo_css test... 17:55:51 INFO - Using env: {'DISPLAY': ':0', 17:55:51 INFO - 'HOME': '/home/cltbld', 17:55:51 INFO - 'JSGC_DISABLE_POISONING': '1', 17:55:51 INFO - 'LANG': 'en_US.UTF-8', 17:55:51 INFO - 'LANGUAGE': 'en_US:en', 17:55:51 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:55:51 INFO - 'LOGNAME': 'cltbld', 17:55:51 INFO - 'MAIL': '/var/mail/cltbld', 17:55:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:55:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:55:51 INFO - 'MOZ_CRASHREPORTER': '1', 17:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:51 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:55:51 INFO - 'MOZ_NO_REMOTE': '1', 17:55:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:51 INFO - 'NO_EM_RESTART': '1', 17:55:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:51 INFO - 'PWD': '/builds/slave/test', 17:55:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:55:51 INFO - 'RUST_BACKTRACE': 'full', 17:55:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:55:51 INFO - 'SHELL': '/bin/bash', 17:55:51 INFO - 'SHLVL': '1', 17:55:51 INFO - 'TERM': 'linux', 17:55:51 INFO - 'TMOUT': '86400', 17:55:51 INFO - 'USER': 'cltbld', 17:55:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', 17:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:51 INFO - '_': '/tools/buildbot/bin/python'} 17:55:51 INFO - TEST-INFO | started process 6044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoqNPTt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:55:52 INFO - PID 6044 | 17:55:52 INFO - PID 6044 | (/builds/slave/test/build/application/firefox/firefox:6093): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:55:52 INFO - PID 6044 | 17:56:02 INFO - PID 6044 | RSS: Main: 141479936 17:56:02 INFO - PID 6044 | 17:59:00 INFO - PID 6044 | Cycle 1(1): loaded http://localhost:59957/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59957/tests/dromaeo/cssquery-ext.html) 17:59:01 INFO - PID 6044 | RSS: Main: 146837504 17:59:01 INFO - PID 6044 | 18:02:02 INFO - PID 6044 | Cycle 1(1): loaded http://localhost:59957/tests/dromaeo/cssquery-ext.html (next: http://localhost:59957/tests/dromaeo/cssquery-jquery.html) 18:02:03 INFO - PID 6044 | RSS: Main: 146489344 18:02:03 INFO - PID 6044 | 18:05:05 INFO - PID 6044 | Cycle 1(1): loaded http://localhost:59957/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59957/tests/dromaeo/cssquery-mootools.html) 18:05:05 INFO - PID 6044 | RSS: Main: 148627456 18:05:05 INFO - PID 6044 | 18:08:07 INFO - PID 6044 | Cycle 1(1): loaded http://localhost:59957/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59957/tests/dromaeo/cssquery-prototype.html) 18:08:07 INFO - PID 6044 | RSS: Main: 147685376 18:08:07 INFO - PID 6044 | 18:11:11 INFO - PID 6044 | Cycle 1(1): loaded http://localhost:59957/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59957/tests/dromaeo/cssquery-yui.html) 18:11:11 INFO - PID 6044 | RSS: Main: 148656128 18:11:11 INFO - PID 6044 | 18:14:13 INFO - PID 6044 | Cycle 1(1): loaded http://localhost:59957/tests/dromaeo/cssquery-yui.html (next: http://localhost:59957/tests/dromaeo/cssquery-dojo.html) 18:14:13 INFO - PID 6044 | RSS: Main: 150937600 18:14:13 INFO - PID 6044 | 18:14:13 INFO - PID 6044 | __start_tp_report 18:14:13 INFO - PID 6044 | _x_x_mozilla_page_load 18:14:13 INFO - PID 6044 | _x_x_mozilla_page_load_details 18:14:13 INFO - PID 6044 | |i|pagename|runs| 18:14:13 INFO - PID 6044 | |0;dojo.html;3896.8441262349506;3923.901902452438;3925.6466917977377;3929.744566603169;3935.90160245994;6161.537884658657;6269.655168965705;6337.904931426026;6349.809505714836;6403.551751377406;6342.714577843996;6343;6369.554131210817;6387.936120638792;6393.488520918327;5614.438556144373;5641.097424412095;5665.971670141644;5736.483716465517;5742.827715168552;5555.2778138842095;5608.85977850555;5629.831105066834;5670.829875103733;5731.885362292773;5524.723763811793;5626.774929002835;5701.857453563653;5709.6574205547595;5750.252467179282;5634.1830434586755;5655.4344565543115;5690.2033715279895;5725.055365864628;5732.254806875079;5627.071533197018;5628.0713682242385;5657.547396208293;5693.658380497183;5702.0021496238;6234;6272.529560282997;6313.210848643919;6324.620522768649;6327.936720632827;6846.315368463163;6849.863002739967;6853.17761868579;6856.588604683685;6866.519343645947;6826.146731658543;6866.828329291758;6868.896966545506;6949.131358580177;6968.3728464438445;6340.682965851689;6364.554481186319;6400.327965563642;6445.484361251089;6452.64510451925;7068.540544864567;7107.928920710727;7137.893626487903;7141.642917854087;7180.712771489187;6727.798166055026;6805.421539169127;6859.725610975505;6892.000659904386;6910;6832.760853370109;6902.102726645604;6943.51395402317;6958.686859091353;7062.752803651848;6862.451003919675;6899.206591241971;6906.482013848981;6922.169339679271;6925.826854328682;6829.317068293131;6841.521093523505;6845.589264644137;6934.133233345832;6956.930430695729;4906.803727850917;4975.353204083446;4981.42713587942;5081.517255860687;5083.059633967728;4519.096180763795;4576.679632425765;4616.722996620214;4621.376114224537;4643.210654188796;6372.553921225563;6394.744210231539;6406.967965160145;6429.7461994910545;6453.709583068773;6794.3545363190415;6819.386255236953;6820.522563420612;6919.827004324831;6924.272951340137;6402.551821372459;6454.838629034218;6465.935340646627;6473.805785826433;6483.059956306403;5538.363088244822;5600.383957764642;5613.298337707786;5616.719164041781;5619.971900140473;7125.42996560274;7136.964315178495;7144.214136444987;7221.205667376585;7241.131064272216;6762.898556521558;6818.93181068183;6842.042114104129;6844.2129155147795;6913.5506192097355;7156.427485801228;7195.82010449722;7227.205007449282;7243.384312333511;7247.347738703542;6801.625910574768;6802.897956530557;6823.351781580742;6836.316368363124;6933.341332573397;6755.966220168868;6839.89740153908;6855;6877.105976223259;6965;6669.066330713801;6693.364130407604;6701.430378417889;6710.932890671226;6729.2934241903895;6615.239247486408;6635.469162466895;6636.070950066898;6728.7981360557305;6736.393724564617;6499.122618446449;6505.642189679613;6590.209174899042;6592.077109204811;6598.736050557924;6653.567518111307;6700.229473610597;6781.593104413751;6782.25395206517;6800.489963252677;6446.258680251643;6494.6103233806125;6524.739010439529;6578.079068930258;6587.505937054644 18:14:13 INFO - PID 6044 | |1;ext.html;953.5756588318197;960.7742180587561;985.275822270631;1008.8537162111498;1010.5806090472454;44118.77940610296;45220.3216951746;45256.547434525724;45272.54727452724;45301;41882.58117418825;42296;42554;42558.787206064;42605.78697106518;7656.770296891103;7758.495697779655;7758.844823103563;7768.728094516693;7778;7737.883931741028;7746.883796743054;7830.451868369188;7831.804204894866;7833.764987050397;8433.620487078097;8655.870161947576;8658.264047555966;8663.653453861838;8665.480071195718;8553;8623.051464338949;8626.65493380264;8627.482351058956;8628.913710862873;8063;8300.7094751684;8318.12659670738;8399.790005249857;8439;41301;41752.79123604393;41765.37351939723;41798.1640367194;41817.37273940894;3655;3666.1201311685004;3670.926581468356;3673.3938900081453;3703.3889408247605;33040.83479582611;33198;33304.3339133216;33342.6665733342;33371;5394.298741163663;5401.513863752242;5419.674819510842;5428.9185662215095;5442.401335853053;220219;220296;221417;221570;221874;53695;53778.731106345;53853.73073134609;53948.46051539434;53955;56394.43605563974;56430;56491;56705.71647141738;56732.43267567272;16830.242639081273;17278.568035799206;17279.827201728072;17293.65412691764;17304.307827687004;14092.295385230698;14103.0832995857;14119.505817296345;14142.575722728334;14212.360443780055;15235.085894846123;15445.922770386076;15479.148646824307;15535.84464155344;15611.453599123975;6186.381361863868;6203.7828675996125;6206.317305096436;6257.9687101564205;6348.714307856158;1080.4111759091313;1091.9727006824894;1093;1097.939613321259;1099.7525556749667;25166.370840728763;25495.23514294574;25617.359566011;25694.35764105875;25782.48435031289;1198.1493139870615;1203.422357268516;1211.6425654431964;1214.6598952293373;1231.1443546734934;13354.198748075147;13441.72303631173;13492.460301587827;13641.931790340985;13718.657033574042;261370;263266;264193;264764;264806;50644;51254.23118653223;56519;56930;58758.4124158753;1538.7537993921144;1546.327347603796;1546.4278217059534;1552.2859484637193;1559.485369827954;30516;30870;31113.222169445944;31142.065738027897;31318;37739;37909.431358529095;42010.579894200666;42101;42130;230926;231974;232166;232588;232639;37794.81102594469;37807;37987.620123798406;38170.42744358781;38400.80799595984;47608;47633.523664762906;47837.52162478331;47851.76074119607;47854.760726196146;35064.82467587748;35310.29379412449;35498.29003419969;35665.46501802423;35894.82052589825;35309;35373.292534148655;35715.82142089273;35751.46372804462;36305;40348;40882;41430;41588.79205603953;41632.583674162874;33556.83221583877;34415.82792086023;34573.827130864185;34759;34763.65236347706;25294.668100186685;25555.616665749658;25684;25733.35666608275;26423.735762642897 18:14:13 INFO - PID 6044 | |2;jquery.html;627.4447114303842;638.6423602782443;647.4011539326123;650.3269116464458;650.6714109374765;22176.77823221767;22749.772502274995;23253.30240092798;23387.415314617123;23567.29298121059;24910.12814551491;26008.21975340743;26043.348916277104;26047.739522604767;26078.478430431427;6545.443637290824;6724.293949135344;6727.360900714424;6728.6635668216395;6737.764178253762;6460.321666225049;6583.308752580958;6701.966490167542;6726.932730672704;6738.090357801708;6669.399754022137;6670.599764014175;6681.966590167042;6686.665666716669;6689.498287628423;6554.344565543455;6649.5677780944325;6649.667516624174;6661.233958094808;6819.965900170517;6342.968285158545;6367.172267605181;6378.68106594673;6412.93587064128;6435.871282574369;28745.137645870658;28892.71107288921;29021.274468138254;29250.853745731136;29272.41455170906;2264.298067599033;2316.8262380321544;2320.2575175943703;2320.7331156917003;2321.025169428844;19642.410727678194;20096.296629617893;20478.18087276507;20571.177152914017;20666.48333791652;2546.2870396289068;2551.1708694674303;2566.3455818766097;2582.780463660591;2628.4348864994117;130249;135246;153651;158342;159428.40571594253;15588.220588970733;15885.602859928595;15904.602384940468;15948.920255398649;16747.665046699243;25648.102316418837;25651.486970260492;25710.228693139237;25715;25770;10842.94578527118;10868.72828179286;10893.440041590378;10921.836172457419;10968.945155274172;9922.900770992343;9957.0540798624;9963.356046252433;10116.494175291205;10173.084422401871;9589.90410095904;9639.807203855884;9656.27577931658;9761.07269809367;9793.363431376938;2849.7435230829324;2868.3116052147334;2974.9107526774233;3004.9032103282143;3094.133642580081;1016.872890888639;1043.0977204717865;1044.2481413382352;1045.2056437107854;1047.5757318286107;20753.169873204904;20794.376168714964;20895.8955205223;21074.946252687612;21695;1096.5394534295615;1102.5755084292605;1106.1261603333276;1110.722319420145;1124.2523721725124;11633.069354451623;11790.351530665725;11830;11856.407179640983;12034.699132521582;557138;558392;559322;563898;566650;117874.41062794632;118750.4062479682;119314;121174;121677.39161304313;1204.1209916760813;1205.3551350027692;1232.7904256276454;1237.2761934268553;1248.912576119681;18472;18584.44246672602;18651.253949841856;19061.046947652285;19250.903745481184;60231.09653355116;61166;62347.6882615584;62673.37326626858;63745;73257.63371183323;73497.6325118371;74977;77942;79145.60427197827;15058.623534411727;15510.767338489706;15543;15557.45548905783;15564.066156030674;23114.537709245385;23253.302400927998;23546.646800297665;23717.288481345586;23728.644070338614;19333.226670933003;19583.216671332986;19593.118309675814;19664.803351966868;19741.01294935219;16957.32170713207;17307.221175047405;17320.480385588453;17777.20002599912;17779.28882844672;19238.23047078101;19717.605647886674;19970.90014549918;20035.59928801445;20115.698264526338;15329.156896370807;15341.693166136838;15428.460003899809;15438;15446.84553154499;18638.34765783191;18712.532186694898;18768.155433005275;18920.621587568447;19421.902890485457 18:14:13 INFO - PID 6044 | |3;mootools.html;1414.6109819799553;1468.4360659804042;1478.6007777899968;1481.5111013365588;1486.123187319482;16478.505644830646;17223.82776172238;17238.913805430988;17263.39578114766;17263.39578114766;16642.334306627752;16778.244978975945;16791.32834686611;16817.663646727087;16878;2881.726236007581;2909.752671022955;2916.8979085732003;2921.9123426297247;2927.312081660808;2746.0663374452683;2838.1627419911074;2859.6139521164587;2861.2274685834814;2873.9856300718466;2748.4640495103463;2844.4737723521216;2845;2845.0611298271624;2845.985770071147;2828.1798278499314;2871.052552657618;2889.609902663145;2898.0581311073984;2903.3467469819334;2807.5227211374117;2811.8031737778365;2814.282357998697;2826.915192544227;2826.9575956360673;16379.59051023722;16726.24731887068;16748.83251167485;16754.497365079067;16770.916145419316;8708.390412671115;9000.189982901506;9073.500957447337;9075.546222688905;9080.091990800933;5135.3067335909545;5270.288511050997;5442.863928401822;5445.1832225166545;5547.805826796042;2047.5085979364994;2062.9484262893397;2069.772325044244;2129.212191489159;2131.818795402393;30210.244743881358;30608.54087188694;30690;30755;30820;7212.386947109554;7240.239774823568;7296.270372962661;7371.262873712586;7414.221506741715;19703.802961970196;19868.50328741793;19901.701474477893;19922.103505342293;19922.90038549798;8368.832623347498;8423.284020858173;8680.045195028542;8688.695895643623;8692.739217823475;7894.723684671124;7921.207879212148;7933.444658873824;7999.320057795153;8138.226868447488;5693.28833895763;5740.569457290637;5773.507028247934;5869.4717475427415;5905.734241959122;1535.6851845371673;1569.7488401855649;1687.2576066530687;1696.3638635511684;1735.2798588585595;967.5307475874196;969.3795970578835;979.0307595480565;991.8859331176862;995.5569771451779;8571.914280857236;8578.485290882567;8671.739847804576;8761.036286008533;8787.780305492413;1038.3199004651965;1039.4802598700649;1042.11940909931;1044.9895501045044;1046.7801761629992;5121.411037730709;5166.405863325691;5264.973675131677;5279.049771041173;5301.257823904656;24860.627090593654;25924.351891202492;25990.480190396465;26030.219093427226;26127.346816329744;24083.638745418833;25372.492550148894;25622.487550249265;25747.227583172535;25756.871215644176;12771.36143192818;12784.296863672587;12849.871501284868;12853.678658033625;12929.482820687255;9429.811403772022;9628.566714497725;9708.805823883624;9737;9779.070988256104;19693.721135410397;20678;20777.896110519352;21295.46761330917;21723.13107475683;21977.890110549346;22356.88821555947;22545.774542254367;22715.88642056845;22917.54164916726;12104.394780261127;12509.124361294986;12550.748985020431;12678.746425071262;12686.746265074462;14941.402343906557;14943.85056149468;15022.774658380351;15182.013169143971;15213.695726085638;11996.520139194334;12391.070669699628;12927.418266178232;13113.541026064042;13340.132891362031;12359.32023738703;12398.876011239772;12499.12506124599;12788.296643684687;12796.488140474277;10916.345019298868;11022.669319920415;11031.944840275748;11080.778384432428;11118;8626.870596941177;8668;8682.913170868464;8711.91288087111;8742.56287185651;8465.788355291166;8616.78458038554;8623.568821559022;8633.223009929137;8646.092160323076 18:14:13 INFO - PID 6044 | |4;prototype.html;546.5764032874524;561.8707697229637;578.482258378751;581.5405829394778;589.7346194212605;6230.501559875211;6293.30773614902;6313.873722525546;6322.209723784527;6387.169667943161;6217.813465596028;6222.533310001745;6226.723521678056;6240.500759939206;6308.211473565804;4912.484189160123;5121.180611102224;5145.897082058366;5149.76826042829;5167.48325167484;4936.679115857476;4974.403071631409;4977.601791856661;5013;5014.598832093442;4995.550400463958;5019.196928491442;5025.773840177201;5048;5057.216131499605;4931.753412329387;5009.44896061433;5016.949830501703;5026.924596131061;5044.571211447032;4532.32015197723;4583.472900616405;4597.287420449836;4601.401817763703;4631.698939568917;6183;6246.437820596123;6264.373562643745;6274.717637706314;6316.115743795872;5828.6211396259105;5849.707514624251;5861.120831875211;5876.647401155944;5905.173275741399;6689;6712.563683360615;6729.93270067298;6747.886598711207;6755.358240967149;4857.902841943177;5070.949290507085;5094.700851282936;5099.770510327045;5120.15517439622;6807.65961701913;6854.9657251713925;6948.6525673716615;6967;7013.403860671849;5261.921071183935;5269.657472264291;5274;5280.102382594968;5283.392409872914;5307.681539107666;5308.893822123536;5332.146856503018;5346.278252435872;5364.517193452608;5866.618669786536;5869.442402971711;5896.587238893237;5898.292204935436;5901.232839730807;6600.537962342686;6668;6732.528722989442;6761.628110453874;6774;1828.9359872404402;1835.476889086604;1836.1828986101325;1847.9353222637144;1862.1992543206552;1257.666718319646;1297.1374036265966;1298.5065675043422;1315.2966907854352;1322.4247452358254;6026.397360263939;6107.572469927062;6159.550651635099;6172.537059720539;6232.781852635136;6684.465242780566;6765.966170169216;6801.897971530431;6810.62541560219;6838;6304.117423560705;6312.24253089623;6328.968355158195;6343.904841427382;6358.300586935434;3547.822608869546;3559.661832125944;3587.587427445877;3589.174489867345;3626.1297288650535;6942.965285173643;6947.9156253123865;6987.336203060701;7003.929960700328;7035.226125126232;6724.495662825308;6799.694013769392;6836.58980461164;6853.383195512328;6884.380405763405;6879.557756996194;6914.446844252448;6936.79189624312;6959.860802784017;7045.225025247219;6590.275069742421;6612.437942774918;6665.833728978696;6735.25912149673;6741.853884839491;6593.967030164818;6642.734290628321;6651.434628056476;6703.966480167568;6705.19537655465;6942.2363540011565;7025.71431426819;7071.752488663078;7091.510782735683;7112.217656057933;5242.16125419931;5250.868728281824;5263.078961181702;5268.315119034501;5269.420363759907;6512.185976752906;6632.767853125118;6651.900221496779;6672.165979252593;6697.296783837822;6315.515853774267;6429.360513069138;6482.319356467503;6521.445677117498;6586;6518.837029074121;6576.506761992774;6625.602463851991;6627.900581491378;6634.369734875179;6347.111404403479;6407.8718425630295;6417.518686098655;6423.807285781434;6446.903296450463;6652.700628471827;6677.966610166918;6700.731970721312;6716.496262780213;6751.864962700817;6380.266269379081;6437.5171862111465;6464.806055818333;6512.511561632802;6529.771457998947 18:14:13 INFO - PID 6044 | |5;yui.html;985.4333758089099;987.4914419074178;989.1641562879369;1005.2561104782463;1015.695291412576;22930.426739331524;24087.518249634995;25530.744692553068;25569.10508132216;25596.61605075923;23370.415739606477;23624.40938976522;23776.76223237767;23957.880210598923;23987.52024959504;1038.875334959804;1070.1011150633467;1071.036067539213;1076.2251179150999;1083.3445765311951;1039.7660526381578;1085.468120620894;1085.723140599146;1088.5917780832187;1099.2030777686193;1161.7211869151386;1161.8489596352504;1161.9012383947374;1162.8255761635737;1163.191581850614;1140.4411838199305;1143.0341361549476;1145.1068166829887;1145.5532342386475;1146.346582448005;853.5732133933034;854.2738672128703;854.7563944275852;855.0807881527383;855.0893298636931;19603.21587136513;19834.206631734713;20045.899770501055;20066.398008059783;21744.89127554352;22482.32553023412;22618;22816.77183228163;22822.315330539943;22857.771422285732;17821.643567128714;17827.286908523773;17934.910325448418;17985.820141798544;18117.275308987624;3686.612905644922;3710.9072273193115;3797.240551889633;3798.1833905710128;3799.9810000950097;152811;154731;155004;155380;157098;17499.037552934456;18049;18180;18198.727019094724;18251;34230.315393691984;34476.82761586176;34591.65408345935;34842.30315393729;34966.30067398638;9605.615775369046;9682.854757178648;9695;9702.70891873245;9704.272179586418;4096.3855421686985;4219.789010549522;4254.276772948606;4338.913221735547;4356.976110614003;5939.524838012949;6047.365026672224;6092.543059270483;6101.054336577838;6109.114178444101;1105.082781291526;1137.425600071975;1143.3197247637643;1150.7353308739036;1154.2382027861572;730.8867125595541;740.6481921087441;755.342851718997;758.332667252825;765.4374035084209;12797.488100476063;12949.287789171685;13123.475060997644;13146.60560183196;13172.736545269041;656.4879394072631;663.6814329121952;667.0794303860641;677.1501765284536;677.5223467455432;5514.8069817557;5523.143912693539;5540.168974653753;5573.554115670737;5663.858403539862;140586;147377.10079309164;147943.52056479297;150307.248463757;153775;131236.3438182803;135585;135643;136349.31825341008;138866;113432.43283783528;114297;115041.4247928755;115382.42308788402;118376.40811795885;10479.528421221215;10494.143648608997;10567.10179634709;10567.52446139941;10634.787304253718;53450;53974;54238.72880635571;54340.45659543354;55939.44060559342;70567.64716176386;70669.64665176641;71690;73483.63258183889;74156;16475.917620411823;16864;17119.229634666222;17139.91430042842;17227.22477488541;18772.812271877105;19092.14085366134;19316.130774114918;19350.516237094187;19373.4187974361;15369.538913832603;15721.764173537178;15804.36782528686;15829.366825327319;15959.521214363587;17218;17290.827091729425;17425.39011134655;17498.562535936704;17697.115144242995;17222.397216097375;17330.566735831704;17549.034803085953;17569.03370314594;17686.91156544209;13320.800187997382;13352.465901364225;13573.59279221625;13696.52062177819;13783.655408614464;13693;13737.519186828413;13803.723925521634;13846.515371961934;13889.791653125008 18:14:13 INFO - PID 6044 | __end_tp_report 18:14:13 INFO - PID 6044 | __start_cc_report 18:14:13 INFO - PID 6044 | _x_x_mozilla_cycle_collect,261 18:14:13 INFO - PID 6044 | __end_cc_report 18:14:13 INFO - PID 6044 | __startTimestamp1506388453350__endTimestamp 18:14:13 INFO - PID 6044 | 18:14:13 INFO - PID 6044 | ------- Summary: start ------- 18:14:13 INFO - PID 6044 | Number of tests: 6 18:14:13 INFO - PID 6044 | 18:14:13 INFO - PID 6044 | [#0] dojo.html Cycles:165 Average:6336.50 Median:6590.21 stddev:760.76 (11.5%) stddev-sans-first:738.62 18:14:13 INFO - PID 6044 | Values: 3896.8 3923.9 3925.6 3929.7 3935.9 6161.5 6269.7 6337.9 6349.8 6403.6 6342.7 6343.0 6369.6 6387.9 6393.5 5614.4 5641.1 5666.0 5736.5 5742.8 5555.3 5608.9 5629.8 5670.8 5731.9 5524.7 5626.8 5701.9 5709.7 5750.3 5634.2 5655.4 5690.2 5725.1 5732.3 5627.1 5628.1 5657.5 5693.7 5702.0 6234.0 6272.5 6313.2 6324.6 6327.9 6846.3 6849.9 6853.2 6856.6 6866.5 6826.1 6866.8 6868.9 6949.1 6968.4 6340.7 6364.6 6400.3 6445.5 6452.6 7068.5 7107.9 7137.9 7141.6 7180.7 6727.8 6805.4 6859.7 6892.0 6910.0 6832.8 6902.1 6943.5 6958.7 7062.8 6862.5 6899.2 6906.5 6922.2 6925.8 6829.3 6841.5 6845.6 6934.1 6956.9 4906.8 4975.4 4981.4 5081.5 5083.1 4519.1 4576.7 4616.7 4621.4 4643.2 6372.6 6394.7 6407.0 6429.7 6453.7 6794.4 6819.4 6820.5 6919.8 6924.3 6402.6 6454.8 6465.9 6473.8 6483.1 5538.4 5600.4 5613.3 5616.7 5620.0 7125.4 7137.0 7144.2 7221.2 7241.1 6762.9 6818.9 6842.0 6844.2 6913.6 7156.4 7195.8 7227.2 7243.4 7247.3 6801.6 6802.9 6823.4 6836.3 6933.3 6756.0 6839.9 6855.0 6877.1 6965.0 6669.1 6693.4 6701.4 6710.9 6729.3 6615.2 6635.5 6636.1 6728.8 6736.4 6499.1 6505.6 6590.2 6592.1 6598.7 6653.6 6700.2 6781.6 6782.3 6800.5 6446.3 6494.6 6524.7 6578.1 6587.5 18:14:13 INFO - PID 6044 | 18:14:13 INFO - PID 6044 | [#1] ext.html Cycles:180 Average:42254.51 Median:3688.39 stddev:62121.60 (1684.2%) stddev-sans-first:62218.46 18:14:13 INFO - PID 6044 | Values: 953.6 960.8 985.3 1008.9 1010.6 44118.8 45220.3 45256.5 45272.5 45301.0 41882.6 42296.0 42554.0 42558.8 42605.8 7656.8 7758.5 7758.8 7768.7 7778.0 7737.9 7746.9 7830.5 7831.8 7833.8 8433.6 8655.9 8658.3 8663.7 8665.5 8553.0 8623.1 8626.7 8627.5 8628.9 8063.0 8300.7 8318.1 8399.8 8439.0 41301.0 41752.8 41765.4 41798.2 41817.4 3655.0 3666.1 3670.9 3673.4 3703.4 33040.8 33198.0 33304.3 33342.7 33371.0 5394.3 5401.5 5419.7 5428.9 5442.4 220219.0 220296.0 221417.0 221570.0 221874.0 53695.0 53778.7 53853.7 53948.5 53955.0 56394.4 56430.0 56491.0 56705.7 56732.4 16830.2 17278.6 17279.8 17293.7 17304.3 14092.3 14103.1 14119.5 14142.6 14212.4 15235.1 15445.9 15479.1 15535.8 15611.5 6186.4 6203.8 6206.3 6258.0 6348.7 1080.4 1092.0 1093.0 1097.9 1099.8 25166.4 25495.2 25617.4 25694.4 25782.5 1198.1 1203.4 1211.6 1214.7 1231.1 13354.2 13441.7 13492.5 13641.9 13718.7 261370.0 263266.0 264193.0 264764.0 264806.0 50644.0 51254.2 56519.0 56930.0 58758.4 1538.8 1546.3 1546.4 1552.3 1559.5 30516.0 30870.0 31113.2 31142.1 31318.0 37739.0 37909.4 42010.6 42101.0 42130.0 230926.0 231974.0 232166.0 232588.0 232639.0 37794.8 37807.0 37987.6 38170.4 38400.8 47608.0 47633.5 47837.5 47851.8 47854.8 35064.8 35310.3 35498.3 35665.5 35894.8 35309.0 35373.3 35715.8 35751.5 36305.0 40348.0 40882.0 41430.0 41588.8 41632.6 33556.8 34415.8 34573.8 34759.0 34763.7 25294.7 25555.6 25684.0 25733.4 26423.7 18:14:13 INFO - PID 6044 | 18:14:13 INFO - PID 6044 | [#2] jquery.html Cycles:180 Average:37865.42 Median:12715.68 stddev:94002.30 (739.3%) stddev-sans-first:94224.42 18:14:13 INFO - PID 6044 | Values: 627.4 638.6 647.4 650.3 650.7 22176.8 22749.8 23253.3 23387.4 23567.3 24910.1 26008.2 26043.3 26047.7 26078.5 6545.4 6724.3 6727.4 6728.7 6737.8 6460.3 6583.3 6702.0 6726.9 6738.1 6669.4 6670.6 6682.0 6686.7 6689.5 6554.3 6649.6 6649.7 6661.2 6820.0 6343.0 6367.2 6378.7 6412.9 6435.9 28745.1 28892.7 29021.3 29250.9 29272.4 2264.3 2316.8 2320.3 2320.7 2321.0 19642.4 20096.3 20478.2 20571.2 20666.5 2546.3 2551.2 2566.3 2582.8 2628.4 130249.0 135246.0 153651.0 158342.0 159428.4 15588.2 15885.6 15904.6 15948.9 16747.7 25648.1 25651.5 25710.2 25715.0 25770.0 10842.9 10868.7 10893.4 10921.8 10968.9 9922.9 9957.1 9963.4 10116.5 10173.1 9589.9 9639.8 9656.3 9761.1 9793.4 2849.7 2868.3 2974.9 3004.9 3094.1 1016.9 1043.1 1044.2 1045.2 1047.6 20753.2 20794.4 20895.9 21074.9 21695.0 1096.5 1102.6 1106.1 1110.7 1124.3 11633.1 11790.4 11830.0 11856.4 12034.7 557138.0 558392.0 559322.0 563898.0 566650.0 117874.4 118750.4 119314.0 121174.0 121677.4 1204.1 1205.4 1232.8 1237.3 1248.9 18472.0 18584.4 18651.3 19061.0 19250.9 60231.1 61166.0 62347.7 62673.4 63745.0 73257.6 73497.6 74977.0 77942.0 79145.6 15058.6 15510.8 15543.0 15557.5 15564.1 23114.5 23253.3 23546.6 23717.3 23728.6 19333.2 19583.2 19593.1 19664.8 19741.0 16957.3 17307.2 17320.5 17777.2 17779.3 19238.2 19717.6 19970.9 20035.6 20115.7 15329.2 15341.7 15428.5 15438.0 15446.8 18638.3 18712.5 18768.2 18920.6 19421.9 18:14:13 INFO - PID 6044 | 18:14:13 INFO - PID 6044 | [#3] mootools.html Cycles:180 Average:10515.86 Median:2747.27 stddev:7789.54 (283.5%) stddev-sans-first:7781.38 18:14:13 INFO - PID 6044 | Values: 1414.6 1468.4 1478.6 1481.5 1486.1 16478.5 17223.8 17238.9 17263.4 17263.4 16642.3 16778.2 16791.3 16817.7 16878.0 2881.7 2909.8 2916.9 2921.9 2927.3 2746.1 2838.2 2859.6 2861.2 2874.0 2748.5 2844.5 2845.0 2845.1 2846.0 2828.2 2871.1 2889.6 2898.1 2903.3 2807.5 2811.8 2814.3 2826.9 2827.0 16379.6 16726.2 16748.8 16754.5 16770.9 8708.4 9000.2 9073.5 9075.5 9080.1 5135.3 5270.3 5442.9 5445.2 5547.8 2047.5 2062.9 2069.8 2129.2 2131.8 30210.2 30608.5 30690.0 30755.0 30820.0 7212.4 7240.2 7296.3 7371.3 7414.2 19703.8 19868.5 19901.7 19922.1 19922.9 8368.8 8423.3 8680.0 8688.7 8692.7 7894.7 7921.2 7933.4 7999.3 8138.2 5693.3 5740.6 5773.5 5869.5 5905.7 1535.7 1569.7 1687.3 1696.4 1735.3 967.5 969.4 979.0 991.9 995.6 8571.9 8578.5 8671.7 8761.0 8787.8 1038.3 1039.5 1042.1 1045.0 1046.8 5121.4 5166.4 5265.0 5279.0 5301.3 24860.6 25924.4 25990.5 26030.2 26127.3 24083.6 25372.5 25622.5 25747.2 25756.9 12771.4 12784.3 12849.9 12853.7 12929.5 9429.8 9628.6 9708.8 9737.0 9779.1 19693.7 20678.0 20777.9 21295.5 21723.1 21977.9 22356.9 22545.8 22715.9 22917.5 12104.4 12509.1 12550.7 12678.7 12686.7 14941.4 14943.9 15022.8 15182.0 15213.7 11996.5 12391.1 12927.4 13113.5 13340.1 12359.3 12398.9 12499.1 12788.3 12796.5 10916.3 11022.7 11031.9 11080.8 11118.0 8626.9 8668.0 8682.9 8711.9 8742.6 8465.8 8616.8 8623.6 8633.2 8646.1 18:14:13 INFO - PID 6044 | 18:14:13 INFO - PID 6044 | [#4] prototype.html Cycles:180 Average:5652.07 Median:6306.16 stddev:1566.56 (24.8%) stddev-sans-first:1523.37 18:14:13 INFO - PID 6044 | Values: 546.6 561.9 578.5 581.5 589.7 6230.5 6293.3 6313.9 6322.2 6387.2 6217.8 6222.5 6226.7 6240.5 6308.2 4912.5 5121.2 5145.9 5149.8 5167.5 4936.7 4974.4 4977.6 5013.0 5014.6 4995.6 5019.2 5025.8 5048.0 5057.2 4931.8 5009.4 5016.9 5026.9 5044.6 4532.3 4583.5 4597.3 4601.4 4631.7 6183.0 6246.4 6264.4 6274.7 6316.1 5828.6 5849.7 5861.1 5876.6 5905.2 6689.0 6712.6 6729.9 6747.9 6755.4 4857.9 5070.9 5094.7 5099.8 5120.2 6807.7 6855.0 6948.7 6967.0 7013.4 5261.9 5269.7 5274.0 5280.1 5283.4 5307.7 5308.9 5332.1 5346.3 5364.5 5866.6 5869.4 5896.6 5898.3 5901.2 6600.5 6668.0 6732.5 6761.6 6774.0 1828.9 1835.5 1836.2 1847.9 1862.2 1257.7 1297.1 1298.5 1315.3 1322.4 6026.4 6107.6 6159.6 6172.5 6232.8 6684.5 6766.0 6801.9 6810.6 6838.0 6304.1 6312.2 6329.0 6343.9 6358.3 3547.8 3559.7 3587.6 3589.2 3626.1 6943.0 6947.9 6987.3 7003.9 7035.2 6724.5 6799.7 6836.6 6853.4 6884.4 6879.6 6914.4 6936.8 6959.9 7045.2 6590.3 6612.4 6665.8 6735.3 6741.9 6594.0 6642.7 6651.4 6704.0 6705.2 6942.2 7025.7 7071.8 7091.5 7112.2 5242.2 5250.9 5263.1 5268.3 5269.4 6512.2 6632.8 6651.9 6672.2 6697.3 6315.5 6429.4 6482.3 6521.4 6586.0 6518.8 6576.5 6625.6 6627.9 6634.4 6347.1 6407.9 6417.5 6423.8 6446.9 6652.7 6678.0 6700.7 6716.5 6751.9 6380.3 6437.5 6464.8 6512.5 6529.8 18:14:13 INFO - PID 6044 | 18:14:13 INFO - PID 6044 | [#5] yui.html Cycles:180 Average:28285.70 Median:17960.37 stddev:42050.63 (234.1%) stddev-sans-first:42118.63 18:14:13 INFO - PID 6044 | Values: 985.4 987.5 989.2 1005.3 1015.7 22930.4 24087.5 25530.7 25569.1 25596.6 23370.4 23624.4 23776.8 23957.9 23987.5 1038.9 1070.1 1071.0 1076.2 1083.3 1039.8 1085.5 1085.7 1088.6 1099.2 1161.7 1161.8 1161.9 1162.8 1163.2 1140.4 1143.0 1145.1 1145.6 1146.3 853.6 854.3 854.8 855.1 855.1 19603.2 19834.2 20045.9 20066.4 21744.9 22482.3 22618.0 22816.8 22822.3 22857.8 17821.6 17827.3 17934.9 17985.8 18117.3 3686.6 3710.9 3797.2 3798.2 3800.0 152811.0 154731.0 155004.0 155380.0 157098.0 17499.0 18049.0 18180.0 18198.7 18251.0 34230.3 34476.8 34591.7 34842.3 34966.3 9605.6 9682.9 9695.0 9702.7 9704.3 4096.4 4219.8 4254.3 4338.9 4357.0 5939.5 6047.4 6092.5 6101.1 6109.1 1105.1 1137.4 1143.3 1150.7 1154.2 730.9 740.6 755.3 758.3 765.4 12797.5 12949.3 13123.5 13146.6 13172.7 656.5 663.7 667.1 677.2 677.5 5514.8 5523.1 5540.2 5573.6 5663.9 140586.0 147377.1 147943.5 150307.2 153775.0 131236.3 135585.0 135643.0 136349.3 138866.0 113432.4 114297.0 115041.4 115382.4 118376.4 10479.5 10494.1 10567.1 10567.5 10634.8 53450.0 53974.0 54238.7 54340.5 55939.4 70567.6 70669.6 71690.0 73483.6 74156.0 16475.9 16864.0 17119.2 17139.9 17227.2 18772.8 19092.1 19316.1 19350.5 19373.4 15369.5 15721.8 15804.4 15829.4 15959.5 17218.0 17290.8 17425.4 17498.6 17697.1 17222.4 17330.6 17549.0 17569.0 17686.9 13320.8 13352.5 13573.6 13696.5 13783.7 13693.0 13737.5 13803.7 13846.5 13889.8 18:14:13 INFO - PID 6044 | -------- Summary: end -------- 18:14:13 INFO - PID 6044 | 18:14:14 INFO - TEST-INFO | 6044: exit 0 18:14:14 INFO - TEST-OK | dromaeo_css | took 1109793ms 18:14:14 INFO - TEST-START | kraken 18:14:14 INFO - Initialising browser for kraken test... 18:14:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59957/getInfo.html -profile /tmp/tmpiaSqjO/profile 18:14:14 INFO - TEST-INFO | started process 6414 (/builds/slave/test/build/application/firefox/firefox http://localhost:59957/getInfo.html) 18:14:20 INFO - TEST-INFO | 6414: exit 0 18:14:20 INFO - Browser initialized. 18:14:20 INFO - Running cycle 1/1 for kraken test... 18:14:20 INFO - Using env: {'DISPLAY': ':0', 18:14:20 INFO - 'HOME': '/home/cltbld', 18:14:20 INFO - 'JSGC_DISABLE_POISONING': '1', 18:14:20 INFO - 'LANG': 'en_US.UTF-8', 18:14:20 INFO - 'LANGUAGE': 'en_US:en', 18:14:20 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:14:20 INFO - 'LOGNAME': 'cltbld', 18:14:20 INFO - 'MAIL': '/var/mail/cltbld', 18:14:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:14:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:14:20 INFO - 'MOZ_CRASHREPORTER': '1', 18:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:20 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:14:20 INFO - 'MOZ_NO_REMOTE': '1', 18:14:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:20 INFO - 'NO_EM_RESTART': '1', 18:14:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:20 INFO - 'PWD': '/builds/slave/test', 18:14:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:14:20 INFO - 'RUST_BACKTRACE': 'full', 18:14:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:14:20 INFO - 'SHELL': '/bin/bash', 18:14:20 INFO - 'SHLVL': '1', 18:14:20 INFO - 'TERM': 'linux', 18:14:20 INFO - 'TMOUT': '86400', 18:14:20 INFO - 'USER': 'cltbld', 18:14:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457', 18:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:20 INFO - '_': '/tools/buildbot/bin/python'} 18:14:20 INFO - TEST-INFO | started process 6652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiaSqjO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:14:21 INFO - PID 6652 | 18:14:21 INFO - PID 6652 | (/builds/slave/test/build/application/firefox/firefox:6702): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:14:21 INFO - PID 6652 | 18:14:31 INFO - PID 6652 | RSS: Main: 141152256 18:14:31 INFO - PID 6652 | 18:14:34 INFO - PID 6652 | Cycle 1(1): loaded http://localhost:59957/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59957/tests/kraken/driver.html?testName=audio-beat-detection) 18:14:35 INFO - PID 6652 | RSS: Main: 147480576 18:14:35 INFO - PID 6652 | 18:14:37 INFO - PID 6652 | Cycle 1(1): loaded http://localhost:59957/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59957/tests/kraken/driver.html?testName=audio-dft) 18:14:38 INFO - PID 6652 | RSS: Main: 147529728 18:14:38 INFO - PID 6652 | 18:14:41 INFO - PID 6652 | Cycle 1(1): loaded http://localhost:59957/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59957/tests/kraken/driver.html?testName=audio-fft) 18:14:41 INFO - PID 6652 | RSS: Main: 143691776 18:14:41 INFO - PID 6652 | 18:14:44 INFO - PID 6652 | Cycle 1(1): loaded http://localhost:59957/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59957/tests/kraken/driver.html?testName=audio-oscillator) 18:14:44 INFO - PID 6652 | RSS: Main: 145506304 18:14:44 INFO - PID 6652 | 18:14:46 INFO - PID 6652 | Cycle 1(1): loaded http://localhost:59957/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59957/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:14:47 INFO - PID 6652 | RSS: Main: 145088512 18:14:47 INFO - PID 6652 | 18:14:50 INFO - PID 6652 | Cycle 1(1): loaded http://localhost:59957/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59957/tests/kraken/driver.html?testName=imaging-darkroom) 18:14:50 INFO - PID 6652 | RSS: Main: 145330176 18:14:50 INFO - PID 6652 | 18:14:54 INFO - PID 6652 | Cycle 1(1): loaded http://localhost:59957/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59957/tests/kraken/driver.html?testName=imaging-desaturate) 18:14:55 INFO - PID 6652 | RSS: Main: 146436096 18:14:55 INFO - PID 6652 | 18:14:58 INFO - PID 6652 | Cycle 1(1): loaded http://localhost:59957/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59957/tests/kraken/driver.html?testName=json-parse-financial) 18:14:58 INFO - PID 6652 | RSS: Main: 147918848 18:14:58 INFO - PID 6652 | 18:15:00 INFO - PID 6652 | Cycle 1(1): loaded http://localhost:59957/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59957/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:15:00 INFO - PID 6652 | RSS: Main: 147636224 18:15:00 INFO - PID 6652 | 18:15:02 INFO - PID 6652 | Cycle 1(1): loaded http://localhost:59957/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59957/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:15:02 INFO - PID 6652 | RSS: Main: 148197376 18:15:02 INFO - PID 6652 | 18:15:04 INFO - PID 6652 | Cycle 1(1): loaded http://localhost:59957/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59957/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:15:05 INFO - PID 6652 | RSS: Main: 148234240 18:15:05 INFO - PID 6652 | 18:15:07 INFO - PID 6652 | Cycle 1(1): loaded http://localhost:59957/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:15:08 INFO - PID 6652 | RSS: Main: 147787776 18:15:08 INFO - PID 6652 | 18:15:11 INFO - PID 6652 | Cycle 1(1): loaded http://localhost:59957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:15:11 INFO - PID 6652 | RSS: Main: 148815872 18:15:11 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | Cycle 1(1): loaded http://localhost:59957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59957/tests/kraken/driver.html?testName=ai-astar) 18:15:13 INFO - PID 6652 | RSS: Main: 150151168 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | __start_tp_report 18:15:13 INFO - PID 6652 | _x_x_mozilla_page_load 18:15:13 INFO - PID 6652 | _x_x_mozilla_page_load_details 18:15:13 INFO - PID 6652 | |i|pagename|runs| 18:15:13 INFO - PID 6652 | |0;ai-astar;105;104;104;105;104;107;104;104;106;105 18:15:13 INFO - PID 6652 | |1;audio-beat-detection;111;113;115;111;115;112;115;116;113;112 18:15:13 INFO - PID 6652 | |2;audio-dft;162;163;163;162;161;162;161;162;162;169 18:15:13 INFO - PID 6652 | |3;audio-fft;73;74;74;73;77;73;76;73;72;74 18:15:13 INFO - PID 6652 | |4;audio-oscillator;78;78;78;77;77;77;78;78;78;77 18:15:13 INFO - PID 6652 | |5;imaging-gaussian-blur;114;114;110;115;120;110;114;114;113;115 18:15:13 INFO - PID 6652 | |6;imaging-darkroom;151;148;149;149;152;150;150;153;150;153 18:15:13 INFO - PID 6652 | |7;imaging-desaturate;98;99;99;94;94;94;94;95;94;97 18:15:13 INFO - PID 6652 | |8;json-parse-financial;46;44;44;44;45;45;45;46;45;44 18:15:13 INFO - PID 6652 | |9;json-stringify-tinderbox;39;38;39;39;39;39;39;39;39;39 18:15:13 INFO - PID 6652 | |10;stanford-crypto-aes;72;72;72;72;73;70;77;69;70;70 18:15:13 INFO - PID 6652 | |11;stanford-crypto-ccm;105;105;106;114;107;108;107;102;103;120 18:15:13 INFO - PID 6652 | |12;stanford-crypto-pbkdf2;153;152;153;147;150;151;152;152;155;156 18:15:13 INFO - PID 6652 | |13;stanford-crypto-sha256-iterative;67;59;59;60;59;59;59;59;62;59 18:15:13 INFO - PID 6652 | __end_tp_report 18:15:13 INFO - PID 6652 | __start_cc_report 18:15:13 INFO - PID 6652 | _x_x_mozilla_cycle_collect,708 18:15:13 INFO - PID 6652 | __end_cc_report 18:15:13 INFO - PID 6652 | __startTimestamp1506388513828__endTimestamp 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | ------- Summary: start ------- 18:15:13 INFO - PID 6652 | Number of tests: 14 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | [#0] ai-astar Cycles:10 Average:104.80 Median:105.00 stddev:1.03 (1.0%) stddev-sans-first:1.09 18:15:13 INFO - PID 6652 | Values: 105.0 104.0 104.0 105.0 104.0 107.0 104.0 104.0 106.0 105.0 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | [#1] audio-beat-detection Cycles:10 Average:113.30 Median:114.00 stddev:1.83 (1.6%) stddev-sans-first:1.74 18:15:13 INFO - PID 6652 | Values: 111.0 113.0 115.0 111.0 115.0 112.0 115.0 116.0 113.0 112.0 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.31 (1.4%) stddev-sans-first:2.44 18:15:13 INFO - PID 6652 | Values: 162.0 163.0 163.0 162.0 161.0 162.0 161.0 162.0 162.0 169.0 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | [#3] audio-fft Cycles:10 Average:73.90 Median:74.00 stddev:1.52 (2.1%) stddev-sans-first:1.58 18:15:13 INFO - PID 6652 | Values: 73.0 74.0 74.0 73.0 77.0 73.0 76.0 73.0 72.0 74.0 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 18:15:13 INFO - PID 6652 | Values: 78.0 78.0 78.0 77.0 77.0 77.0 78.0 78.0 78.0 77.0 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:2.81 (2.5%) stddev-sans-first:2.98 18:15:13 INFO - PID 6652 | Values: 114.0 114.0 110.0 115.0 120.0 110.0 114.0 114.0 113.0 115.0 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:1.72 (1.1%) stddev-sans-first:1.81 18:15:13 INFO - PID 6652 | Values: 151.0 148.0 149.0 149.0 152.0 150.0 150.0 153.0 150.0 153.0 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:2.20 (2.3%) stddev-sans-first:2.19 18:15:13 INFO - PID 6652 | Values: 98.0 99.0 99.0 94.0 94.0 94.0 94.0 95.0 94.0 97.0 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | [#8] json-parse-financial Cycles:10 Average:44.80 Median:45.00 stddev:0.79 (1.8%) stddev-sans-first:0.71 18:15:13 INFO - PID 6652 | Values: 46.0 44.0 44.0 44.0 45.0 45.0 45.0 46.0 45.0 44.0 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | [#9] json-stringify-tinderbox Cycles:10 Average:38.90 Median:39.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 18:15:13 INFO - PID 6652 | Values: 39.0 38.0 39.0 39.0 39.0 39.0 39.0 39.0 39.0 39.0 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | [#10] stanford-crypto-aes Cycles:10 Average:71.70 Median:72.00 stddev:2.26 (3.1%) stddev-sans-first:2.40 18:15:13 INFO - PID 6652 | Values: 72.0 72.0 72.0 72.0 73.0 70.0 77.0 69.0 70.0 70.0 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | [#11] stanford-crypto-ccm Cycles:10 Average:107.70 Median:107.00 stddev:5.42 (5.1%) stddev-sans-first:5.66 18:15:13 INFO - PID 6652 | Values: 105.0 105.0 106.0 114.0 107.0 108.0 107.0 102.0 103.0 120.0 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:152.50 stddev:2.51 (1.6%) stddev-sans-first:2.65 18:15:13 INFO - PID 6652 | Values: 153.0 152.0 153.0 147.0 150.0 151.0 152.0 152.0 155.0 156.0 18:15:13 INFO - PID 6652 | 18:15:13 INFO - PID 6652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.20 Median:59.00 stddev:2.57 (4.4%) stddev-sans-first:1.01 18:15:13 INFO - PID 6652 | Values: 67.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 62.0 59.0 18:15:13 INFO - PID 6652 | -------- Summary: end -------- 18:15:13 INFO - PID 6652 | 18:15:14 INFO - PID 6652 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:15:14 INFO - TEST-INFO | 6652: exit 0 18:15:14 INFO - TEST-OK | kraken | took 60414ms 18:15:14 INFO - SUITE-END | took 1170s 18:15:14 INFO - Completed test suite (00:19:30) 18:15:14 INFO - javascript benchmark 18:15:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9099.164897488257, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3896.8441262349506, 3923.901902452438, 3925.6466917977377, 3929.744566603169, 3935.90160245994, 6161.537884658657, 6269.655168965705, 6337.904931426026, 6349.809505714836, 6403.551751377406, 6342.714577843996, 6343.0, 6369.554131210817, 6387.936120638792, 6393.488520918327, 5614.438556144373, 5641.097424412095, 5665.971670141644, 5736.483716465517, 5742.827715168552, 5555.2778138842095, 5608.85977850555, 5629.831105066834, 5670.829875103733, 5731.885362292773, 5524.723763811793, 5626.774929002835, 5701.857453563653, 5709.6574205547595, 5750.252467179282, 5634.1830434586755, 5655.4344565543115, 5690.2033715279895, 5725.055365864628, 5732.254806875079, 5627.071533197018, 5628.0713682242385, 5657.547396208293, 5693.658380497183, 5702.0021496238, 6234.0, 6272.529560282997, 6313.210848643919, 6324.620522768649, 6327.936720632827, 6846.315368463163, 6849.863002739967, 6853.17761868579, 6856.588604683685, 6866.519343645947, 6826.146731658543, 6866.828329291758, 6868.896966545506, 6949.131358580177, 6968.3728464438445, 6340.682965851689, 6364.554481186319, 6400.327965563642, 6445.484361251089, 6452.64510451925, 7068.540544864567, 7107.928920710727, 7137.893626487903, 7141.642917854087, 7180.712771489187, 6727.798166055026, 6805.421539169127, 6859.725610975505, 6892.000659904386, 6910.0, 6832.760853370109, 6902.102726645604, 6943.51395402317, 6958.686859091353, 7062.752803651848, 6862.451003919675, 6899.206591241971, 6906.482013848981, 6922.169339679271, 6925.826854328682, 6829.317068293131, 6841.521093523505, 6845.589264644137, 6934.133233345832, 6956.930430695729, 4906.803727850917, 4975.353204083446, 4981.42713587942, 5081.517255860687, 5083.059633967728, 4519.096180763795, 4576.679632425765, 4616.722996620214, 4621.376114224537, 4643.210654188796, 6372.553921225563, 6394.744210231539, 6406.967965160145, 6429.7461994910545, 6453.709583068773, 6794.3545363190415, 6819.386255236953, 6820.522563420612, 6919.827004324831, 6924.272951340137, 6402.551821372459, 6454.838629034218, 6465.935340646627, 6473.805785826433, 6483.059956306403, 5538.363088244822, 5600.383957764642, 5613.298337707786, 5616.719164041781, 5619.971900140473, 7125.42996560274, 7136.964315178495, 7144.214136444987, 7221.205667376585, 7241.131064272216, 6762.898556521558, 6818.93181068183, 6842.042114104129, 6844.2129155147795, 6913.5506192097355, 7156.427485801228, 7195.82010449722, 7227.205007449282, 7243.384312333511, 7247.347738703542, 6801.625910574768, 6802.897956530557, 6823.351781580742, 6836.316368363124, 6933.341332573397, 6755.966220168868, 6839.89740153908, 6855.0, 6877.105976223259, 6965.0, 6669.066330713801, 6693.364130407604, 6701.430378417889, 6710.932890671226, 6729.2934241903895, 6615.239247486408, 6635.469162466895, 6636.070950066898, 6728.7981360557305, 6736.393724564617, 6499.122618446449, 6505.642189679613, 6590.209174899042, 6592.077109204811, 6598.736050557924, 6653.567518111307, 6700.229473610597, 6781.593104413751, 6782.25395206517, 6800.489963252677, 6446.258680251643, 6494.6103233806125, 6524.739010439529, 6578.079068930258, 6587.505937054644], "value": 6284.421197138711, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [953.5756588318197, 960.7742180587561, 985.275822270631, 1008.8537162111498, 1010.5806090472454, 44118.77940610296, 45220.3216951746, 45256.547434525724, 45272.54727452724, 45301.0, 41882.58117418825, 42296.0, 42554.0, 42558.787206064, 42605.78697106518, 7656.770296891103, 7758.495697779655, 7758.844823103563, 7768.728094516693, 7778.0, 7737.883931741028, 7746.883796743054, 7830.451868369188, 7831.804204894866, 7833.764987050397, 8433.620487078097, 8655.870161947576, 8658.264047555966, 8663.653453861838, 8665.480071195718, 8553.0, 8623.051464338949, 8626.65493380264, 8627.482351058956, 8628.913710862873, 8063.0, 8300.7094751684, 8318.12659670738, 8399.790005249857, 8439.0, 41301.0, 41752.79123604393, 41765.37351939723, 41798.1640367194, 41817.37273940894, 3655.0, 3666.1201311685004, 3670.926581468356, 3673.3938900081453, 3703.3889408247605, 33040.83479582611, 33198.0, 33304.3339133216, 33342.6665733342, 33371.0, 5394.298741163663, 5401.513863752242, 5419.674819510842, 5428.9185662215095, 5442.401335853053, 220219.0, 220296.0, 221417.0, 221570.0, 221874.0, 53695.0, 53778.731106345, 53853.73073134609, 53948.46051539434, 53955.0, 56394.43605563974, 56430.0, 56491.0, 56705.71647141738, 56732.43267567272, 16830.242639081273, 17278.568035799206, 17279.827201728072, 17293.65412691764, 17304.307827687004, 14092.295385230698, 14103.0832995857, 14119.505817296345, 14142.575722728334, 14212.360443780055, 15235.085894846123, 15445.922770386076, 15479.148646824307, 15535.84464155344, 15611.453599123975, 6186.381361863868, 6203.7828675996125, 6206.317305096436, 6257.9687101564205, 6348.714307856158, 1080.4111759091313, 1091.9727006824894, 1093.0, 1097.939613321259, 1099.7525556749667, 25166.370840728763, 25495.23514294574, 25617.359566011, 25694.35764105875, 25782.48435031289, 1198.1493139870615, 1203.422357268516, 1211.6425654431964, 1214.6598952293373, 1231.1443546734934, 13354.198748075147, 13441.72303631173, 13492.460301587827, 13641.931790340985, 13718.657033574042, 261370.0, 263266.0, 264193.0, 264764.0, 264806.0, 50644.0, 51254.23118653223, 56519.0, 56930.0, 58758.4124158753, 1538.7537993921144, 1546.327347603796, 1546.4278217059534, 1552.2859484637193, 1559.485369827954, 30516.0, 30870.0, 31113.222169445944, 31142.065738027897, 31318.0, 37739.0, 37909.431358529095, 42010.579894200666, 42101.0, 42130.0, 230926.0, 231974.0, 232166.0, 232588.0, 232639.0, 37794.81102594469, 37807.0, 37987.620123798406, 38170.42744358781, 38400.80799595984, 47608.0, 47633.523664762906, 47837.52162478331, 47851.76074119607, 47854.760726196146, 35064.82467587748, 35310.29379412449, 35498.29003419969, 35665.46501802423, 35894.82052589825, 35309.0, 35373.292534148655, 35715.82142089273, 35751.46372804462, 36305.0, 40348.0, 40882.0, 41430.0, 41588.79205603953, 41632.583674162874, 33556.83221583877, 34415.82792086023, 34573.827130864185, 34759.0, 34763.65236347706, 25294.668100186685, 25555.616665749658, 25684.0, 25733.35666608275, 26423.735762642897], "value": 18814.82803475731, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.4447114303842, 638.6423602782443, 647.4011539326123, 650.3269116464458, 650.6714109374765, 22176.77823221767, 22749.772502274995, 23253.30240092798, 23387.415314617123, 23567.29298121059, 24910.12814551491, 26008.21975340743, 26043.348916277104, 26047.739522604767, 26078.478430431427, 6545.443637290824, 6724.293949135344, 6727.360900714424, 6728.6635668216395, 6737.764178253762, 6460.321666225049, 6583.308752580958, 6701.966490167542, 6726.932730672704, 6738.090357801708, 6669.399754022137, 6670.599764014175, 6681.966590167042, 6686.665666716669, 6689.498287628423, 6554.344565543455, 6649.5677780944325, 6649.667516624174, 6661.233958094808, 6819.965900170517, 6342.968285158545, 6367.172267605181, 6378.68106594673, 6412.93587064128, 6435.871282574369, 28745.137645870658, 28892.71107288921, 29021.274468138254, 29250.853745731136, 29272.41455170906, 2264.298067599033, 2316.8262380321544, 2320.2575175943703, 2320.7331156917003, 2321.025169428844, 19642.410727678194, 20096.296629617893, 20478.18087276507, 20571.177152914017, 20666.48333791652, 2546.2870396289068, 2551.1708694674303, 2566.3455818766097, 2582.780463660591, 2628.4348864994117, 130249.0, 135246.0, 153651.0, 158342.0, 159428.40571594253, 15588.220588970733, 15885.602859928595, 15904.602384940468, 15948.920255398649, 16747.665046699243, 25648.102316418837, 25651.486970260492, 25710.228693139237, 25715.0, 25770.0, 10842.94578527118, 10868.72828179286, 10893.440041590378, 10921.836172457419, 10968.945155274172, 9922.900770992343, 9957.0540798624, 9963.356046252433, 10116.494175291205, 10173.084422401871, 9589.90410095904, 9639.807203855884, 9656.27577931658, 9761.07269809367, 9793.363431376938, 2849.7435230829324, 2868.3116052147334, 2974.9107526774233, 3004.9032103282143, 3094.133642580081, 1016.872890888639, 1043.0977204717865, 1044.2481413382352, 1045.2056437107854, 1047.5757318286107, 20753.169873204904, 20794.376168714964, 20895.8955205223, 21074.946252687612, 21695.0, 1096.5394534295615, 1102.5755084292605, 1106.1261603333276, 1110.722319420145, 1124.2523721725124, 11633.069354451623, 11790.351530665725, 11830.0, 11856.407179640983, 12034.699132521582, 557138.0, 558392.0, 559322.0, 563898.0, 566650.0, 117874.41062794632, 118750.4062479682, 119314.0, 121174.0, 121677.39161304313, 1204.1209916760813, 1205.3551350027692, 1232.7904256276454, 1237.2761934268553, 1248.912576119681, 18472.0, 18584.44246672602, 18651.253949841856, 19061.046947652285, 19250.903745481184, 60231.09653355116, 61166.0, 62347.6882615584, 62673.37326626858, 63745.0, 73257.63371183323, 73497.6325118371, 74977.0, 77942.0, 79145.60427197827, 15058.623534411727, 15510.767338489706, 15543.0, 15557.45548905783, 15564.066156030674, 23114.537709245385, 23253.302400927998, 23546.646800297665, 23717.288481345586, 23728.644070338614, 19333.226670933003, 19583.216671332986, 19593.118309675814, 19664.803351966868, 19741.01294935219, 16957.32170713207, 17307.221175047405, 17320.480385588453, 17777.20002599912, 17779.28882844672, 19238.23047078101, 19717.605647886674, 19970.90014549918, 20035.59928801445, 20115.698264526338, 15329.156896370807, 15341.693166136838, 15428.460003899809, 15438.0, 15446.84553154499, 18638.34765783191, 18712.532186694898, 18768.155433005275, 18920.621587568447, 19421.902890485457], "value": 12655.412119726443, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.6109819799553, 1468.4360659804042, 1478.6007777899968, 1481.5111013365588, 1486.123187319482, 16478.505644830646, 17223.82776172238, 17238.913805430988, 17263.39578114766, 17263.39578114766, 16642.334306627752, 16778.244978975945, 16791.32834686611, 16817.663646727087, 16878.0, 2881.726236007581, 2909.752671022955, 2916.8979085732003, 2921.9123426297247, 2927.312081660808, 2746.0663374452683, 2838.1627419911074, 2859.6139521164587, 2861.2274685834814, 2873.9856300718466, 2748.4640495103463, 2844.4737723521216, 2845.0, 2845.0611298271624, 2845.985770071147, 2828.1798278499314, 2871.052552657618, 2889.609902663145, 2898.0581311073984, 2903.3467469819334, 2807.5227211374117, 2811.8031737778365, 2814.282357998697, 2826.915192544227, 2826.9575956360673, 16379.59051023722, 16726.24731887068, 16748.83251167485, 16754.497365079067, 16770.916145419316, 8708.390412671115, 9000.189982901506, 9073.500957447337, 9075.546222688905, 9080.091990800933, 5135.3067335909545, 5270.288511050997, 5442.863928401822, 5445.1832225166545, 5547.805826796042, 2047.5085979364994, 2062.9484262893397, 2069.772325044244, 2129.212191489159, 2131.818795402393, 30210.244743881358, 30608.54087188694, 30690.0, 30755.0, 30820.0, 7212.386947109554, 7240.239774823568, 7296.270372962661, 7371.262873712586, 7414.221506741715, 19703.802961970196, 19868.50328741793, 19901.701474477893, 19922.103505342293, 19922.90038549798, 8368.832623347498, 8423.284020858173, 8680.045195028542, 8688.695895643623, 8692.739217823475, 7894.723684671124, 7921.207879212148, 7933.444658873824, 7999.320057795153, 8138.226868447488, 5693.28833895763, 5740.569457290637, 5773.507028247934, 5869.4717475427415, 5905.734241959122, 1535.6851845371673, 1569.7488401855649, 1687.2576066530687, 1696.3638635511684, 1735.2798588585595, 967.5307475874196, 969.3795970578835, 979.0307595480565, 991.8859331176862, 995.5569771451779, 8571.914280857236, 8578.485290882567, 8671.739847804576, 8761.036286008533, 8787.780305492413, 1038.3199004651965, 1039.4802598700649, 1042.11940909931, 1044.9895501045044, 1046.7801761629992, 5121.411037730709, 5166.405863325691, 5264.973675131677, 5279.049771041173, 5301.257823904656, 24860.627090593654, 25924.351891202492, 25990.480190396465, 26030.219093427226, 26127.346816329744, 24083.638745418833, 25372.492550148894, 25622.487550249265, 25747.227583172535, 25756.871215644176, 12771.36143192818, 12784.296863672587, 12849.871501284868, 12853.678658033625, 12929.482820687255, 9429.811403772022, 9628.566714497725, 9708.805823883624, 9737.0, 9779.070988256104, 19693.721135410397, 20678.0, 20777.896110519352, 21295.46761330917, 21723.13107475683, 21977.890110549346, 22356.88821555947, 22545.774542254367, 22715.88642056845, 22917.54164916726, 12104.394780261127, 12509.124361294986, 12550.748985020431, 12678.746425071262, 12686.746265074462, 14941.402343906557, 14943.85056149468, 15022.774658380351, 15182.013169143971, 15213.695726085638, 11996.520139194334, 12391.070669699628, 12927.418266178232, 13113.541026064042, 13340.132891362031, 12359.32023738703, 12398.876011239772, 12499.12506124599, 12788.296643684687, 12796.488140474277, 10916.345019298868, 11022.669319920415, 11031.944840275748, 11080.778384432428, 11118.0, 8626.870596941177, 8668.0, 8682.913170868464, 8711.91288087111, 8742.56287185651, 8465.788355291166, 8616.78458038554, 8623.568821559022, 8633.223009929137, 8646.092160323076], "value": 7370.622535322213, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.5764032874524, 561.8707697229637, 578.482258378751, 581.5405829394778, 589.7346194212605, 6230.501559875211, 6293.30773614902, 6313.873722525546, 6322.209723784527, 6387.169667943161, 6217.813465596028, 6222.533310001745, 6226.723521678056, 6240.500759939206, 6308.211473565804, 4912.484189160123, 5121.180611102224, 5145.897082058366, 5149.76826042829, 5167.48325167484, 4936.679115857476, 4974.403071631409, 4977.601791856661, 5013.0, 5014.598832093442, 4995.550400463958, 5019.196928491442, 5025.773840177201, 5048.0, 5057.216131499605, 4931.753412329387, 5009.44896061433, 5016.949830501703, 5026.924596131061, 5044.571211447032, 4532.32015197723, 4583.472900616405, 4597.287420449836, 4601.401817763703, 4631.698939568917, 6183.0, 6246.437820596123, 6264.373562643745, 6274.717637706314, 6316.115743795872, 5828.6211396259105, 5849.707514624251, 5861.120831875211, 5876.647401155944, 5905.173275741399, 6689.0, 6712.563683360615, 6729.93270067298, 6747.886598711207, 6755.358240967149, 4857.902841943177, 5070.949290507085, 5094.700851282936, 5099.770510327045, 5120.15517439622, 6807.65961701913, 6854.9657251713925, 6948.6525673716615, 6967.0, 7013.403860671849, 5261.921071183935, 5269.657472264291, 5274.0, 5280.102382594968, 5283.392409872914, 5307.681539107666, 5308.893822123536, 5332.146856503018, 5346.278252435872, 5364.517193452608, 5866.618669786536, 5869.442402971711, 5896.587238893237, 5898.292204935436, 5901.232839730807, 6600.537962342686, 6668.0, 6732.528722989442, 6761.628110453874, 6774.0, 1828.9359872404402, 1835.476889086604, 1836.1828986101325, 1847.9353222637144, 1862.1992543206552, 1257.666718319646, 1297.1374036265966, 1298.5065675043422, 1315.2966907854352, 1322.4247452358254, 6026.397360263939, 6107.572469927062, 6159.550651635099, 6172.537059720539, 6232.781852635136, 6684.465242780566, 6765.966170169216, 6801.897971530431, 6810.62541560219, 6838.0, 6304.117423560705, 6312.24253089623, 6328.968355158195, 6343.904841427382, 6358.300586935434, 3547.822608869546, 3559.661832125944, 3587.587427445877, 3589.174489867345, 3626.1297288650535, 6942.965285173643, 6947.9156253123865, 6987.336203060701, 7003.929960700328, 7035.226125126232, 6724.495662825308, 6799.694013769392, 6836.58980461164, 6853.383195512328, 6884.380405763405, 6879.557756996194, 6914.446844252448, 6936.79189624312, 6959.860802784017, 7045.225025247219, 6590.275069742421, 6612.437942774918, 6665.833728978696, 6735.25912149673, 6741.853884839491, 6593.967030164818, 6642.734290628321, 6651.434628056476, 6703.966480167568, 6705.19537655465, 6942.2363540011565, 7025.71431426819, 7071.752488663078, 7091.510782735683, 7112.217656057933, 5242.16125419931, 5250.868728281824, 5263.078961181702, 5268.315119034501, 5269.420363759907, 6512.185976752906, 6632.767853125118, 6651.900221496779, 6672.165979252593, 6697.296783837822, 6315.515853774267, 6429.360513069138, 6482.319356467503, 6521.445677117498, 6586.0, 6518.837029074121, 6576.506761992774, 6625.602463851991, 6627.900581491378, 6634.369734875179, 6347.111404403479, 6407.8718425630295, 6417.518686098655, 6423.807285781434, 6446.903296450463, 6652.700628471827, 6677.966610166918, 6700.731970721312, 6716.496262780213, 6751.864962700817, 6380.266269379081, 6437.5171862111465, 6464.806055818333, 6512.511561632802, 6529.771457998947], "value": 5203.573598495184, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [985.4333758089099, 987.4914419074178, 989.1641562879369, 1005.2561104782463, 1015.695291412576, 22930.426739331524, 24087.518249634995, 25530.744692553068, 25569.10508132216, 25596.61605075923, 23370.415739606477, 23624.40938976522, 23776.76223237767, 23957.880210598923, 23987.52024959504, 1038.875334959804, 1070.1011150633467, 1071.036067539213, 1076.2251179150999, 1083.3445765311951, 1039.7660526381578, 1085.468120620894, 1085.723140599146, 1088.5917780832187, 1099.2030777686193, 1161.7211869151386, 1161.8489596352504, 1161.9012383947374, 1162.8255761635737, 1163.191581850614, 1140.4411838199305, 1143.0341361549476, 1145.1068166829887, 1145.5532342386475, 1146.346582448005, 853.5732133933034, 854.2738672128703, 854.7563944275852, 855.0807881527383, 855.0893298636931, 19603.21587136513, 19834.206631734713, 20045.899770501055, 20066.398008059783, 21744.89127554352, 22482.32553023412, 22618.0, 22816.77183228163, 22822.315330539943, 22857.771422285732, 17821.643567128714, 17827.286908523773, 17934.910325448418, 17985.820141798544, 18117.275308987624, 3686.612905644922, 3710.9072273193115, 3797.240551889633, 3798.1833905710128, 3799.9810000950097, 152811.0, 154731.0, 155004.0, 155380.0, 157098.0, 17499.037552934456, 18049.0, 18180.0, 18198.727019094724, 18251.0, 34230.315393691984, 34476.82761586176, 34591.65408345935, 34842.30315393729, 34966.30067398638, 9605.615775369046, 9682.854757178648, 9695.0, 9702.70891873245, 9704.272179586418, 4096.3855421686985, 4219.789010549522, 4254.276772948606, 4338.913221735547, 4356.976110614003, 5939.524838012949, 6047.365026672224, 6092.543059270483, 6101.054336577838, 6109.114178444101, 1105.082781291526, 1137.425600071975, 1143.3197247637643, 1150.7353308739036, 1154.2382027861572, 730.8867125595541, 740.6481921087441, 755.342851718997, 758.332667252825, 765.4374035084209, 12797.488100476063, 12949.287789171685, 13123.475060997644, 13146.60560183196, 13172.736545269041, 656.4879394072631, 663.6814329121952, 667.0794303860641, 677.1501765284536, 677.5223467455432, 5514.8069817557, 5523.143912693539, 5540.168974653753, 5573.554115670737, 5663.858403539862, 140586.0, 147377.10079309164, 147943.52056479297, 150307.248463757, 153775.0, 131236.3438182803, 135585.0, 135643.0, 136349.31825341008, 138866.0, 113432.43283783528, 114297.0, 115041.4247928755, 115382.42308788402, 118376.40811795885, 10479.528421221215, 10494.143648608997, 10567.10179634709, 10567.52446139941, 10634.787304253718, 53450.0, 53974.0, 54238.72880635571, 54340.45659543354, 55939.44060559342, 70567.64716176386, 70669.64665176641, 71690.0, 73483.63258183889, 74156.0, 16475.917620411823, 16864.0, 17119.229634666222, 17139.91430042842, 17227.22477488541, 18772.812271877105, 19092.14085366134, 19316.130774114918, 19350.516237094187, 19373.4187974361, 15369.538913832603, 15721.764173537178, 15804.36782528686, 15829.366825327319, 15959.521214363587, 17218.0, 17290.827091729425, 17425.39011134655, 17498.562535936704, 17697.115144242995, 17222.397216097375, 17330.566735831704, 17549.034803085953, 17569.03370314594, 17686.91156544209, 13320.800187997382, 13352.465901364225, 13573.59279221625, 13696.52062177819, 13783.655408614464, 13693.0, 13737.519186828413, 13803.723925521634, 13846.515371961934, 13889.791653125008], "value": 9888.606216010625, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1367.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 104.0, 104.0, 105.0, 104.0, 107.0, 104.0, 104.0, 106.0, 105.0], "value": 104.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 115.0, 111.0, 115.0, 112.0, 115.0, 116.0, 113.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 162.0, 161.0, 162.0, 161.0, 162.0, 162.0, 169.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 73.0, 77.0, 73.0, 76.0, 73.0, 72.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 77.0, 77.0, 77.0, 78.0, 78.0, 78.0, 77.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 110.0, 115.0, 120.0, 110.0, 114.0, 114.0, 113.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 149.0, 149.0, 152.0, 150.0, 150.0, 153.0, 150.0, 153.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 99.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 97.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 44.0, 44.0, 44.0, 45.0, 45.0, 45.0, 46.0, 45.0, 44.0], "value": 44.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 39.0, 39.0, 39.0, 39.0, 39.0, 39.0, 39.0, 39.0], "value": 38.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 72.0, 73.0, 70.0, 77.0, 69.0, 70.0, 70.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 106.0, 114.0, 107.0, 108.0, 107.0, 102.0, 103.0, 120.0], "value": 107.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 153.0, 147.0, 150.0, 151.0, 152.0, 152.0, 155.0, 156.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 62.0, 59.0], "value": 60.2, "unit": "score"}]}]} 18:15:15 INFO - Return code: 0 18:15:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:15:15 INFO - # TBPL SUCCESS # 18:15:15 INFO - Running post-action listener: _package_coverage_data 18:15:15 INFO - Running post-action listener: _resource_record_post_action 18:15:15 INFO - [mozharness: 2017-09-26 01:15:15.139597Z] Finished run-tests step (success) 18:15:15 INFO - Running post-run listener: _resource_record_post_run 18:15:15 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 438272; Write bytes: 333934592; Read time: 988; Write time: 529164 18:15:15 INFO - TinderboxPrint: CPU usage
13.1% 18:15:15 INFO - TinderboxPrint: I/O read bytes / time
438,272 / 988 18:15:15 INFO - TinderboxPrint: I/O write bytes / time
333,934,592 / 529,164 18:15:15 INFO - TinderboxPrint: CPU idle
8,238.4 (86.9%) 18:15:15 INFO - TinderboxPrint: CPU user
1,187.8 (12.5%) 18:15:15 INFO - TinderboxPrint: Swap in / out
0 / 0 18:15:15 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13164544; Read time: 0; Write time: 2144 18:15:15 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:15:15 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 438272; Write bytes: 320770048; Read time: 988; Write time: 527020 18:15:15 INFO - Running post-run listener: _upload_blobber_files 18:15:15 INFO - Blob upload gear active. 18:15:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:15:15 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 18:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:15:16 INFO - (blobuploader) - INFO - Open directory for files ... 18:15:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:15:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:15:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:17 INFO - (blobuploader) - INFO - Done attempting. 18:15:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:15:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:15:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:24 INFO - (blobuploader) - INFO - Done attempting. 18:15:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:15:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:15:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:25 INFO - (blobuploader) - INFO - Done attempting. 18:15:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:15:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:15:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:26 INFO - (blobuploader) - INFO - Done attempting. 18:15:26 INFO - (blobuploader) - INFO - Iteration through files over. 18:15:26 INFO - Return code: 0 18:15:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:15:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:15:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95c808b64f6885d91175f1c6685300c7c78fb56b34f965b01e6d21f7447e2d80ffef6abe27c7a2ca2e73cee369280a8029949bb3ea5bc3bc176364ba5ed11d2b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d04e267ee63704cccf8a3a397a0a8e2775f510f024e199e15954d6faeec4484352cafa89344478c9c9c7280a2e090328b69c468e19a515689d8b0db3f54834f6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/574597b1e34d0886d17b1c4564b9980e90e2f8bffdf318547c25c264c9f4054c84ff3a4331e75e1d7b486056d7b40fad31f72002d893f9319831ec767502b76c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62ceeb45a6df43d1a0b7fcfcdf403d7758246b5a2b2bbc544fe3b879fabd5ed9edd010bc7d130fe7df782a6355bd951fe5d70b7234b0339103a86396f49cf06f"} 18:15:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:15:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:15:26 INFO - Contents: 18:15:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95c808b64f6885d91175f1c6685300c7c78fb56b34f965b01e6d21f7447e2d80ffef6abe27c7a2ca2e73cee369280a8029949bb3ea5bc3bc176364ba5ed11d2b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d04e267ee63704cccf8a3a397a0a8e2775f510f024e199e15954d6faeec4484352cafa89344478c9c9c7280a2e090328b69c468e19a515689d8b0db3f54834f6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/574597b1e34d0886d17b1c4564b9980e90e2f8bffdf318547c25c264c9f4054c84ff3a4331e75e1d7b486056d7b40fad31f72002d893f9319831ec767502b76c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62ceeb45a6df43d1a0b7fcfcdf403d7758246b5a2b2bbc544fe3b879fabd5ed9edd010bc7d130fe7df782a6355bd951fe5d70b7234b0339103a86396f49cf06f"} 18:15:26 INFO - Running post-run listener: copy_logs_to_upload_dir 18:15:26 INFO - Copying logs to upload dir... 18:15:26 INFO - mkdir: /builds/slave/test/build/upload/logs 18:15:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.773421 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-25 18:15:26.867061) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 18:15:26.871319) ========= 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=8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95c808b64f6885d91175f1c6685300c7c78fb56b34f965b01e6d21f7447e2d80ffef6abe27c7a2ca2e73cee369280a8029949bb3ea5bc3bc176364ba5ed11d2b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d04e267ee63704cccf8a3a397a0a8e2775f510f024e199e15954d6faeec4484352cafa89344478c9c9c7280a2e090328b69c468e19a515689d8b0db3f54834f6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/574597b1e34d0886d17b1c4564b9980e90e2f8bffdf318547c25c264c9f4054c84ff3a4331e75e1d7b486056d7b40fad31f72002d893f9319831ec767502b76c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62ceeb45a6df43d1a0b7fcfcdf403d7758246b5a2b2bbc544fe3b879fabd5ed9edd010bc7d130fe7df782a6355bd951fe5d70b7234b0339103a86396f49cf06f"} build_url:https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95c808b64f6885d91175f1c6685300c7c78fb56b34f965b01e6d21f7447e2d80ffef6abe27c7a2ca2e73cee369280a8029949bb3ea5bc3bc176364ba5ed11d2b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d04e267ee63704cccf8a3a397a0a8e2775f510f024e199e15954d6faeec4484352cafa89344478c9c9c7280a2e090328b69c468e19a515689d8b0db3f54834f6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/574597b1e34d0886d17b1c4564b9980e90e2f8bffdf318547c25c264c9f4054c84ff3a4331e75e1d7b486056d7b40fad31f72002d893f9319831ec767502b76c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62ceeb45a6df43d1a0b7fcfcdf403d7758246b5a2b2bbc544fe3b879fabd5ed9edd010bc7d130fe7df782a6355bd951fe5d70b7234b0339103a86396f49cf06f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 18:15:26.902615) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 18:15:26.903006) ========= 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=8783db0840cc980e80bb0bd400000236-1506387278.617857-997006457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 18:15:26.985108) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 18:15:26.985450) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 18:15:26.985813) ========= ========= Total master_lag: 0.28 =========