builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1506012746.08 results: success (0) revision: b14c75b83d0226333b1240466ea9f07cfb206ff3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 09:52:26.077263) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 09:52:26.077659) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 09:52:26.077980) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 09:52:26.200683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:52:26.200927) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 09:52:26-- 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% 46.3M=0s 2017-09-21 09:52:26 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.175883 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:52:26.402110) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:52:26.402383) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018551 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:52:26.454215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:52:26.454526) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b14c75b83d0226333b1240466ea9f07cfb206ff3 --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 b14c75b83d0226333b1240466ea9f07cfb206ff3 --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=c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 09:52:26,820 truncating revision to first 12 chars 2017-09-21 09:52:26,821 Setting DEBUG logging. 2017-09-21 09:52:26,821 attempt 1/10 2017-09-21 09:52:26,821 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b14c75b83d02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 09:52:27,082 unpacking tar archive at: mozilla-central-b14c75b83d02/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586245 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:52:27.065989) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 09:52:27.066289) ========= script_repo_revision: b14c75b83d0226333b1240466ea9f07cfb206ff3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 09:52:27.066732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 09:52:27.067105) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 09:52:27.093879) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-21 09:52:27.094141) ========= /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=c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:52:27 INFO - MultiFileLogger online at 20170921 09:52:27 in /builds/slave/test 09:52:27 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 09:52:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:52:27 INFO - {'append_to_log': False, 09:52:27 INFO - 'base_work_dir': '/builds/slave/test', 09:52:27 INFO - 'blob_upload_branch': 'Firefox', 09:52:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:52:27 INFO - 'branch': 'Firefox', 09:52:27 INFO - 'buildbot_json_path': 'buildprops.json', 09:52:27 INFO - 'code_coverage': False, 09:52:27 INFO - 'config_files': ('talos/linux_config.py',), 09:52:27 INFO - 'default_actions': ('clobber', 09:52:27 INFO - 'read-buildbot-config', 09:52:27 INFO - 'download-and-extract', 09:52:27 INFO - 'populate-webroot', 09:52:27 INFO - 'create-virtualenv', 09:52:27 INFO - 'install', 09:52:27 INFO - 'setup-mitmproxy', 09:52:27 INFO - 'run-tests'), 09:52:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:52:27 INFO - 'disable_ccov_upload': False, 09:52:27 INFO - 'disable_stylo': False, 09:52:27 INFO - 'download_minidump_stackwalk': True, 09:52:27 INFO - 'download_symbols': 'ondemand', 09:52:27 INFO - 'enable_stylo': False, 09:52:27 INFO - 'enable_webrender': False, 09:52:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 09:52:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:52:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:52:27 INFO - 'gecko_profile': False, 09:52:27 INFO - 'gecko_profile_interval': 0, 09:52:27 INFO - 'installer_path': 'installer.exe', 09:52:27 INFO - 'log_level': 'info', 09:52:27 INFO - 'log_name': 'talos', 09:52:27 INFO - 'log_to_console': True, 09:52:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:52:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:52:27 INFO - 'opt_config_files': (), 09:52:27 INFO - 'pip_index': False, 09:52:27 INFO - 'suite': 'dromaeojs-e10s', 09:52:27 INFO - 'system_bits': '32', 09:52:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:52:27 INFO - 'title': 'talos-linux64-ix-004', 09:52:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:52:27 INFO - 'use_talos_json': True, 09:52:27 INFO - 'verify': 'False', 09:52:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:52:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:52:27 INFO - 'work_dir': 'build'} 09:52:27 INFO - [mozharness: 2017-09-21 16:52:27.620509Z] Running clobber step. 09:52:27 INFO - Running pre-action listener: _resource_record_pre_action 09:52:27 INFO - Running main action method: clobber 09:52:27 INFO - rmtree: /builds/slave/test/build 09:52:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:52:29 INFO - Running post-action listener: _resource_record_post_action 09:52:29 INFO - [mozharness: 2017-09-21 16:52:29.123492Z] Finished clobber step (success) 09:52:29 INFO - [mozharness: 2017-09-21 16:52:29.123590Z] Running read-buildbot-config step. 09:52:29 INFO - Running pre-action listener: _resource_record_pre_action 09:52:29 INFO - Running main action method: read_buildbot_config 09:52:29 INFO - Using buildbot properties: 09:52:29 INFO - { 09:52:29 INFO - "project": "", 09:52:29 INFO - "product": "firefox", 09:52:29 INFO - "who": "archaeopteryx@coole-files.de", 09:52:29 INFO - "installer_path": "public/build/target.tar.bz2", 09:52:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:52:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 09:52:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 09:52:29 INFO - "stage_platform": "linux64-pgo", 09:52:29 INFO - "basedir": "/builds/slave/test", 09:52:29 INFO - "buildnumber": 192, 09:52:29 INFO - "platform": "ubuntu64_hw", 09:52:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:52:29 INFO - "slavebuilddir": "test", 09:52:29 INFO - "taskId": "ATpPwEqoQ7-vty1BGIcPzQ", 09:52:29 INFO - "branch": "mozilla-central", 09:52:29 INFO - "script_repo_revision": "production", 09:52:29 INFO - "revision": "b14c75b83d0226333b1240466ea9f07cfb206ff3", 09:52:29 INFO - "slavename": "talos-linux64-ix-004", 09:52:29 INFO - "repo_path": "mozilla-central" 09:52:29 INFO - } 09:52:29 INFO - Finding installer, test and symbols from parent task. 09:52:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ATpPwEqoQ7-vty1BGIcPzQ'}, attempt #1 09:52:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ATpPwEqoQ7-vty1BGIcPzQ'}, attempt #1 09:52:30 INFO - Task dependencies: PaoJjzfISE2tJvHNzbVhiw 09:52:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw'}, attempt #1 09:52:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.tar.bz2 09:52:31 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.test_packages.json 09:52:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.crashreporter-symbols.zip 09:52:31 INFO - Running post-action listener: _resource_record_post_action 09:52:31 INFO - [mozharness: 2017-09-21 16:52:31.353266Z] Finished read-buildbot-config step (success) 09:52:31 INFO - [mozharness: 2017-09-21 16:52:31.353576Z] Running download-and-extract step. 09:52:31 INFO - Running pre-action listener: _resource_record_pre_action 09:52:31 INFO - Running main action method: download_and_extract 09:52:31 INFO - mkdir: /builds/slave/test/build/tests 09:52:31 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')]} 09:52:31 INFO - trying https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.test_packages.json 09:52:31 INFO - Downloading https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:52:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:52:32 INFO - Downloaded 989 bytes. 09:52:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:52:32 INFO - Using the following test package requirements: 09:52:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:52:32 INFO - u'common': [u'target.common.tests.zip'], 09:52:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:52:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:52:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:52:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:52:32 INFO - u'mozbase': [u'target.common.tests.zip'], 09:52:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:52:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:52:32 INFO - u'web-platform': [u'target.common.tests.zip', 09:52:32 INFO - u'target.web-platform.tests.tar.gz'], 09:52:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:52:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 09:52:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.common.tests.zip 09:52:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:52:32 INFO - Fetch https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.common.tests.zip into memory 09:52:33 INFO - Content-Length response header: 55326003 09:52:33 INFO - Bytes received: 55326003 09:52:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.talos.tests.zip 09:52:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:52:43 INFO - Fetch https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.talos.tests.zip into memory 09:52:44 INFO - Content-Length response header: 14509184 09:52:44 INFO - Bytes received: 14509184 09:52: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')]} 09:52:44 INFO - trying https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.tar.bz2 09:52:44 INFO - Downloading https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:52:47 INFO - Downloaded 62334866 bytes. 09:52:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.tar.bz2 09:52:47 INFO - mkdir: /builds/slave/test/properties 09:52:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:52:47 INFO - Writing to file /builds/slave/test/properties/build_url 09:52:47 INFO - Contents: 09:52:47 INFO - build_url:https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.tar.bz2 09:52:47 INFO - Running post-action listener: _resource_record_post_action 09:52:47 INFO - Running post-action listener: find_tests_for_verification 09:52:47 INFO - Running post-action listener: set_extra_try_arguments 09:52:47 INFO - [mozharness: 2017-09-21 16:52:47.528195Z] Finished download-and-extract step (success) 09:52:47 INFO - [mozharness: 2017-09-21 16:52:47.528297Z] Running populate-webroot step. 09:52:47 INFO - Running pre-action listener: _resource_record_pre_action 09:52:47 INFO - Running main action method: populate_webroot 09:52:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:52:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:52:47 INFO - 'tests': ['tresize', 09:52:47 INFO - 'tcanvasmark']}, 09:52:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:52:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:52:47 INFO - 'tests': ['dromaeo_css', 09:52:47 INFO - 'kraken']}, 09:52:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:52:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:52:47 INFO - 'talos_options': ['--disable-stylo'], 09:52:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:52:47 INFO - 'tests': ['damp', 'tps']}, 09:52:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:52:47 INFO - 'talos_options': ['--disable-stylo'], 09:52:47 INFO - 'tests': ['damp', 'tps']}, 09:52:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:52:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:52:47 INFO - 'tests': ['dromaeo_dom']}, 09:52:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:52:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:52:47 INFO - 'tests': ['basic_compositor_video', 09:52:47 INFO - 'glvideo']}, 09:52:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:52:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:52:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:52:47 INFO - 'talos_options': ['--disable-stylo'], 09:52:47 INFO - 'tests': ['ts_paint_webext', 09:52:47 INFO - 'tp5o_webext']}, 09:52:47 INFO - 'other-e10s': {'tests': ['a11yr', 09:52:47 INFO - 'ts_paint', 09:52:47 INFO - 'tpaint', 09:52:47 INFO - 'sessionrestore', 09:52:47 INFO - 'sessionrestore_many_windows', 09:52:47 INFO - 'sessionrestore_no_auto_restore', 09:52:47 INFO - 'tabpaint']}, 09:52:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:52:47 INFO - 'tests': ['a11yr', 09:52:47 INFO - 'ts_paint', 09:52:47 INFO - 'tpaint', 09:52:47 INFO - 'sessionrestore', 09:52:47 INFO - 'sessionrestore_many_windows', 09:52:47 INFO - 'sessionrestore_no_auto_restore', 09:52:47 INFO - 'tabpaint']}, 09:52:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:52:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 09:52:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:52:47 INFO - 'tests': ['perf_reftest_singletons']}, 09:52:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:52:47 INFO - 'tests': ['bloom_basic']}, 09:52:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:52:47 INFO - 'tsvgr_opacity', 09:52:47 INFO - 'tart', 09:52:47 INFO - 'tscrollx', 09:52:47 INFO - 'tsvg_static']}, 09:52:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:52:47 INFO - 'tests': ['tsvgx', 09:52:47 INFO - 'tsvgr_opacity', 09:52:47 INFO - 'tart', 09:52:47 INFO - 'tscrollx', 09:52:47 INFO - 'tsvg_static']}, 09:52:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:52:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:52:47 INFO - 'talos_options': ['--disable-stylo'], 09:52:47 INFO - 'tests': ['tp5o']}, 09:52:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:52:47 INFO - 'talos_options': ['--mitmproxy', 09:52:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:52:47 INFO - '--firstNonBlankPaint'], 09:52:47 INFO - 'tests': ['tp6_google', 09:52:47 INFO - 'tp6_youtube', 09:52:47 INFO - 'tp6_amazon', 09:52:47 INFO - 'tp6_facebook']}, 09:52:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:52:47 INFO - 'talos_options': ['--disable-stylo', 09:52:47 INFO - '--mitmproxy', 09:52:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:52:47 INFO - '--firstNonBlankPaint'], 09:52:47 INFO - 'tests': ['tp6_google', 09:52:47 INFO - 'tp6_youtube', 09:52:47 INFO - 'tp6_amazon', 09:52:47 INFO - 'tp6_facebook']}, 09:52:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:52:47 INFO - 'talos_options': ['--stylo-threads=1', 09:52:47 INFO - '--mitmproxy', 09:52:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:52:47 INFO - '--firstNonBlankPaint'], 09:52:47 INFO - 'tests': ['tp6_google', 09:52:47 INFO - 'tp6_youtube', 09:52:47 INFO - 'tp6_amazon', 09:52:47 INFO - 'tp6_facebook']}, 09:52:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:52:47 INFO - 'talos_options': ['--xperf_path', 09:52:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:47 INFO - 'tests': ['tp5n']}, 09:52:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:52:47 INFO - 'talos_options': ['--disable-stylo', 09:52:47 INFO - '--xperf_path', 09:52:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:47 INFO - 'tests': ['tp5n']}}} 09:52:47 INFO - Running post-action listener: _resource_record_post_action 09:52:47 INFO - [mozharness: 2017-09-21 16:52:47.551214Z] Finished populate-webroot step (success) 09:52:47 INFO - [mozharness: 2017-09-21 16:52:47.551305Z] Running create-virtualenv step. 09:52:47 INFO - Running pre-action listener: _resource_record_pre_action 09:52:47 INFO - Running main action method: create_virtualenv 09:52:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:52:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:52:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 09:52:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:52:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:52:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:52:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:52:48 INFO - Installing pip...............done. 09:52:48 INFO - Return code: 0 09:52:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:52:48 INFO - Reading from file tmpfile_stdout 09:52:48 INFO - Output received: 09:52:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 09:52:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299090>, '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 0x2299d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2293f90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', '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 09:52:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:52:48 INFO - Using env: {'DISPLAY': ':0', 09:52:48 INFO - 'HOME': '/home/cltbld', 09:52:48 INFO - 'LANG': 'en_US.UTF-8', 09:52:48 INFO - 'LANGUAGE': 'en_US:en', 09:52:48 INFO - 'LOGNAME': 'cltbld', 09:52:48 INFO - 'MAIL': '/var/mail/cltbld', 09:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:48 INFO - 'MOZ_NO_REMOTE': '1', 09:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:48 INFO - 'NO_EM_RESTART': '1', 09:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:48 INFO - 'PWD': '/builds/slave/test', 09:52:48 INFO - 'SHELL': '/bin/bash', 09:52:48 INFO - 'SHLVL': '1', 09:52:48 INFO - 'TERM': 'linux', 09:52:48 INFO - 'TMOUT': '86400', 09:52:48 INFO - 'USER': 'cltbld', 09:52:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', 09:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:48 INFO - '_': '/tools/buildbot/bin/python'} 09:52:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:52:49 INFO - Downloading/unpacking pip>=1.5 09:52:49 INFO - Running setup.py egg_info for package pip 09:52:49 INFO - warning: no files found matching 'pip/cacert.pem' 09:52:49 INFO - warning: no files found matching '*.html' under directory 'docs' 09:52:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:52:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:52:49 INFO - Installing collected packages: pip 09:52:49 INFO - Found existing installation: pip 1.1 09:52:49 INFO - Uninstalling pip: 09:52:49 INFO - Successfully uninstalled pip 09:52:49 INFO - Running setup.py install for pip 09:52:49 INFO - warning: no files found matching 'pip/cacert.pem' 09:52:49 INFO - warning: no files found matching '*.html' under directory 'docs' 09:52:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:52:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:52:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 09:52:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 09:52:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 09:52:49 INFO - Successfully installed pip 09:52:49 INFO - Cleaning up... 09:52:49 INFO - Return code: 0 09:52:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299090>, '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 0x2299d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2293f90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', '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 09:52:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:52:49 INFO - Using env: {'DISPLAY': ':0', 09:52:49 INFO - 'HOME': '/home/cltbld', 09:52:49 INFO - 'LANG': 'en_US.UTF-8', 09:52:49 INFO - 'LANGUAGE': 'en_US:en', 09:52:49 INFO - 'LOGNAME': 'cltbld', 09:52:49 INFO - 'MAIL': '/var/mail/cltbld', 09:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:49 INFO - 'MOZ_NO_REMOTE': '1', 09:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:49 INFO - 'NO_EM_RESTART': '1', 09:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:49 INFO - 'PWD': '/builds/slave/test', 09:52:49 INFO - 'SHELL': '/bin/bash', 09:52:49 INFO - 'SHLVL': '1', 09:52:49 INFO - 'TERM': 'linux', 09:52:49 INFO - 'TMOUT': '86400', 09:52:49 INFO - 'USER': 'cltbld', 09:52:49 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', 09:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:49 INFO - '_': '/tools/buildbot/bin/python'} 09:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:49 INFO - Downloading/unpacking psutil>=3.1.1 09:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:52:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:51 INFO - Installing collected packages: psutil 09:52:51 INFO - Running setup.py install for psutil 09:52:51 INFO - building 'psutil._psutil_linux' extension 09:52:51 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 09:52:51 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 09:52:51 INFO - building 'psutil._psutil_posix' extension 09:52:51 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 09:52:51 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 09:52:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:51 INFO - Successfully installed psutil 09:52:51 INFO - Cleaning up... 09:52:51 INFO - Return code: 0 09:52:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299090>, '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 0x2299d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2293f90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', '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 09:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:52:51 INFO - Using env: {'DISPLAY': ':0', 09:52:51 INFO - 'HOME': '/home/cltbld', 09:52:51 INFO - 'LANG': 'en_US.UTF-8', 09:52:51 INFO - 'LANGUAGE': 'en_US:en', 09:52:51 INFO - 'LOGNAME': 'cltbld', 09:52:51 INFO - 'MAIL': '/var/mail/cltbld', 09:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:51 INFO - 'MOZ_NO_REMOTE': '1', 09:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:51 INFO - 'NO_EM_RESTART': '1', 09:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:51 INFO - 'PWD': '/builds/slave/test', 09:52:51 INFO - 'SHELL': '/bin/bash', 09:52:51 INFO - 'SHLVL': '1', 09:52:51 INFO - 'TERM': 'linux', 09:52:51 INFO - 'TMOUT': '86400', 09:52:51 INFO - 'USER': 'cltbld', 09:52:51 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', 09:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:51 INFO - '_': '/tools/buildbot/bin/python'} 09:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:52:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:52:53 INFO - Installing collected packages: mozsystemmonitor 09:52:53 INFO - Running setup.py install for mozsystemmonitor 09:52:53 INFO - Successfully installed mozsystemmonitor 09:52:53 INFO - Cleaning up... 09:52:54 INFO - Return code: 0 09:52:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299090>, '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 0x2299d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2293f90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', '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 09:52:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:52:54 INFO - Using env: {'DISPLAY': ':0', 09:52:54 INFO - 'HOME': '/home/cltbld', 09:52:54 INFO - 'LANG': 'en_US.UTF-8', 09:52:54 INFO - 'LANGUAGE': 'en_US:en', 09:52:54 INFO - 'LOGNAME': 'cltbld', 09:52:54 INFO - 'MAIL': '/var/mail/cltbld', 09:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:54 INFO - 'MOZ_NO_REMOTE': '1', 09:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:54 INFO - 'NO_EM_RESTART': '1', 09:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:54 INFO - 'PWD': '/builds/slave/test', 09:52:54 INFO - 'SHELL': '/bin/bash', 09:52:54 INFO - 'SHLVL': '1', 09:52:54 INFO - 'TERM': 'linux', 09:52:54 INFO - 'TMOUT': '86400', 09:52:54 INFO - 'USER': 'cltbld', 09:52:54 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', 09:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:54 INFO - '_': '/tools/buildbot/bin/python'} 09:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:54 INFO - Downloading/unpacking jsonschema==2.5.1 09:52:54 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 09:52:54 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 09:52:54 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 09:52:54 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 09:52:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:52:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:52:55 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 09:52:55 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 09:52:55 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 09:52:55 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 09:52:55 INFO - Downloading functools32-3.2.3-2.tar.gz 09:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:52:55 INFO - warning: no files found matching '*.txt' 09:52:55 INFO - no previously-included directories found matching 'build' 09:52:55 INFO - no previously-included directories found matching 'dist' 09:52:55 INFO - no previously-included directories found matching '.git*' 09:52:55 INFO - Installing collected packages: jsonschema, functools32 09:52:56 INFO - Running setup.py install for functools32 09:52:56 INFO - warning: no files found matching '*.txt' 09:52:56 INFO - no previously-included directories found matching 'build' 09:52:56 INFO - no previously-included directories found matching 'dist' 09:52:56 INFO - no previously-included directories found matching '.git*' 09:52:56 INFO - Successfully installed jsonschema functools32 09:52:56 INFO - Cleaning up... 09:52:56 INFO - Return code: 0 09:52:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:56 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 0x1f291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299090>, '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 0x2299d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2293f90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', '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 09:52:56 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 09:52:56 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 09:52:56 INFO - Using env: {'DISPLAY': ':0', 09:52:56 INFO - 'HOME': '/home/cltbld', 09:52:56 INFO - 'LANG': 'en_US.UTF-8', 09:52:56 INFO - 'LANGUAGE': 'en_US:en', 09:52:56 INFO - 'LOGNAME': 'cltbld', 09:52:56 INFO - 'MAIL': '/var/mail/cltbld', 09:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:56 INFO - 'MOZ_NO_REMOTE': '1', 09:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:56 INFO - 'NO_EM_RESTART': '1', 09:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:56 INFO - 'PWD': '/builds/slave/test', 09:52:56 INFO - 'SHELL': '/bin/bash', 09:52:56 INFO - 'SHLVL': '1', 09:52:56 INFO - 'TERM': 'linux', 09:52:56 INFO - 'TMOUT': '86400', 09:52:56 INFO - 'USER': 'cltbld', 09:52:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', 09:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:56 INFO - '_': '/tools/buildbot/bin/python'} 09:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:52:56 INFO - Cleaning up... 09:52:56 INFO - Return code: 0 09:52:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:56 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 0x1f291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299090>, '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 0x2299d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2293f90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', '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 09:52:56 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 09:52:56 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 09:52:56 INFO - Using env: {'DISPLAY': ':0', 09:52:56 INFO - 'HOME': '/home/cltbld', 09:52:56 INFO - 'LANG': 'en_US.UTF-8', 09:52:56 INFO - 'LANGUAGE': 'en_US:en', 09:52:56 INFO - 'LOGNAME': 'cltbld', 09:52:56 INFO - 'MAIL': '/var/mail/cltbld', 09:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:56 INFO - 'MOZ_NO_REMOTE': '1', 09:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:56 INFO - 'NO_EM_RESTART': '1', 09:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:56 INFO - 'PWD': '/builds/slave/test', 09:52:56 INFO - 'SHELL': '/bin/bash', 09:52:56 INFO - 'SHLVL': '1', 09:52:56 INFO - 'TERM': 'linux', 09:52:56 INFO - 'TMOUT': '86400', 09:52:56 INFO - 'USER': 'cltbld', 09:52:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', 09:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:56 INFO - '_': '/tools/buildbot/bin/python'} 09:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:52:56 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 09:52:56 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 09:52:56 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 09:52:56 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 09:52:57 INFO - Downloading blobuploader-1.2.4.tar.gz 09:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:52:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:52:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:58 INFO - Downloading docopt-0.6.1.tar.gz 09:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:52:58 INFO - Installing collected packages: blobuploader, requests, docopt 09:52:58 INFO - Running setup.py install for blobuploader 09:52:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:52:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:52:58 INFO - Running setup.py install for requests 09:52:58 INFO - Running setup.py install for docopt 09:52:58 INFO - Successfully installed blobuploader requests docopt 09:52:58 INFO - Cleaning up... 09:52:58 INFO - Return code: 0 09:52:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52: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')]} 09:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:58 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 0x1f291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299090>, '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 0x2299d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2293f90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', '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 09:52:58 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 09:52:58 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 09:52:58 INFO - Using env: {'DISPLAY': ':0', 09:52:58 INFO - 'HOME': '/home/cltbld', 09:52:58 INFO - 'LANG': 'en_US.UTF-8', 09:52:59 INFO - 'LANGUAGE': 'en_US:en', 09:52:59 INFO - 'LOGNAME': 'cltbld', 09:52:59 INFO - 'MAIL': '/var/mail/cltbld', 09:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:59 INFO - 'MOZ_NO_REMOTE': '1', 09:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:59 INFO - 'NO_EM_RESTART': '1', 09:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:59 INFO - 'PWD': '/builds/slave/test', 09:52:59 INFO - 'SHELL': '/bin/bash', 09:52:59 INFO - 'SHLVL': '1', 09:52:59 INFO - 'TERM': 'linux', 09:52:59 INFO - 'TMOUT': '86400', 09:52:59 INFO - 'USER': 'cltbld', 09:52:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', 09:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:59 INFO - '_': '/tools/buildbot/bin/python'} 09:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:52:59 INFO - Running setup.py (path:/tmp/pip-lWvt4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:52:59 INFO - Running setup.py (path:/tmp/pip-qh5Z30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:52:59 INFO - Running setup.py (path:/tmp/pip-K2X7yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:52:59 INFO - Running setup.py (path:/tmp/pip-TQh3XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:52:59 INFO - Running setup.py (path:/tmp/pip-8vMMZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:52:59 INFO - Running setup.py (path:/tmp/pip-CGn4zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:52:59 INFO - Running setup.py (path:/tmp/pip-GmzLc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:52:59 INFO - Running setup.py (path:/tmp/pip-ubxlsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:52:59 INFO - Running setup.py (path:/tmp/pip-n3KD9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:52:59 INFO - Running setup.py (path:/tmp/pip-s3_QPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:52:59 INFO - Running setup.py (path:/tmp/pip-mMCq73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:52:59 INFO - Running setup.py (path:/tmp/pip-61jodQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:53:00 INFO - Running setup.py (path:/tmp/pip-LQmwvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:53:00 INFO - Running setup.py (path:/tmp/pip-AwCavl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:00 INFO - Running setup.py (path:/tmp/pip-ogbEl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:53:00 INFO - Running setup.py (path:/tmp/pip-FdveJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:53:00 INFO - Running setup.py (path:/tmp/pip-jTXl1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:53:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:53:00 INFO - Running setup.py install for manifestparser 09:53:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Running setup.py install for mozcrash 09:53:00 INFO - Running setup.py install for mozdebug 09:53:00 INFO - Running setup.py install for mozdevice 09:53:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Running setup.py install for mozfile 09:53:00 INFO - Running setup.py install for mozhttpd 09:53:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Running setup.py install for mozinfo 09:53:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:53:01 INFO - Running setup.py install for mozInstall 09:53:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:53:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:53:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:53:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:53:01 INFO - Running setup.py install for mozleak 09:53:01 INFO - Running setup.py install for mozlog 09:53:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:53:01 INFO - Running setup.py install for moznetwork 09:53:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:53:01 INFO - Running setup.py install for mozprocess 09:53:01 INFO - Running setup.py install for mozprofile 09:53:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:53:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:53:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:53:01 INFO - Running setup.py install for mozrunner 09:53:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:53:01 INFO - Running setup.py install for mozscreenshot 09:53:01 INFO - Running setup.py install for moztest 09:53:02 INFO - Running setup.py install for mozversion 09:53:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:53:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:53:02 INFO - Cleaning up... 09:53:02 INFO - Return code: 0 09:53:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:02 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')]} 09:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:02 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')]} 09:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:02 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 0x1f291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299090>, '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 0x2299d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2293f90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', '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 09:53:02 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 09:53:02 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 09:53:02 INFO - Using env: {'DISPLAY': ':0', 09:53:02 INFO - 'HOME': '/home/cltbld', 09:53:02 INFO - 'LANG': 'en_US.UTF-8', 09:53:02 INFO - 'LANGUAGE': 'en_US:en', 09:53:02 INFO - 'LOGNAME': 'cltbld', 09:53:02 INFO - 'MAIL': '/var/mail/cltbld', 09:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:02 INFO - 'MOZ_NO_REMOTE': '1', 09:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:02 INFO - 'NO_EM_RESTART': '1', 09:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:02 INFO - 'PWD': '/builds/slave/test', 09:53:02 INFO - 'SHELL': '/bin/bash', 09:53:02 INFO - 'SHLVL': '1', 09:53:02 INFO - 'TERM': 'linux', 09:53:02 INFO - 'TMOUT': '86400', 09:53:02 INFO - 'USER': 'cltbld', 09:53:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', 09:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:02 INFO - '_': '/tools/buildbot/bin/python'} 09:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:53:02 INFO - Running setup.py (path:/tmp/pip-MTcIii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:53:02 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)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:53:02 INFO - Running setup.py (path:/tmp/pip-hjC2aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:53:02 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)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:53:02 INFO - Running setup.py (path:/tmp/pip-JUEHDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:53:02 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)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:53:02 INFO - Running setup.py (path:/tmp/pip-hUYZRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:53:02 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)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:53:02 INFO - Running setup.py (path:/tmp/pip-37zcgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:53:02 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)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:53:02 INFO - Running setup.py (path:/tmp/pip-j7BdSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:53:02 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)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:53:02 INFO - Running setup.py (path:/tmp/pip-oPX9Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:53:02 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)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:53:02 INFO - Running setup.py (path:/tmp/pip-02rMUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:53:02 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)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:53:02 INFO - Running setup.py (path:/tmp/pip-hPnzrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:53:03 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)) 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:53:03 INFO - Running setup.py (path:/tmp/pip-iTFRx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:53:03 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)) 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:53:03 INFO - Running setup.py (path:/tmp/pip-YdV1RN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:53:03 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)) 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:53:03 INFO - Running setup.py (path:/tmp/pip-jTXMu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:53:03 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)) 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:53:03 INFO - Running setup.py (path:/tmp/pip-BKJ942-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:53:03 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)) 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:53:03 INFO - Running setup.py (path:/tmp/pip-SpMBEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:53:03 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)) 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:03 INFO - Running setup.py (path:/tmp/pip-Bumug6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:03 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)) 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:53:03 INFO - Running setup.py (path:/tmp/pip-SwQGaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:53:03 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)) 09:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:53:03 INFO - Running setup.py (path:/tmp/pip-jnJQOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:53:03 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)) 09:53:03 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)) 09:53:03 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)) 09:53:03 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)) 09:53:03 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)) 09:53:03 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)) 09:53:03 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)) 09:53:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:53:03 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 09:53:03 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 09:53:03 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 09:53:03 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 09:53:04 INFO - Downloading blessings-1.6.tar.gz 09:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:53:04 INFO - Installing collected packages: blessings 09:53:04 INFO - Running setup.py install for blessings 09:53:04 INFO - Successfully installed blessings 09:53:04 INFO - Cleaning up... 09:53:04 INFO - Return code: 0 09:53:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:53:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:05 INFO - Reading from file tmpfile_stdout 09:53:05 INFO - Current package versions: 09:53:05 INFO - argparse == 1.2.1 09:53:05 INFO - blessings == 1.6 09:53:05 INFO - blobuploader == 1.2.4 09:53:05 INFO - docopt == 0.6.1 09:53:05 INFO - functools32 == 3.2.3-2 09:53:05 INFO - jsonschema == 2.5.1 09:53:05 INFO - manifestparser == 1.1 09:53:05 INFO - mozInstall == 1.13 09:53:05 INFO - mozcrash == 1.0 09:53:05 INFO - mozdebug == 0.1 09:53:05 INFO - mozdevice == 0.51 09:53:05 INFO - mozfile == 1.2 09:53:05 INFO - mozhttpd == 0.7 09:53:05 INFO - mozinfo == 0.10 09:53:05 INFO - mozleak == 0.1 09:53:05 INFO - mozlog == 3.5 09:53:05 INFO - moznetwork == 0.27 09:53:05 INFO - mozprocess == 0.25 09:53:05 INFO - mozprofile == 0.28 09:53:05 INFO - mozrunner == 6.13 09:53:05 INFO - mozscreenshot == 0.1 09:53:05 INFO - mozsystemmonitor == 0.3 09:53:05 INFO - moztest == 0.8 09:53:05 INFO - mozversion == 1.4 09:53:05 INFO - psutil == 3.1.1 09:53:05 INFO - requests == 1.2.3 09:53:05 INFO - wsgiref == 0.1.2 09:53:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53: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')]} 09:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:05 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 0x1f291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299090>, '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 0x2299d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2293f90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', '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 09:53:05 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 09:53:05 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 09:53:05 INFO - Using env: {'DISPLAY': ':0', 09:53:05 INFO - 'HOME': '/home/cltbld', 09:53:05 INFO - 'LANG': 'en_US.UTF-8', 09:53:05 INFO - 'LANGUAGE': 'en_US:en', 09:53:05 INFO - 'LOGNAME': 'cltbld', 09:53:05 INFO - 'MAIL': '/var/mail/cltbld', 09:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:05 INFO - 'MOZ_NO_REMOTE': '1', 09:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:05 INFO - 'NO_EM_RESTART': '1', 09:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:05 INFO - 'PWD': '/builds/slave/test', 09:53:05 INFO - 'SHELL': '/bin/bash', 09:53:05 INFO - 'SHLVL': '1', 09:53:05 INFO - 'TERM': 'linux', 09:53:05 INFO - 'TMOUT': '86400', 09:53:05 INFO - 'USER': 'cltbld', 09:53:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', 09:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:05 INFO - '_': '/tools/buildbot/bin/python'} 09:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:05 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)) 09:53:05 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)) 09:53:05 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)) 09:53:05 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)) 09:53:05 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)) 09:53:05 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)) 09:53:05 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)) 09:53:05 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)) 09:53:05 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)) 09:53:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:53:05 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 09:53:05 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 09:53:05 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 09:53:05 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 09:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:53:06 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)) 09:53:06 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)) 09:53:06 INFO - Installing collected packages: simplejson 09:53:06 INFO - Running setup.py install for simplejson 09:53:06 INFO - building 'simplejson._speedups' extension 09:53:06 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 09:53:07 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 09:53:07 INFO - Successfully installed simplejson 09:53:07 INFO - Cleaning up... 09:53:07 INFO - Return code: 0 09:53:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:07 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 0x1f291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2299090>, '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 0x2299d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2293f90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', '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 09:53:07 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 09:53:07 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 09:53:07 INFO - Using env: {'DISPLAY': ':0', 09:53:07 INFO - 'HOME': '/home/cltbld', 09:53:07 INFO - 'LANG': 'en_US.UTF-8', 09:53:07 INFO - 'LANGUAGE': 'en_US:en', 09:53:07 INFO - 'LOGNAME': 'cltbld', 09:53:07 INFO - 'MAIL': '/var/mail/cltbld', 09:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:07 INFO - 'MOZ_NO_REMOTE': '1', 09:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:07 INFO - 'NO_EM_RESTART': '1', 09:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:07 INFO - 'PWD': '/builds/slave/test', 09:53:07 INFO - 'SHELL': '/bin/bash', 09:53:07 INFO - 'SHLVL': '1', 09:53:07 INFO - 'TERM': 'linux', 09:53:07 INFO - 'TMOUT': '86400', 09:53:07 INFO - 'USER': 'cltbld', 09:53:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', 09:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:07 INFO - '_': '/tools/buildbot/bin/python'} 09:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:53:07 INFO - Cleaning up... 09:53:07 INFO - Return code: 0 09:53:07 INFO - Running post-action listener: _resource_record_post_action 09:53:07 INFO - Running post-action listener: _start_resource_monitoring 09:53:07 INFO - Starting resource monitoring. 09:53:07 INFO - [mozharness: 2017-09-21 16:53:07.892718Z] Finished create-virtualenv step (success) 09:53:07 INFO - [mozharness: 2017-09-21 16:53:07.893299Z] Running install step. 09:53:07 INFO - Running pre-action listener: _resource_record_pre_action 09:53:07 INFO - Running main action method: install 09:53:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:08 INFO - Reading from file tmpfile_stdout 09:53:08 INFO - Detecting whether we're running mozinstall >=1.0... 09:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:53:08 INFO - Reading from file tmpfile_stdout 09:53:08 INFO - Output received: 09:53:08 INFO - Usage: mozinstall [options] installer 09:53:08 INFO - Options: 09:53:08 INFO - -h, --help show this help message and exit 09:53:08 INFO - -d DEST, --destination=DEST 09:53:08 INFO - Directory to install application into. [default: 09:53:08 INFO - "/builds/slave/test"] 09:53:08 INFO - --app=APP Application being installed. [default: firefox] 09:53:08 INFO - mkdir: /builds/slave/test/build/application 09:53:08 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'] 09:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:53:25 INFO - Reading from file tmpfile_stdout 09:53:25 INFO - Output received: 09:53:25 INFO - /builds/slave/test/build/application/firefox/firefox 09:53:25 INFO - Running post-action listener: _resource_record_post_action 09:53:25 INFO - [mozharness: 2017-09-21 16:53:25.864619Z] Finished install step (success) 09:53:25 INFO - [mozharness: 2017-09-21 16:53:25.865020Z] Running setup-mitmproxy step. 09:53:25 INFO - Running pre-action listener: _resource_record_pre_action 09:53:25 INFO - Running main action method: setup_mitmproxy 09:53:25 INFO - Skipping: mitmproxy is not required 09:53:25 INFO - Running post-action listener: _resource_record_post_action 09:53:25 INFO - [mozharness: 2017-09-21 16:53:25.866628Z] Finished setup-mitmproxy step (success) 09:53:25 INFO - [mozharness: 2017-09-21 16:53:25.866941Z] Running run-tests step. 09:53:25 INFO - Running pre-action listener: _resource_record_pre_action 09:53:25 INFO - Running pre-action listener: _set_gcov_prefix 09:53:25 INFO - Running main action method: run_tests 09:53:25 WARNING - Try message not found. 09:53:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:53:25 INFO - Python 2.7.3 09:53:25 INFO - Return code: 0 09:53:25 INFO - grabbing minidump binary from tooltool 09:53: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')]} 09:53:25 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 0x2299090>, '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 0x2299d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2293f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:53:25 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 09:53:25 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 09:53:25 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 09:53:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:53:25 INFO - Return code: 0 09:53:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:53:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:53:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:53:26 INFO - ENV: RUST_BACKTRACE is now full 09:53:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:53:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:53:26 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/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 09:53:26 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/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 09:53:26 INFO - Using env: {'DISPLAY': ':0', 09:53:26 INFO - 'HOME': '/home/cltbld', 09:53:26 INFO - 'LANG': 'en_US.UTF-8', 09:53:26 INFO - 'LANGUAGE': 'en_US:en', 09:53:26 INFO - 'LOGNAME': 'cltbld', 09:53:26 INFO - 'MAIL': '/var/mail/cltbld', 09:53:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:53:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:26 INFO - 'MOZ_NO_REMOTE': '1', 09:53:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:26 INFO - 'NO_EM_RESTART': '1', 09:53:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:26 INFO - 'PWD': '/builds/slave/test', 09:53:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:53:26 INFO - 'RUST_BACKTRACE': 'full', 09:53:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:53:26 INFO - 'SHELL': '/bin/bash', 09:53:26 INFO - 'SHLVL': '1', 09:53:26 INFO - 'TERM': 'linux', 09:53:26 INFO - 'TMOUT': '86400', 09:53:26 INFO - 'USER': 'cltbld', 09:53:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', 09:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:26 INFO - '_': '/tools/buildbot/bin/python'} 09:53:26 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/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 09:53:26 INFO - mozversion application_buildid: 20170921152748 09:53:26 INFO - mozversion application_changeset: b14c75b83d0226333b1240466ea9f07cfb206ff3 09:53:26 INFO - mozversion application_display_name: Nightly 09:53:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:53:26 INFO - mozversion application_name: Firefox 09:53:26 INFO - mozversion application_remotingname: firefox 09:53:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:53:26 INFO - mozversion application_vendor: Mozilla 09:53:26 INFO - mozversion application_version: 58.0a1 09:53:26 INFO - mozversion platform_buildid: 20170921152748 09:53:26 INFO - mozversion platform_changeset: b14c75b83d0226333b1240466ea9f07cfb206ff3 09:53:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:53:26 INFO - mozversion platform_version: 58.0a1 09:53:26 INFO - using testdate: 1506012806 09:53:26 INFO - actual date: 1506012806 09:53:26 INFO - starting webserver on 'localhost:33601' 09:53:26 INFO - SUITE-START | Running 2 tests 09:53:26 INFO - TEST-START | dromaeo_css 09:53:26 INFO - Initialising browser for dromaeo_css test... 09:53:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33601/getInfo.html -profile /tmp/tmpyazrPG/profile 09:53:26 INFO - TEST-INFO | started process 30802 (/builds/slave/test/build/application/firefox/firefox http://localhost:33601/getInfo.html) 09:53:32 INFO - TEST-INFO | 30802: exit 0 09:53:32 INFO - Browser initialized. 09:53:32 INFO - Running cycle 1/1 for dromaeo_css test... 09:53:32 INFO - Using env: {'DISPLAY': ':0', 09:53:32 INFO - 'HOME': '/home/cltbld', 09:53:32 INFO - 'JSGC_DISABLE_POISONING': '1', 09:53:32 INFO - 'LANG': 'en_US.UTF-8', 09:53:32 INFO - 'LANGUAGE': 'en_US:en', 09:53:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:53:32 INFO - 'LOGNAME': 'cltbld', 09:53:32 INFO - 'MAIL': '/var/mail/cltbld', 09:53:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:53:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:53:32 INFO - 'MOZ_CRASHREPORTER': '1', 09:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:53:32 INFO - 'MOZ_NO_REMOTE': '1', 09:53:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:32 INFO - 'NO_EM_RESTART': '1', 09:53:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:32 INFO - 'PWD': '/builds/slave/test', 09:53:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:53:32 INFO - 'RUST_BACKTRACE': 'full', 09:53:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:53:32 INFO - 'SHELL': '/bin/bash', 09:53:32 INFO - 'SHLVL': '1', 09:53:32 INFO - 'TERM': 'linux', 09:53:32 INFO - 'TMOUT': '86400', 09:53:32 INFO - 'USER': 'cltbld', 09:53:32 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', 09:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:32 INFO - '_': '/tools/buildbot/bin/python'} 09:53:32 INFO - TEST-INFO | started process 31041 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyazrPG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:33 INFO - PID 31041 | 09:53:33 INFO - PID 31041 | (/builds/slave/test/build/application/firefox/firefox:31091): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:53:33 INFO - PID 31041 | 09:53:43 INFO - PID 31041 | RSS: Main: 147894272 09:53:43 INFO - PID 31041 | 09:56:40 INFO - PID 31041 | Cycle 1(1): loaded http://localhost:33601/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33601/tests/dromaeo/cssquery-ext.html) 09:56:41 INFO - PID 31041 | RSS: Main: 148627456 09:56:41 INFO - PID 31041 | 09:59:43 INFO - PID 31041 | Cycle 1(1): loaded http://localhost:33601/tests/dromaeo/cssquery-ext.html (next: http://localhost:33601/tests/dromaeo/cssquery-jquery.html) 09:59:43 INFO - PID 31041 | RSS: Main: 148037632 09:59:43 INFO - PID 31041 | 10:02:45 INFO - PID 31041 | Cycle 1(1): loaded http://localhost:33601/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33601/tests/dromaeo/cssquery-mootools.html) 10:02:45 INFO - PID 31041 | RSS: Main: 150695936 10:02:45 INFO - PID 31041 | 10:05:47 INFO - PID 31041 | Cycle 1(1): loaded http://localhost:33601/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33601/tests/dromaeo/cssquery-prototype.html) 10:05:48 INFO - PID 31041 | RSS: Main: 148807680 10:05:48 INFO - PID 31041 | 10:08:51 INFO - PID 31041 | Cycle 1(1): loaded http://localhost:33601/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33601/tests/dromaeo/cssquery-yui.html) 10:08:51 INFO - PID 31041 | RSS: Main: 149823488 10:08:51 INFO - PID 31041 | 10:11:53 INFO - PID 31041 | Cycle 1(1): loaded http://localhost:33601/tests/dromaeo/cssquery-yui.html (next: http://localhost:33601/tests/dromaeo/cssquery-dojo.html) 10:11:53 INFO - PID 31041 | RSS: Main: 152510464 10:11:53 INFO - PID 31041 | 10:11:53 INFO - PID 31041 | __start_tp_report 10:11:53 INFO - PID 31041 | _x_x_mozilla_page_load 10:11:53 INFO - PID 31041 | _x_x_mozilla_page_load_details 10:11:53 INFO - PID 31041 | |i|pagename|runs| 10:11:53 INFO - PID 31041 | |0;dojo.html;3882.2623701496696;3900.1419687668704;3927.489426374571;3929.62668546488;3944.901377465563;6185.350538193492;6300.21247344082;6331.715072821723;6401.679916004205;6455.612663240209;6364;6397.936020639792;6426.839329016777;6432.77485288015;6470.288268290485;5737.598368114233;5741.569382296324;5752.626079304852;5792;5831.183634291203;109.88510049208367;5656.490915817576;5683.147527870811;5690.687012214326;5858.707064646772;5702.2301989231755;5791.652500849962;5792.073268277056;5801.187833703285;5806.7386967586135;5714.685692286923;5732.082866741343;5759.1937128802;5802.535797136261;5814.418558144152;5682.090865461548;5704.172894930253;5754.050581654022;5767.567432442584;5777.104548794901;6331.588446750992;6337.429631333156;6376.649284289362;6426.421622053991;6456.580322279084;6839.076724642209;6904.758333458305;6917.169939607229;6964.825879353006;7022.332878376546;7025.981232721227;7102.751403700898;7109.39570136539;7128.180259270199;7130.465215108888;6462.644554549498;6479.967600162016;6540.084388185658;6547.083408322791;6561.60630362175;7095;7131.572105673677;7188.065551478275;7200.243974382719;7226.783196504113;6897.586144831326;6921.6193109379465;6947.4789390795895;6951.965240173767;6957.8956315655305;6856.280090590416;6946.895796563055;6956.8956465653055;7056.858862822817;7056.894146587805;6854.10896583441;6863.073485079551;6917.9308206917285;6920.757773477904;7015.333543313377;6993.0209770632155;7036.542624729376;7044.084269044992;7048.048513450619;7051.89422158668;5010.398752149766;5074.568661663726;5134.435212126663;5163.509466600667;5164.04465173944;4595.471520775153;4606.309053641913;4621.745803980813;4645.0477652081245;4691.038337140878;6385.6487893165395;6467.191601049869;6475.061116138134;6486.124373209651;6487.481001519867;6923.584584924921;6926.688299026556;7004.894926576106;7017.122859642544;7023.367896889203;6264.279607845065;6288.27684816252;6366.522510811707;6384.297727249998;6470.967645161838;5578.553715702734;5592.832215033555;5595.440455954454;5662.631928924607;5677.744501497443;7221.386182174574;7276.7453139140935;7304.598247096461;7307.086614173229;7316.926830731731;6892.069570607904;6893.241743408221;7005.2644472329675;7007.754728584475;7013.824654383681;7136.143662760502;7194.352508274281;7202.855942881009;7227.168875579376;7249.166345870292;6812.284710105368;6908.654567271717;6934.791956241321;6964.65176741171;6968.965155174395;6873.175218973555;6956;6968.268331825288;6973.163220413583;7059.611721355374;6649.401553860176;6714.83212919681;6741.393274605113;6742.696578653874;6744.730210791513;6671.766488172891;6697.698603562754;6698.56459330142;6705.362990515893;6705.765298214539;6573.967130164318;6624.436922861418;6642.867142657216;6646.634435106115;6657.600543967377;6781.660916954232;6796.35434633709;6804.6257455840405;6836.248012718696;6856.9314306856295;6510.381513756186;6625.204975402789;6632.4694024478895;6654.866902662016;6676.165479315086 10:11:53 INFO - PID 31041 | |1;ext.html;897.3354427536915;919.2324409118386;933.8039011807518;944.3625552751895;947.0907928388747;43820.56179438205;44498;44723.55276447235;44741.32888006674;44805.999999999956;42035;44469;44921;44987;45011.324830127574;8510.148985101503;8584.613692383826;8589.95705021474;8616.956915215414;8652.653893844239;8343.582820858963;8450.915490845106;8453;8491.915080849174;8494.447860889053;8452.957735211316;8502.872456913152;8542.572871356408;8542.572871356408;8548.31613470924;8378.748637540884;8379.45533540321;8428.915710842874;8457.95771021147;8462.830743385159;8076.717314894009;8131.878021829677;8137.593120344019;8143.226393492668;8149.348052155813;39753.80123099366;39889.601103988876;39928.600713993066;39943.80028099841;39993.80003099995;3758.5677647070665;3778.3387907116144;3786.924261514754;3789.0716774390175;3789.886303410902;33241.83379083113;33256.501152482735;33350;33411.3317733644;33551.83224083864;5368.570514358842;5481.945180548223;5537.058700020966;5538.141588053858;5574.498295153415;214597;218636;221612;223717;226369;52236;52685.47314526882;52693.209601856004;52702.73648631732;52784.208236876475;55286.17070743942;55432.16851747227;55949.44050559524;56035.719821400635;56087.71956140193;16241.756373654405;16329.67340653204;16333.67332653364;16427.09650969208;16445.424410145588;13255;13312.800307995389;13332.066755327034;13339.19964802115;13355.065145439727;13721.45114195421;13852.445902163801;13862.514811981533;14000.089994150349;14051.086679365808;5505.614606977553;5607.383187849333;5640.182173584807;5648.237487939075;5700.4299570043495;1075.2634445404922;1114.6043154679971;1120.8991190792706;1127.3067063755896;1131.4229742831214;25651;25688.357791055;25739.48521029569;25762.74237257641;26115.477690446463;1165.7843298989715;1186.6618013866007;1197.4970512384818;1224.12475080318;1236.6722818453118;13375.799363009563;13452.663683407798;13736.45054197841;13754.31228438574;13944.651383715489;280115;281758;282325;282407;282914;57062.714686426305;57067.14399284014;57256.42743572594;57257.42742572521;57271.14093288604;1463.5609317204796;1480.7334679757746;1508.2248662460904;1523.6724104317402;1531.7472617018068;25233.74766252314;25274.494510110064;25320.873395632905;25430.491390171723;25441.745582544678;39655.40516892307;39842.2031559373;39868.2026359477;39896.80051599723;39934.001649958984;235021;235192;236236;239004;240001;36620.26759464849;36885.26229475449;37905.4314185293;38119.80940095282;38266.6173338263;46760.29859552041;48303.275450867564;48889.75555122344;48973.75513122412;49090.75454622847;35687.28625427529;36294.45558316575;36350.454743179405;36531.26937461289;36661;35594;35757.28485430329;35785.284294313446;35878.461823073194;36038.639613603526;42365.576344236164;42415.1516969665;42436;42981.35527967146;43151.13697726091;34269;34281.142971425914;34287.314253714285;34304.48543271803;35035.29929401448;26935.326616834736;27180.592291116045;27615.309617258925;27657.170284891487;27697.58453623157 10:11:53 INFO - PID 31041 | |2;jquery.html;592.7428778860165;598.2581598817462;604.2084868821846;625.3246493786711;640.7469049725358;23382.181623643177;23861.522769544597;24057.51884962302;24065.1577194798;24110;25697.614535781933;26804.463910721774;26864.731352686515;26880.462390752175;26903.86548067262;6505.837354066139;6634.203895532519;6665.40011398974;6682.331766823303;6689.23073846509;6567.507436942248;6612.933870661304;6753.088333075046;6842.213145488258;6863;6810.387065164135;6812.4550035997245;6824.488163387766;6827.624480653562;6829.112215412014;6480.384363485485;6671.199456065303;6714.764983225564;6797.218319893202;6814.62519561424;6274.247090349141;6285.057241413779;6295.213098362705;6297.4962003039645;6299.275583307933;30613.08160755181;30890.69109308923;31083.06750797457;31100.8444957776;31182.688173118204;2238.597052530544;2242.988785056081;2254.7068881045525;2270.636698128308;2271.772822717715;19910.80089199104;21801.563968720537;21898.781012189833;21906.671399929015;21906.671399929015;2537.251510804317;2590.248827839924;2625.5930330798756;2635.920922372313;2648.4173481833964;140396;146636;152151.23924380308;156057;163401.18299408545;16471.588210294838;16863.662726745395;16886.493405197863;16979.575510612332;17166.742498862528;26419.603705944428;26529.33676658099;26581.867090664422;26642.86678566595;26687.599686004727;10248.692539223835;10528.684139475828;10556.736081598021;10579.682609521727;10632.52153653072;9344.719658410258;9474.289428292906;9484.14642682148;9508.857367139499;9576.95211523952;9722.2708296878;9821.558029888673;9928.205743540499;9980.201583873273;10046.748831279276;2953.616029916097;3000.324926891432;3019.682933291973;3022.2444388902773;3056.8777248910237;1036.7149034015556;1052.074174726236;1055.266589720137;1061.230607809332;1063.1176123817213;21431.357059288246;22145.557088858455;22161.116305114247;22239.666405003936;22323.55352892933;1099.912007039435;1106.6845948904524;1107.7396811749231;1112.5494174859195;1121.2263538158645;11996.520139194508;12245.510179592895;12344.259344439182;12425.689357765947;12474.251544907334;602382;602941;612816;616950;622428;126478;128167;128366;129157.35421322833;131831.34084329518;1200.7118291610125;1206.9879301206875;1242.5340497313507;1249.0444809720389;1259.571745606498;18982.620347592696;19065.237390504226;19401.126949287034;19534.21863125516;19957;61987;62449.37550624435;62915.37084629278;63189.36810631835;63436.68281658562;80323.59838200771;80473.59763201147;80609;81004.59497702474;81293;15939.36242550285;16151.838481615034;16215.270312835715;16262.918685406497;16264.349426022827;24814.503709926063;24844.751552484242;25105.372365691004;25150.62274065854;25341;20170.89914550418;20474.38576842697;20529.794702053387;20689.58620827605;20694;16215.108169050816;16891.831081689026;17124.657506850042;17284.135793210542;17497.38759143424;20174.59650807005;20353.79646203519;20555.8972205138;20555.8972205138;20602.793972060088;15671.58955693993;15816.76274855855;15913.761293580374;15971.760423593423;15992.840071599136;19628.411147665593;19976.20095196234;20014;20174.596508069462;20325.695114572998 10:11:53 INFO - PID 31041 | |3;mootools.html;1405.9015868889178;1467.1857119298784;1476.4684713503136;1478.120518291616;1488.5459934719913;16740.41408550701;17680.29278828847;17689.292428302884;17722.37971670992;17730.290788368482;17399.304027838873;17744.290228390848;17753;17754.378596749117;17775.82224177758;2845.943081138376;2868.827870327782;2927.634045744282;2947.82313061217;2954.3943491584173;2855.657321121458;2872.7127287271314;2895.218291061412;2899.797014209006;2903.7531809796087;2842.744153026227;2855.7001514840954;2864.398476319975;2868.211241908471;2874.741273285404;2635.920922372313;2718.945621087577;2724.209979106057;2725.168823508829;2730.6723193216744;2685.140754958414;2694.461107778452;2698.311930457721;2698.63568418263;2698.973010269892;16223.918880405641;16575.668486630322;16606.83393166077;16634;16968.151592420454;7762.45662803604;8331.916680833236;8341.582920853933;8344;8392.538410387426;5576.470235327637;5756.222909907151;5827.88344233113;5915.053591425351;5929.169916211734;1998.1607724755638;2012.7383440152687;2041.5406533529838;2043.4891277180704;2066.638338290793;31471.852814718575;32300.030999070066;32361.190970225463;32439.6756032439;32487.83756081228;7151.427885769126;7180.005495152478;7219.386352160021;7318.048653674989;7370.447216458787;20242.190312387633;20317.593648126956;20323.898380508002;20342.288019919233;20342.389728308175;8318.37612179089;8549.743507694779;8564.828703425897;8567.057623661392;8575;7508.3993280537425;7632;7653.425993050543;7789.7273595423885;7795.220477952273;5574.554035677217;5820.156077368758;5840.941590584125;5891.7054147292465;5907.822765317047;1633.3466613354515;1688.8986660800392;1691.8900271482314;1706.8634509239232;1710.6920754264352;932.7994481186578;939.7227817793768;956.679512363366;959.7648576098901;965.5896244096231;8220.465669731448;8226.753197404087;8240.258376746122;8244.29923456513;8292.295154911779;782.1279273609998;801.3869389916719;801.4750338528273;820.7742870710603;824.7360844529693;5580.469855363815;6242.563020588606;6256;6347.873042539123;6427.06807512908;25142.12002579901;25388.238352849443;25462.490750184894;25865;25892;24253.757462425503;25239.242822715347;25306.87346563292;25405.745942540707;25595.232143035737;12376.195547289397;12444.564440244549;12642;12661.620151395473;12696.746065078647;8920.821583568162;9725.416475011521;9914.553845077133;9933.850992234979;10010;21485.46286342854;21518.892405537874;21561.353159405244;22204;22677.546449071255;22363.329100127023;22521.774782251967;22710.65934010958;23107.306780796604;23181.42046448785;12011.879881201427;12229.327386993446;12344.13591048618;12346.074044446523;12347.073969452147;15370;15447.304871281043;15450.690986179989;15599.454019109276;15749.13379764124;11743.060555155396;11829.704257393634;12072.698182545506;12196.268223906594;12205.816912746493;12237.938810305892;12683.11218214716;12699.873001270238;12711.364431778558;12782.872171278168;11452.198346115692;11499.19505634631;11549.942250288696;11554.075673946232;11561.537538498365;7929.246721561442;8005.945848879629;8067.636956336862;8100.797480063045;8132.349412046904;8285.710000149966;8373;8385.874211886705;8451.535165565952;8545.487270763773 10:11:53 INFO - PID 31041 | |4;prototype.html;541.8374487653703;561.9016672082385;567.0530214541715;568.4599630351166;575.2866445607448;6203.162573052637;6257.155284036654;6290.86764382411;6312.147860038894;6330;6169.223849267825;6213.937860621392;6246.9062964055465;6264.185655864731;6298.779542716006;5102.209157580581;5121.615878809095;5123.308353372303;5146.6140039497;5172.301739265207;4903.632227582928;5054.494550544953;5125.538701516863;5153.922691159635;5164.45773193813;4946.689127381229;4955.677880937746;4983.900321993558;5028.8239911603105;5033.622478314122;4992.40091189056;4997.15048441764;4999.150144475448;5000.549950504472;5022.949770502285;4348.543402942709;4541.500434952186;4551.4083169188125;4552.795124219418;4567.949371644507;6023.909641355383;6089.269287685462;6113.358097399798;6128.295246046717;6136.846578835521;5816.2148110005455;5816.952948469274;5840.415958404125;5872.0898260769645;5874.471297583238;6633.583704392242;6636.435902948255;6683.966580167116;6685.863403221415;6707.75906457307;4867.148249056401;5100.744962751847;5127.512886275797;5131.281620573122;5151.072806894757;6764.154480689914;6836.555623884481;6866.759663411806;6938.618375989318;6948.200956889972;5207.661502002357;5210.114280572312;5258.447862974409;5264.473552644705;5274.314339135888;5313.920291195635;5323.574114070942;5332.5467335276935;5336.599755018312;5378.058839703036;5881.5000724938;5912.556558258148;5924.822255332347;5941.851453713605;5954.791582294599;6572.901406478906;6578.934210657832;6613.4709223262025;6653.135092438049;6682.632455214913;1802.7836659600932;1805.395192610464;1816.9454916352531;1839.5309196154894;1844.1609067874085;1126.2622981946838;1214.4838443661408;1215.4044518186024;1219.3903048475763;1223.3699644682995;6016.1878146450545;6039.335673075958;6095.512359011268;6146.293176284695;6148.938510614926;6557.409833115043;6668;6739.764108256188;6796.8300792479595;6845.863082738318;6155;6187.876242475215;6240.219972503437;6244.188255526752;6247.437730604177;3515.5781306243416;3550.627184145679;3552.698020668272;3611.33190359779;3627.4921510988484;6987.510874238755;7000.26497217795;7016.859662806715;7107.680154393065;7137.785866424016;6876.553024053421;6897.689603967833;6952;7003.548757934682;7038.718451261994;6954.756583519553;7085.185203701641;7100.360967512948;7121.287871212838;7172.713091476283;6711.832204194934;6792.320767923168;6801.918848690746;6827.180738311435;6843.931560684329;6815.863682726219;6834.487413443912;6836.965815170893;6863.142107236596;6865.622390768555;6940.618265995418;7013.438924886099;7084.433245340463;7121.750738724119;7125.643717814192;5653.745581448927;5668.829935101953;5689.260396148474;5733.932346194766;5734.2258795062135;6562.934370656423;6612.966935165294;6726.495512836655;6755.864882702417;6815.682667892742;6518.869622607616;6554.344565543408;6575.572587781779;6590.275069742229;6594.241662208908;6518.478521718156;6546.345365463416;6594.703238354382;6595.868082638416;6603.80188594343;6459.677016149268;6470.255920569007;6493.772717954849;6512.772052978123;6523.11937888379;6656.600603963778;6658.167729033871;6692.263850976291;6698.430633396216;6709.7651582194385;6312.179416675986;6429.421352078335;6508.15393998796;6545.967270163619;6573.474122070318 10:11:53 INFO - PID 31041 | |5;yui.html;949.0509490509486;950.3062764182147;950.5009869818349;952.9857052144215;977.6382738386798;19599;20735;20973.265935692252;21089.15643374265;21090.261840835556;19009.52476188096;19273.325433609825;19345.516362090955;19364.22543098278;19373.806261937378;999.3061760316285;1035.2649618770645;1035.3632516002642;1035.6737627647306;1037.6990672704906;1006.8238058339798;1014.8731408573929;1015.5176291261629;1020.143079812957;1020.9030142136485;1035.3839465518004;1062.0335494699825;1073.88187299397;1074.0870260278778;1075.0969185883855;1078.9676309710721;1082.4804094034907;1082.8484012238332;1083.2363183955292;1086.0334302470808;768.1703759939252;774.5236679442158;774.8295375017487;776.6776787633125;777.7122464688046;19712.70430943537;19818.504537386536;21276.89361553198;21937.122515099378;22077;22349.32952011442;22366;22382.440438988993;22599.20902768395;22801.315960521046;18639.53401164968;18661.90669046646;18706.532336691693;18806.529836754053;18831.62336753257;3862.7875466849314;3865.207632435372;3867.091233560111;3896.3181443247317;3900.2199560088097;124162.6103662126;159734;159784;162291;164570;18441.81558184428;18984.62030759377;19039.428817135507;19151.329703460313;19156.712649310273;34111;34249;34977;35030.64969350274;35256;9338.112879276458;9534.95232523833;9537.332386733;9543.618255269712;9557.761055973657;4733.360996265529;4739.597134243559;4762.714237145713;4804.399450068741;4829.492903245179;5708.343540492897;5842.503387212135;5856.267966504187;5876.08920617305;5877;1125.611663975927;1160.344405410957;1163.3310846263432;1164.4236103128835;1173.8884805943421;685.8971154326891;704.651197657163;714.4034730999673;718.1346477494607;724.2612535214053;13567.728645427036;13695.726085478234;13777.55335689738;14062.929685351508;14132.576022719335;719.5035425556349;726.7463625246407;737.2222305467783;738.9371903388272;742.840289337795;5848.093545500455;5956.910646340309;5970.373110823388;6026.758929642765;6027.758889644453;148788;151221;152853.23573382062;153473;154151;134569;135202;135798;141188.29405852905;142467.28766356103;116544.41727791307;118683.40658296653;119121.40439297921;121192;122232.77767222392;11259.98660120593;11357.716057098309;11459.4270286487;11628.360440175871;11783.941080294544;55706.44293557013;56484.717576413495;56510.43489565052;57325.42674573201;58050.709746451;71200;71590.83526971907;73299;73628;74074.25925740674;17094.82905170982;17586;17939.103044847965;17940;17971.281148753904;20207.191712331343;20272.898635506728;20273.391798246077;20316.085776140404;20486.897565512078;15904;16126.596835079217;16219.35122595083;16230.18849057566;16325.346986120898;18233;18325.633487330444;18478.353257636456;18548.350807721665;18739.437816865517;18180.45458636243;18341.816581834544;18403.63192736111;18408.723869142243;18577;13784.172949623055;13897.444102236203;14110.858891410955;14196.006279560745;14292.142471451747;13497.932510337385;13802.930985345009;13826.30868456553;13877.028607997343;13883 10:11:53 INFO - PID 31041 | __end_tp_report 10:11:53 INFO - PID 31041 | __start_cc_report 10:11:53 INFO - PID 31041 | _x_x_mozilla_cycle_collect,267 10:11:53 INFO - PID 31041 | __end_cc_report 10:11:53 INFO - PID 31041 | __startTimestamp1506013913488__endTimestamp 10:11:53 INFO - PID 31041 | 10:11:53 INFO - PID 31041 | ------- Summary: start ------- 10:11:53 INFO - PID 31041 | Number of tests: 6 10:11:53 INFO - PID 31041 | 10:11:53 INFO - PID 31041 | [#0] dojo.html Cycles:165 Average:6371.24 Median:6649.40 stddev:912.59 (13.7%) stddev-sans-first:894.26 10:11:53 INFO - PID 31041 | Values: 3882.3 3900.1 3927.5 3929.6 3944.9 6185.4 6300.2 6331.7 6401.7 6455.6 6364.0 6397.9 6426.8 6432.8 6470.3 5737.6 5741.6 5752.6 5792.0 5831.2 109.9 5656.5 5683.1 5690.7 5858.7 5702.2 5791.7 5792.1 5801.2 5806.7 5714.7 5732.1 5759.2 5802.5 5814.4 5682.1 5704.2 5754.1 5767.6 5777.1 6331.6 6337.4 6376.6 6426.4 6456.6 6839.1 6904.8 6917.2 6964.8 7022.3 7026.0 7102.8 7109.4 7128.2 7130.5 6462.6 6480.0 6540.1 6547.1 6561.6 7095.0 7131.6 7188.1 7200.2 7226.8 6897.6 6921.6 6947.5 6952.0 6957.9 6856.3 6946.9 6956.9 7056.9 7056.9 6854.1 6863.1 6917.9 6920.8 7015.3 6993.0 7036.5 7044.1 7048.0 7051.9 5010.4 5074.6 5134.4 5163.5 5164.0 4595.5 4606.3 4621.7 4645.0 4691.0 6385.6 6467.2 6475.1 6486.1 6487.5 6923.6 6926.7 7004.9 7017.1 7023.4 6264.3 6288.3 6366.5 6384.3 6471.0 5578.6 5592.8 5595.4 5662.6 5677.7 7221.4 7276.7 7304.6 7307.1 7316.9 6892.1 6893.2 7005.3 7007.8 7013.8 7136.1 7194.4 7202.9 7227.2 7249.2 6812.3 6908.7 6934.8 6964.7 6969.0 6873.2 6956.0 6968.3 6973.2 7059.6 6649.4 6714.8 6741.4 6742.7 6744.7 6671.8 6697.7 6698.6 6705.4 6705.8 6574.0 6624.4 6642.9 6646.6 6657.6 6781.7 6796.4 6804.6 6836.2 6856.9 6510.4 6625.2 6632.5 6654.9 6676.2 10:11:53 INFO - PID 31041 | 10:11:53 INFO - PID 31041 | [#1] ext.html Cycles:180 Average:42782.16 Median:3789.48 stddev:64451.77 (1700.8%) stddev-sans-first:64555.85 10:11:53 INFO - PID 31041 | Values: 897.3 919.2 933.8 944.4 947.1 43820.6 44498.0 44723.6 44741.3 44806.0 42035.0 44469.0 44921.0 44987.0 45011.3 8510.1 8584.6 8590.0 8617.0 8652.7 8343.6 8450.9 8453.0 8491.9 8494.4 8453.0 8502.9 8542.6 8542.6 8548.3 8378.7 8379.5 8428.9 8458.0 8462.8 8076.7 8131.9 8137.6 8143.2 8149.3 39753.8 39889.6 39928.6 39943.8 39993.8 3758.6 3778.3 3786.9 3789.1 3789.9 33241.8 33256.5 33350.0 33411.3 33551.8 5368.6 5481.9 5537.1 5538.1 5574.5 214597.0 218636.0 221612.0 223717.0 226369.0 52236.0 52685.5 52693.2 52702.7 52784.2 55286.2 55432.2 55949.4 56035.7 56087.7 16241.8 16329.7 16333.7 16427.1 16445.4 13255.0 13312.8 13332.1 13339.2 13355.1 13721.5 13852.4 13862.5 14000.1 14051.1 5505.6 5607.4 5640.2 5648.2 5700.4 1075.3 1114.6 1120.9 1127.3 1131.4 25651.0 25688.4 25739.5 25762.7 26115.5 1165.8 1186.7 1197.5 1224.1 1236.7 13375.8 13452.7 13736.5 13754.3 13944.7 280115.0 281758.0 282325.0 282407.0 282914.0 57062.7 57067.1 57256.4 57257.4 57271.1 1463.6 1480.7 1508.2 1523.7 1531.7 25233.7 25274.5 25320.9 25430.5 25441.7 39655.4 39842.2 39868.2 39896.8 39934.0 235021.0 235192.0 236236.0 239004.0 240001.0 36620.3 36885.3 37905.4 38119.8 38266.6 46760.3 48303.3 48889.8 48973.8 49090.8 35687.3 36294.5 36350.5 36531.3 36661.0 35594.0 35757.3 35785.3 35878.5 36038.6 42365.6 42415.2 42436.0 42981.4 43151.1 34269.0 34281.1 34287.3 34304.5 35035.3 26935.3 27180.6 27615.3 27657.2 27697.6 10:11:53 INFO - PID 31041 | 10:11:53 INFO - PID 31041 | [#2] jquery.html Cycles:180 Average:40159.99 Median:12826.98 stddev:102209.62 (796.8%) stddev-sans-first:102453.17 10:11:53 INFO - PID 31041 | Values: 592.7 598.3 604.2 625.3 640.7 23382.2 23861.5 24057.5 24065.2 24110.0 25697.6 26804.5 26864.7 26880.5 26903.9 6505.8 6634.2 6665.4 6682.3 6689.2 6567.5 6612.9 6753.1 6842.2 6863.0 6810.4 6812.5 6824.5 6827.6 6829.1 6480.4 6671.2 6714.8 6797.2 6814.6 6274.2 6285.1 6295.2 6297.5 6299.3 30613.1 30890.7 31083.1 31100.8 31182.7 2238.6 2243.0 2254.7 2270.6 2271.8 19910.8 21801.6 21898.8 21906.7 21906.7 2537.3 2590.2 2625.6 2635.9 2648.4 140396.0 146636.0 152151.2 156057.0 163401.2 16471.6 16863.7 16886.5 16979.6 17166.7 26419.6 26529.3 26581.9 26642.9 26687.6 10248.7 10528.7 10556.7 10579.7 10632.5 9344.7 9474.3 9484.1 9508.9 9577.0 9722.3 9821.6 9928.2 9980.2 10046.7 2953.6 3000.3 3019.7 3022.2 3056.9 1036.7 1052.1 1055.3 1061.2 1063.1 21431.4 22145.6 22161.1 22239.7 22323.6 1099.9 1106.7 1107.7 1112.5 1121.2 11996.5 12245.5 12344.3 12425.7 12474.3 602382.0 602941.0 612816.0 616950.0 622428.0 126478.0 128167.0 128366.0 129157.4 131831.3 1200.7 1207.0 1242.5 1249.0 1259.6 18982.6 19065.2 19401.1 19534.2 19957.0 61987.0 62449.4 62915.4 63189.4 63436.7 80323.6 80473.6 80609.0 81004.6 81293.0 15939.4 16151.8 16215.3 16262.9 16264.3 24814.5 24844.8 25105.4 25150.6 25341.0 20170.9 20474.4 20529.8 20689.6 20694.0 16215.1 16891.8 17124.7 17284.1 17497.4 20174.6 20353.8 20555.9 20555.9 20602.8 15671.6 15816.8 15913.8 15971.8 15992.8 19628.4 19976.2 20014.0 20174.6 20325.7 10:11:53 INFO - PID 31041 | 10:11:53 INFO - PID 31041 | [#3] mootools.html Cycles:180 Average:10584.75 Median:2698.80 stddev:7993.86 (296.2%) stddev-sans-first:7986.54 10:11:53 INFO - PID 31041 | Values: 1405.9 1467.2 1476.5 1478.1 1488.5 16740.4 17680.3 17689.3 17722.4 17730.3 17399.3 17744.3 17753.0 17754.4 17775.8 2845.9 2868.8 2927.6 2947.8 2954.4 2855.7 2872.7 2895.2 2899.8 2903.8 2842.7 2855.7 2864.4 2868.2 2874.7 2635.9 2718.9 2724.2 2725.2 2730.7 2685.1 2694.5 2698.3 2698.6 2699.0 16223.9 16575.7 16606.8 16634.0 16968.2 7762.5 8331.9 8341.6 8344.0 8392.5 5576.5 5756.2 5827.9 5915.1 5929.2 1998.2 2012.7 2041.5 2043.5 2066.6 31471.9 32300.0 32361.2 32439.7 32487.8 7151.4 7180.0 7219.4 7318.0 7370.4 20242.2 20317.6 20323.9 20342.3 20342.4 8318.4 8549.7 8564.8 8567.1 8575.0 7508.4 7632.0 7653.4 7789.7 7795.2 5574.6 5820.2 5840.9 5891.7 5907.8 1633.3 1688.9 1691.9 1706.9 1710.7 932.8 939.7 956.7 959.8 965.6 8220.5 8226.8 8240.3 8244.3 8292.3 782.1 801.4 801.5 820.8 824.7 5580.5 6242.6 6256.0 6347.9 6427.1 25142.1 25388.2 25462.5 25865.0 25892.0 24253.8 25239.2 25306.9 25405.7 25595.2 12376.2 12444.6 12642.0 12661.6 12696.7 8920.8 9725.4 9914.6 9933.9 10010.0 21485.5 21518.9 21561.4 22204.0 22677.5 22363.3 22521.8 22710.7 23107.3 23181.4 12011.9 12229.3 12344.1 12346.1 12347.1 15370.0 15447.3 15450.7 15599.5 15749.1 11743.1 11829.7 12072.7 12196.3 12205.8 12237.9 12683.1 12699.9 12711.4 12782.9 11452.2 11499.2 11549.9 11554.1 11561.5 7929.2 8005.9 8067.6 8100.8 8132.3 8285.7 8373.0 8385.9 8451.5 8545.5 10:11:53 INFO - PID 31041 | 10:11:53 INFO - PID 31041 | [#4] prototype.html Cycles:180 Average:5668.43 Median:6242.20 stddev:1585.11 (25.4%) stddev-sans-first:1542.15 10:11:53 INFO - PID 31041 | Values: 541.8 561.9 567.1 568.5 575.3 6203.2 6257.2 6290.9 6312.1 6330.0 6169.2 6213.9 6246.9 6264.2 6298.8 5102.2 5121.6 5123.3 5146.6 5172.3 4903.6 5054.5 5125.5 5153.9 5164.5 4946.7 4955.7 4983.9 5028.8 5033.6 4992.4 4997.2 4999.2 5000.5 5022.9 4348.5 4541.5 4551.4 4552.8 4567.9 6023.9 6089.3 6113.4 6128.3 6136.8 5816.2 5817.0 5840.4 5872.1 5874.5 6633.6 6636.4 6684.0 6685.9 6707.8 4867.1 5100.7 5127.5 5131.3 5151.1 6764.2 6836.6 6866.8 6938.6 6948.2 5207.7 5210.1 5258.4 5264.5 5274.3 5313.9 5323.6 5332.5 5336.6 5378.1 5881.5 5912.6 5924.8 5941.9 5954.8 6572.9 6578.9 6613.5 6653.1 6682.6 1802.8 1805.4 1816.9 1839.5 1844.2 1126.3 1214.5 1215.4 1219.4 1223.4 6016.2 6039.3 6095.5 6146.3 6148.9 6557.4 6668.0 6739.8 6796.8 6845.9 6155.0 6187.9 6240.2 6244.2 6247.4 3515.6 3550.6 3552.7 3611.3 3627.5 6987.5 7000.3 7016.9 7107.7 7137.8 6876.6 6897.7 6952.0 7003.5 7038.7 6954.8 7085.2 7100.4 7121.3 7172.7 6711.8 6792.3 6801.9 6827.2 6843.9 6815.9 6834.5 6837.0 6863.1 6865.6 6940.6 7013.4 7084.4 7121.8 7125.6 5653.7 5668.8 5689.3 5733.9 5734.2 6562.9 6613.0 6726.5 6755.9 6815.7 6518.9 6554.3 6575.6 6590.3 6594.2 6518.5 6546.3 6594.7 6595.9 6603.8 6459.7 6470.3 6493.8 6512.8 6523.1 6656.6 6658.2 6692.3 6698.4 6709.8 6312.2 6429.4 6508.2 6546.0 6573.5 10:11:53 INFO - PID 31041 | 10:11:53 INFO - PID 31041 | [#5] yui.html Cycles:180 Average:28658.38 Median:18997.07 stddev:42815.47 (225.4%) stddev-sans-first:42885.02 10:11:53 INFO - PID 31041 | Values: 949.1 950.3 950.5 953.0 977.6 19599.0 20735.0 20973.3 21089.2 21090.3 19009.5 19273.3 19345.5 19364.2 19373.8 999.3 1035.3 1035.4 1035.7 1037.7 1006.8 1014.9 1015.5 1020.1 1020.9 1035.4 1062.0 1073.9 1074.1 1075.1 1079.0 1082.5 1082.8 1083.2 1086.0 768.2 774.5 774.8 776.7 777.7 19712.7 19818.5 21276.9 21937.1 22077.0 22349.3 22366.0 22382.4 22599.2 22801.3 18639.5 18661.9 18706.5 18806.5 18831.6 3862.8 3865.2 3867.1 3896.3 3900.2 124162.6 159734.0 159784.0 162291.0 164570.0 18441.8 18984.6 19039.4 19151.3 19156.7 34111.0 34249.0 34977.0 35030.6 35256.0 9338.1 9535.0 9537.3 9543.6 9557.8 4733.4 4739.6 4762.7 4804.4 4829.5 5708.3 5842.5 5856.3 5876.1 5877.0 1125.6 1160.3 1163.3 1164.4 1173.9 685.9 704.7 714.4 718.1 724.3 13567.7 13695.7 13777.6 14062.9 14132.6 719.5 726.7 737.2 738.9 742.8 5848.1 5956.9 5970.4 6026.8 6027.8 148788.0 151221.0 152853.2 153473.0 154151.0 134569.0 135202.0 135798.0 141188.3 142467.3 116544.4 118683.4 119121.4 121192.0 122232.8 11260.0 11357.7 11459.4 11628.4 11783.9 55706.4 56484.7 56510.4 57325.4 58050.7 71200.0 71590.8 73299.0 73628.0 74074.3 17094.8 17586.0 17939.1 17940.0 17971.3 20207.2 20272.9 20273.4 20316.1 20486.9 15904.0 16126.6 16219.4 16230.2 16325.3 18233.0 18325.6 18478.4 18548.4 18739.4 18180.5 18341.8 18403.6 18408.7 18577.0 13784.2 13897.4 14110.9 14196.0 14292.1 13497.9 13802.9 13826.3 13877.0 13883.0 10:11:53 INFO - PID 31041 | -------- Summary: end -------- 10:11:53 INFO - PID 31041 | 10:11:54 INFO - TEST-INFO | 31041: exit 0 10:11:54 INFO - TEST-OK | dromaeo_css | took 1107950ms 10:11:54 INFO - TEST-START | kraken 10:11:54 INFO - Initialising browser for kraken test... 10:11:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33601/getInfo.html -profile /tmp/tmpDTRT7R/profile 10:11:54 INFO - TEST-INFO | started process 31413 (/builds/slave/test/build/application/firefox/firefox http://localhost:33601/getInfo.html) 10:11:59 INFO - TEST-INFO | 31413: exit 0 10:11:59 INFO - Browser initialized. 10:11:59 INFO - Running cycle 1/1 for kraken test... 10:11:59 INFO - Using env: {'DISPLAY': ':0', 10:11:59 INFO - 'HOME': '/home/cltbld', 10:11:59 INFO - 'JSGC_DISABLE_POISONING': '1', 10:11:59 INFO - 'LANG': 'en_US.UTF-8', 10:11:59 INFO - 'LANGUAGE': 'en_US:en', 10:11:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:11:59 INFO - 'LOGNAME': 'cltbld', 10:11:59 INFO - 'MAIL': '/var/mail/cltbld', 10:11:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:11:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:11:59 INFO - 'MOZ_CRASHREPORTER': '1', 10:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:11:59 INFO - 'MOZ_NO_REMOTE': '1', 10:11:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:59 INFO - 'NO_EM_RESTART': '1', 10:11:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:59 INFO - 'PWD': '/builds/slave/test', 10:11:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:11:59 INFO - 'RUST_BACKTRACE': 'full', 10:11:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:11:59 INFO - 'SHELL': '/bin/bash', 10:11:59 INFO - 'SHLVL': '1', 10:11:59 INFO - 'TERM': 'linux', 10:11:59 INFO - 'TMOUT': '86400', 10:11:59 INFO - 'USER': 'cltbld', 10:11:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203', 10:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:59 INFO - '_': '/tools/buildbot/bin/python'} 10:11:59 INFO - TEST-INFO | started process 31652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDTRT7R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:00 INFO - PID 31652 | 10:12:00 INFO - PID 31652 | (/builds/slave/test/build/application/firefox/firefox:31703): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:12:00 INFO - PID 31652 | 10:12:10 INFO - PID 31652 | RSS: Main: 147124224 10:12:10 INFO - PID 31652 | 10:12:13 INFO - PID 31652 | Cycle 1(1): loaded http://localhost:33601/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33601/tests/kraken/driver.html?testName=audio-beat-detection) 10:12:14 INFO - PID 31652 | RSS: Main: 152780800 10:12:14 INFO - PID 31652 | 10:12:16 INFO - PID 31652 | Cycle 1(1): loaded http://localhost:33601/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33601/tests/kraken/driver.html?testName=audio-dft) 10:12:17 INFO - PID 31652 | RSS: Main: 153010176 10:12:17 INFO - PID 31652 | 10:12:20 INFO - PID 31652 | Cycle 1(1): loaded http://localhost:33601/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33601/tests/kraken/driver.html?testName=audio-fft) 10:12:20 INFO - PID 31652 | RSS: Main: 149393408 10:12:20 INFO - PID 31652 | 10:12:22 INFO - PID 31652 | Cycle 1(1): loaded http://localhost:33601/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33601/tests/kraken/driver.html?testName=audio-oscillator) 10:12:23 INFO - PID 31652 | RSS: Main: 150908928 10:12:23 INFO - PID 31652 | 10:12:25 INFO - PID 31652 | Cycle 1(1): loaded http://localhost:33601/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33601/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:12:26 INFO - PID 31652 | RSS: Main: 150818816 10:12:26 INFO - PID 31652 | 10:12:29 INFO - PID 31652 | Cycle 1(1): loaded http://localhost:33601/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33601/tests/kraken/driver.html?testName=imaging-darkroom) 10:12:29 INFO - PID 31652 | RSS: Main: 150228992 10:12:29 INFO - PID 31652 | 10:12:33 INFO - PID 31652 | Cycle 1(1): loaded http://localhost:33601/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33601/tests/kraken/driver.html?testName=imaging-desaturate) 10:12:33 INFO - PID 31652 | RSS: Main: 151793664 10:12:33 INFO - PID 31652 | 10:12:36 INFO - PID 31652 | Cycle 1(1): loaded http://localhost:33601/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33601/tests/kraken/driver.html?testName=json-parse-financial) 10:12:37 INFO - PID 31652 | RSS: Main: 153182208 10:12:37 INFO - PID 31652 | 10:12:38 INFO - PID 31652 | Cycle 1(1): loaded http://localhost:33601/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33601/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:12:39 INFO - PID 31652 | RSS: Main: 152948736 10:12:39 INFO - PID 31652 | 10:12:41 INFO - PID 31652 | Cycle 1(1): loaded http://localhost:33601/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33601/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:12:41 INFO - PID 31652 | RSS: Main: 153194496 10:12:41 INFO - PID 31652 | 10:12:43 INFO - PID 31652 | Cycle 1(1): loaded http://localhost:33601/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33601/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:12:44 INFO - PID 31652 | RSS: Main: 150331392 10:12:44 INFO - PID 31652 | 10:12:46 INFO - PID 31652 | Cycle 1(1): loaded http://localhost:33601/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33601/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:12:47 INFO - PID 31652 | RSS: Main: 150040576 10:12:47 INFO - PID 31652 | 10:12:50 INFO - PID 31652 | Cycle 1(1): loaded http://localhost:33601/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33601/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:12:50 INFO - PID 31652 | RSS: Main: 150888448 10:12:50 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | Cycle 1(1): loaded http://localhost:33601/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33601/tests/kraken/driver.html?testName=ai-astar) 10:12:52 INFO - PID 31652 | RSS: Main: 152207360 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | __start_tp_report 10:12:52 INFO - PID 31652 | _x_x_mozilla_page_load 10:12:52 INFO - PID 31652 | _x_x_mozilla_page_load_details 10:12:52 INFO - PID 31652 | |i|pagename|runs| 10:12:52 INFO - PID 31652 | |0;ai-astar;105;104;106;107;105;115;109;106;104;105 10:12:52 INFO - PID 31652 | |1;audio-beat-detection;112;113;111;116;115;111;115;113;113;114 10:12:52 INFO - PID 31652 | |2;audio-dft;162;164;165;164;162;164;163;160;164;165 10:12:52 INFO - PID 31652 | |3;audio-fft;73;72;73;85;72;72;73;73;73;75 10:12:52 INFO - PID 31652 | |4;audio-oscillator;78;79;79;85;78;78;77;78;79;82 10:12:52 INFO - PID 31652 | |5;imaging-gaussian-blur;114;113;113;113;113;113;114;111;114;115 10:12:52 INFO - PID 31652 | |6;imaging-darkroom;150;150;149;150;151;151;150;151;150;151 10:12:52 INFO - PID 31652 | |7;imaging-desaturate;94;98;94;95;93;94;94;94;97;94 10:12:52 INFO - PID 31652 | |8;json-parse-financial;46;45;47;47;46;46;45;51;46;44 10:12:52 INFO - PID 31652 | |9;json-stringify-tinderbox;37;38;37;38;37;37;38;38;37;36 10:12:52 INFO - PID 31652 | |10;stanford-crypto-aes;70;73;70;72;72;72;73;73;71;72 10:12:52 INFO - PID 31652 | |11;stanford-crypto-ccm;107;105;105;107;106;101;107;107;112;107 10:12:52 INFO - PID 31652 | |12;stanford-crypto-pbkdf2;154;155;152;154;152;153;151;149;164;156 10:12:52 INFO - PID 31652 | |13;stanford-crypto-sha256-iterative;58;58;60;59;57;61;62;58;59;59 10:12:52 INFO - PID 31652 | __end_tp_report 10:12:52 INFO - PID 31652 | __start_cc_report 10:12:52 INFO - PID 31652 | _x_x_mozilla_cycle_collect,711 10:12:52 INFO - PID 31652 | __end_cc_report 10:12:52 INFO - PID 31652 | __startTimestamp1506013972585__endTimestamp 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | ------- Summary: start ------- 10:12:52 INFO - PID 31652 | Number of tests: 14 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | [#0] ai-astar Cycles:10 Average:106.60 Median:106.00 stddev:3.31 (3.1%) stddev-sans-first:3.46 10:12:52 INFO - PID 31652 | Values: 105.0 104.0 106.0 107.0 105.0 115.0 109.0 106.0 104.0 105.0 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | [#1] audio-beat-detection Cycles:10 Average:113.30 Median:113.50 stddev:1.70 (1.5%) stddev-sans-first:1.74 10:12:52 INFO - PID 31652 | Values: 112.0 113.0 111.0 116.0 115.0 111.0 115.0 113.0 113.0 114.0 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | [#2] audio-dft Cycles:10 Average:163.30 Median:164.00 stddev:1.57 (1.0%) stddev-sans-first:1.59 10:12:52 INFO - PID 31652 | Values: 162.0 164.0 165.0 164.0 162.0 164.0 163.0 160.0 164.0 165.0 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | [#3] audio-fft Cycles:10 Average:74.10 Median:73.00 stddev:3.93 (5.4%) stddev-sans-first:4.15 10:12:52 INFO - PID 31652 | Values: 73.0 72.0 73.0 85.0 72.0 72.0 73.0 73.0 73.0 75.0 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:79.00 stddev:2.41 (3.0%) stddev-sans-first:2.51 10:12:52 INFO - PID 31652 | Values: 78.0 79.0 79.0 85.0 78.0 78.0 77.0 78.0 79.0 82.0 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.50 stddev:1.06 (0.9%) stddev-sans-first:1.09 10:12:52 INFO - PID 31652 | Values: 114.0 113.0 113.0 113.0 113.0 113.0 114.0 111.0 114.0 115.0 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 10:12:52 INFO - PID 31652 | Values: 150.0 150.0 149.0 150.0 151.0 151.0 150.0 151.0 150.0 151.0 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:1.57 (1.7%) stddev-sans-first:1.64 10:12:52 INFO - PID 31652 | Values: 94.0 98.0 94.0 95.0 93.0 94.0 94.0 94.0 97.0 94.0 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | [#8] json-parse-financial Cycles:10 Average:46.30 Median:46.00 stddev:1.89 (4.1%) stddev-sans-first:2.00 10:12:52 INFO - PID 31652 | Values: 46.0 45.0 47.0 47.0 46.0 46.0 45.0 51.0 46.0 44.0 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | [#9] json-stringify-tinderbox Cycles:10 Average:37.30 Median:37.50 stddev:0.67 (1.8%) stddev-sans-first:0.71 10:12:52 INFO - PID 31652 | Values: 37.0 38.0 37.0 38.0 37.0 37.0 38.0 38.0 37.0 36.0 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | [#10] stanford-crypto-aes Cycles:10 Average:71.80 Median:72.00 stddev:1.14 (1.6%) stddev-sans-first:1.00 10:12:52 INFO - PID 31652 | Values: 70.0 73.0 70.0 72.0 72.0 72.0 73.0 73.0 71.0 72.0 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | [#11] stanford-crypto-ccm Cycles:10 Average:106.40 Median:107.00 stddev:2.72 (2.5%) stddev-sans-first:2.87 10:12:52 INFO - PID 31652 | Values: 107.0 105.0 105.0 107.0 106.0 101.0 107.0 107.0 112.0 107.0 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:154.00 stddev:4.06 (2.6%) stddev-sans-first:4.30 10:12:52 INFO - PID 31652 | Values: 154.0 155.0 152.0 154.0 152.0 153.0 151.0 149.0 164.0 156.0 10:12:52 INFO - PID 31652 | 10:12:52 INFO - PID 31652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.10 Median:59.00 stddev:1.52 (2.6%) stddev-sans-first:1.56 10:12:52 INFO - PID 31652 | Values: 58.0 58.0 60.0 59.0 57.0 61.0 62.0 58.0 59.0 59.0 10:12:52 INFO - PID 31652 | -------- Summary: end -------- 10:12:52 INFO - PID 31652 | 10:12:53 INFO - PID 31652 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:12:53 INFO - TEST-INFO | 31652: exit 0 10:12:53 INFO - TEST-OK | kraken | took 59162ms 10:12:53 INFO - SUITE-END | took 1167s 10:12:53 INFO - Completed test suite (00:19:27) 10:12:53 INFO - javascript benchmark 10:12:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9126.320245426841, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3882.2623701496696, 3900.1419687668704, 3927.489426374571, 3929.62668546488, 3944.901377465563, 6185.350538193492, 6300.21247344082, 6331.715072821723, 6401.679916004205, 6455.612663240209, 6364.0, 6397.936020639792, 6426.839329016777, 6432.77485288015, 6470.288268290485, 5737.598368114233, 5741.569382296324, 5752.626079304852, 5792.0, 5831.183634291203, 109.88510049208367, 5656.490915817576, 5683.147527870811, 5690.687012214326, 5858.707064646772, 5702.2301989231755, 5791.652500849962, 5792.073268277056, 5801.187833703285, 5806.7386967586135, 5714.685692286923, 5732.082866741343, 5759.1937128802, 5802.535797136261, 5814.418558144152, 5682.090865461548, 5704.172894930253, 5754.050581654022, 5767.567432442584, 5777.104548794901, 6331.588446750992, 6337.429631333156, 6376.649284289362, 6426.421622053991, 6456.580322279084, 6839.076724642209, 6904.758333458305, 6917.169939607229, 6964.825879353006, 7022.332878376546, 7025.981232721227, 7102.751403700898, 7109.39570136539, 7128.180259270199, 7130.465215108888, 6462.644554549498, 6479.967600162016, 6540.084388185658, 6547.083408322791, 6561.60630362175, 7095.0, 7131.572105673677, 7188.065551478275, 7200.243974382719, 7226.783196504113, 6897.586144831326, 6921.6193109379465, 6947.4789390795895, 6951.965240173767, 6957.8956315655305, 6856.280090590416, 6946.895796563055, 6956.8956465653055, 7056.858862822817, 7056.894146587805, 6854.10896583441, 6863.073485079551, 6917.9308206917285, 6920.757773477904, 7015.333543313377, 6993.0209770632155, 7036.542624729376, 7044.084269044992, 7048.048513450619, 7051.89422158668, 5010.398752149766, 5074.568661663726, 5134.435212126663, 5163.509466600667, 5164.04465173944, 4595.471520775153, 4606.309053641913, 4621.745803980813, 4645.0477652081245, 4691.038337140878, 6385.6487893165395, 6467.191601049869, 6475.061116138134, 6486.124373209651, 6487.481001519867, 6923.584584924921, 6926.688299026556, 7004.894926576106, 7017.122859642544, 7023.367896889203, 6264.279607845065, 6288.27684816252, 6366.522510811707, 6384.297727249998, 6470.967645161838, 5578.553715702734, 5592.832215033555, 5595.440455954454, 5662.631928924607, 5677.744501497443, 7221.386182174574, 7276.7453139140935, 7304.598247096461, 7307.086614173229, 7316.926830731731, 6892.069570607904, 6893.241743408221, 7005.2644472329675, 7007.754728584475, 7013.824654383681, 7136.143662760502, 7194.352508274281, 7202.855942881009, 7227.168875579376, 7249.166345870292, 6812.284710105368, 6908.654567271717, 6934.791956241321, 6964.65176741171, 6968.965155174395, 6873.175218973555, 6956.0, 6968.268331825288, 6973.163220413583, 7059.611721355374, 6649.401553860176, 6714.83212919681, 6741.393274605113, 6742.696578653874, 6744.730210791513, 6671.766488172891, 6697.698603562754, 6698.56459330142, 6705.362990515893, 6705.765298214539, 6573.967130164318, 6624.436922861418, 6642.867142657216, 6646.634435106115, 6657.600543967377, 6781.660916954232, 6796.35434633709, 6804.6257455840405, 6836.248012718696, 6856.9314306856295, 6510.381513756186, 6625.204975402789, 6632.4694024478895, 6654.866902662016, 6676.165479315086], "value": 6310.14799362718, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.3354427536915, 919.2324409118386, 933.8039011807518, 944.3625552751895, 947.0907928388747, 43820.56179438205, 44498.0, 44723.55276447235, 44741.32888006674, 44805.999999999956, 42035.0, 44469.0, 44921.0, 44987.0, 45011.324830127574, 8510.148985101503, 8584.613692383826, 8589.95705021474, 8616.956915215414, 8652.653893844239, 8343.582820858963, 8450.915490845106, 8453.0, 8491.915080849174, 8494.447860889053, 8452.957735211316, 8502.872456913152, 8542.572871356408, 8542.572871356408, 8548.31613470924, 8378.748637540884, 8379.45533540321, 8428.915710842874, 8457.95771021147, 8462.830743385159, 8076.717314894009, 8131.878021829677, 8137.593120344019, 8143.226393492668, 8149.348052155813, 39753.80123099366, 39889.601103988876, 39928.600713993066, 39943.80028099841, 39993.80003099995, 3758.5677647070665, 3778.3387907116144, 3786.924261514754, 3789.0716774390175, 3789.886303410902, 33241.83379083113, 33256.501152482735, 33350.0, 33411.3317733644, 33551.83224083864, 5368.570514358842, 5481.945180548223, 5537.058700020966, 5538.141588053858, 5574.498295153415, 214597.0, 218636.0, 221612.0, 223717.0, 226369.0, 52236.0, 52685.47314526882, 52693.209601856004, 52702.73648631732, 52784.208236876475, 55286.17070743942, 55432.16851747227, 55949.44050559524, 56035.719821400635, 56087.71956140193, 16241.756373654405, 16329.67340653204, 16333.67332653364, 16427.09650969208, 16445.424410145588, 13255.0, 13312.800307995389, 13332.066755327034, 13339.19964802115, 13355.065145439727, 13721.45114195421, 13852.445902163801, 13862.514811981533, 14000.089994150349, 14051.086679365808, 5505.614606977553, 5607.383187849333, 5640.182173584807, 5648.237487939075, 5700.4299570043495, 1075.2634445404922, 1114.6043154679971, 1120.8991190792706, 1127.3067063755896, 1131.4229742831214, 25651.0, 25688.357791055, 25739.48521029569, 25762.74237257641, 26115.477690446463, 1165.7843298989715, 1186.6618013866007, 1197.4970512384818, 1224.12475080318, 1236.6722818453118, 13375.799363009563, 13452.663683407798, 13736.45054197841, 13754.31228438574, 13944.651383715489, 280115.0, 281758.0, 282325.0, 282407.0, 282914.0, 57062.714686426305, 57067.14399284014, 57256.42743572594, 57257.42742572521, 57271.14093288604, 1463.5609317204796, 1480.7334679757746, 1508.2248662460904, 1523.6724104317402, 1531.7472617018068, 25233.74766252314, 25274.494510110064, 25320.873395632905, 25430.491390171723, 25441.745582544678, 39655.40516892307, 39842.2031559373, 39868.2026359477, 39896.80051599723, 39934.001649958984, 235021.0, 235192.0, 236236.0, 239004.0, 240001.0, 36620.26759464849, 36885.26229475449, 37905.4314185293, 38119.80940095282, 38266.6173338263, 46760.29859552041, 48303.275450867564, 48889.75555122344, 48973.75513122412, 49090.75454622847, 35687.28625427529, 36294.45558316575, 36350.454743179405, 36531.26937461289, 36661.0, 35594.0, 35757.28485430329, 35785.284294313446, 35878.461823073194, 36038.639613603526, 42365.576344236164, 42415.1516969665, 42436.0, 42981.35527967146, 43151.13697726091, 34269.0, 34281.142971425914, 34287.314253714285, 34304.48543271803, 35035.29929401448, 26935.326616834736, 27180.592291116045, 27615.309617258925, 27657.170284891487, 27697.58453623157], "value": 18704.9859430364, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.7428778860165, 598.2581598817462, 604.2084868821846, 625.3246493786711, 640.7469049725358, 23382.181623643177, 23861.522769544597, 24057.51884962302, 24065.1577194798, 24110.0, 25697.614535781933, 26804.463910721774, 26864.731352686515, 26880.462390752175, 26903.86548067262, 6505.837354066139, 6634.203895532519, 6665.40011398974, 6682.331766823303, 6689.23073846509, 6567.507436942248, 6612.933870661304, 6753.088333075046, 6842.213145488258, 6863.0, 6810.387065164135, 6812.4550035997245, 6824.488163387766, 6827.624480653562, 6829.112215412014, 6480.384363485485, 6671.199456065303, 6714.764983225564, 6797.218319893202, 6814.62519561424, 6274.247090349141, 6285.057241413779, 6295.213098362705, 6297.4962003039645, 6299.275583307933, 30613.08160755181, 30890.69109308923, 31083.06750797457, 31100.8444957776, 31182.688173118204, 2238.597052530544, 2242.988785056081, 2254.7068881045525, 2270.636698128308, 2271.772822717715, 19910.80089199104, 21801.563968720537, 21898.781012189833, 21906.671399929015, 21906.671399929015, 2537.251510804317, 2590.248827839924, 2625.5930330798756, 2635.920922372313, 2648.4173481833964, 140396.0, 146636.0, 152151.23924380308, 156057.0, 163401.18299408545, 16471.588210294838, 16863.662726745395, 16886.493405197863, 16979.575510612332, 17166.742498862528, 26419.603705944428, 26529.33676658099, 26581.867090664422, 26642.86678566595, 26687.599686004727, 10248.692539223835, 10528.684139475828, 10556.736081598021, 10579.682609521727, 10632.52153653072, 9344.719658410258, 9474.289428292906, 9484.14642682148, 9508.857367139499, 9576.95211523952, 9722.2708296878, 9821.558029888673, 9928.205743540499, 9980.201583873273, 10046.748831279276, 2953.616029916097, 3000.324926891432, 3019.682933291973, 3022.2444388902773, 3056.8777248910237, 1036.7149034015556, 1052.074174726236, 1055.266589720137, 1061.230607809332, 1063.1176123817213, 21431.357059288246, 22145.557088858455, 22161.116305114247, 22239.666405003936, 22323.55352892933, 1099.912007039435, 1106.6845948904524, 1107.7396811749231, 1112.5494174859195, 1121.2263538158645, 11996.520139194508, 12245.510179592895, 12344.259344439182, 12425.689357765947, 12474.251544907334, 602382.0, 602941.0, 612816.0, 616950.0, 622428.0, 126478.0, 128167.0, 128366.0, 129157.35421322833, 131831.34084329518, 1200.7118291610125, 1206.9879301206875, 1242.5340497313507, 1249.0444809720389, 1259.571745606498, 18982.620347592696, 19065.237390504226, 19401.126949287034, 19534.21863125516, 19957.0, 61987.0, 62449.37550624435, 62915.37084629278, 63189.36810631835, 63436.68281658562, 80323.59838200771, 80473.59763201147, 80609.0, 81004.59497702474, 81293.0, 15939.36242550285, 16151.838481615034, 16215.270312835715, 16262.918685406497, 16264.349426022827, 24814.503709926063, 24844.751552484242, 25105.372365691004, 25150.62274065854, 25341.0, 20170.89914550418, 20474.38576842697, 20529.794702053387, 20689.58620827605, 20694.0, 16215.108169050816, 16891.831081689026, 17124.657506850042, 17284.135793210542, 17497.38759143424, 20174.59650807005, 20353.79646203519, 20555.8972205138, 20555.8972205138, 20602.793972060088, 15671.58955693993, 15816.76274855855, 15913.761293580374, 15971.760423593423, 15992.840071599136, 19628.411147665593, 19976.20095196234, 20014.0, 20174.596508069462, 20325.695114572998], "value": 12950.312843443793, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.9015868889178, 1467.1857119298784, 1476.4684713503136, 1478.120518291616, 1488.5459934719913, 16740.41408550701, 17680.29278828847, 17689.292428302884, 17722.37971670992, 17730.290788368482, 17399.304027838873, 17744.290228390848, 17753.0, 17754.378596749117, 17775.82224177758, 2845.943081138376, 2868.827870327782, 2927.634045744282, 2947.82313061217, 2954.3943491584173, 2855.657321121458, 2872.7127287271314, 2895.218291061412, 2899.797014209006, 2903.7531809796087, 2842.744153026227, 2855.7001514840954, 2864.398476319975, 2868.211241908471, 2874.741273285404, 2635.920922372313, 2718.945621087577, 2724.209979106057, 2725.168823508829, 2730.6723193216744, 2685.140754958414, 2694.461107778452, 2698.311930457721, 2698.63568418263, 2698.973010269892, 16223.918880405641, 16575.668486630322, 16606.83393166077, 16634.0, 16968.151592420454, 7762.45662803604, 8331.916680833236, 8341.582920853933, 8344.0, 8392.538410387426, 5576.470235327637, 5756.222909907151, 5827.88344233113, 5915.053591425351, 5929.169916211734, 1998.1607724755638, 2012.7383440152687, 2041.5406533529838, 2043.4891277180704, 2066.638338290793, 31471.852814718575, 32300.030999070066, 32361.190970225463, 32439.6756032439, 32487.83756081228, 7151.427885769126, 7180.005495152478, 7219.386352160021, 7318.048653674989, 7370.447216458787, 20242.190312387633, 20317.593648126956, 20323.898380508002, 20342.288019919233, 20342.389728308175, 8318.37612179089, 8549.743507694779, 8564.828703425897, 8567.057623661392, 8575.0, 7508.3993280537425, 7632.0, 7653.425993050543, 7789.7273595423885, 7795.220477952273, 5574.554035677217, 5820.156077368758, 5840.941590584125, 5891.7054147292465, 5907.822765317047, 1633.3466613354515, 1688.8986660800392, 1691.8900271482314, 1706.8634509239232, 1710.6920754264352, 932.7994481186578, 939.7227817793768, 956.679512363366, 959.7648576098901, 965.5896244096231, 8220.465669731448, 8226.753197404087, 8240.258376746122, 8244.29923456513, 8292.295154911779, 782.1279273609998, 801.3869389916719, 801.4750338528273, 820.7742870710603, 824.7360844529693, 5580.469855363815, 6242.563020588606, 6256.0, 6347.873042539123, 6427.06807512908, 25142.12002579901, 25388.238352849443, 25462.490750184894, 25865.0, 25892.0, 24253.757462425503, 25239.242822715347, 25306.87346563292, 25405.745942540707, 25595.232143035737, 12376.195547289397, 12444.564440244549, 12642.0, 12661.620151395473, 12696.746065078647, 8920.821583568162, 9725.416475011521, 9914.553845077133, 9933.850992234979, 10010.0, 21485.46286342854, 21518.892405537874, 21561.353159405244, 22204.0, 22677.546449071255, 22363.329100127023, 22521.774782251967, 22710.65934010958, 23107.306780796604, 23181.42046448785, 12011.879881201427, 12229.327386993446, 12344.13591048618, 12346.074044446523, 12347.073969452147, 15370.0, 15447.304871281043, 15450.690986179989, 15599.454019109276, 15749.13379764124, 11743.060555155396, 11829.704257393634, 12072.698182545506, 12196.268223906594, 12205.816912746493, 12237.938810305892, 12683.11218214716, 12699.873001270238, 12711.364431778558, 12782.872171278168, 11452.198346115692, 11499.19505634631, 11549.942250288696, 11554.075673946232, 11561.537538498365, 7929.246721561442, 8005.945848879629, 8067.636956336862, 8100.797480063045, 8132.349412046904, 8285.710000149966, 8373.0, 8385.874211886705, 8451.535165565952, 8545.487270763773], "value": 7321.491479656487, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.8374487653703, 561.9016672082385, 567.0530214541715, 568.4599630351166, 575.2866445607448, 6203.162573052637, 6257.155284036654, 6290.86764382411, 6312.147860038894, 6330.0, 6169.223849267825, 6213.937860621392, 6246.9062964055465, 6264.185655864731, 6298.779542716006, 5102.209157580581, 5121.615878809095, 5123.308353372303, 5146.6140039497, 5172.301739265207, 4903.632227582928, 5054.494550544953, 5125.538701516863, 5153.922691159635, 5164.45773193813, 4946.689127381229, 4955.677880937746, 4983.900321993558, 5028.8239911603105, 5033.622478314122, 4992.40091189056, 4997.15048441764, 4999.150144475448, 5000.549950504472, 5022.949770502285, 4348.543402942709, 4541.500434952186, 4551.4083169188125, 4552.795124219418, 4567.949371644507, 6023.909641355383, 6089.269287685462, 6113.358097399798, 6128.295246046717, 6136.846578835521, 5816.2148110005455, 5816.952948469274, 5840.415958404125, 5872.0898260769645, 5874.471297583238, 6633.583704392242, 6636.435902948255, 6683.966580167116, 6685.863403221415, 6707.75906457307, 4867.148249056401, 5100.744962751847, 5127.512886275797, 5131.281620573122, 5151.072806894757, 6764.154480689914, 6836.555623884481, 6866.759663411806, 6938.618375989318, 6948.200956889972, 5207.661502002357, 5210.114280572312, 5258.447862974409, 5264.473552644705, 5274.314339135888, 5313.920291195635, 5323.574114070942, 5332.5467335276935, 5336.599755018312, 5378.058839703036, 5881.5000724938, 5912.556558258148, 5924.822255332347, 5941.851453713605, 5954.791582294599, 6572.901406478906, 6578.934210657832, 6613.4709223262025, 6653.135092438049, 6682.632455214913, 1802.7836659600932, 1805.395192610464, 1816.9454916352531, 1839.5309196154894, 1844.1609067874085, 1126.2622981946838, 1214.4838443661408, 1215.4044518186024, 1219.3903048475763, 1223.3699644682995, 6016.1878146450545, 6039.335673075958, 6095.512359011268, 6146.293176284695, 6148.938510614926, 6557.409833115043, 6668.0, 6739.764108256188, 6796.8300792479595, 6845.863082738318, 6155.0, 6187.876242475215, 6240.219972503437, 6244.188255526752, 6247.437730604177, 3515.5781306243416, 3550.627184145679, 3552.698020668272, 3611.33190359779, 3627.4921510988484, 6987.510874238755, 7000.26497217795, 7016.859662806715, 7107.680154393065, 7137.785866424016, 6876.553024053421, 6897.689603967833, 6952.0, 7003.548757934682, 7038.718451261994, 6954.756583519553, 7085.185203701641, 7100.360967512948, 7121.287871212838, 7172.713091476283, 6711.832204194934, 6792.320767923168, 6801.918848690746, 6827.180738311435, 6843.931560684329, 6815.863682726219, 6834.487413443912, 6836.965815170893, 6863.142107236596, 6865.622390768555, 6940.618265995418, 7013.438924886099, 7084.433245340463, 7121.750738724119, 7125.643717814192, 5653.745581448927, 5668.829935101953, 5689.260396148474, 5733.932346194766, 5734.2258795062135, 6562.934370656423, 6612.966935165294, 6726.495512836655, 6755.864882702417, 6815.682667892742, 6518.869622607616, 6554.344565543408, 6575.572587781779, 6590.275069742229, 6594.241662208908, 6518.478521718156, 6546.345365463416, 6594.703238354382, 6595.868082638416, 6603.80188594343, 6459.677016149268, 6470.255920569007, 6493.772717954849, 6512.772052978123, 6523.11937888379, 6656.600603963778, 6658.167729033871, 6692.263850976291, 6698.430633396216, 6709.7651582194385, 6312.179416675986, 6429.421352078335, 6508.15393998796, 6545.967270163619, 6573.474122070318], "value": 5204.844757794477, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [949.0509490509486, 950.3062764182147, 950.5009869818349, 952.9857052144215, 977.6382738386798, 19599.0, 20735.0, 20973.265935692252, 21089.15643374265, 21090.261840835556, 19009.52476188096, 19273.325433609825, 19345.516362090955, 19364.22543098278, 19373.806261937378, 999.3061760316285, 1035.2649618770645, 1035.3632516002642, 1035.6737627647306, 1037.6990672704906, 1006.8238058339798, 1014.8731408573929, 1015.5176291261629, 1020.143079812957, 1020.9030142136485, 1035.3839465518004, 1062.0335494699825, 1073.88187299397, 1074.0870260278778, 1075.0969185883855, 1078.9676309710721, 1082.4804094034907, 1082.8484012238332, 1083.2363183955292, 1086.0334302470808, 768.1703759939252, 774.5236679442158, 774.8295375017487, 776.6776787633125, 777.7122464688046, 19712.70430943537, 19818.504537386536, 21276.89361553198, 21937.122515099378, 22077.0, 22349.32952011442, 22366.0, 22382.440438988993, 22599.20902768395, 22801.315960521046, 18639.53401164968, 18661.90669046646, 18706.532336691693, 18806.529836754053, 18831.62336753257, 3862.7875466849314, 3865.207632435372, 3867.091233560111, 3896.3181443247317, 3900.2199560088097, 124162.6103662126, 159734.0, 159784.0, 162291.0, 164570.0, 18441.81558184428, 18984.62030759377, 19039.428817135507, 19151.329703460313, 19156.712649310273, 34111.0, 34249.0, 34977.0, 35030.64969350274, 35256.0, 9338.112879276458, 9534.95232523833, 9537.332386733, 9543.618255269712, 9557.761055973657, 4733.360996265529, 4739.597134243559, 4762.714237145713, 4804.399450068741, 4829.492903245179, 5708.343540492897, 5842.503387212135, 5856.267966504187, 5876.08920617305, 5877.0, 1125.611663975927, 1160.344405410957, 1163.3310846263432, 1164.4236103128835, 1173.8884805943421, 685.8971154326891, 704.651197657163, 714.4034730999673, 718.1346477494607, 724.2612535214053, 13567.728645427036, 13695.726085478234, 13777.55335689738, 14062.929685351508, 14132.576022719335, 719.5035425556349, 726.7463625246407, 737.2222305467783, 738.9371903388272, 742.840289337795, 5848.093545500455, 5956.910646340309, 5970.373110823388, 6026.758929642765, 6027.758889644453, 148788.0, 151221.0, 152853.23573382062, 153473.0, 154151.0, 134569.0, 135202.0, 135798.0, 141188.29405852905, 142467.28766356103, 116544.41727791307, 118683.40658296653, 119121.40439297921, 121192.0, 122232.77767222392, 11259.98660120593, 11357.716057098309, 11459.4270286487, 11628.360440175871, 11783.941080294544, 55706.44293557013, 56484.717576413495, 56510.43489565052, 57325.42674573201, 58050.709746451, 71200.0, 71590.83526971907, 73299.0, 73628.0, 74074.25925740674, 17094.82905170982, 17586.0, 17939.103044847965, 17940.0, 17971.281148753904, 20207.191712331343, 20272.898635506728, 20273.391798246077, 20316.085776140404, 20486.897565512078, 15904.0, 16126.596835079217, 16219.35122595083, 16230.18849057566, 16325.346986120898, 18233.0, 18325.633487330444, 18478.353257636456, 18548.350807721665, 18739.437816865517, 18180.45458636243, 18341.816581834544, 18403.63192736111, 18408.723869142243, 18577.0, 13784.172949623055, 13897.444102236203, 14110.858891410955, 14196.006279560745, 14292.142471451747, 13497.932510337385, 13802.930985345009, 13826.30868456553, 13877.028607997343, 13883.0], "value": 9918.890584524144, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1369.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 104.0, 106.0, 107.0, 105.0, 115.0, 109.0, 106.0, 104.0, 105.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 111.0, 116.0, 115.0, 111.0, 115.0, 113.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 165.0, 164.0, 162.0, 164.0, 163.0, 160.0, 164.0, 165.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 85.0, 72.0, 72.0, 73.0, 73.0, 73.0, 75.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 85.0, 78.0, 78.0, 77.0, 78.0, 79.0, 82.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 111.0, 114.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 150.0, 151.0, 151.0, 150.0, 151.0, 150.0, 151.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 94.0, 95.0, 93.0, 94.0, 94.0, 94.0, 97.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 45.0, 47.0, 47.0, 46.0, 46.0, 45.0, 51.0, 46.0, 44.0], "value": 46.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 38.0, 37.0, 37.0, 38.0, 38.0, 37.0, 36.0], "value": 37.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 70.0, 72.0, 72.0, 72.0, 73.0, 73.0, 71.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 105.0, 107.0, 106.0, 101.0, 107.0, 107.0, 112.0, 107.0], "value": 106.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 155.0, 152.0, 154.0, 152.0, 153.0, 151.0, 149.0, 164.0, 156.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 60.0, 59.0, 57.0, 61.0, 62.0, 58.0, 59.0, 59.0], "value": 59.1, "unit": "score"}]}]} 10:12:53 INFO - Return code: 0 10:12:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:12:53 INFO - # TBPL SUCCESS # 10:12:53 INFO - Running post-action listener: _package_coverage_data 10:12:53 INFO - Running post-action listener: _resource_record_post_action 10:12:53 INFO - [mozharness: 2017-09-21 17:12:53.861355Z] Finished run-tests step (success) 10:12:53 INFO - Running post-run listener: _resource_record_post_run 10:12:53 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 24576; Write bytes: 331845632; Read time: 256; Write time: 317112 10:12:53 INFO - TinderboxPrint: CPU usage
13.1% 10:12:53 INFO - TinderboxPrint: I/O read bytes / time
24,576 / 256 10:12:53 INFO - TinderboxPrint: I/O write bytes / time
331,845,632 / 317,112 10:12:53 INFO - TinderboxPrint: CPU idle
8,213.4 (86.9%) 10:12:53 INFO - TinderboxPrint: CPU user
1,185.5 (12.5%) 10:12:53 INFO - TinderboxPrint: Swap in / out
0 / 0 10:12:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12632064; Read time: 0; Write time: 1564 10:12:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:12:53 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 24576; Write bytes: 318193664; Read time: 256; Write time: 315512 10:12:54 INFO - Running post-run listener: _upload_blobber_files 10:12:54 INFO - Blob upload gear active. 10:12:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:12:54 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 10:12:54 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'] 10:12:54 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 10:12:54 INFO - (blobuploader) - INFO - Open directory for files ... 10:12:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:12:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:12:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:12:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:12:55 INFO - (blobuploader) - INFO - Done attempting. 10:12:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:12:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:12:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:12:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:12:56 INFO - (blobuploader) - INFO - Done attempting. 10:12:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:12:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:12:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:12:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:12:57 INFO - (blobuploader) - INFO - Done attempting. 10:12:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:12:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:12:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:13:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:04 INFO - (blobuploader) - INFO - Done attempting. 10:13:04 INFO - (blobuploader) - INFO - Iteration through files over. 10:13:04 INFO - Return code: 0 10:13:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:13:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:13:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7f62d1fa0671f07efe7c1d0163a1a71be77780cf1d24c578f59741020459cbb694db9bc0e97f5e7c5009803dcb61a79b822536310ae67e91dfc2e6b068e0c0d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/185bd240c1ccf482cd9fc8f26bc17649531f2dea0dedc86857b2f40d434ae9f09604ef6d54755a386f6d3c74875b9c2fa4df6724f2c42e37045abaec0f3742d4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1655038ba3346a2544166eebfcbd048465f39d0a480a363d8edcab066fb449a88f6d2a6a59084d69ac53265bca1063f6d68aefc93bdf6866bc9fbadfc394f230", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bda7d6a14ec4ce59344500e3c8c4a2a1afe631d67990f481dd621e6dcc37d84bf8df60b35fbdd3c70f9d20e8bea6295015f29259ae436c8d0f4d27bff3a985de"} 10:13:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:13:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:13:04 INFO - Contents: 10:13:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7f62d1fa0671f07efe7c1d0163a1a71be77780cf1d24c578f59741020459cbb694db9bc0e97f5e7c5009803dcb61a79b822536310ae67e91dfc2e6b068e0c0d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/185bd240c1ccf482cd9fc8f26bc17649531f2dea0dedc86857b2f40d434ae9f09604ef6d54755a386f6d3c74875b9c2fa4df6724f2c42e37045abaec0f3742d4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1655038ba3346a2544166eebfcbd048465f39d0a480a363d8edcab066fb449a88f6d2a6a59084d69ac53265bca1063f6d68aefc93bdf6866bc9fbadfc394f230", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bda7d6a14ec4ce59344500e3c8c4a2a1afe631d67990f481dd621e6dcc37d84bf8df60b35fbdd3c70f9d20e8bea6295015f29259ae436c8d0f4d27bff3a985de"} 10:13:04 INFO - Running post-run listener: copy_logs_to_upload_dir 10:13:04 INFO - Copying logs to upload dir... 10:13:04 INFO - mkdir: /builds/slave/test/build/upload/logs 10:13:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.379577 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-21 10:13:04.523548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 10:13:04.529096) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203 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/c7f62d1fa0671f07efe7c1d0163a1a71be77780cf1d24c578f59741020459cbb694db9bc0e97f5e7c5009803dcb61a79b822536310ae67e91dfc2e6b068e0c0d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/185bd240c1ccf482cd9fc8f26bc17649531f2dea0dedc86857b2f40d434ae9f09604ef6d54755a386f6d3c74875b9c2fa4df6724f2c42e37045abaec0f3742d4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1655038ba3346a2544166eebfcbd048465f39d0a480a363d8edcab066fb449a88f6d2a6a59084d69ac53265bca1063f6d68aefc93bdf6866bc9fbadfc394f230", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bda7d6a14ec4ce59344500e3c8c4a2a1afe631d67990f481dd621e6dcc37d84bf8df60b35fbdd3c70f9d20e8bea6295015f29259ae436c8d0f4d27bff3a985de"} build_url:https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011537 build_url: 'https://queue.taskcluster.net/v1/task/PaoJjzfISE2tJvHNzbVhiw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7f62d1fa0671f07efe7c1d0163a1a71be77780cf1d24c578f59741020459cbb694db9bc0e97f5e7c5009803dcb61a79b822536310ae67e91dfc2e6b068e0c0d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/185bd240c1ccf482cd9fc8f26bc17649531f2dea0dedc86857b2f40d434ae9f09604ef6d54755a386f6d3c74875b9c2fa4df6724f2c42e37045abaec0f3742d4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1655038ba3346a2544166eebfcbd048465f39d0a480a363d8edcab066fb449a88f6d2a6a59084d69ac53265bca1063f6d68aefc93bdf6866bc9fbadfc394f230", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bda7d6a14ec4ce59344500e3c8c4a2a1afe631d67990f481dd621e6dcc37d84bf8df60b35fbdd3c70f9d20e8bea6295015f29259ae436c8d0f4d27bff3a985de"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 10:13:04.559858) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 10:13:04.560170) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506011781.591942-1474806203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 10:13:04.642568) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 10:13:04.645885) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 10:13:04.646189) ========= ========= Total master_lag: 0.23 =========