builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-076 starttime: 1505688625.19 results: success (0) revision: dd87b8587fc1d63e57ebdadcbabba89c6d172969 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.187232) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.187592) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.187863) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.312777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.313055) ========= 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=9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-17 15:50:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.3M=0.001s 2017-09-17 15:50:25 (20.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126848 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.512518) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.512803) ========= 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=9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021562 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:25.601054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-17 15:50:25.601641) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd87b8587fc1d63e57ebdadcbabba89c6d172969 --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 dd87b8587fc1d63e57ebdadcbabba89c6d172969 --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=9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-17 15:50:25,651 truncating revision to first 12 chars 2017-09-17 15:50:25,652 Setting DEBUG logging. 2017-09-17 15:50:25,652 attempt 1/10 2017-09-17 15:50:25,652 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd87b8587fc1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-17 15:50:26,425 unpacking tar archive at: mozilla-central-dd87b8587fc1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.070224 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-17 15:50:26.707788) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.708073) ========= script_repo_revision: dd87b8587fc1d63e57ebdadcbabba89c6d172969 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.711450) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.711712) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 15:50:26.732878) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-17 15:50:26.733238) ========= /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=9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:50:26 INFO - MultiFileLogger online at 20170917 15:50:26 in /builds/slave/test 15:50:26 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 15:50:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:26 INFO - {'append_to_log': False, 15:50:26 INFO - 'base_work_dir': '/builds/slave/test', 15:50:26 INFO - 'blob_upload_branch': 'Firefox', 15:50:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:26 INFO - 'branch': 'Firefox', 15:50:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:26 INFO - 'code_coverage': False, 15:50:26 INFO - 'config_files': ('talos/linux_config.py',), 15:50:26 INFO - 'default_actions': ('clobber', 15:50:26 INFO - 'read-buildbot-config', 15:50:26 INFO - 'download-and-extract', 15:50:26 INFO - 'populate-webroot', 15:50:26 INFO - 'create-virtualenv', 15:50:26 INFO - 'install', 15:50:26 INFO - 'setup-mitmproxy', 15:50:26 INFO - 'run-tests'), 15:50:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:26 INFO - 'disable_ccov_upload': False, 15:50:26 INFO - 'disable_stylo': False, 15:50:26 INFO - 'download_minidump_stackwalk': True, 15:50:26 INFO - 'download_symbols': 'ondemand', 15:50:26 INFO - 'enable_stylo': False, 15:50:26 INFO - 'enable_webrender': False, 15:50:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:50:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:26 INFO - 'gecko_profile': False, 15:50:26 INFO - 'gecko_profile_interval': 0, 15:50:26 INFO - 'installer_path': 'installer.exe', 15:50:26 INFO - 'log_level': 'info', 15:50:26 INFO - 'log_name': 'talos', 15:50:26 INFO - 'log_to_console': True, 15:50:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:50:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:50:26 INFO - 'opt_config_files': (), 15:50:26 INFO - 'pip_index': False, 15:50:26 INFO - 'suite': 'dromaeojs-e10s', 15:50:26 INFO - 'system_bits': '32', 15:50:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:26 INFO - 'title': 'talos-linux64-ix-076', 15:50:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:26 INFO - 'use_talos_json': True, 15:50:26 INFO - 'verify': 'False', 15:50:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:26 INFO - 'work_dir': 'build'} 15:50:26 INFO - [mozharness: 2017-09-17 22:50:26.905501Z] Running clobber step. 15:50:26 INFO - Running pre-action listener: _resource_record_pre_action 15:50:26 INFO - Running main action method: clobber 15:50:26 INFO - rmtree: /builds/slave/test/build 15:50:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:27 INFO - Running post-action listener: _resource_record_post_action 15:50:27 INFO - [mozharness: 2017-09-17 22:50:27.895809Z] Finished clobber step (success) 15:50:27 INFO - [mozharness: 2017-09-17 22:50:27.895906Z] Running read-buildbot-config step. 15:50:27 INFO - Running pre-action listener: _resource_record_pre_action 15:50:27 INFO - Running main action method: read_buildbot_config 15:50:27 INFO - Using buildbot properties: 15:50:27 INFO - { 15:50:27 INFO - "project": "", 15:50:27 INFO - "product": "firefox", 15:50:27 INFO - "who": "archaeopteryx@coole-files.de", 15:50:27 INFO - "installer_path": "public/build/target.tar.bz2", 15:50:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:50:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:50:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 15:50:27 INFO - "stage_platform": "linux64-pgo", 15:50:27 INFO - "basedir": "/builds/slave/test", 15:50:27 INFO - "buildnumber": 175, 15:50:27 INFO - "platform": "ubuntu64_hw", 15:50:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:50:27 INFO - "slavebuilddir": "test", 15:50:27 INFO - "taskId": "ZAMdsAScR3W4ZDHZRAUzIQ", 15:50:27 INFO - "branch": "mozilla-central", 15:50:27 INFO - "script_repo_revision": "production", 15:50:27 INFO - "revision": "dd87b8587fc1d63e57ebdadcbabba89c6d172969", 15:50:27 INFO - "slavename": "talos-linux64-ix-076", 15:50:27 INFO - "repo_path": "mozilla-central" 15:50:27 INFO - } 15:50:27 INFO - Finding installer, test and symbols from parent task. 15:50:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZAMdsAScR3W4ZDHZRAUzIQ'}, attempt #1 15:50:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZAMdsAScR3W4ZDHZRAUzIQ'}, attempt #1 15:50:28 INFO - Task dependencies: YIKFqidGRWqiZ2H-El64-g 15:50:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g'}, attempt #1 15:50:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2 15:50:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.test_packages.json 15:50:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.crashreporter-symbols.zip 15:50:29 INFO - Running post-action listener: _resource_record_post_action 15:50:29 INFO - [mozharness: 2017-09-17 22:50:29.272934Z] Finished read-buildbot-config step (success) 15:50:29 INFO - [mozharness: 2017-09-17 22:50:29.273188Z] Running download-and-extract step. 15:50:29 INFO - Running pre-action listener: _resource_record_pre_action 15:50:29 INFO - Running main action method: download_and_extract 15:50:29 INFO - mkdir: /builds/slave/test/build/tests 15:50:29 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')]} 15:50:29 INFO - trying https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.test_packages.json 15:50:29 INFO - Downloading https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:50:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:50:29 INFO - Downloaded 989 bytes. 15:50:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:50:29 INFO - Using the following test package requirements: 15:50:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:50:29 INFO - u'common': [u'target.common.tests.zip'], 15:50:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:50:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:50:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:50:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:50:29 INFO - u'mozbase': [u'target.common.tests.zip'], 15:50:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:50:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:50:29 INFO - u'web-platform': [u'target.common.tests.zip', 15:50:29 INFO - u'target.web-platform.tests.tar.gz'], 15:50:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:50:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:50:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.common.tests.zip 15:50:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:50:29 INFO - Fetch https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.common.tests.zip into memory 15:50:32 INFO - Content-Length response header: 55321145 15:50:32 INFO - Bytes received: 55321145 15:50:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.talos.tests.zip 15:50:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:50:43 INFO - Fetch https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.talos.tests.zip into memory 15:50:44 INFO - Content-Length response header: 14508748 15:50:44 INFO - Bytes received: 14508748 15:50: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')]} 15:50:44 INFO - trying https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2 15:50:44 INFO - Downloading https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:50:47 INFO - Downloaded 62189680 bytes. 15:50:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2 15:50:47 INFO - mkdir: /builds/slave/test/properties 15:50:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:50:47 INFO - Writing to file /builds/slave/test/properties/build_url 15:50:47 INFO - Contents: 15:50:47 INFO - build_url:https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2 15:50:47 INFO - Running post-action listener: _resource_record_post_action 15:50:47 INFO - Running post-action listener: find_tests_for_verification 15:50:47 INFO - Running post-action listener: set_extra_try_arguments 15:50:47 INFO - [mozharness: 2017-09-17 22:50:47.817741Z] Finished download-and-extract step (success) 15:50:47 INFO - [mozharness: 2017-09-17 22:50:47.817838Z] Running populate-webroot step. 15:50:47 INFO - Running pre-action listener: _resource_record_pre_action 15:50:47 INFO - Running main action method: populate_webroot 15:50:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:50:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['tresize', 15:50:47 INFO - 'tcanvasmark']}, 15:50:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:50:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['dromaeo_css', 15:50:47 INFO - 'kraken']}, 15:50:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'tests': ['damp', 'tps']}, 15:50:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['damp', 'tps']}, 15:50:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:50:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['dromaeo_dom']}, 15:50:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:50:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['basic_compositor_video', 15:50:47 INFO - 'glvideo']}, 15:50:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:50:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['ts_paint_webext', 15:50:47 INFO - 'tp5o_webext']}, 15:50:47 INFO - 'other-e10s': {'tests': ['a11yr', 15:50:47 INFO - 'ts_paint', 15:50:47 INFO - 'tpaint', 15:50:47 INFO - 'sessionrestore', 15:50:47 INFO - 'sessionrestore_many_windows', 15:50:47 INFO - 'sessionrestore_no_auto_restore', 15:50:47 INFO - 'tabpaint']}, 15:50:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['a11yr', 15:50:47 INFO - 'ts_paint', 15:50:47 INFO - 'tpaint', 15:50:47 INFO - 'sessionrestore', 15:50:47 INFO - 'sessionrestore_many_windows', 15:50:47 INFO - 'sessionrestore_no_auto_restore', 15:50:47 INFO - 'tabpaint']}, 15:50:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:50:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:50:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['perf_reftest_singletons']}, 15:50:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['bloom_basic']}, 15:50:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:50:47 INFO - 'tsvgr_opacity', 15:50:47 INFO - 'tart', 15:50:47 INFO - 'tscrollx', 15:50:47 INFO - 'tsvg_static']}, 15:50:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['tsvgx', 15:50:47 INFO - 'tsvgr_opacity', 15:50:47 INFO - 'tart', 15:50:47 INFO - 'tscrollx', 15:50:47 INFO - 'tsvg_static']}, 15:50:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:50:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo'], 15:50:47 INFO - 'tests': ['tp5o']}, 15:50:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:50:47 INFO - 'talos_options': ['--mitmproxy', 15:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:50:47 INFO - '--firstNonBlankPaint'], 15:50:47 INFO - 'tests': ['tp6_google', 15:50:47 INFO - 'tp6_youtube', 15:50:47 INFO - 'tp6_amazon', 15:50:47 INFO - 'tp6_facebook']}, 15:50:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo', 15:50:47 INFO - '--mitmproxy', 15:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:50:47 INFO - '--firstNonBlankPaint'], 15:50:47 INFO - 'tests': ['tp6_google', 15:50:47 INFO - 'tp6_youtube', 15:50:47 INFO - 'tp6_amazon', 15:50:47 INFO - 'tp6_facebook']}, 15:50:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:50:47 INFO - 'talos_options': ['--stylo-threads=1', 15:50:47 INFO - '--mitmproxy', 15:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:50:47 INFO - '--firstNonBlankPaint'], 15:50:47 INFO - 'tests': ['tp6_google', 15:50:47 INFO - 'tp6_youtube', 15:50:47 INFO - 'tp6_amazon', 15:50:47 INFO - 'tp6_facebook']}, 15:50:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--xperf_path', 15:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:47 INFO - 'tests': ['tp5n']}, 15:50:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:47 INFO - 'talos_options': ['--disable-stylo', 15:50:47 INFO - '--xperf_path', 15:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:47 INFO - 'tests': ['tp5n']}}} 15:50:47 INFO - Running post-action listener: _resource_record_post_action 15:50:47 INFO - [mozharness: 2017-09-17 22:50:47.838009Z] Finished populate-webroot step (success) 15:50:47 INFO - [mozharness: 2017-09-17 22:50:47.838117Z] Running create-virtualenv step. 15:50:47 INFO - Running pre-action listener: _resource_record_pre_action 15:50:47 INFO - Running main action method: create_virtualenv 15:50:47 INFO - Creating virtualenv /builds/slave/test/build/venv 15:50:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:50:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:50:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:50:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:50:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:50:48 INFO - Installing distribute.............................................................................................................................................................................................done. 15:50:48 INFO - Installing pip...............done. 15:50:48 INFO - Return code: 0 15:50:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:50:48 INFO - Reading from file tmpfile_stdout 15:50:48 INFO - Output received: 15:50: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) 15:50:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50: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')]} 15:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50: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 0xe6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da090>, '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 0x11dad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', '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 15:50: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 15:50: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 15:50:48 INFO - Using env: {'DISPLAY': ':0', 15:50:48 INFO - 'HOME': '/home/cltbld', 15:50:48 INFO - 'LANG': 'en_US.UTF-8', 15:50:48 INFO - 'LANGUAGE': 'en_US:en', 15:50:48 INFO - 'LOGNAME': 'cltbld', 15:50:48 INFO - 'MAIL': '/var/mail/cltbld', 15:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:48 INFO - 'MOZ_NO_REMOTE': '1', 15:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:48 INFO - 'NO_EM_RESTART': '1', 15:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:48 INFO - 'PWD': '/builds/slave/test', 15:50:48 INFO - 'SHELL': '/bin/bash', 15:50:48 INFO - 'SHLVL': '1', 15:50:48 INFO - 'TERM': 'linux', 15:50:48 INFO - 'TMOUT': '86400', 15:50:48 INFO - 'USER': 'cltbld', 15:50:48 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', 15:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:48 INFO - '_': '/tools/buildbot/bin/python'} 15:50:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:50:50 INFO - Downloading/unpacking pip>=1.5 15:50:50 INFO - Running setup.py egg_info for package pip 15:50:50 INFO - warning: no files found matching 'pip/cacert.pem' 15:50:50 INFO - warning: no files found matching '*.html' under directory 'docs' 15:50:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:50:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:50:50 INFO - Installing collected packages: pip 15:50:50 INFO - Found existing installation: pip 1.1 15:50:50 INFO - Uninstalling pip: 15:50:50 INFO - Successfully uninstalled pip 15:50:50 INFO - Running setup.py install for pip 15:50:50 INFO - warning: no files found matching 'pip/cacert.pem' 15:50:50 INFO - warning: no files found matching '*.html' under directory 'docs' 15:50:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:50:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:50:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:50:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:50:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:50:50 INFO - Successfully installed pip 15:50:50 INFO - Cleaning up... 15:50:50 INFO - Return code: 0 15:50:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da090>, '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 0x11dad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', '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 15:50:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:50:50 INFO - Using env: {'DISPLAY': ':0', 15:50:50 INFO - 'HOME': '/home/cltbld', 15:50:50 INFO - 'LANG': 'en_US.UTF-8', 15:50:50 INFO - 'LANGUAGE': 'en_US:en', 15:50:50 INFO - 'LOGNAME': 'cltbld', 15:50:50 INFO - 'MAIL': '/var/mail/cltbld', 15:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:50 INFO - 'MOZ_NO_REMOTE': '1', 15:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:50 INFO - 'NO_EM_RESTART': '1', 15:50:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:50 INFO - 'PWD': '/builds/slave/test', 15:50:50 INFO - 'SHELL': '/bin/bash', 15:50:50 INFO - 'SHLVL': '1', 15:50:50 INFO - 'TERM': 'linux', 15:50:50 INFO - 'TMOUT': '86400', 15:50:50 INFO - 'USER': 'cltbld', 15:50:50 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', 15:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:50 INFO - '_': '/tools/buildbot/bin/python'} 15:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:50 INFO - Downloading/unpacking psutil>=3.1.1 15:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:51 INFO - Installing collected packages: psutil 15:50:51 INFO - Running setup.py install for psutil 15:50:51 INFO - building 'psutil._psutil_linux' extension 15:50: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 15:50: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 15:50:51 INFO - building 'psutil._psutil_posix' extension 15:50: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 15:50: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 15:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:51 INFO - Successfully installed psutil 15:50:51 INFO - Cleaning up... 15:50:52 INFO - Return code: 0 15:50:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da090>, '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 0x11dad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', '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 15:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:50:52 INFO - Using env: {'DISPLAY': ':0', 15:50:52 INFO - 'HOME': '/home/cltbld', 15:50:52 INFO - 'LANG': 'en_US.UTF-8', 15:50:52 INFO - 'LANGUAGE': 'en_US:en', 15:50:52 INFO - 'LOGNAME': 'cltbld', 15:50:52 INFO - 'MAIL': '/var/mail/cltbld', 15:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:52 INFO - 'MOZ_NO_REMOTE': '1', 15:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:52 INFO - 'NO_EM_RESTART': '1', 15:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:52 INFO - 'PWD': '/builds/slave/test', 15:50:52 INFO - 'SHELL': '/bin/bash', 15:50:52 INFO - 'SHLVL': '1', 15:50:52 INFO - 'TERM': 'linux', 15:50:52 INFO - 'TMOUT': '86400', 15:50:52 INFO - 'USER': 'cltbld', 15:50:52 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', 15:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:52 INFO - '_': '/tools/buildbot/bin/python'} 15:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:50:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:50:53 INFO - Installing collected packages: mozsystemmonitor 15:50:53 INFO - Running setup.py install for mozsystemmonitor 15:50:53 INFO - Successfully installed mozsystemmonitor 15:50:53 INFO - Cleaning up... 15:50:54 INFO - Return code: 0 15:50:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50: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')]} 15:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50: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 0xe6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da090>, '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 0x11dad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', '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 15:50: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 15:50: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 15:50:54 INFO - Using env: {'DISPLAY': ':0', 15:50:54 INFO - 'HOME': '/home/cltbld', 15:50:54 INFO - 'LANG': 'en_US.UTF-8', 15:50:54 INFO - 'LANGUAGE': 'en_US:en', 15:50:54 INFO - 'LOGNAME': 'cltbld', 15:50:54 INFO - 'MAIL': '/var/mail/cltbld', 15:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:54 INFO - 'MOZ_NO_REMOTE': '1', 15:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:54 INFO - 'NO_EM_RESTART': '1', 15:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:54 INFO - 'PWD': '/builds/slave/test', 15:50:54 INFO - 'SHELL': '/bin/bash', 15:50:54 INFO - 'SHLVL': '1', 15:50:54 INFO - 'TERM': 'linux', 15:50:54 INFO - 'TMOUT': '86400', 15:50:54 INFO - 'USER': 'cltbld', 15:50:54 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', 15:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:54 INFO - '_': '/tools/buildbot/bin/python'} 15:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:54 INFO - Downloading/unpacking jsonschema==2.5.1 15:50: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 15:50: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 15:50: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 15:50: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 15:50:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:50:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:50: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 15:50: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 15:50: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 15:50: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 15:50:55 INFO - Downloading functools32-3.2.3-2.tar.gz 15:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:50:55 INFO - warning: no files found matching '*.txt' 15:50:55 INFO - no previously-included directories found matching 'build' 15:50:55 INFO - no previously-included directories found matching 'dist' 15:50:55 INFO - no previously-included directories found matching '.git*' 15:50:55 INFO - Installing collected packages: jsonschema, functools32 15:50:55 INFO - Running setup.py install for functools32 15:50:56 INFO - warning: no files found matching '*.txt' 15:50:56 INFO - no previously-included directories found matching 'build' 15:50:56 INFO - no previously-included directories found matching 'dist' 15:50:56 INFO - no previously-included directories found matching '.git*' 15:50:56 INFO - Successfully installed jsonschema functools32 15:50:56 INFO - Cleaning up... 15:50:56 INFO - Return code: 0 15:50:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50: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')]} 15:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50: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 0xe6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da090>, '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 0x11dad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', '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 15:50: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 15:50: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 15:50:56 INFO - Using env: {'DISPLAY': ':0', 15:50:56 INFO - 'HOME': '/home/cltbld', 15:50:56 INFO - 'LANG': 'en_US.UTF-8', 15:50:56 INFO - 'LANGUAGE': 'en_US:en', 15:50:56 INFO - 'LOGNAME': 'cltbld', 15:50:56 INFO - 'MAIL': '/var/mail/cltbld', 15:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:56 INFO - 'MOZ_NO_REMOTE': '1', 15:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:56 INFO - 'NO_EM_RESTART': '1', 15:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:56 INFO - 'PWD': '/builds/slave/test', 15:50:56 INFO - 'SHELL': '/bin/bash', 15:50:56 INFO - 'SHLVL': '1', 15:50:56 INFO - 'TERM': 'linux', 15:50:56 INFO - 'TMOUT': '86400', 15:50:56 INFO - 'USER': 'cltbld', 15:50:56 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', 15:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:56 INFO - '_': '/tools/buildbot/bin/python'} 15:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:50:56 INFO - Cleaning up... 15:50:56 INFO - Return code: 0 15:50:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50: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')]} 15:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50: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 0xe6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da090>, '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 0x11dad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', '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 15:50: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 15:50: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 15:50:56 INFO - Using env: {'DISPLAY': ':0', 15:50:56 INFO - 'HOME': '/home/cltbld', 15:50:56 INFO - 'LANG': 'en_US.UTF-8', 15:50:56 INFO - 'LANGUAGE': 'en_US:en', 15:50:56 INFO - 'LOGNAME': 'cltbld', 15:50:56 INFO - 'MAIL': '/var/mail/cltbld', 15:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:56 INFO - 'MOZ_NO_REMOTE': '1', 15:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:56 INFO - 'NO_EM_RESTART': '1', 15:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:56 INFO - 'PWD': '/builds/slave/test', 15:50:56 INFO - 'SHELL': '/bin/bash', 15:50:56 INFO - 'SHLVL': '1', 15:50:56 INFO - 'TERM': 'linux', 15:50:56 INFO - 'TMOUT': '86400', 15:50:56 INFO - 'USER': 'cltbld', 15:50:56 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', 15:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:56 INFO - '_': '/tools/buildbot/bin/python'} 15:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:56 INFO - Downloading/unpacking blobuploader==1.2.4 15:50: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 15:50: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 15:50: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 15:50: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 15:50:57 INFO - Downloading blobuploader-1.2.4.tar.gz 15:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:50:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:50:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:58 INFO - Downloading docopt-0.6.1.tar.gz 15:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:50:58 INFO - Installing collected packages: blobuploader, requests, docopt 15:50:58 INFO - Running setup.py install for blobuploader 15:50:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:50:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:50:58 INFO - Running setup.py install for requests 15:50:59 INFO - Running setup.py install for docopt 15:50:59 INFO - Successfully installed blobuploader requests docopt 15:50:59 INFO - Cleaning up... 15:50:59 INFO - Return code: 0 15:50:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:59 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 0xe6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da090>, '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 0x11dad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', '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 15:50:59 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 15:50:59 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 15:50:59 INFO - Using env: {'DISPLAY': ':0', 15:50:59 INFO - 'HOME': '/home/cltbld', 15:50:59 INFO - 'LANG': 'en_US.UTF-8', 15:50:59 INFO - 'LANGUAGE': 'en_US:en', 15:50:59 INFO - 'LOGNAME': 'cltbld', 15:50:59 INFO - 'MAIL': '/var/mail/cltbld', 15:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:59 INFO - 'MOZ_NO_REMOTE': '1', 15:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:59 INFO - 'NO_EM_RESTART': '1', 15:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:59 INFO - 'PWD': '/builds/slave/test', 15:50:59 INFO - 'SHELL': '/bin/bash', 15:50:59 INFO - 'SHLVL': '1', 15:50:59 INFO - 'TERM': 'linux', 15:50:59 INFO - 'TMOUT': '86400', 15:50:59 INFO - 'USER': 'cltbld', 15:50:59 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', 15:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:59 INFO - '_': '/tools/buildbot/bin/python'} 15:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:50:59 INFO - Running setup.py (path:/tmp/pip-INRPcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:50:59 INFO - Running setup.py (path:/tmp/pip-ES2sZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:50:59 INFO - Running setup.py (path:/tmp/pip-zfNYYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:50:59 INFO - Running setup.py (path:/tmp/pip-lzKcaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:50:59 INFO - Running setup.py (path:/tmp/pip-lLwiP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:50:59 INFO - Running setup.py (path:/tmp/pip-VZMR7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:50:59 INFO - Running setup.py (path:/tmp/pip-8JMdWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:50:59 INFO - Running setup.py (path:/tmp/pip-zelLhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:50:59 INFO - Running setup.py (path:/tmp/pip-PxXg8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:00 INFO - Running setup.py (path:/tmp/pip-m_yNhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:00 INFO - Running setup.py (path:/tmp/pip-IugjXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:00 INFO - Running setup.py (path:/tmp/pip-rEy966-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:00 INFO - Running setup.py (path:/tmp/pip-_U8qPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:00 INFO - Running setup.py (path:/tmp/pip-8DVdVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:00 INFO - Running setup.py (path:/tmp/pip-9RCiI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:00 INFO - Running setup.py (path:/tmp/pip-E0PgkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:00 INFO - Running setup.py (path:/tmp/pip-B2ClAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:00 INFO - Running setup.py install for manifestparser 15:51:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:00 INFO - Running setup.py install for mozcrash 15:51:00 INFO - Running setup.py install for mozdebug 15:51:00 INFO - Running setup.py install for mozdevice 15:51:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:01 INFO - Running setup.py install for mozfile 15:51:01 INFO - Running setup.py install for mozhttpd 15:51:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:01 INFO - Running setup.py install for mozinfo 15:51:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:01 INFO - Running setup.py install for mozInstall 15:51:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:01 INFO - Running setup.py install for mozleak 15:51:01 INFO - Running setup.py install for mozlog 15:51:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:01 INFO - Running setup.py install for moznetwork 15:51:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:01 INFO - Running setup.py install for mozprocess 15:51:01 INFO - Running setup.py install for mozprofile 15:51:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:01 INFO - Running setup.py install for mozrunner 15:51:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:02 INFO - Running setup.py install for mozscreenshot 15:51:02 INFO - Running setup.py install for moztest 15:51:02 INFO - Running setup.py install for mozversion 15:51:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:02 INFO - Cleaning up... 15:51:02 INFO - Return code: 0 15:51:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51: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')]} 15:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51: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 0xe6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da090>, '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 0x11dad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', '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 15:51: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 15:51: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 15:51:02 INFO - Using env: {'DISPLAY': ':0', 15:51:02 INFO - 'HOME': '/home/cltbld', 15:51:02 INFO - 'LANG': 'en_US.UTF-8', 15:51:02 INFO - 'LANGUAGE': 'en_US:en', 15:51:02 INFO - 'LOGNAME': 'cltbld', 15:51:02 INFO - 'MAIL': '/var/mail/cltbld', 15:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:02 INFO - 'MOZ_NO_REMOTE': '1', 15:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:02 INFO - 'NO_EM_RESTART': '1', 15:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:02 INFO - 'PWD': '/builds/slave/test', 15:51:02 INFO - 'SHELL': '/bin/bash', 15:51:02 INFO - 'SHLVL': '1', 15:51:02 INFO - 'TERM': 'linux', 15:51:02 INFO - 'TMOUT': '86400', 15:51:02 INFO - 'USER': 'cltbld', 15:51:02 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', 15:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:02 INFO - '_': '/tools/buildbot/bin/python'} 15:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:02 INFO - Running setup.py (path:/tmp/pip-wBvfsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51: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)) 15:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:02 INFO - Running setup.py (path:/tmp/pip-nYVDic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51: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)) 15:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:02 INFO - Running setup.py (path:/tmp/pip-1ISRJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51: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)) 15:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:02 INFO - Running setup.py (path:/tmp/pip-pqhBZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51: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)) 15:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:02 INFO - Running setup.py (path:/tmp/pip-872zDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51: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)) 15:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:02 INFO - Running setup.py (path:/tmp/pip-7FTo2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:03 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)) 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:03 INFO - Running setup.py (path:/tmp/pip-1COCa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:03 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)) 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:03 INFO - Running setup.py (path:/tmp/pip-ZhSG0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:03 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)) 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:03 INFO - Running setup.py (path:/tmp/pip-2n706X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51: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)) 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:03 INFO - Running setup.py (path:/tmp/pip-4VFqCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51: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)) 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:03 INFO - Running setup.py (path:/tmp/pip-Jrzn02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51: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)) 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:03 INFO - Running setup.py (path:/tmp/pip-uPqLCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51: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)) 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:03 INFO - Running setup.py (path:/tmp/pip-ecaDx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51: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)) 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:03 INFO - Running setup.py (path:/tmp/pip-0f48PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51: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)) 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:03 INFO - Running setup.py (path:/tmp/pip-0NbY5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51: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)) 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:03 INFO - Running setup.py (path:/tmp/pip-NhJa0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51: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)) 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:03 INFO - Running setup.py (path:/tmp/pip-kn0nkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51: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 15:51: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 15:51: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 15:51: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 15:51:04 INFO - Downloading blessings-1.6.tar.gz 15:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:05 INFO - Installing collected packages: blessings 15:51:05 INFO - Running setup.py install for blessings 15:51:05 INFO - Successfully installed blessings 15:51:05 INFO - Cleaning up... 15:51:05 INFO - Return code: 0 15:51:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:05 INFO - Reading from file tmpfile_stdout 15:51:05 INFO - Current package versions: 15:51:05 INFO - argparse == 1.2.1 15:51:05 INFO - blessings == 1.6 15:51:05 INFO - blobuploader == 1.2.4 15:51:05 INFO - docopt == 0.6.1 15:51:05 INFO - functools32 == 3.2.3-2 15:51:05 INFO - jsonschema == 2.5.1 15:51:05 INFO - manifestparser == 1.1 15:51:05 INFO - mozInstall == 1.13 15:51:05 INFO - mozcrash == 1.0 15:51:05 INFO - mozdebug == 0.1 15:51:05 INFO - mozdevice == 0.51 15:51:05 INFO - mozfile == 1.2 15:51:05 INFO - mozhttpd == 0.7 15:51:05 INFO - mozinfo == 0.10 15:51:05 INFO - mozleak == 0.1 15:51:05 INFO - mozlog == 3.5 15:51:05 INFO - moznetwork == 0.27 15:51:05 INFO - mozprocess == 0.25 15:51:05 INFO - mozprofile == 0.28 15:51:05 INFO - mozrunner == 6.13 15:51:05 INFO - mozscreenshot == 0.1 15:51:05 INFO - mozsystemmonitor == 0.3 15:51:05 INFO - moztest == 0.8 15:51:05 INFO - mozversion == 1.4 15:51:05 INFO - psutil == 3.1.1 15:51:05 INFO - requests == 1.2.3 15:51:05 INFO - wsgiref == 0.1.2 15:51:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51: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')]} 15:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51: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 0xe6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da090>, '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 0x11dad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', '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 15:51: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 15:51: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 15:51:05 INFO - Using env: {'DISPLAY': ':0', 15:51:05 INFO - 'HOME': '/home/cltbld', 15:51:05 INFO - 'LANG': 'en_US.UTF-8', 15:51:05 INFO - 'LANGUAGE': 'en_US:en', 15:51:05 INFO - 'LOGNAME': 'cltbld', 15:51:05 INFO - 'MAIL': '/var/mail/cltbld', 15:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:05 INFO - 'MOZ_NO_REMOTE': '1', 15:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:05 INFO - 'NO_EM_RESTART': '1', 15:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:05 INFO - 'PWD': '/builds/slave/test', 15:51:05 INFO - 'SHELL': '/bin/bash', 15:51:05 INFO - 'SHLVL': '1', 15:51:05 INFO - 'TERM': 'linux', 15:51:05 INFO - 'TMOUT': '86400', 15:51:05 INFO - 'USER': 'cltbld', 15:51:05 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', 15:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:05 INFO - '_': '/tools/buildbot/bin/python'} 15:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:51: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 15:51: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 15:51: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 15:51: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 15:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:51: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)) 15:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:51:06 INFO - Installing collected packages: simplejson 15:51:06 INFO - Running setup.py install for simplejson 15:51:06 INFO - building 'simplejson._speedups' extension 15:51: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 15:51: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 15:51:07 INFO - Successfully installed simplejson 15:51:07 INFO - Cleaning up... 15:51:07 INFO - Return code: 0 15:51:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51: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 0xe6a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11da090>, '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 0x11dad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', '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 15:51: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 15:51: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 15:51:07 INFO - Using env: {'DISPLAY': ':0', 15:51:07 INFO - 'HOME': '/home/cltbld', 15:51:07 INFO - 'LANG': 'en_US.UTF-8', 15:51:07 INFO - 'LANGUAGE': 'en_US:en', 15:51:07 INFO - 'LOGNAME': 'cltbld', 15:51:07 INFO - 'MAIL': '/var/mail/cltbld', 15:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:07 INFO - 'MOZ_NO_REMOTE': '1', 15:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:07 INFO - 'NO_EM_RESTART': '1', 15:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:07 INFO - 'PWD': '/builds/slave/test', 15:51:07 INFO - 'SHELL': '/bin/bash', 15:51:07 INFO - 'SHLVL': '1', 15:51:07 INFO - 'TERM': 'linux', 15:51:07 INFO - 'TMOUT': '86400', 15:51:07 INFO - 'USER': 'cltbld', 15:51:07 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', 15:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:07 INFO - '_': '/tools/buildbot/bin/python'} 15:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:51:08 INFO - Cleaning up... 15:51:08 INFO - Return code: 0 15:51:08 INFO - Running post-action listener: _resource_record_post_action 15:51:08 INFO - Running post-action listener: _start_resource_monitoring 15:51:08 INFO - Starting resource monitoring. 15:51:08 INFO - [mozharness: 2017-09-17 22:51:08.090917Z] Finished create-virtualenv step (success) 15:51:08 INFO - [mozharness: 2017-09-17 22:51:08.091386Z] Running install step. 15:51:08 INFO - Running pre-action listener: _resource_record_pre_action 15:51:08 INFO - Running main action method: install 15:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:08 INFO - Reading from file tmpfile_stdout 15:51:08 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:08 INFO - Reading from file tmpfile_stdout 15:51:08 INFO - Output received: 15:51:08 INFO - Usage: mozinstall [options] installer 15:51:08 INFO - Options: 15:51:08 INFO - -h, --help show this help message and exit 15:51:08 INFO - -d DEST, --destination=DEST 15:51:08 INFO - Directory to install application into. [default: 15:51:08 INFO - "/builds/slave/test"] 15:51:08 INFO - --app=APP Application being installed. [default: firefox] 15:51:08 INFO - mkdir: /builds/slave/test/build/application 15:51: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'] 15:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:51:26 INFO - Reading from file tmpfile_stdout 15:51:26 INFO - Output received: 15:51:26 INFO - /builds/slave/test/build/application/firefox/firefox 15:51:26 INFO - Running post-action listener: _resource_record_post_action 15:51:26 INFO - [mozharness: 2017-09-17 22:51:26.212487Z] Finished install step (success) 15:51:26 INFO - [mozharness: 2017-09-17 22:51:26.212737Z] Running setup-mitmproxy step. 15:51:26 INFO - Running pre-action listener: _resource_record_pre_action 15:51:26 INFO - Running main action method: setup_mitmproxy 15:51:26 INFO - Skipping: mitmproxy is not required 15:51:26 INFO - Running post-action listener: _resource_record_post_action 15:51:26 INFO - [mozharness: 2017-09-17 22:51:26.213857Z] Finished setup-mitmproxy step (success) 15:51:26 INFO - [mozharness: 2017-09-17 22:51:26.214140Z] Running run-tests step. 15:51:26 INFO - Running pre-action listener: _resource_record_pre_action 15:51:26 INFO - Running pre-action listener: _set_gcov_prefix 15:51:26 INFO - Running main action method: run_tests 15:51:26 WARNING - Try message not found. 15:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:51:26 INFO - Python 2.7.3 15:51:26 INFO - Return code: 0 15:51:26 INFO - grabbing minidump binary from tooltool 15:51:26 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')]} 15:51:26 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 0x11da090>, '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 0x11dad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:51:26 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 15:51:26 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 15:51:26 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 15:51:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:51:26 INFO - Return code: 0 15:51:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:51:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:51:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:51:26 INFO - ENV: RUST_BACKTRACE is now full 15:51:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:51:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:51: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/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 15:51: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/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 15:51:26 INFO - Using env: {'DISPLAY': ':0', 15:51:26 INFO - 'HOME': '/home/cltbld', 15:51:26 INFO - 'LANG': 'en_US.UTF-8', 15:51:26 INFO - 'LANGUAGE': 'en_US:en', 15:51:26 INFO - 'LOGNAME': 'cltbld', 15:51:26 INFO - 'MAIL': '/var/mail/cltbld', 15:51:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:26 INFO - 'MOZ_NO_REMOTE': '1', 15:51:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:26 INFO - 'NO_EM_RESTART': '1', 15:51:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:26 INFO - 'PWD': '/builds/slave/test', 15:51:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:26 INFO - 'RUST_BACKTRACE': 'full', 15:51:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:51:26 INFO - 'SHELL': '/bin/bash', 15:51:26 INFO - 'SHLVL': '1', 15:51:26 INFO - 'TERM': 'linux', 15:51:26 INFO - 'TMOUT': '86400', 15:51:26 INFO - 'USER': 'cltbld', 15:51:26 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', 15:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:26 INFO - '_': '/tools/buildbot/bin/python'} 15:51: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/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 15:51:26 INFO - mozversion application_buildid: 20170917213019 15:51:26 INFO - mozversion application_changeset: dd87b8587fc1d63e57ebdadcbabba89c6d172969 15:51:26 INFO - mozversion application_display_name: Nightly 15:51:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:51:26 INFO - mozversion application_name: Firefox 15:51:26 INFO - mozversion application_remotingname: firefox 15:51:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:51:26 INFO - mozversion application_vendor: Mozilla 15:51:26 INFO - mozversion application_version: 57.0a1 15:51:26 INFO - mozversion platform_buildid: 20170917213019 15:51:26 INFO - mozversion platform_changeset: dd87b8587fc1d63e57ebdadcbabba89c6d172969 15:51:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:51:26 INFO - mozversion platform_version: 57.0a1 15:51:26 INFO - using testdate: 1505688686 15:51:26 INFO - actual date: 1505688686 15:51:26 INFO - starting webserver on 'localhost:50553' 15:51:26 INFO - SUITE-START | Running 2 tests 15:51:26 INFO - TEST-START | dromaeo_css 15:51:26 INFO - Initialising browser for dromaeo_css test... 15:51:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50553/getInfo.html -profile /tmp/tmpkmvCOF/profile 15:51:26 INFO - TEST-INFO | started process 23028 (/builds/slave/test/build/application/firefox/firefox http://localhost:50553/getInfo.html) 15:51:32 INFO - TEST-INFO | 23028: exit 0 15:51:32 INFO - Browser initialized. 15:51:32 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:33 INFO - Using env: {'DISPLAY': ':0', 15:51:33 INFO - 'HOME': '/home/cltbld', 15:51:33 INFO - 'JSGC_DISABLE_POISONING': '1', 15:51:33 INFO - 'LANG': 'en_US.UTF-8', 15:51:33 INFO - 'LANGUAGE': 'en_US:en', 15:51:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:51:33 INFO - 'LOGNAME': 'cltbld', 15:51:33 INFO - 'MAIL': '/var/mail/cltbld', 15:51:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:33 INFO - 'MOZ_CRASHREPORTER': '1', 15:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:51:33 INFO - 'MOZ_NO_REMOTE': '1', 15:51:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:33 INFO - 'NO_EM_RESTART': '1', 15:51:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:33 INFO - 'PWD': '/builds/slave/test', 15:51:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:33 INFO - 'RUST_BACKTRACE': 'full', 15:51:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:51:33 INFO - 'SHELL': '/bin/bash', 15:51:33 INFO - 'SHLVL': '1', 15:51:33 INFO - 'TERM': 'linux', 15:51:33 INFO - 'TMOUT': '86400', 15:51:33 INFO - 'USER': 'cltbld', 15:51:33 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', 15:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:33 INFO - '_': '/tools/buildbot/bin/python'} 15:51:33 INFO - TEST-INFO | started process 23263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmvCOF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:33 INFO - PID 23263 | 15:51:33 INFO - PID 23263 | (/builds/slave/test/build/application/firefox/firefox:23313): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:51:33 INFO - PID 23263 | 15:51:44 INFO - PID 23263 | RSS: Main: 143740928 15:51:44 INFO - PID 23263 | 15:54:41 INFO - PID 23263 | Cycle 1(1): loaded http://localhost:50553/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50553/tests/dromaeo/cssquery-ext.html) 15:54:43 INFO - PID 23263 | RSS: Main: 148217856 15:54:43 INFO - PID 23263 | 15:57:44 INFO - PID 23263 | Cycle 1(1): loaded http://localhost:50553/tests/dromaeo/cssquery-ext.html (next: http://localhost:50553/tests/dromaeo/cssquery-jquery.html) 15:57:45 INFO - PID 23263 | RSS: Main: 148676608 15:57:45 INFO - PID 23263 | 16:00:47 INFO - PID 23263 | Cycle 1(1): loaded http://localhost:50553/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50553/tests/dromaeo/cssquery-mootools.html) 16:00:47 INFO - PID 23263 | RSS: Main: 150372352 16:00:47 INFO - PID 23263 | 16:03:49 INFO - PID 23263 | Cycle 1(1): loaded http://localhost:50553/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50553/tests/dromaeo/cssquery-prototype.html) 16:03:49 INFO - PID 23263 | RSS: Main: 149123072 16:03:49 INFO - PID 23263 | 16:06:52 INFO - PID 23263 | Cycle 1(1): loaded http://localhost:50553/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50553/tests/dromaeo/cssquery-yui.html) 16:06:53 INFO - PID 23263 | RSS: Main: 149909504 16:06:53 INFO - PID 23263 | 16:09:54 INFO - PID 23263 | Cycle 1(1): loaded http://localhost:50553/tests/dromaeo/cssquery-yui.html (next: http://localhost:50553/tests/dromaeo/cssquery-dojo.html) 16:09:55 INFO - PID 23263 | RSS: Main: 152395776 16:09:55 INFO - PID 23263 | 16:09:55 INFO - PID 23263 | __start_tp_report 16:09:55 INFO - PID 23263 | _x_x_mozilla_page_load 16:09:55 INFO - PID 23263 | _x_x_mozilla_page_load_details 16:09:55 INFO - PID 23263 | |i|pagename|runs| 16:09:55 INFO - PID 23263 | |0;dojo.html;3829.02359898226;3888.7666739995584;3888.863889763859;3909.589493103222;3915.3735402335615;6158.076288556718;6245.032020036891;6247.968760156198;6281.403266689663;6328.77849275276;6249.750009999594;6255.562110652256;6259.405356491126;6289.716962736677;6307.873842523147;5633.549316054706;5635.830925072254;5655.7172141392975;5659.207710920464;5726.198332233491;5548.944510554883;5669.461401166883;5686.687232202227;5749.080147176453;5755.68343741094;5638.097904335327;5643.4074422185695;5673.517750991171;5753.65478071315;5795.4784069433745;5495.560355171577;5560.77756889724;5595.7481913313995;5665.575081868835;5677.063284558043;5575.163725441175;5588.692621905793;5607.383187849333;5626.381098079208;5636.549076073904;6210.813675589739;6226.315105338409;6253.656048917308;6255.530835187379;6289.559730818844;6737.562058466184;6749.426298764611;6831.965840170817;6849.1780986281465;6854;6675.6662166891465;6796.728130874759;6799.048133261347;6816.4546836252985;6895.5173137880365;6205.937940620581;6278.434940855299;6308.432241098323;6342.048692696087;6356.951103067942;6912.896306555405;7055.188653304833;7074.398676112588;7076.504644674927;7093.113360829896;6569.835754106186;6711.228208756055;6728.966355168291;6803.387695107464;6807.897881531781;6662.933370666328;6743.494237932175;6787.592744435349;6791.252962174157;6813.1142951415995;6844.863102737917;6849.1096157499205;6853.383195512328;6857.9657101715175;6860.1081859358965;6663.800085997428;6764.0530325754435;6776.186857577122;6863.142107236596;6864.622445765531;4847.515248475124;4904.828331008398;4915.287283343895;4989.25161225819;4992.925106123411;4505.707129036602;4506.81972721094;4527.275635898306;4566.8173273068705;4587.816487340536;6261.092141639528;6341.778037768656;6349;6354.17395738551;6354.968225158845;6764;6774.051632771416;6775.220849602359;6860.759873404407;6873.656317184221;6203.6587987660205;6275.152854364694;6317.241930968313;6323.019931910561;6327.683615819191;5481.177823326533;5545.556355491551;5565.443455654402;5569.248151499496;5577.27495425592;6862.828429289308;6967.198772141269;6976.441884649216;7073.752418665322;7162.964185179041;6744.932550674431;6755.831104222336;6773.119494465688;6777.1189745332795;6780.050792888901;7017.684204210721;7023.47323950716;7026.613536255555;7045.753398631024;7106.538075025313;6688.331166883273;6778.4916131289365;6781.287964763629;6788.796336109925;6791.626460544519;6797.524173307821;6803.7618683345845;6815.761448349284;6888.207856096413;6890.896636550356;6432.517561183024;6528.37980391862;6533.150690410216;6533.738650453929;6630.502712296694;6568.080468734285;6591.967040164768;6602.471802255904;6644.501662375244;6646.069550263063;6529.902051469327;6594.472442204708;6616.8345791355605;6617.2721000688925;6618.8345291368105;6602.075709400592;6633.270340262471;6642.136522252076;6720.260771315054;6729;6315.715792789428;6388.425041746079;6428.228612566522;6437.839054023687;6534.052562378333 16:09:55 INFO - PID 23263 | |1;ext.html;943.3113826906358;975.117518645626;979.6571200079973;979.6767066867934;991.6033586565377;44309.556904430945;45185.32222016668;45302.7734861326;45342.31986520205;45354;41642.37536436956;41652.58347416525;41772.16455670885;41837.37243941343;41891.58108418915;7362.852742945138;7484.476086673935;7490;7497.512661677001;7498.8125296867465;7168.641567921609;7226.6025368604705;7228.9277107229045;7236.0231368765335;7281.52670076446;7219.205887352413;7219.783406497813;7222.602756848371;7399.4450416219;8042.5978701065005;8133.877991830127;8186.54973976431;8189.344852411793;8190.631421586043;8190.754277371689;8118.959405202936;8200.05699344577;8207;8217.8356432871;8217.972753405824;41915.58084419147;42193.36709949353;42840.357394639104;43238.35142472865;43260.56739432597;3712.517372741553;3731.6828069614116;3757.4927384802977;3759.830807613664;3761.097336639214;33836.830815845766;33888.152796180046;33978.660213397794;34588.30823383518;34786.30427391463;5477.698726570037;5514.641548299348;5522.088855338864;5537.916931246034;5548.389677135512;210595;211250;212718;212742;212769;48465.515344846805;49531;54517.1822422664;55259.44740552623;56114.719426403426;58596.41403585995;58963.41036589665;59056.40943590595;59076;59134.40865591289;15333.386664533295;15362.462313819186;15395.538133856002;15452.768208476882;15458.84541154574;12128.090393220544;12181.147319687714;12220.938895305466;12373.690657733629;12380.876191238152;15359.61600959985;15551.611209719622;15568.221588920509;15627;15660.275224346045;6209.844753881099;6290.685465726695;6326.49388048955;6332.651704156316;6354.459870910932;1101.5648818716722;1110.6779034080025;1112.8163852964333;1121.657894342217;1122.685648018556;25861.870690646425;25877.870610646827;25919.22242332733;26053;26182.6072608911;1173.5129921082655;1186.2467333243453;1189.0012389592785;1205.7287110400089;1231.07054174098;13614.795778063337;13667.179969201681;13849.723005539832;13877.295181052521;13877.791833122512;285918;286914;287007;287097;287530;60315;60455.69772151111;60472.39527604756;60496;60700.39299606947;1482.792409062732;1525.3593490733697;1527.9465218717291;1532.0654400815495;1535.3398038843404;25049.87475062613;25163.370915726522;25245.359051661584;25611.487770244865;25660.615090774027;43121.568784311756;43174.352384713624;43202.567974321115;43220.56779432166;43322.566774333114;239148;240885;261396;269372;269651;36794.448083278236;36869.26261474809;37564.436533452565;39557.2088558233;41750.79124604358;51921;52169.21746173887;52215.47784522106;52496;52838.47161528336;38253.04367390726;38285;38448.23103537969;38779.61220387873;39041.41437878491;38014.239715206095;38065.809670951465;38158.23683526369;38197.61802381941;38719.612803872726;38920;39559;39728.40407393949;39748.403773943995;39986.20027599374;36205.81897090498;36954;37797.62202377941;37896;37926;26506.867465662548;26653.600195997464;26902.32744181411;27571.035013775225;27651.620878025344 16:09:55 INFO - PID 23263 | |2;jquery.html;579.2122713110169;595.5741644724025;596.9761209551618;612.5497759147026;618.9412005859444;23233.30300090998;24072.518549628996;24107.758922410772;24138.637920431185;24198.03207871683;24582.50834983299;26554.203373898767;26625;26712.065077722284;26730.331741706468;6422.357764223575;6478.481721462295;6489.61062336259;6547.410733034026;6552.868942621145;6336.968315158418;6410.423061924426;6521.510886683494;6613.305602911673;6640.56836305641;6594.505412094089;6603.240627327847;6603.669816509179;6603.93396066038;6607.966960165192;6583.14419125513;6596.373344532286;6597.80206593803;6603.075569420285;6604.834879128012;5946.672932988684;6118.357572454917;6147.815565533041;6150.292716337589;6156.599821011665;30035.849820750977;30525;30575.38849223003;30578.84710576455;30650.38699226003;2203.746569144537;2237.127520267097;2240.0703707961175;2242;2242.932712018642;19807.7028844566;20329.796702033087;20413.69379459309;20561.4859628509;20721.27475538364;2488.9377765555823;2531.797456203499;2575.1759436980174;2579.5356835769553;2589.976959101163;141767;146581;147528.26235868753;156073;163466.3653363463;15094.075959475103;15609.843901561066;15750.527484175263;15991.28039238237;16134.435294764628;25559.48881022369;25645.61531577028;25652.230433087036;25670.229893102864;25777.74222257791;9674.661386851567;9720.95139524312;9724;9818.75453113678;9889.802203956024;8632.438891472035;8687.739367818975;8710.172533609424;8720.956395217983;8725.65097396097;9731.951340243395;9842.50787460624;9933.701988940344;9944.552495137592;9997.400155990665;2734.904278350248;2750.7936904732223;2773.084881988939;2778.360976975307;2796.804223704362;1029.6910926722103;1051.4374809476892;1064.6007747094839;1064.6433444795925;1065.776187000723;20995.8950205248;21087;21191.78808211929;21263.468413289484;21779.782202177776;1106.441247170174;1106.9889301107046;1110.650145204258;1114.4817659788237;1116.4083035990939;11583.247088939192;11680.240784348991;11862.822057669142;11912.583059592873;11961.342126183143;642907;654518;665975;689498;692120;127103.36448317699;127359;129159;130760.3461982703;131429.3428532851;1044.1803184500284;1069.3370110531364;1125.9324440533594;1127.5038982847684;1187.827764974074;21629.891850540647;21716.67424988595;22476.77523224812;22485;22504.774952250267;59080.704596476746;61525;64424.677876610316;64622.353776461634;66336.6683166581;79144.20855791369;79184;79216.20783792318;80093.59953200197;80504.59747701224;20654.89672551688;21347.35957921203;21487.14051437925;21538.353849384544;21738.456538586663;24381;24511.264662060166;24552.140675076287;24717.25848224556;24735.752642473344;18577.53556161107;20042.599148016667;20281.391558253275;20302.79697203009;20313.695294570887;17272;17417.39039133624;17573.121343932497;17954.371596994566;18022.459326220236;18505.167267472727;18885.43343699691;18920.810791892454;19668.50828729293;20919.686204707246;20927.26754563583;20960.68558971586;21077.578448431253;21088.789112109298;21146.89426552919;19063;19432.222711091963;19443.8055619442;19941.501462462973;19987.900060499604 16:09:55 INFO - PID 23263 | |3;mootools.html;1418.546065259117;1492.9104253744777;1555.9066456012633;1557.540525544964;1557.5794535475416;17602;18158.092095395226;18192.090395480238;18197.090145492723;18211.089445527738;17787.288508459646;17910.5522361941;17912.55218619532;17971.910140449312;17986;2566.525192839331;2661.800364972625;2669.9466010679776;2670.145553422896;2675;2625.4224070704413;2752.779777617796;2795.4409118176345;2814.873330700113;2817.09852847089;2662.2279538933685;2670.1322070327224;2694.0705456617534;2695.0028489458928;2695.595660650908;2699.0688212566633;2730.385663225778;2758.3655759175404;2761.4615150045747;2767.4465106978687;2660.9467810643873;2686.355274734069;2700.189943017087;2711.688155862081;2719.687235967869;16026.839731602651;16284.674306513922;16301;16305.755413668805;16312.102834344107;8210.589470526449;8475.95762021192;8479.491230526188;8483.44857584255;8483.703070392568;5143.537081662668;5593.496585307301;5603.719814009283;5733.713314334266;5757.769689212427;1803.7384579235938;1812.2207450796152;1871.6818140916077;1892.4890279624424;1901.5341241395809;29884.701152988408;30209.848950755324;30380;30445.543316850264;30508.237294067603;6627.768028118992;6768.796936091925;6959.095317608679;6972;7013.333733295329;18596.628067438847;18715.90642046781;18824.24703011864;18830.71753923692;18869.71695424542;8081.111077781439;8208.630611622491;8249.752507424786;8251.133630968781;8281.29608983243;7590.354819840375;7605.581693006938;7707.653155607899;7709.4603377763015;7760.883586746203;5495.752691128909;5544.085225937756;5572.944270557324;5629.802956896571;5862.149988251765;1469.8015767871414;1500.8574185452364;1549.690061987607;1568.8431156884221;1578.2818817438038;914.7164379042518;928.7167413938679;930.1163894300306;936.2743873498093;943.8537026760863;9021.954890225506;9062.637494500146;9170.403923744936;9312;9338.533073346305;1038.5741845843168;1041.0786453988123;1044.6552637629563;1049.7113293844254;1051.4690081508788;4772.3557319761385;4786.880327991828;5021.799128034838;5315.468453154654;5441.428649991773;24540;25506.362340941254;25673.358166045997;25702.228933132035;25748.227553173434;23689.881550592138;24716;25141;25899.223023309332;25978.090766823072;12037.699057523458;12697.809532857014;12811.487540498276;12847.678808029874;12852.228866268053;9399.154076133182;9466.242700584075;9505.572249248939;9543.18882894934;9697.078777516124;21055.157793688082;21179.470513236676;21411.143554257655;21414.892925535274;22096.779032209473;21622.13511459587;21829.345119646438;21875;21916.561668766855;22418.32745017652;13196.80204796948;13499.662508437368;13602;13612.591622251348;13624.65938351549;15657.530274091796;15678;15689.215539223222;15851.920740396225;15884.841151588336;12287.69280767988;12563.309018004098;12900.096993210385;13011.739765204833;13266.403011864682;12494.187877788278;12626.053046021401;12953.676158095746;12981.156224845356;13088.345582720636;10599.470026498799;10602.946985265024;10751.193660475652;10770.299930504492;10839.349639021368;8083.555404452812;8095.23095305945;8112.83774324522;8142.8778568322705;8243.505389676639;7774.3003129716335;7799.415043871619;7808.41436892224;7884.329831964347;7896.921030789618 16:09:55 INFO - PID 23263 | |4;prototype.html;524.9658772179808;553.4410245651892;563.3155715805296;569.8917205730913;579.2007030298188;6199.4730447911925;6283.052253801325;6305.369463053698;6307.590006649564;6323.209598800144;6189.907151392721;6240.625562466255;6250.781222657208;6272.874542509147;6298.149749783778;4963.528464795839;5068.5438310552045;5074.3657042869645;5101.183810590306;5109.540141387274;5077.746112694351;5140.228965655163;5140.845774626767;5148.536631703146;5167;4804;4994.350734404522;5040.445550989388;5051.696898186102;5063.316452278932;4905.828296009622;4913.213885778294;4972.651914365996;4985.551300382983;5017.89964200714;4479.3281007848755;4486.573775491356;4499.505054444008;4501.244514639293;4519.819207231707;6094.847628809271;6123.387661233885;6161.291451483092;6181.907271390933;6237;5888.411158884121;5924.644521328691;5933.317668468138;5937.495312898409;5964.403559644044;6654.600723956578;6660.633665148415;6722.529422940396;6738.865222695518;6795.558288711218;5031.371078615173;5053.949460505385;5054.444011158769;5083.593312534988;5103.515166059218;6786.796396108125;6949.131358580127;7014.597080583852;7034.331738484836;7071.8939215911805;5195.402528709247;5197.220416937414;5207.3230480037355;5209.140491818807;5212.921806172911;5253.264542963988;5270.683758974474;5298.311219541435;5309.522143007148;5317.122674758699;5853.180554722342;5855.151003104526;5872.647641141545;5888.234529511222;5895.115732640053;6698.363655452724;6699.363560461748;6739.090222819955;6739.831504212336;6767.492438067066;1796.2006906926554;1800.2708902894349;1802.8016918138994;1808.6744386010382;1810.4478134169206;1242.7017515796144;1297.4096785962365;1298.363801737142;1303.6284658872175;1307.8365204349457;6252.624842509464;6270.404311590391;6281;6303.117563541108;6345.07996340528;6607.537472376887;6697.631630260383;6795.18457785059;6811.216710078305;6826.795196144124;6215.160953271251;6235.282942461675;6269.185005949197;6281.685915704196;6323.336049714806;3575.6948713719307;3590;3599.640035996432;3602.1534939289245;3607.1342877709685;7047;7136.3220494052985;7145.92854071463;7181.6409179540815;7221.891671624825;7000.649967501605;7041.366277035091;7048.964755176191;7068.293170682993;7090.751823686146;6996.300369963064;7001.684924178424;7008.719651214098;7041.3310735480045;7048.541844780073;6719.395254427125;6742.662866856539;6766.4248538874745;6773.390394864486;6774.220964589135;6717.596944183365;6719.932800671931;6728.966355168192;6780.389764920984;6801.795946121624;6940.305969403019;6947;6958.269381715049;7099.929000709927;7104.147502299757;5168.431472538093;5194.97402512985;5208.5312321891215;5212.582993360598;5214.348206474191;6451.516136289891;6740.865182696417;6777.525573209828;6791.72833086671;6821.89767153503;6227.875442491216;6479.902801457888;6536.803895883131;6541;6700.83247918806;6463.321351258238;6522.684447021239;6598.274189839018;6607.531046200783;6661.866762664817;6568.80293591193;6573.112629794917;6631.701573429304;6637.402633762791;6671.966640166962;6714.764983225564;6746.4265537429865;6749.763758268437;6776.7628133015105;6792.286809885089;6457.192850893638;6514.804555863332;6516.57642253252;6563.540552161303;6569 16:09:55 INFO - PID 23263 | |5;yui.html;957.9281553883457;993.9105480506753;995.8854731705853;1007.5768177365503;1018.322815327807;20121.597568048648;20315.187392504282;20543.589128217445;20611.175552977882;20681.586368272627;19186.23255069799;19389.418317450465;19445.902770486162;19487.512812179702;19523.804761952375;1035.9585616575328;1054.752133248686;1056.915446764257;1060.9257351985364;1061.1828891753346;1099.3349023840542;1101.1466113761858;1101.641966360932;1102.2614848051824;1103.9282446640982;1097.00720847633;1139.3107170162057;1143.5254369436673;1143.8684551276626;1144.5822274869654;1125.8480105185777;1134.6652737442473;1138.0781566930812;1138.5445821671315;1138.9658310250707;811.4360519438992;817.7342363731811;817.9141190175066;827.2637352756052;835.1356346181733;20262.49343766403;20263.088161032643;20282.188712451483;20305.898470507553;20485.5902881943;22902.65646015311;23250.186243481396;23759.049638014458;23886.64170037451;23970.161044363365;18593.7210941836;18685.813141868544;18868.716969245474;19087;19172.80827191724;3828.349180639298;3856.421536769507;3861.7296789224765;3868.2650296443585;3871.4386413970096;136208;159019;160426;160533.19733401376;160613;15776.60558486047;16064.437744679113;16069.919650401673;16163.919180404258;16172.83827161737;26378.076767313436;26411.603825942628;26504.072357467398;26509.602355964675;26539.071132510657;9340.906590934139;9371.390859594105;9418.105279998526;9429.528523573794;9452;4432.135733531994;4451.866444006685;4464.866054018385;4500.122476117126;4505.098980203972;6028.336882942873;6059.151718759377;6146.569740118238;6185.505159587222;6205.410486003822;1121.4448847820217;1126.1947707389256;1143.4340001699045;1158.3165932099932;1159.5825502818977;741.1921006103373;756.3155344413315;763.6830715253108;778.8325510015261;784.2510402565537;13970.441182352795;14067.507637232648;14139.575812725634;14570.708585828224;14741.262936853114;742.6027075514573;748.9625518724042;749.3518106837546;761.7562380038335;762.1502025241927;6458.709358078898;6490;6554.335139017751;6591.637459939653;6635.701393437307;156850;156893;159107;159309;159818.2009089947;134088.32955835157;134620;136307.31846340705;138189;139358;113638;114219.42890285661;114260;115064;116730;12426.62720118398;12476.251424914533;12482.375881205722;12592.685182870502;12663.430145643284;56121;56457;57017.14474282806;57827.4217257822;57900.13149802672;69456.65271673811;70369.64815175891;71121.64439177977;71233.64383178052;72052.27947720456;17514.299428022736;17579;17780.733289000418;17830.732539012184;17869.195886185415;18283.26866925308;18293.17680704345;18399.448016559523;18424.631507370046;18727.812721873153;18659.253629854655;18784.7182292263;18793;18992.52518687044;19006.429807105807;14987.550373488813;15181.468648597245;15283.77074343908;15354.923225383802;15412.306446209723;18355.174017169527;18441.17014734367;18560.628787424444;18580.81419185791;18717.25130994745;12681.55614553523;12706.237625742486;12739.55411560628;12767.425465853874;12886.935565322114;13774.517891873737;13917.930410347883;13952.58142255734;14003.50987715425;14030.298485075502 16:09:55 INFO - PID 23263 | __end_tp_report 16:09:55 INFO - PID 23263 | __start_cc_report 16:09:55 INFO - PID 23263 | _x_x_mozilla_cycle_collect,275 16:09:55 INFO - PID 23263 | __end_cc_report 16:09:55 INFO - PID 23263 | __startTimestamp1505689795180__endTimestamp 16:09:55 INFO - PID 23263 | 16:09:55 INFO - PID 23263 | ------- Summary: start ------- 16:09:55 INFO - PID 23263 | Number of tests: 6 16:09:55 INFO - PID 23263 | 16:09:55 INFO - PID 23263 | [#0] dojo.html Cycles:165 Average:6262.71 Median:6533.15 stddev:739.86 (11.3%) stddev-sans-first:717.07 16:09:55 INFO - PID 23263 | Values: 3829.0 3888.8 3888.9 3909.6 3915.4 6158.1 6245.0 6248.0 6281.4 6328.8 6249.8 6255.6 6259.4 6289.7 6307.9 5633.5 5635.8 5655.7 5659.2 5726.2 5548.9 5669.5 5686.7 5749.1 5755.7 5638.1 5643.4 5673.5 5753.7 5795.5 5495.6 5560.8 5595.7 5665.6 5677.1 5575.2 5588.7 5607.4 5626.4 5636.5 6210.8 6226.3 6253.7 6255.5 6289.6 6737.6 6749.4 6832.0 6849.2 6854.0 6675.7 6796.7 6799.0 6816.5 6895.5 6205.9 6278.4 6308.4 6342.0 6357.0 6912.9 7055.2 7074.4 7076.5 7093.1 6569.8 6711.2 6729.0 6803.4 6807.9 6662.9 6743.5 6787.6 6791.3 6813.1 6844.9 6849.1 6853.4 6858.0 6860.1 6663.8 6764.1 6776.2 6863.1 6864.6 4847.5 4904.8 4915.3 4989.3 4992.9 4505.7 4506.8 4527.3 4566.8 4587.8 6261.1 6341.8 6349.0 6354.2 6355.0 6764.0 6774.1 6775.2 6860.8 6873.7 6203.7 6275.2 6317.2 6323.0 6327.7 5481.2 5545.6 5565.4 5569.2 5577.3 6862.8 6967.2 6976.4 7073.8 7163.0 6744.9 6755.8 6773.1 6777.1 6780.1 7017.7 7023.5 7026.6 7045.8 7106.5 6688.3 6778.5 6781.3 6788.8 6791.6 6797.5 6803.8 6815.8 6888.2 6890.9 6432.5 6528.4 6533.2 6533.7 6630.5 6568.1 6592.0 6602.5 6644.5 6646.1 6529.9 6594.5 6616.8 6617.3 6618.8 6602.1 6633.3 6642.1 6720.3 6729.0 6315.7 6388.4 6428.2 6437.8 6534.1 16:09:55 INFO - PID 23263 | 16:09:55 INFO - PID 23263 | [#1] ext.html Cycles:180 Average:43694.52 Median:38749.61 stddev:66065.33 (170.5%) stddev-sans-first:66172.68 16:09:55 INFO - PID 23263 | Values: 943.3 975.1 979.7 979.7 991.6 44309.6 45185.3 45302.8 45342.3 45354.0 41642.4 41652.6 41772.2 41837.4 41891.6 7362.9 7484.5 7490.0 7497.5 7498.8 7168.6 7226.6 7228.9 7236.0 7281.5 7219.2 7219.8 7222.6 7399.4 8042.6 8133.9 8186.5 8189.3 8190.6 8190.8 8119.0 8200.1 8207.0 8217.8 8218.0 41915.6 42193.4 42840.4 43238.4 43260.6 3712.5 3731.7 3757.5 3759.8 3761.1 33836.8 33888.2 33978.7 34588.3 34786.3 5477.7 5514.6 5522.1 5537.9 5548.4 210595.0 211250.0 212718.0 212742.0 212769.0 48465.5 49531.0 54517.2 55259.4 56114.7 58596.4 58963.4 59056.4 59076.0 59134.4 15333.4 15362.5 15395.5 15452.8 15458.8 12128.1 12181.1 12220.9 12373.7 12380.9 15359.6 15551.6 15568.2 15627.0 15660.3 6209.8 6290.7 6326.5 6332.7 6354.5 1101.6 1110.7 1112.8 1121.7 1122.7 25861.9 25877.9 25919.2 26053.0 26182.6 1173.5 1186.2 1189.0 1205.7 1231.1 13614.8 13667.2 13849.7 13877.3 13877.8 285918.0 286914.0 287007.0 287097.0 287530.0 60315.0 60455.7 60472.4 60496.0 60700.4 1482.8 1525.4 1527.9 1532.1 1535.3 25049.9 25163.4 25245.4 25611.5 25660.6 43121.6 43174.4 43202.6 43220.6 43322.6 239148.0 240885.0 261396.0 269372.0 269651.0 36794.4 36869.3 37564.4 39557.2 41750.8 51921.0 52169.2 52215.5 52496.0 52838.5 38253.0 38285.0 38448.2 38779.6 39041.4 38014.2 38065.8 38158.2 38197.6 38719.6 38920.0 39559.0 39728.4 39748.4 39986.2 36205.8 36954.0 37797.6 37896.0 37926.0 26506.9 26653.6 26902.3 27571.0 27651.6 16:09:55 INFO - PID 23263 | 16:09:55 INFO - PID 23263 | [#2] jquery.html Cycles:180 Average:41813.22 Median:24446.13 stddev:111236.83 (455.0%) stddev-sans-first:111505.79 16:09:55 INFO - PID 23263 | Values: 579.2 595.6 597.0 612.5 618.9 23233.3 24072.5 24107.8 24138.6 24198.0 24582.5 26554.2 26625.0 26712.1 26730.3 6422.4 6478.5 6489.6 6547.4 6552.9 6337.0 6410.4 6521.5 6613.3 6640.6 6594.5 6603.2 6603.7 6603.9 6608.0 6583.1 6596.4 6597.8 6603.1 6604.8 5946.7 6118.4 6147.8 6150.3 6156.6 30035.8 30525.0 30575.4 30578.8 30650.4 2203.7 2237.1 2240.1 2242.0 2242.9 19807.7 20329.8 20413.7 20561.5 20721.3 2488.9 2531.8 2575.2 2579.5 2590.0 141767.0 146581.0 147528.3 156073.0 163466.4 15094.1 15609.8 15750.5 15991.3 16134.4 25559.5 25645.6 25652.2 25670.2 25777.7 9674.7 9721.0 9724.0 9818.8 9889.8 8632.4 8687.7 8710.2 8721.0 8725.7 9732.0 9842.5 9933.7 9944.6 9997.4 2734.9 2750.8 2773.1 2778.4 2796.8 1029.7 1051.4 1064.6 1064.6 1065.8 20995.9 21087.0 21191.8 21263.5 21779.8 1106.4 1107.0 1110.7 1114.5 1116.4 11583.2 11680.2 11862.8 11912.6 11961.3 642907.0 654518.0 665975.0 689498.0 692120.0 127103.4 127359.0 129159.0 130760.3 131429.3 1044.2 1069.3 1125.9 1127.5 1187.8 21629.9 21716.7 22476.8 22485.0 22504.8 59080.7 61525.0 64424.7 64622.4 66336.7 79144.2 79184.0 79216.2 80093.6 80504.6 20654.9 21347.4 21487.1 21538.4 21738.5 24381.0 24511.3 24552.1 24717.3 24735.8 18577.5 20042.6 20281.4 20302.8 20313.7 17272.0 17417.4 17573.1 17954.4 18022.5 18505.2 18885.4 18920.8 19668.5 20919.7 20927.3 20960.7 21077.6 21088.8 21146.9 19063.0 19432.2 19443.8 19941.5 19987.9 16:09:55 INFO - PID 23263 | 16:09:55 INFO - PID 23263 | [#3] mootools.html Cycles:180 Average:10443.02 Median:14301.76 stddev:7819.57 (54.7%) stddev-sans-first:7812.12 16:09:55 INFO - PID 23263 | Values: 1418.5 1492.9 1555.9 1557.5 1557.6 17602.0 18158.1 18192.1 18197.1 18211.1 17787.3 17910.6 17912.6 17971.9 17986.0 2566.5 2661.8 2669.9 2670.1 2675.0 2625.4 2752.8 2795.4 2814.9 2817.1 2662.2 2670.1 2694.1 2695.0 2695.6 2699.1 2730.4 2758.4 2761.5 2767.4 2660.9 2686.4 2700.2 2711.7 2719.7 16026.8 16284.7 16301.0 16305.8 16312.1 8210.6 8476.0 8479.5 8483.4 8483.7 5143.5 5593.5 5603.7 5733.7 5757.8 1803.7 1812.2 1871.7 1892.5 1901.5 29884.7 30209.8 30380.0 30445.5 30508.2 6627.8 6768.8 6959.1 6972.0 7013.3 18596.6 18715.9 18824.2 18830.7 18869.7 8081.1 8208.6 8249.8 8251.1 8281.3 7590.4 7605.6 7707.7 7709.5 7760.9 5495.8 5544.1 5572.9 5629.8 5862.1 1469.8 1500.9 1549.7 1568.8 1578.3 914.7 928.7 930.1 936.3 943.9 9022.0 9062.6 9170.4 9312.0 9338.5 1038.6 1041.1 1044.7 1049.7 1051.5 4772.4 4786.9 5021.8 5315.5 5441.4 24540.0 25506.4 25673.4 25702.2 25748.2 23689.9 24716.0 25141.0 25899.2 25978.1 12037.7 12697.8 12811.5 12847.7 12852.2 9399.2 9466.2 9505.6 9543.2 9697.1 21055.2 21179.5 21411.1 21414.9 22096.8 21622.1 21829.3 21875.0 21916.6 22418.3 13196.8 13499.7 13602.0 13612.6 13624.7 15657.5 15678.0 15689.2 15851.9 15884.8 12287.7 12563.3 12900.1 13011.7 13266.4 12494.2 12626.1 12953.7 12981.2 13088.3 10599.5 10602.9 10751.2 10770.3 10839.3 8083.6 8095.2 8112.8 8142.9 8243.5 7774.3 7799.4 7808.4 7884.3 7896.9 16:09:55 INFO - PID 23263 | 16:09:55 INFO - PID 23263 | [#4] prototype.html Cycles:180 Average:5674.39 Median:6276.94 stddev:1593.73 (25.4%) stddev-sans-first:1550.63 16:09:55 INFO - PID 23263 | Values: 525.0 553.4 563.3 569.9 579.2 6199.5 6283.1 6305.4 6307.6 6323.2 6189.9 6240.6 6250.8 6272.9 6298.1 4963.5 5068.5 5074.4 5101.2 5109.5 5077.7 5140.2 5140.8 5148.5 5167.0 4804.0 4994.4 5040.4 5051.7 5063.3 4905.8 4913.2 4972.7 4985.6 5017.9 4479.3 4486.6 4499.5 4501.2 4519.8 6094.8 6123.4 6161.3 6181.9 6237.0 5888.4 5924.6 5933.3 5937.5 5964.4 6654.6 6660.6 6722.5 6738.9 6795.6 5031.4 5053.9 5054.4 5083.6 5103.5 6786.8 6949.1 7014.6 7034.3 7071.9 5195.4 5197.2 5207.3 5209.1 5212.9 5253.3 5270.7 5298.3 5309.5 5317.1 5853.2 5855.2 5872.6 5888.2 5895.1 6698.4 6699.4 6739.1 6739.8 6767.5 1796.2 1800.3 1802.8 1808.7 1810.4 1242.7 1297.4 1298.4 1303.6 1307.8 6252.6 6270.4 6281.0 6303.1 6345.1 6607.5 6697.6 6795.2 6811.2 6826.8 6215.2 6235.3 6269.2 6281.7 6323.3 3575.7 3590.0 3599.6 3602.2 3607.1 7047.0 7136.3 7145.9 7181.6 7221.9 7000.6 7041.4 7049.0 7068.3 7090.8 6996.3 7001.7 7008.7 7041.3 7048.5 6719.4 6742.7 6766.4 6773.4 6774.2 6717.6 6719.9 6729.0 6780.4 6801.8 6940.3 6947.0 6958.3 7099.9 7104.1 5168.4 5195.0 5208.5 5212.6 5214.3 6451.5 6740.9 6777.5 6791.7 6821.9 6227.9 6479.9 6536.8 6541.0 6700.8 6463.3 6522.7 6598.3 6607.5 6661.9 6568.8 6573.1 6631.7 6637.4 6672.0 6714.8 6746.4 6749.8 6776.8 6792.3 6457.2 6514.8 6516.6 6563.5 6569.0 16:09:55 INFO - PID 23263 | 16:09:55 INFO - PID 23263 | [#5] yui.html Cycles:180 Average:28324.42 Median:18626.49 stddev:42977.06 (230.7%) stddev-sans-first:43048.50 16:09:55 INFO - PID 23263 | Values: 957.9 993.9 995.9 1007.6 1018.3 20121.6 20315.2 20543.6 20611.2 20681.6 19186.2 19389.4 19445.9 19487.5 19523.8 1036.0 1054.8 1056.9 1060.9 1061.2 1099.3 1101.1 1101.6 1102.3 1103.9 1097.0 1139.3 1143.5 1143.9 1144.6 1125.8 1134.7 1138.1 1138.5 1139.0 811.4 817.7 817.9 827.3 835.1 20262.5 20263.1 20282.2 20305.9 20485.6 22902.7 23250.2 23759.0 23886.6 23970.2 18593.7 18685.8 18868.7 19087.0 19172.8 3828.3 3856.4 3861.7 3868.3 3871.4 136208.0 159019.0 160426.0 160533.2 160613.0 15776.6 16064.4 16069.9 16163.9 16172.8 26378.1 26411.6 26504.1 26509.6 26539.1 9340.9 9371.4 9418.1 9429.5 9452.0 4432.1 4451.9 4464.9 4500.1 4505.1 6028.3 6059.2 6146.6 6185.5 6205.4 1121.4 1126.2 1143.4 1158.3 1159.6 741.2 756.3 763.7 778.8 784.3 13970.4 14067.5 14139.6 14570.7 14741.3 742.6 749.0 749.4 761.8 762.2 6458.7 6490.0 6554.3 6591.6 6635.7 156850.0 156893.0 159107.0 159309.0 159818.2 134088.3 134620.0 136307.3 138189.0 139358.0 113638.0 114219.4 114260.0 115064.0 116730.0 12426.6 12476.3 12482.4 12592.7 12663.4 56121.0 56457.0 57017.1 57827.4 57900.1 69456.7 70369.6 71121.6 71233.6 72052.3 17514.3 17579.0 17780.7 17830.7 17869.2 18283.3 18293.2 18399.4 18424.6 18727.8 18659.3 18784.7 18793.0 18992.5 19006.4 14987.6 15181.5 15283.8 15354.9 15412.3 18355.2 18441.2 18560.6 18580.8 18717.3 12681.6 12706.2 12739.6 12767.4 12886.9 13774.5 13917.9 13952.6 14003.5 14030.3 16:09:55 INFO - PID 23263 | -------- Summary: end -------- 16:09:55 INFO - PID 23263 | 16:09:55 INFO - TEST-INFO | 23263: exit 0 16:09:55 INFO - TEST-OK | dromaeo_css | took 1109318ms 16:09:55 INFO - TEST-START | kraken 16:09:55 INFO - Initialising browser for kraken test... 16:09:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50553/getInfo.html -profile /tmp/tmp5y5Ofa/profile 16:09:55 INFO - TEST-INFO | started process 23639 (/builds/slave/test/build/application/firefox/firefox http://localhost:50553/getInfo.html) 16:10:01 INFO - TEST-INFO | 23639: exit 0 16:10:01 INFO - Browser initialized. 16:10:01 INFO - Running cycle 1/1 for kraken test... 16:10:01 INFO - Using env: {'DISPLAY': ':0', 16:10:01 INFO - 'HOME': '/home/cltbld', 16:10:01 INFO - 'JSGC_DISABLE_POISONING': '1', 16:10:01 INFO - 'LANG': 'en_US.UTF-8', 16:10:01 INFO - 'LANGUAGE': 'en_US:en', 16:10:01 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:10:01 INFO - 'LOGNAME': 'cltbld', 16:10:01 INFO - 'MAIL': '/var/mail/cltbld', 16:10:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:10:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:10:01 INFO - 'MOZ_CRASHREPORTER': '1', 16:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:01 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:10:01 INFO - 'MOZ_NO_REMOTE': '1', 16:10:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:01 INFO - 'NO_EM_RESTART': '1', 16:10:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:01 INFO - 'PWD': '/builds/slave/test', 16:10:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:10:01 INFO - 'RUST_BACKTRACE': 'full', 16:10:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:10:01 INFO - 'SHELL': '/bin/bash', 16:10:01 INFO - 'SHLVL': '1', 16:10:01 INFO - 'TERM': 'linux', 16:10:01 INFO - 'TMOUT': '86400', 16:10:01 INFO - 'USER': 'cltbld', 16:10:01 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577', 16:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:01 INFO - '_': '/tools/buildbot/bin/python'} 16:10:01 INFO - TEST-INFO | started process 23875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5y5Ofa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:02 INFO - PID 23875 | 16:10:02 INFO - PID 23875 | (/builds/slave/test/build/application/firefox/firefox:23925): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:10:02 INFO - PID 23875 | 16:10:12 INFO - PID 23875 | RSS: Main: 148029440 16:10:12 INFO - PID 23875 | 16:10:15 INFO - PID 23875 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50553/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:15 INFO - PID 23875 | RSS: Main: 153157632 16:10:15 INFO - PID 23875 | 16:10:18 INFO - PID 23875 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50553/tests/kraken/driver.html?testName=audio-dft) 16:10:19 INFO - PID 23875 | RSS: Main: 154189824 16:10:19 INFO - PID 23875 | 16:10:22 INFO - PID 23875 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50553/tests/kraken/driver.html?testName=audio-fft) 16:10:22 INFO - PID 23875 | RSS: Main: 150777856 16:10:22 INFO - PID 23875 | 16:10:24 INFO - PID 23875 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50553/tests/kraken/driver.html?testName=audio-oscillator) 16:10:25 INFO - PID 23875 | RSS: Main: 151244800 16:10:25 INFO - PID 23875 | 16:10:27 INFO - PID 23875 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50553/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:28 INFO - PID 23875 | RSS: Main: 151113728 16:10:28 INFO - PID 23875 | 16:10:31 INFO - PID 23875 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50553/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:31 INFO - PID 23875 | RSS: Main: 151113728 16:10:31 INFO - PID 23875 | 16:10:35 INFO - PID 23875 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50553/tests/kraken/driver.html?testName=imaging-desaturate) 16:10:35 INFO - PID 23875 | RSS: Main: 152367104 16:10:35 INFO - PID 23875 | 16:10:38 INFO - PID 23875 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50553/tests/kraken/driver.html?testName=json-parse-financial) 16:10:39 INFO - PID 23875 | RSS: Main: 153722880 16:10:39 INFO - PID 23875 | 16:10:40 INFO - PID 23875 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50553/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:10:41 INFO - PID 23875 | RSS: Main: 153399296 16:10:41 INFO - PID 23875 | 16:10:43 INFO - PID 23875 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:10:43 INFO - PID 23875 | RSS: Main: 153329664 16:10:43 INFO - PID 23875 | 16:10:45 INFO - PID 23875 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:10:46 INFO - PID 23875 | RSS: Main: 150675456 16:10:46 INFO - PID 23875 | 16:10:48 INFO - PID 23875 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:10:49 INFO - PID 23875 | RSS: Main: 150700032 16:10:49 INFO - PID 23875 | 16:10:52 INFO - PID 23875 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:10:52 INFO - PID 23875 | RSS: Main: 151220224 16:10:52 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | Cycle 1(1): loaded http://localhost:50553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50553/tests/kraken/driver.html?testName=ai-astar) 16:10:54 INFO - PID 23875 | RSS: Main: 152576000 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | __start_tp_report 16:10:54 INFO - PID 23875 | _x_x_mozilla_page_load 16:10:54 INFO - PID 23875 | _x_x_mozilla_page_load_details 16:10:54 INFO - PID 23875 | |i|pagename|runs| 16:10:54 INFO - PID 23875 | |0;ai-astar;107;106;105;104;106;107;107;107;105;103 16:10:54 INFO - PID 23875 | |1;audio-beat-detection;113;111;111;114;112;140;112;147;181;114 16:10:54 INFO - PID 23875 | |2;audio-dft;167;162;161;162;161;162;160;169;164;175 16:10:54 INFO - PID 23875 | |3;audio-fft;73;73;73;72;74;73;72;73;73;74 16:10:54 INFO - PID 23875 | |4;audio-oscillator;78;80;80;87;78;79;78;78;78;89 16:10:54 INFO - PID 23875 | |5;imaging-gaussian-blur;113;113;113;113;114;113;113;114;110;114 16:10:54 INFO - PID 23875 | |6;imaging-darkroom;148;150;149;149;149;150;149;149;152;151 16:10:54 INFO - PID 23875 | |7;imaging-desaturate;95;94;100;94;94;94;95;94;95;94 16:10:54 INFO - PID 23875 | |8;json-parse-financial;44;44;45;43;45;47;43;44;45;44 16:10:54 INFO - PID 23875 | |9;json-stringify-tinderbox;39;39;38;39;39;39;39;38;39;39 16:10:54 INFO - PID 23875 | |10;stanford-crypto-aes;76;74;75;72;70;76;72;74;71;73 16:10:54 INFO - PID 23875 | |11;stanford-crypto-ccm;107;105;106;115;110;114;112;108;104;102 16:10:54 INFO - PID 23875 | |12;stanford-crypto-pbkdf2;152;151;157;155;152;149;157;150;150;149 16:10:54 INFO - PID 23875 | |13;stanford-crypto-sha256-iterative;66;60;59;59;59;59;59;59;58;58 16:10:54 INFO - PID 23875 | __end_tp_report 16:10:54 INFO - PID 23875 | __start_cc_report 16:10:54 INFO - PID 23875 | _x_x_mozilla_cycle_collect,701 16:10:54 INFO - PID 23875 | __end_cc_report 16:10:54 INFO - PID 23875 | __startTimestamp1505689854649__endTimestamp 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | ------- Summary: start ------- 16:10:54 INFO - PID 23875 | Number of tests: 14 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | [#0] ai-astar Cycles:10 Average:105.70 Median:106.50 stddev:1.42 (1.3%) stddev-sans-first:1.42 16:10:54 INFO - PID 23875 | Values: 107.0 106.0 105.0 104.0 106.0 107.0 107.0 107.0 105.0 103.0 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:114.00 stddev:23.47 (20.6%) stddev-sans-first:24.46 16:10:54 INFO - PID 23875 | Values: 113.0 111.0 111.0 114.0 112.0 140.0 112.0 147.0 181.0 114.0 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:4.72 (2.9%) stddev-sans-first:4.90 16:10:54 INFO - PID 23875 | Values: 167.0 162.0 161.0 162.0 161.0 162.0 160.0 169.0 164.0 175.0 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | [#3] audio-fft Cycles:10 Average:73.00 Median:73.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 16:10:54 INFO - PID 23875 | Values: 73.0 73.0 73.0 72.0 74.0 73.0 72.0 73.0 73.0 74.0 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | [#4] audio-oscillator Cycles:10 Average:80.50 Median:79.50 stddev:4.06 (5.1%) stddev-sans-first:4.21 16:10:54 INFO - PID 23875 | Values: 78.0 80.0 80.0 87.0 78.0 79.0 78.0 78.0 78.0 89.0 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:1.15 (1.0%) stddev-sans-first:1.22 16:10:54 INFO - PID 23875 | Values: 113.0 113.0 113.0 113.0 114.0 113.0 113.0 114.0 110.0 114.0 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:149.50 stddev:1.17 (0.8%) stddev-sans-first:1.09 16:10:54 INFO - PID 23875 | Values: 148.0 150.0 149.0 149.0 149.0 150.0 149.0 149.0 152.0 151.0 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.00 stddev:1.85 (2.0%) stddev-sans-first:1.96 16:10:54 INFO - PID 23875 | Values: 95.0 94.0 100.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | [#8] json-parse-financial Cycles:10 Average:44.40 Median:44.50 stddev:1.17 (2.6%) stddev-sans-first:1.24 16:10:54 INFO - PID 23875 | Values: 44.0 44.0 45.0 43.0 45.0 47.0 43.0 44.0 45.0 44.0 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | [#9] json-stringify-tinderbox Cycles:10 Average:38.80 Median:39.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 16:10:54 INFO - PID 23875 | Values: 39.0 39.0 38.0 39.0 39.0 39.0 39.0 38.0 39.0 39.0 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:74.00 stddev:2.06 (2.8%) stddev-sans-first:1.94 16:10:54 INFO - PID 23875 | Values: 76.0 74.0 75.0 72.0 70.0 76.0 72.0 74.0 71.0 73.0 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | [#11] stanford-crypto-ccm Cycles:10 Average:108.30 Median:109.00 stddev:4.35 (4.0%) stddev-sans-first:4.59 16:10:54 INFO - PID 23875 | Values: 107.0 105.0 106.0 115.0 110.0 114.0 112.0 108.0 104.0 102.0 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.20 Median:152.00 stddev:3.08 (2.0%) stddev-sans-first:3.27 16:10:54 INFO - PID 23875 | Values: 152.0 151.0 157.0 155.0 152.0 149.0 157.0 150.0 150.0 149.0 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:59.00 stddev:2.32 (3.9%) stddev-sans-first:0.60 16:10:54 INFO - PID 23875 | Values: 66.0 60.0 59.0 59.0 59.0 59.0 59.0 59.0 58.0 58.0 16:10:54 INFO - PID 23875 | -------- Summary: end -------- 16:10:54 INFO - PID 23875 | 16:10:54 INFO - PID 23875 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:10:55 INFO - TEST-INFO | 23875: exit 0 16:10:55 INFO - TEST-OK | kraken | took 59396ms 16:10:55 INFO - SUITE-END | took 1168s 16:10:55 INFO - Completed test suite (00:19:28) 16:10:55 INFO - javascript benchmark 16:10:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9086.77396190464, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3829.02359898226, 3888.7666739995584, 3888.863889763859, 3909.589493103222, 3915.3735402335615, 6158.076288556718, 6245.032020036891, 6247.968760156198, 6281.403266689663, 6328.77849275276, 6249.750009999594, 6255.562110652256, 6259.405356491126, 6289.716962736677, 6307.873842523147, 5633.549316054706, 5635.830925072254, 5655.7172141392975, 5659.207710920464, 5726.198332233491, 5548.944510554883, 5669.461401166883, 5686.687232202227, 5749.080147176453, 5755.68343741094, 5638.097904335327, 5643.4074422185695, 5673.517750991171, 5753.65478071315, 5795.4784069433745, 5495.560355171577, 5560.77756889724, 5595.7481913313995, 5665.575081868835, 5677.063284558043, 5575.163725441175, 5588.692621905793, 5607.383187849333, 5626.381098079208, 5636.549076073904, 6210.813675589739, 6226.315105338409, 6253.656048917308, 6255.530835187379, 6289.559730818844, 6737.562058466184, 6749.426298764611, 6831.965840170817, 6849.1780986281465, 6854.0, 6675.6662166891465, 6796.728130874759, 6799.048133261347, 6816.4546836252985, 6895.5173137880365, 6205.937940620581, 6278.434940855299, 6308.432241098323, 6342.048692696087, 6356.951103067942, 6912.896306555405, 7055.188653304833, 7074.398676112588, 7076.504644674927, 7093.113360829896, 6569.835754106186, 6711.228208756055, 6728.966355168291, 6803.387695107464, 6807.897881531781, 6662.933370666328, 6743.494237932175, 6787.592744435349, 6791.252962174157, 6813.1142951415995, 6844.863102737917, 6849.1096157499205, 6853.383195512328, 6857.9657101715175, 6860.1081859358965, 6663.800085997428, 6764.0530325754435, 6776.186857577122, 6863.142107236596, 6864.622445765531, 4847.515248475124, 4904.828331008398, 4915.287283343895, 4989.25161225819, 4992.925106123411, 4505.707129036602, 4506.81972721094, 4527.275635898306, 4566.8173273068705, 4587.816487340536, 6261.092141639528, 6341.778037768656, 6349.0, 6354.17395738551, 6354.968225158845, 6764.0, 6774.051632771416, 6775.220849602359, 6860.759873404407, 6873.656317184221, 6203.6587987660205, 6275.152854364694, 6317.241930968313, 6323.019931910561, 6327.683615819191, 5481.177823326533, 5545.556355491551, 5565.443455654402, 5569.248151499496, 5577.27495425592, 6862.828429289308, 6967.198772141269, 6976.441884649216, 7073.752418665322, 7162.964185179041, 6744.932550674431, 6755.831104222336, 6773.119494465688, 6777.1189745332795, 6780.050792888901, 7017.684204210721, 7023.47323950716, 7026.613536255555, 7045.753398631024, 7106.538075025313, 6688.331166883273, 6778.4916131289365, 6781.287964763629, 6788.796336109925, 6791.626460544519, 6797.524173307821, 6803.7618683345845, 6815.761448349284, 6888.207856096413, 6890.896636550356, 6432.517561183024, 6528.37980391862, 6533.150690410216, 6533.738650453929, 6630.502712296694, 6568.080468734285, 6591.967040164768, 6602.471802255904, 6644.501662375244, 6646.069550263063, 6529.902051469327, 6594.472442204708, 6616.8345791355605, 6617.2721000688925, 6618.8345291368105, 6602.075709400592, 6633.270340262471, 6642.136522252076, 6720.260771315054, 6729.0, 6315.715792789428, 6388.425041746079, 6428.228612566522, 6437.839054023687, 6534.052562378333], "value": 6212.730380671952, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [943.3113826906358, 975.117518645626, 979.6571200079973, 979.6767066867934, 991.6033586565377, 44309.556904430945, 45185.32222016668, 45302.7734861326, 45342.31986520205, 45354.0, 41642.37536436956, 41652.58347416525, 41772.16455670885, 41837.37243941343, 41891.58108418915, 7362.852742945138, 7484.476086673935, 7490.0, 7497.512661677001, 7498.8125296867465, 7168.641567921609, 7226.6025368604705, 7228.9277107229045, 7236.0231368765335, 7281.52670076446, 7219.205887352413, 7219.783406497813, 7222.602756848371, 7399.4450416219, 8042.5978701065005, 8133.877991830127, 8186.54973976431, 8189.344852411793, 8190.631421586043, 8190.754277371689, 8118.959405202936, 8200.05699344577, 8207.0, 8217.8356432871, 8217.972753405824, 41915.58084419147, 42193.36709949353, 42840.357394639104, 43238.35142472865, 43260.56739432597, 3712.517372741553, 3731.6828069614116, 3757.4927384802977, 3759.830807613664, 3761.097336639214, 33836.830815845766, 33888.152796180046, 33978.660213397794, 34588.30823383518, 34786.30427391463, 5477.698726570037, 5514.641548299348, 5522.088855338864, 5537.916931246034, 5548.389677135512, 210595.0, 211250.0, 212718.0, 212742.0, 212769.0, 48465.515344846805, 49531.0, 54517.1822422664, 55259.44740552623, 56114.719426403426, 58596.41403585995, 58963.41036589665, 59056.40943590595, 59076.0, 59134.40865591289, 15333.386664533295, 15362.462313819186, 15395.538133856002, 15452.768208476882, 15458.84541154574, 12128.090393220544, 12181.147319687714, 12220.938895305466, 12373.690657733629, 12380.876191238152, 15359.61600959985, 15551.611209719622, 15568.221588920509, 15627.0, 15660.275224346045, 6209.844753881099, 6290.685465726695, 6326.49388048955, 6332.651704156316, 6354.459870910932, 1101.5648818716722, 1110.6779034080025, 1112.8163852964333, 1121.657894342217, 1122.685648018556, 25861.870690646425, 25877.870610646827, 25919.22242332733, 26053.0, 26182.6072608911, 1173.5129921082655, 1186.2467333243453, 1189.0012389592785, 1205.7287110400089, 1231.07054174098, 13614.795778063337, 13667.179969201681, 13849.723005539832, 13877.295181052521, 13877.791833122512, 285918.0, 286914.0, 287007.0, 287097.0, 287530.0, 60315.0, 60455.69772151111, 60472.39527604756, 60496.0, 60700.39299606947, 1482.792409062732, 1525.3593490733697, 1527.9465218717291, 1532.0654400815495, 1535.3398038843404, 25049.87475062613, 25163.370915726522, 25245.359051661584, 25611.487770244865, 25660.615090774027, 43121.568784311756, 43174.352384713624, 43202.567974321115, 43220.56779432166, 43322.566774333114, 239148.0, 240885.0, 261396.0, 269372.0, 269651.0, 36794.448083278236, 36869.26261474809, 37564.436533452565, 39557.2088558233, 41750.79124604358, 51921.0, 52169.21746173887, 52215.47784522106, 52496.0, 52838.47161528336, 38253.04367390726, 38285.0, 38448.23103537969, 38779.61220387873, 39041.41437878491, 38014.239715206095, 38065.809670951465, 38158.23683526369, 38197.61802381941, 38719.612803872726, 38920.0, 39559.0, 39728.40407393949, 39748.403773943995, 39986.20027599374, 36205.81897090498, 36954.0, 37797.62202377941, 37896.0, 37926.0, 26506.867465662548, 26653.600195997464, 26902.32744181411, 27571.035013775225, 27651.620878025344], "value": 18816.416085042507, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.2122713110169, 595.5741644724025, 596.9761209551618, 612.5497759147026, 618.9412005859444, 23233.30300090998, 24072.518549628996, 24107.758922410772, 24138.637920431185, 24198.03207871683, 24582.50834983299, 26554.203373898767, 26625.0, 26712.065077722284, 26730.331741706468, 6422.357764223575, 6478.481721462295, 6489.61062336259, 6547.410733034026, 6552.868942621145, 6336.968315158418, 6410.423061924426, 6521.510886683494, 6613.305602911673, 6640.56836305641, 6594.505412094089, 6603.240627327847, 6603.669816509179, 6603.93396066038, 6607.966960165192, 6583.14419125513, 6596.373344532286, 6597.80206593803, 6603.075569420285, 6604.834879128012, 5946.672932988684, 6118.357572454917, 6147.815565533041, 6150.292716337589, 6156.599821011665, 30035.849820750977, 30525.0, 30575.38849223003, 30578.84710576455, 30650.38699226003, 2203.746569144537, 2237.127520267097, 2240.0703707961175, 2242.0, 2242.932712018642, 19807.7028844566, 20329.796702033087, 20413.69379459309, 20561.4859628509, 20721.27475538364, 2488.9377765555823, 2531.797456203499, 2575.1759436980174, 2579.5356835769553, 2589.976959101163, 141767.0, 146581.0, 147528.26235868753, 156073.0, 163466.3653363463, 15094.075959475103, 15609.843901561066, 15750.527484175263, 15991.28039238237, 16134.435294764628, 25559.48881022369, 25645.61531577028, 25652.230433087036, 25670.229893102864, 25777.74222257791, 9674.661386851567, 9720.95139524312, 9724.0, 9818.75453113678, 9889.802203956024, 8632.438891472035, 8687.739367818975, 8710.172533609424, 8720.956395217983, 8725.65097396097, 9731.951340243395, 9842.50787460624, 9933.701988940344, 9944.552495137592, 9997.400155990665, 2734.904278350248, 2750.7936904732223, 2773.084881988939, 2778.360976975307, 2796.804223704362, 1029.6910926722103, 1051.4374809476892, 1064.6007747094839, 1064.6433444795925, 1065.776187000723, 20995.8950205248, 21087.0, 21191.78808211929, 21263.468413289484, 21779.782202177776, 1106.441247170174, 1106.9889301107046, 1110.650145204258, 1114.4817659788237, 1116.4083035990939, 11583.247088939192, 11680.240784348991, 11862.822057669142, 11912.583059592873, 11961.342126183143, 642907.0, 654518.0, 665975.0, 689498.0, 692120.0, 127103.36448317699, 127359.0, 129159.0, 130760.3461982703, 131429.3428532851, 1044.1803184500284, 1069.3370110531364, 1125.9324440533594, 1127.5038982847684, 1187.827764974074, 21629.891850540647, 21716.67424988595, 22476.77523224812, 22485.0, 22504.774952250267, 59080.704596476746, 61525.0, 64424.677876610316, 64622.353776461634, 66336.6683166581, 79144.20855791369, 79184.0, 79216.20783792318, 80093.59953200197, 80504.59747701224, 20654.89672551688, 21347.35957921203, 21487.14051437925, 21538.353849384544, 21738.456538586663, 24381.0, 24511.264662060166, 24552.140675076287, 24717.25848224556, 24735.752642473344, 18577.53556161107, 20042.599148016667, 20281.391558253275, 20302.79697203009, 20313.695294570887, 17272.0, 17417.39039133624, 17573.121343932497, 17954.371596994566, 18022.459326220236, 18505.167267472727, 18885.43343699691, 18920.810791892454, 19668.50828729293, 20919.686204707246, 20927.26754563583, 20960.68558971586, 21077.578448431253, 21088.789112109298, 21146.89426552919, 19063.0, 19432.222711091963, 19443.8055619442, 19941.501462462973, 19987.900060499604], "value": 12911.734703618904, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.546065259117, 1492.9104253744777, 1555.9066456012633, 1557.540525544964, 1557.5794535475416, 17602.0, 18158.092095395226, 18192.090395480238, 18197.090145492723, 18211.089445527738, 17787.288508459646, 17910.5522361941, 17912.55218619532, 17971.910140449312, 17986.0, 2566.525192839331, 2661.800364972625, 2669.9466010679776, 2670.145553422896, 2675.0, 2625.4224070704413, 2752.779777617796, 2795.4409118176345, 2814.873330700113, 2817.09852847089, 2662.2279538933685, 2670.1322070327224, 2694.0705456617534, 2695.0028489458928, 2695.595660650908, 2699.0688212566633, 2730.385663225778, 2758.3655759175404, 2761.4615150045747, 2767.4465106978687, 2660.9467810643873, 2686.355274734069, 2700.189943017087, 2711.688155862081, 2719.687235967869, 16026.839731602651, 16284.674306513922, 16301.0, 16305.755413668805, 16312.102834344107, 8210.589470526449, 8475.95762021192, 8479.491230526188, 8483.44857584255, 8483.703070392568, 5143.537081662668, 5593.496585307301, 5603.719814009283, 5733.713314334266, 5757.769689212427, 1803.7384579235938, 1812.2207450796152, 1871.6818140916077, 1892.4890279624424, 1901.5341241395809, 29884.701152988408, 30209.848950755324, 30380.0, 30445.543316850264, 30508.237294067603, 6627.768028118992, 6768.796936091925, 6959.095317608679, 6972.0, 7013.333733295329, 18596.628067438847, 18715.90642046781, 18824.24703011864, 18830.71753923692, 18869.71695424542, 8081.111077781439, 8208.630611622491, 8249.752507424786, 8251.133630968781, 8281.29608983243, 7590.354819840375, 7605.581693006938, 7707.653155607899, 7709.4603377763015, 7760.883586746203, 5495.752691128909, 5544.085225937756, 5572.944270557324, 5629.802956896571, 5862.149988251765, 1469.8015767871414, 1500.8574185452364, 1549.690061987607, 1568.8431156884221, 1578.2818817438038, 914.7164379042518, 928.7167413938679, 930.1163894300306, 936.2743873498093, 943.8537026760863, 9021.954890225506, 9062.637494500146, 9170.403923744936, 9312.0, 9338.533073346305, 1038.5741845843168, 1041.0786453988123, 1044.6552637629563, 1049.7113293844254, 1051.4690081508788, 4772.3557319761385, 4786.880327991828, 5021.799128034838, 5315.468453154654, 5441.428649991773, 24540.0, 25506.362340941254, 25673.358166045997, 25702.228933132035, 25748.227553173434, 23689.881550592138, 24716.0, 25141.0, 25899.223023309332, 25978.090766823072, 12037.699057523458, 12697.809532857014, 12811.487540498276, 12847.678808029874, 12852.228866268053, 9399.154076133182, 9466.242700584075, 9505.572249248939, 9543.18882894934, 9697.078777516124, 21055.157793688082, 21179.470513236676, 21411.143554257655, 21414.892925535274, 22096.779032209473, 21622.13511459587, 21829.345119646438, 21875.0, 21916.561668766855, 22418.32745017652, 13196.80204796948, 13499.662508437368, 13602.0, 13612.591622251348, 13624.65938351549, 15657.530274091796, 15678.0, 15689.215539223222, 15851.920740396225, 15884.841151588336, 12287.69280767988, 12563.309018004098, 12900.096993210385, 13011.739765204833, 13266.403011864682, 12494.187877788278, 12626.053046021401, 12953.676158095746, 12981.156224845356, 13088.345582720636, 10599.470026498799, 10602.946985265024, 10751.193660475652, 10770.299930504492, 10839.349639021368, 8083.555404452812, 8095.23095305945, 8112.83774324522, 8142.8778568322705, 8243.505389676639, 7774.3003129716335, 7799.415043871619, 7808.41436892224, 7884.329831964347, 7896.921030789618], "value": 7227.041926451037, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.9658772179808, 553.4410245651892, 563.3155715805296, 569.8917205730913, 579.2007030298188, 6199.4730447911925, 6283.052253801325, 6305.369463053698, 6307.590006649564, 6323.209598800144, 6189.907151392721, 6240.625562466255, 6250.781222657208, 6272.874542509147, 6298.149749783778, 4963.528464795839, 5068.5438310552045, 5074.3657042869645, 5101.183810590306, 5109.540141387274, 5077.746112694351, 5140.228965655163, 5140.845774626767, 5148.536631703146, 5167.0, 4804.0, 4994.350734404522, 5040.445550989388, 5051.696898186102, 5063.316452278932, 4905.828296009622, 4913.213885778294, 4972.651914365996, 4985.551300382983, 5017.89964200714, 4479.3281007848755, 4486.573775491356, 4499.505054444008, 4501.244514639293, 4519.819207231707, 6094.847628809271, 6123.387661233885, 6161.291451483092, 6181.907271390933, 6237.0, 5888.411158884121, 5924.644521328691, 5933.317668468138, 5937.495312898409, 5964.403559644044, 6654.600723956578, 6660.633665148415, 6722.529422940396, 6738.865222695518, 6795.558288711218, 5031.371078615173, 5053.949460505385, 5054.444011158769, 5083.593312534988, 5103.515166059218, 6786.796396108125, 6949.131358580127, 7014.597080583852, 7034.331738484836, 7071.8939215911805, 5195.402528709247, 5197.220416937414, 5207.3230480037355, 5209.140491818807, 5212.921806172911, 5253.264542963988, 5270.683758974474, 5298.311219541435, 5309.522143007148, 5317.122674758699, 5853.180554722342, 5855.151003104526, 5872.647641141545, 5888.234529511222, 5895.115732640053, 6698.363655452724, 6699.363560461748, 6739.090222819955, 6739.831504212336, 6767.492438067066, 1796.2006906926554, 1800.2708902894349, 1802.8016918138994, 1808.6744386010382, 1810.4478134169206, 1242.7017515796144, 1297.4096785962365, 1298.363801737142, 1303.6284658872175, 1307.8365204349457, 6252.624842509464, 6270.404311590391, 6281.0, 6303.117563541108, 6345.07996340528, 6607.537472376887, 6697.631630260383, 6795.18457785059, 6811.216710078305, 6826.795196144124, 6215.160953271251, 6235.282942461675, 6269.185005949197, 6281.685915704196, 6323.336049714806, 3575.6948713719307, 3590.0, 3599.640035996432, 3602.1534939289245, 3607.1342877709685, 7047.0, 7136.3220494052985, 7145.92854071463, 7181.6409179540815, 7221.891671624825, 7000.649967501605, 7041.366277035091, 7048.964755176191, 7068.293170682993, 7090.751823686146, 6996.300369963064, 7001.684924178424, 7008.719651214098, 7041.3310735480045, 7048.541844780073, 6719.395254427125, 6742.662866856539, 6766.4248538874745, 6773.390394864486, 6774.220964589135, 6717.596944183365, 6719.932800671931, 6728.966355168192, 6780.389764920984, 6801.795946121624, 6940.305969403019, 6947.0, 6958.269381715049, 7099.929000709927, 7104.147502299757, 5168.431472538093, 5194.97402512985, 5208.5312321891215, 5212.582993360598, 5214.348206474191, 6451.516136289891, 6740.865182696417, 6777.525573209828, 6791.72833086671, 6821.89767153503, 6227.875442491216, 6479.902801457888, 6536.803895883131, 6541.0, 6700.83247918806, 6463.321351258238, 6522.684447021239, 6598.274189839018, 6607.531046200783, 6661.866762664817, 6568.80293591193, 6573.112629794917, 6631.701573429304, 6637.402633762791, 6671.966640166962, 6714.764983225564, 6746.4265537429865, 6749.763758268437, 6776.7628133015105, 6792.286809885089, 6457.192850893638, 6514.804555863332, 6516.57642253252, 6563.540552161303, 6569.0], "value": 5213.288937221737, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [957.9281553883457, 993.9105480506753, 995.8854731705853, 1007.5768177365503, 1018.322815327807, 20121.597568048648, 20315.187392504282, 20543.589128217445, 20611.175552977882, 20681.586368272627, 19186.23255069799, 19389.418317450465, 19445.902770486162, 19487.512812179702, 19523.804761952375, 1035.9585616575328, 1054.752133248686, 1056.915446764257, 1060.9257351985364, 1061.1828891753346, 1099.3349023840542, 1101.1466113761858, 1101.641966360932, 1102.2614848051824, 1103.9282446640982, 1097.00720847633, 1139.3107170162057, 1143.5254369436673, 1143.8684551276626, 1144.5822274869654, 1125.8480105185777, 1134.6652737442473, 1138.0781566930812, 1138.5445821671315, 1138.9658310250707, 811.4360519438992, 817.7342363731811, 817.9141190175066, 827.2637352756052, 835.1356346181733, 20262.49343766403, 20263.088161032643, 20282.188712451483, 20305.898470507553, 20485.5902881943, 22902.65646015311, 23250.186243481396, 23759.049638014458, 23886.64170037451, 23970.161044363365, 18593.7210941836, 18685.813141868544, 18868.716969245474, 19087.0, 19172.80827191724, 3828.349180639298, 3856.421536769507, 3861.7296789224765, 3868.2650296443585, 3871.4386413970096, 136208.0, 159019.0, 160426.0, 160533.19733401376, 160613.0, 15776.60558486047, 16064.437744679113, 16069.919650401673, 16163.919180404258, 16172.83827161737, 26378.076767313436, 26411.603825942628, 26504.072357467398, 26509.602355964675, 26539.071132510657, 9340.906590934139, 9371.390859594105, 9418.105279998526, 9429.528523573794, 9452.0, 4432.135733531994, 4451.866444006685, 4464.866054018385, 4500.122476117126, 4505.098980203972, 6028.336882942873, 6059.151718759377, 6146.569740118238, 6185.505159587222, 6205.410486003822, 1121.4448847820217, 1126.1947707389256, 1143.4340001699045, 1158.3165932099932, 1159.5825502818977, 741.1921006103373, 756.3155344413315, 763.6830715253108, 778.8325510015261, 784.2510402565537, 13970.441182352795, 14067.507637232648, 14139.575812725634, 14570.708585828224, 14741.262936853114, 742.6027075514573, 748.9625518724042, 749.3518106837546, 761.7562380038335, 762.1502025241927, 6458.709358078898, 6490.0, 6554.335139017751, 6591.637459939653, 6635.701393437307, 156850.0, 156893.0, 159107.0, 159309.0, 159818.2009089947, 134088.32955835157, 134620.0, 136307.31846340705, 138189.0, 139358.0, 113638.0, 114219.42890285661, 114260.0, 115064.0, 116730.0, 12426.62720118398, 12476.251424914533, 12482.375881205722, 12592.685182870502, 12663.430145643284, 56121.0, 56457.0, 57017.14474282806, 57827.4217257822, 57900.13149802672, 69456.65271673811, 70369.64815175891, 71121.64439177977, 71233.64383178052, 72052.27947720456, 17514.299428022736, 17579.0, 17780.733289000418, 17830.732539012184, 17869.195886185415, 18283.26866925308, 18293.17680704345, 18399.448016559523, 18424.631507370046, 18727.812721873153, 18659.253629854655, 18784.7182292263, 18793.0, 18992.52518687044, 19006.429807105807, 14987.550373488813, 15181.468648597245, 15283.77074343908, 15354.923225383802, 15412.306446209723, 18355.174017169527, 18441.17014734367, 18560.628787424444, 18580.81419185791, 18717.25130994745, 12681.55614553523, 12706.237625742486, 12739.55411560628, 12767.425465853874, 12886.935565322114, 13774.517891873737, 13917.930410347883, 13952.58142255734, 14003.50987715425, 14030.298485075502], "value": 9898.168601290366, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1383.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 106.0, 105.0, 104.0, 106.0, 107.0, 107.0, 107.0, 105.0, 103.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 111.0, 114.0, 112.0, 140.0, 112.0, 147.0, 181.0, 114.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 161.0, 162.0, 161.0, 162.0, 160.0, 169.0, 164.0, 175.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 72.0, 74.0, 73.0, 72.0, 73.0, 73.0, 74.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 80.0, 87.0, 78.0, 79.0, 78.0, 78.0, 78.0, 89.0], "value": 80.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 110.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 149.0, 149.0, 149.0, 150.0, 149.0, 149.0, 152.0, 151.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 100.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 45.0, 43.0, 45.0, 47.0, 43.0, 44.0, 45.0, 44.0], "value": 44.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 38.0, 39.0, 39.0, 39.0, 39.0, 38.0, 39.0, 39.0], "value": 38.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 72.0, 70.0, 76.0, 72.0, 74.0, 71.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 106.0, 115.0, 110.0, 114.0, 112.0, 108.0, 104.0, 102.0], "value": 108.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 157.0, 155.0, 152.0, 149.0, 157.0, 150.0, 150.0, 149.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 58.0], "value": 59.6, "unit": "score"}]}]} 16:10:55 INFO - Return code: 0 16:10:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:10:55 INFO - # TBPL SUCCESS # 16:10:55 INFO - Running post-action listener: _package_coverage_data 16:10:55 INFO - Running post-action listener: _resource_record_post_action 16:10:55 INFO - [mozharness: 2017-09-17 23:10:55.433476Z] Finished run-tests step (success) 16:10:55 INFO - Running post-run listener: _resource_record_post_run 16:10:55 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 342528000; Read time: 0; Write time: 234980 16:10:55 INFO - TinderboxPrint: CPU usage
13.1% 16:10:55 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:10:55 INFO - TinderboxPrint: I/O write bytes / time
342,528,000 / 234,980 16:10:55 INFO - TinderboxPrint: CPU idle
8,226.6 (86.9%) 16:10:55 INFO - TinderboxPrint: CPU user
1,187.9 (12.6%) 16:10:55 INFO - TinderboxPrint: Swap in / out
0 / 0 16:10:55 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13463552; Read time: 0; Write time: 2504 16:10:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:10:55 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 328609792; Read time: 0; Write time: 232476 16:10:56 INFO - Running post-run listener: _upload_blobber_files 16:10:56 INFO - Blob upload gear active. 16:10:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:10:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:10:56 INFO - (blobuploader) - INFO - Open directory for files ... 16:10:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:10:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:10:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:10:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:10:57 INFO - (blobuploader) - INFO - Done attempting. 16:10:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:10:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:10:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:11:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:04 INFO - (blobuploader) - INFO - Done attempting. 16:11:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:11:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:11:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:05 INFO - (blobuploader) - INFO - Done attempting. 16:11:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:11:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:11:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:06 INFO - (blobuploader) - INFO - Done attempting. 16:11:06 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:06 INFO - Return code: 0 16:11:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4532e6a222a5980615cf8252add9d26e25890d4a05942a69cf8a5fe49302b6b4383c3ea17622024cb84eba462c0c50f233e709139cfb3a448c2e205083d4b22", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d254c0f01eb17faf598de00d9fe6daf18255987c28120fddcef76b7187509addb635bce82127907c5effdc047244cccc095d6e408a8a1624a1791f1bbffd025b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72b697a07c47ef3bfbf2f6ac2324e1c7aedeffa43946784ec5441c7572bcb9ac536a209a7697b732db89a66d3a19adf802a182efdb1e52bea46c241f732ad168", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f36f3fd888d7a4226a6976de760cc172086fdb443df5520419a40886128660259e2617f72122cbf51981b4aa62e9d98c12b875d0a9fa8644d70bb0a6ed05c93"} 16:11:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:06 INFO - Contents: 16:11:06 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4532e6a222a5980615cf8252add9d26e25890d4a05942a69cf8a5fe49302b6b4383c3ea17622024cb84eba462c0c50f233e709139cfb3a448c2e205083d4b22", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d254c0f01eb17faf598de00d9fe6daf18255987c28120fddcef76b7187509addb635bce82127907c5effdc047244cccc095d6e408a8a1624a1791f1bbffd025b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72b697a07c47ef3bfbf2f6ac2324e1c7aedeffa43946784ec5441c7572bcb9ac536a209a7697b732db89a66d3a19adf802a182efdb1e52bea46c241f732ad168", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f36f3fd888d7a4226a6976de760cc172086fdb443df5520419a40886128660259e2617f72122cbf51981b4aa62e9d98c12b875d0a9fa8644d70bb0a6ed05c93"} 16:11:06 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:06 INFO - Copying logs to upload dir... 16:11:06 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.871834 ========= master_lag: 1.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-17 16:11:07.610719) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 16:11:07.619648) ========= 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=9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4532e6a222a5980615cf8252add9d26e25890d4a05942a69cf8a5fe49302b6b4383c3ea17622024cb84eba462c0c50f233e709139cfb3a448c2e205083d4b22", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d254c0f01eb17faf598de00d9fe6daf18255987c28120fddcef76b7187509addb635bce82127907c5effdc047244cccc095d6e408a8a1624a1791f1bbffd025b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72b697a07c47ef3bfbf2f6ac2324e1c7aedeffa43946784ec5441c7572bcb9ac536a209a7697b732db89a66d3a19adf802a182efdb1e52bea46c241f732ad168", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f36f3fd888d7a4226a6976de760cc172086fdb443df5520419a40886128660259e2617f72122cbf51981b4aa62e9d98c12b875d0a9fa8644d70bb0a6ed05c93"} build_url:https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/YIKFqidGRWqiZ2H-El64-g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4532e6a222a5980615cf8252add9d26e25890d4a05942a69cf8a5fe49302b6b4383c3ea17622024cb84eba462c0c50f233e709139cfb3a448c2e205083d4b22", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d254c0f01eb17faf598de00d9fe6daf18255987c28120fddcef76b7187509addb635bce82127907c5effdc047244cccc095d6e408a8a1624a1791f1bbffd025b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72b697a07c47ef3bfbf2f6ac2324e1c7aedeffa43946784ec5441c7572bcb9ac536a209a7697b732db89a66d3a19adf802a182efdb1e52bea46c241f732ad168", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f36f3fd888d7a4226a6976de760cc172086fdb443df5520419a40886128660259e2617f72122cbf51981b4aa62e9d98c12b875d0a9fa8644d70bb0a6ed05c93"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 16:11:07.660189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 16:11:07.664686) ========= 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=9bfb7e13875ed353a705960e000001c0-1505688308.336728-442598577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 16:11:07.714298) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 16:11:07.714607) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 16:11:07.714917) ========= ========= Total master_lag: 1.26 =========