builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1506005179.58 results: success (0) revision: f7e9777221a34f9f23c2e4933307eb38b621b679 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.584251) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.584630) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.584965) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.654542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.654839) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 07:46:20-- 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% 224M=0s 2017-09-21 07:46:20 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099802 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.770337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.770620) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019444 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.841358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.841655) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f7e9777221a34f9f23c2e4933307eb38b621b679 --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 f7e9777221a34f9f23c2e4933307eb38b621b679 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 07:46:20,571 truncating revision to first 12 chars 2017-09-21 07:46:20,571 Setting DEBUG logging. 2017-09-21 07:46:20,571 attempt 1/10 2017-09-21 07:46:20,571 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f7e9777221a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 07:46:20,985 unpacking tar archive at: mozilla-central-f7e9777221a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.728459 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:20.591799) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:20.592065) ========= script_repo_revision: f7e9777221a34f9f23c2e4933307eb38b621b679 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:20.592411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:20.592681) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:20.635913) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-21 07:46:20.636162) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:46:21 INFO - MultiFileLogger online at 20170921 07:46:21 in /builds/slave/test 07:46:21 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 07:46:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:46:21 INFO - {'append_to_log': False, 07:46:21 INFO - 'base_work_dir': '/builds/slave/test', 07:46:21 INFO - 'blob_upload_branch': 'Firefox', 07:46:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:46:21 INFO - 'branch': 'Firefox', 07:46:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:46:21 INFO - 'code_coverage': False, 07:46:21 INFO - 'config_files': ('talos/linux_config.py',), 07:46:21 INFO - 'default_actions': ('clobber', 07:46:21 INFO - 'read-buildbot-config', 07:46:21 INFO - 'download-and-extract', 07:46:21 INFO - 'populate-webroot', 07:46:21 INFO - 'create-virtualenv', 07:46:21 INFO - 'install', 07:46:21 INFO - 'setup-mitmproxy', 07:46:21 INFO - 'run-tests'), 07:46:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:46:21 INFO - 'disable_ccov_upload': False, 07:46:21 INFO - 'disable_stylo': False, 07:46:21 INFO - 'download_minidump_stackwalk': True, 07:46:21 INFO - 'download_symbols': 'ondemand', 07:46:21 INFO - 'enable_stylo': False, 07:46:21 INFO - 'enable_webrender': False, 07:46:21 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:46:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:46:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:46:21 INFO - 'gecko_profile': False, 07:46:21 INFO - 'gecko_profile_interval': 0, 07:46:21 INFO - 'installer_path': 'installer.exe', 07:46:21 INFO - 'log_level': 'info', 07:46:21 INFO - 'log_name': 'talos', 07:46:21 INFO - 'log_to_console': True, 07:46:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:46:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:46:21 INFO - 'opt_config_files': (), 07:46:21 INFO - 'pip_index': False, 07:46:21 INFO - 'suite': 'dromaeojs-e10s', 07:46:21 INFO - 'system_bits': '32', 07:46:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:46:21 INFO - 'title': 'talos-linux64-ix-038', 07:46:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:46:21 INFO - 'use_talos_json': True, 07:46:21 INFO - 'verify': 'False', 07:46:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:46:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:46:21 INFO - 'work_dir': 'build'} 07:46:21 INFO - [mozharness: 2017-09-21 14:46:21.514424Z] Running clobber step. 07:46:21 INFO - Running pre-action listener: _resource_record_pre_action 07:46:21 INFO - Running main action method: clobber 07:46:21 INFO - rmtree: /builds/slave/test/build 07:46:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:46:22 INFO - Running post-action listener: _resource_record_post_action 07:46:22 INFO - [mozharness: 2017-09-21 14:46:22.523889Z] Finished clobber step (success) 07:46:22 INFO - [mozharness: 2017-09-21 14:46:22.523987Z] Running read-buildbot-config step. 07:46:22 INFO - Running pre-action listener: _resource_record_pre_action 07:46:22 INFO - Running main action method: read_buildbot_config 07:46:22 INFO - Using buildbot properties: 07:46:22 INFO - { 07:46:22 INFO - "project": "", 07:46:22 INFO - "product": "firefox", 07:46:22 INFO - "who": "archaeopteryx@coole-files.de", 07:46:22 INFO - "installer_path": "public/build/target.tar.bz2", 07:46:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:46:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:46:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:46:22 INFO - "stage_platform": "linux64-pgo", 07:46:22 INFO - "basedir": "/builds/slave/test", 07:46:22 INFO - "buildnumber": 191, 07:46:22 INFO - "platform": "ubuntu64_hw", 07:46:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:46:22 INFO - "slavebuilddir": "test", 07:46:22 INFO - "taskId": "EUOrcHppRzGrijdy5iE1Wg", 07:46:22 INFO - "branch": "mozilla-central", 07:46:22 INFO - "script_repo_revision": "production", 07:46:22 INFO - "revision": "f7e9777221a34f9f23c2e4933307eb38b621b679", 07:46:22 INFO - "slavename": "talos-linux64-ix-038", 07:46:22 INFO - "repo_path": "mozilla-central" 07:46:22 INFO - } 07:46:22 INFO - Finding installer, test and symbols from parent task. 07:46:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EUOrcHppRzGrijdy5iE1Wg'}, attempt #1 07:46:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EUOrcHppRzGrijdy5iE1Wg'}, attempt #1 07:46:23 INFO - Task dependencies: UMmLAK4MS9-u7NhJjbWm7w 07:46:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w'}, attempt #1 07:46:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2 07:46:23 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.test_packages.json 07:46:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.crashreporter-symbols.zip 07:46:23 INFO - Running post-action listener: _resource_record_post_action 07:46:23 INFO - [mozharness: 2017-09-21 14:46:23.890275Z] Finished read-buildbot-config step (success) 07:46:23 INFO - [mozharness: 2017-09-21 14:46:23.890490Z] Running download-and-extract step. 07:46:23 INFO - Running pre-action listener: _resource_record_pre_action 07:46:23 INFO - Running main action method: download_and_extract 07:46:23 INFO - mkdir: /builds/slave/test/build/tests 07:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:23 INFO - trying https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.test_packages.json 07:46:23 INFO - Downloading https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:46:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:46:24 INFO - Downloaded 989 bytes. 07:46:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:46:24 INFO - Using the following test package requirements: 07:46:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:46:24 INFO - u'common': [u'target.common.tests.zip'], 07:46:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:46:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:46:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:46:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:46:24 INFO - u'mozbase': [u'target.common.tests.zip'], 07:46:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:46:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:46:24 INFO - u'web-platform': [u'target.common.tests.zip', 07:46:24 INFO - u'target.web-platform.tests.tar.gz'], 07:46:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:46:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:46:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.common.tests.zip 07:46:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:46:24 INFO - Fetch https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.common.tests.zip into memory 07:46:26 INFO - Content-Length response header: 55332910 07:46:26 INFO - Bytes received: 55332910 07:46:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.talos.tests.zip 07:46:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:46:37 INFO - Fetch https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.talos.tests.zip into memory 07:46:38 INFO - Content-Length response header: 14509184 07:46:38 INFO - Bytes received: 14509184 07:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:38 INFO - trying https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2 07:46:38 INFO - Downloading https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:46:41 INFO - Downloaded 62318367 bytes. 07:46:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2 07:46:41 INFO - mkdir: /builds/slave/test/properties 07:46:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:46:41 INFO - Writing to file /builds/slave/test/properties/build_url 07:46:41 INFO - Contents: 07:46:41 INFO - build_url:https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2 07:46:41 INFO - Running post-action listener: _resource_record_post_action 07:46:41 INFO - Running post-action listener: find_tests_for_verification 07:46:41 INFO - Running post-action listener: set_extra_try_arguments 07:46:41 INFO - [mozharness: 2017-09-21 14:46:41.618803Z] Finished download-and-extract step (success) 07:46:41 INFO - [mozharness: 2017-09-21 14:46:41.618900Z] Running populate-webroot step. 07:46:41 INFO - Running pre-action listener: _resource_record_pre_action 07:46:41 INFO - Running main action method: populate_webroot 07:46:41 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:46:41 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:41 INFO - 'tests': ['tresize', 07:46:41 INFO - 'tcanvasmark']}, 07:46:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:46:41 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:41 INFO - 'tests': ['dromaeo_css', 07:46:41 INFO - 'kraken']}, 07:46:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:46:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:41 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:46:41 INFO - 'talos_options': ['--disable-stylo'], 07:46:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:46:41 INFO - 'tests': ['damp', 'tps']}, 07:46:41 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:46:41 INFO - 'talos_options': ['--disable-stylo'], 07:46:41 INFO - 'tests': ['damp', 'tps']}, 07:46:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:41 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:41 INFO - 'tests': ['dromaeo_dom']}, 07:46:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:46:41 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:41 INFO - 'tests': ['basic_compositor_video', 07:46:41 INFO - 'glvideo']}, 07:46:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:46:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:46:41 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:46:41 INFO - 'talos_options': ['--disable-stylo'], 07:46:41 INFO - 'tests': ['ts_paint_webext', 07:46:41 INFO - 'tp5o_webext']}, 07:46:41 INFO - 'other-e10s': {'tests': ['a11yr', 07:46:41 INFO - 'ts_paint', 07:46:41 INFO - 'tpaint', 07:46:41 INFO - 'sessionrestore', 07:46:41 INFO - 'sessionrestore_many_windows', 07:46:41 INFO - 'sessionrestore_no_auto_restore', 07:46:41 INFO - 'tabpaint']}, 07:46:41 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:41 INFO - 'tests': ['a11yr', 07:46:41 INFO - 'ts_paint', 07:46:41 INFO - 'tpaint', 07:46:41 INFO - 'sessionrestore', 07:46:41 INFO - 'sessionrestore_many_windows', 07:46:41 INFO - 'sessionrestore_no_auto_restore', 07:46:41 INFO - 'tabpaint']}, 07:46:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:46:41 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:46:41 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:41 INFO - 'tests': ['perf_reftest_singletons']}, 07:46:41 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:41 INFO - 'tests': ['bloom_basic']}, 07:46:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:46:41 INFO - 'tsvgr_opacity', 07:46:41 INFO - 'tart', 07:46:41 INFO - 'tscrollx', 07:46:41 INFO - 'tsvg_static']}, 07:46:41 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:41 INFO - 'tests': ['tsvgx', 07:46:41 INFO - 'tsvgr_opacity', 07:46:41 INFO - 'tart', 07:46:41 INFO - 'tscrollx', 07:46:41 INFO - 'tsvg_static']}, 07:46:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:46:41 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:46:41 INFO - 'talos_options': ['--disable-stylo'], 07:46:41 INFO - 'tests': ['tp5o']}, 07:46:41 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:46:41 INFO - 'talos_options': ['--mitmproxy', 07:46:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:46:41 INFO - '--firstNonBlankPaint'], 07:46:41 INFO - 'tests': ['tp6_google', 07:46:41 INFO - 'tp6_youtube', 07:46:41 INFO - 'tp6_amazon', 07:46:41 INFO - 'tp6_facebook']}, 07:46:41 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:46:41 INFO - 'talos_options': ['--disable-stylo', 07:46:41 INFO - '--mitmproxy', 07:46:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:46:41 INFO - '--firstNonBlankPaint'], 07:46:41 INFO - 'tests': ['tp6_google', 07:46:41 INFO - 'tp6_youtube', 07:46:41 INFO - 'tp6_amazon', 07:46:41 INFO - 'tp6_facebook']}, 07:46:41 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:46:41 INFO - 'talos_options': ['--stylo-threads=1', 07:46:41 INFO - '--mitmproxy', 07:46:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:46:41 INFO - '--firstNonBlankPaint'], 07:46:41 INFO - 'tests': ['tp6_google', 07:46:41 INFO - 'tp6_youtube', 07:46:41 INFO - 'tp6_amazon', 07:46:41 INFO - 'tp6_facebook']}, 07:46:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:46:41 INFO - 'talos_options': ['--xperf_path', 07:46:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:41 INFO - 'tests': ['tp5n']}, 07:46:41 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:46:41 INFO - 'talos_options': ['--disable-stylo', 07:46:41 INFO - '--xperf_path', 07:46:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:41 INFO - 'tests': ['tp5n']}}} 07:46:41 INFO - Running post-action listener: _resource_record_post_action 07:46:41 INFO - [mozharness: 2017-09-21 14:46:41.637779Z] Finished populate-webroot step (success) 07:46:41 INFO - [mozharness: 2017-09-21 14:46:41.637884Z] Running create-virtualenv step. 07:46:41 INFO - Running pre-action listener: _resource_record_pre_action 07:46:41 INFO - Running main action method: create_virtualenv 07:46:41 INFO - Creating virtualenv /builds/slave/test/build/venv 07:46:41 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:46:41 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:46:41 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:46:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:46:42 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:42 INFO - Installing pip...............done. 07:46:42 INFO - Return code: 0 07:46:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:46:42 INFO - Reading from file tmpfile_stdout 07:46:42 INFO - Output received: 07:46:42 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:46:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:46:42 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')]} 07:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:42 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')]} 07:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:42 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 0x229b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2607a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b090>, '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 0x260bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2605f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', '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 07:46:42 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 07:46:42 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 07:46:42 INFO - Using env: {'DISPLAY': ':0', 07:46:42 INFO - 'HOME': '/home/cltbld', 07:46:42 INFO - 'LANG': 'en_US.UTF-8', 07:46:42 INFO - 'LANGUAGE': 'en_US:en', 07:46:42 INFO - 'LOGNAME': 'cltbld', 07:46:42 INFO - 'MAIL': '/var/mail/cltbld', 07:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:42 INFO - 'MOZ_NO_REMOTE': '1', 07:46:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:42 INFO - 'NO_EM_RESTART': '1', 07:46:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:42 INFO - 'PWD': '/builds/slave/test', 07:46:42 INFO - 'SHELL': '/bin/bash', 07:46:42 INFO - 'SHLVL': '1', 07:46:42 INFO - 'TERM': 'linux', 07:46:42 INFO - 'TMOUT': '86400', 07:46:42 INFO - 'USER': 'cltbld', 07:46:42 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', 07:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:42 INFO - '_': '/tools/buildbot/bin/python'} 07:46:43 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:46:43 INFO - Downloading/unpacking pip>=1.5 07:46:43 INFO - Running setup.py egg_info for package pip 07:46:43 INFO - warning: no files found matching 'pip/cacert.pem' 07:46:43 INFO - warning: no files found matching '*.html' under directory 'docs' 07:46:43 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:46:43 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:46:43 INFO - Installing collected packages: pip 07:46:43 INFO - Found existing installation: pip 1.1 07:46:43 INFO - Uninstalling pip: 07:46:43 INFO - Successfully uninstalled pip 07:46:43 INFO - Running setup.py install for pip 07:46:43 INFO - warning: no files found matching 'pip/cacert.pem' 07:46:43 INFO - warning: no files found matching '*.html' under directory 'docs' 07:46:43 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:46:43 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:46:43 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:46:43 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:46:43 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:46:43 INFO - Successfully installed pip 07:46:43 INFO - Cleaning up... 07:46:43 INFO - Return code: 0 07:46:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:43 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 0x229b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2607a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b090>, '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 0x260bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2605f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', '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 07:46:43 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 07:46:43 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 07:46:43 INFO - Using env: {'DISPLAY': ':0', 07:46:43 INFO - 'HOME': '/home/cltbld', 07:46:43 INFO - 'LANG': 'en_US.UTF-8', 07:46:43 INFO - 'LANGUAGE': 'en_US:en', 07:46:43 INFO - 'LOGNAME': 'cltbld', 07:46:43 INFO - 'MAIL': '/var/mail/cltbld', 07:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:43 INFO - 'MOZ_NO_REMOTE': '1', 07:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:43 INFO - 'NO_EM_RESTART': '1', 07:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:43 INFO - 'PWD': '/builds/slave/test', 07:46:43 INFO - 'SHELL': '/bin/bash', 07:46:43 INFO - 'SHLVL': '1', 07:46:43 INFO - 'TERM': 'linux', 07:46:43 INFO - 'TMOUT': '86400', 07:46:43 INFO - 'USER': 'cltbld', 07:46:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', 07:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:43 INFO - '_': '/tools/buildbot/bin/python'} 07:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:44 INFO - Downloading/unpacking psutil>=3.1.1 07:46:44 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 07:46:44 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 07:46:44 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 07:46:44 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 07:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:45 INFO - Installing collected packages: psutil 07:46:45 INFO - Running setup.py install for psutil 07:46:45 INFO - building 'psutil._psutil_linux' extension 07:46:45 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 07:46:45 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 07:46:45 INFO - building 'psutil._psutil_posix' extension 07:46:45 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 07:46:45 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 07:46:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:45 INFO - Successfully installed psutil 07:46:45 INFO - Cleaning up... 07:46:45 INFO - Return code: 0 07:46:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:46:45 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')]} 07:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:45 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')]} 07:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:45 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 0x229b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2607a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b090>, '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 0x260bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2605f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', '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 07:46:45 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 07:46:45 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 07:46:45 INFO - Using env: {'DISPLAY': ':0', 07:46:45 INFO - 'HOME': '/home/cltbld', 07:46:45 INFO - 'LANG': 'en_US.UTF-8', 07:46:45 INFO - 'LANGUAGE': 'en_US:en', 07:46:45 INFO - 'LOGNAME': 'cltbld', 07:46:45 INFO - 'MAIL': '/var/mail/cltbld', 07:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:45 INFO - 'MOZ_NO_REMOTE': '1', 07:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:45 INFO - 'NO_EM_RESTART': '1', 07:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:45 INFO - 'PWD': '/builds/slave/test', 07:46:45 INFO - 'SHELL': '/bin/bash', 07:46:45 INFO - 'SHLVL': '1', 07:46:45 INFO - 'TERM': 'linux', 07:46:45 INFO - 'TMOUT': '86400', 07:46:45 INFO - 'USER': 'cltbld', 07:46:45 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', 07:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:45 INFO - '_': '/tools/buildbot/bin/python'} 07:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:46:46 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 07:46:46 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 07:46:46 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 07:46:46 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 07:46:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:46:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:46:47 INFO - Installing collected packages: mozsystemmonitor 07:46:47 INFO - Running setup.py install for mozsystemmonitor 07:46:47 INFO - Successfully installed mozsystemmonitor 07:46:47 INFO - Cleaning up... 07:46:49 INFO - Return code: 0 07:46:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x229b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2607a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b090>, '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 0x260bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2605f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', '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 07:46:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:46:49 INFO - Using env: {'DISPLAY': ':0', 07:46:49 INFO - 'HOME': '/home/cltbld', 07:46:49 INFO - 'LANG': 'en_US.UTF-8', 07:46:49 INFO - 'LANGUAGE': 'en_US:en', 07:46:49 INFO - 'LOGNAME': 'cltbld', 07:46:49 INFO - 'MAIL': '/var/mail/cltbld', 07:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:49 INFO - 'MOZ_NO_REMOTE': '1', 07:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:49 INFO - 'NO_EM_RESTART': '1', 07:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:49 INFO - 'PWD': '/builds/slave/test', 07:46:49 INFO - 'SHELL': '/bin/bash', 07:46:49 INFO - 'SHLVL': '1', 07:46:49 INFO - 'TERM': 'linux', 07:46:49 INFO - 'TMOUT': '86400', 07:46:49 INFO - 'USER': 'cltbld', 07:46:49 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', 07:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:49 INFO - '_': '/tools/buildbot/bin/python'} 07:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:49 INFO - Downloading/unpacking jsonschema==2.5.1 07:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:46:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:46: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 07:46: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 07:46: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 07:46: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 07:46:51 INFO - Downloading functools32-3.2.3-2.tar.gz 07:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:46:51 INFO - warning: no files found matching '*.txt' 07:46:51 INFO - no previously-included directories found matching 'build' 07:46:51 INFO - no previously-included directories found matching 'dist' 07:46:51 INFO - no previously-included directories found matching '.git*' 07:46:51 INFO - Installing collected packages: jsonschema, functools32 07:46:51 INFO - Running setup.py install for functools32 07:46:51 INFO - warning: no files found matching '*.txt' 07:46:51 INFO - no previously-included directories found matching 'build' 07:46:51 INFO - no previously-included directories found matching 'dist' 07:46:51 INFO - no previously-included directories found matching '.git*' 07:46:51 INFO - Successfully installed jsonschema functools32 07:46:51 INFO - Cleaning up... 07:46:51 INFO - Return code: 0 07:46:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x229b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2607a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b090>, '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 0x260bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2605f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', '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 07:46:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:46:51 INFO - Using env: {'DISPLAY': ':0', 07:46:51 INFO - 'HOME': '/home/cltbld', 07:46:51 INFO - 'LANG': 'en_US.UTF-8', 07:46:51 INFO - 'LANGUAGE': 'en_US:en', 07:46:51 INFO - 'LOGNAME': 'cltbld', 07:46:51 INFO - 'MAIL': '/var/mail/cltbld', 07:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:51 INFO - 'MOZ_NO_REMOTE': '1', 07:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:51 INFO - 'NO_EM_RESTART': '1', 07:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:51 INFO - 'PWD': '/builds/slave/test', 07:46:51 INFO - 'SHELL': '/bin/bash', 07:46:51 INFO - 'SHLVL': '1', 07:46:51 INFO - 'TERM': 'linux', 07:46:51 INFO - 'TMOUT': '86400', 07:46:51 INFO - 'USER': 'cltbld', 07:46:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', 07:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:51 INFO - '_': '/tools/buildbot/bin/python'} 07:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:46:52 INFO - Cleaning up... 07:46:52 INFO - Return code: 0 07:46:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:46: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')]} 07:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46: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')]} 07:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46: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', '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 0x229b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2607a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b090>, '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 0x260bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2605f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', '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 07:46: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:46: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 blobuploader==1.2.4 07:46:52 INFO - Using env: {'DISPLAY': ':0', 07:46:52 INFO - 'HOME': '/home/cltbld', 07:46:52 INFO - 'LANG': 'en_US.UTF-8', 07:46:52 INFO - 'LANGUAGE': 'en_US:en', 07:46:52 INFO - 'LOGNAME': 'cltbld', 07:46:52 INFO - 'MAIL': '/var/mail/cltbld', 07:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:52 INFO - 'MOZ_NO_REMOTE': '1', 07:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:52 INFO - 'NO_EM_RESTART': '1', 07:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:52 INFO - 'PWD': '/builds/slave/test', 07:46:52 INFO - 'SHELL': '/bin/bash', 07:46:52 INFO - 'SHLVL': '1', 07:46:52 INFO - 'TERM': 'linux', 07:46:52 INFO - 'TMOUT': '86400', 07:46:52 INFO - 'USER': 'cltbld', 07:46:52 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', 07:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:52 INFO - '_': '/tools/buildbot/bin/python'} 07:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:52 INFO - Downloading/unpacking blobuploader==1.2.4 07:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:57 INFO - Downloading blobuploader-1.2.4.tar.gz 07:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:46:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:46:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:46: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 07:46: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 07:46: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 07:46: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 07:46:58 INFO - Downloading docopt-0.6.1.tar.gz 07:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:46:58 INFO - Installing collected packages: blobuploader, requests, docopt 07:46:58 INFO - Running setup.py install for blobuploader 07:46:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:46:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:46:58 INFO - Running setup.py install for requests 07:46:58 INFO - Running setup.py install for docopt 07:46:58 INFO - Successfully installed blobuploader requests docopt 07:46:58 INFO - Cleaning up... 07:46:59 INFO - Return code: 0 07:46:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46: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')]} 07:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46: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')]} 07:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46: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 0x229b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2607a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b090>, '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 0x260bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2605f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', '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 07:46: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 07:46: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 07:46:59 INFO - Using env: {'DISPLAY': ':0', 07:46:59 INFO - 'HOME': '/home/cltbld', 07:46:59 INFO - 'LANG': 'en_US.UTF-8', 07:46:59 INFO - 'LANGUAGE': 'en_US:en', 07:46:59 INFO - 'LOGNAME': 'cltbld', 07:46:59 INFO - 'MAIL': '/var/mail/cltbld', 07:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:59 INFO - 'MOZ_NO_REMOTE': '1', 07:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:59 INFO - 'NO_EM_RESTART': '1', 07:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:59 INFO - 'PWD': '/builds/slave/test', 07:46:59 INFO - 'SHELL': '/bin/bash', 07:46:59 INFO - 'SHLVL': '1', 07:46:59 INFO - 'TERM': 'linux', 07:46:59 INFO - 'TMOUT': '86400', 07:46:59 INFO - 'USER': 'cltbld', 07:46:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', 07:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:59 INFO - '_': '/tools/buildbot/bin/python'} 07:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:59 INFO - Running setup.py (path:/tmp/pip-WkOiJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:59 INFO - Running setup.py (path:/tmp/pip-cnDG3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:59 INFO - Running setup.py (path:/tmp/pip-QReRr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:59 INFO - Running setup.py (path:/tmp/pip-Ge8k4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:59 INFO - Running setup.py (path:/tmp/pip-oVL7xK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:59 INFO - Running setup.py (path:/tmp/pip-VqVPIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:59 INFO - Running setup.py (path:/tmp/pip-VLFk3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:59 INFO - Running setup.py (path:/tmp/pip-DIlJWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:59 INFO - Running setup.py (path:/tmp/pip-teEGCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:59 INFO - Running setup.py (path:/tmp/pip-9ZCd3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:59 INFO - Running setup.py (path:/tmp/pip-b5Lpbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:59 INFO - Running setup.py (path:/tmp/pip-Hp8mNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:00 INFO - Running setup.py (path:/tmp/pip-4ghVDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:00 INFO - Running setup.py (path:/tmp/pip-R6GhE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:00 INFO - Running setup.py (path:/tmp/pip-yTJjyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:00 INFO - Running setup.py (path:/tmp/pip-43tQez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:00 INFO - Running setup.py (path:/tmp/pip-2C4UCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:47:00 INFO - Running setup.py install for manifestparser 07:47:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:47:00 INFO - Running setup.py install for mozcrash 07:47:00 INFO - Running setup.py install for mozdebug 07:47:00 INFO - Running setup.py install for mozdevice 07:47:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:47:00 INFO - Running setup.py install for mozfile 07:47:00 INFO - Running setup.py install for mozhttpd 07:47:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:47:00 INFO - Running setup.py install for mozinfo 07:47:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:47:01 INFO - Running setup.py install for mozInstall 07:47:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:47:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:47:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:47:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:47:01 INFO - Running setup.py install for mozleak 07:47:01 INFO - Running setup.py install for mozlog 07:47:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:47:01 INFO - Running setup.py install for moznetwork 07:47:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:47:01 INFO - Running setup.py install for mozprocess 07:47:01 INFO - Running setup.py install for mozprofile 07:47:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:47:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:47:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:47:01 INFO - Running setup.py install for mozrunner 07:47:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:47:01 INFO - Running setup.py install for mozscreenshot 07:47:01 INFO - Running setup.py install for moztest 07:47:02 INFO - Running setup.py install for mozversion 07:47:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:47:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:47:02 INFO - Cleaning up... 07:47:02 INFO - Return code: 0 07:47:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47: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')]} 07:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47: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 0x229b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2607a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b090>, '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 0x260bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2605f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', '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 07:47: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 07:47: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 07:47:02 INFO - Using env: {'DISPLAY': ':0', 07:47:02 INFO - 'HOME': '/home/cltbld', 07:47:02 INFO - 'LANG': 'en_US.UTF-8', 07:47:02 INFO - 'LANGUAGE': 'en_US:en', 07:47:02 INFO - 'LOGNAME': 'cltbld', 07:47:02 INFO - 'MAIL': '/var/mail/cltbld', 07:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:02 INFO - 'MOZ_NO_REMOTE': '1', 07:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:02 INFO - 'NO_EM_RESTART': '1', 07:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:02 INFO - 'PWD': '/builds/slave/test', 07:47:02 INFO - 'SHELL': '/bin/bash', 07:47:02 INFO - 'SHLVL': '1', 07:47:02 INFO - 'TERM': 'linux', 07:47:02 INFO - 'TMOUT': '86400', 07:47:02 INFO - 'USER': 'cltbld', 07:47:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', 07:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:02 INFO - '_': '/tools/buildbot/bin/python'} 07:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:02 INFO - Running setup.py (path:/tmp/pip-YF9d75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47: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)) 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:02 INFO - Running setup.py (path:/tmp/pip-Pah87V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47: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)) 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:02 INFO - Running setup.py (path:/tmp/pip-FFdgs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47: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)) 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:02 INFO - Running setup.py (path:/tmp/pip-4HUNGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47: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)) 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:02 INFO - Running setup.py (path:/tmp/pip-7POsZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47: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)) 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:02 INFO - Running setup.py (path:/tmp/pip-VNkyGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:02 INFO - Running setup.py (path:/tmp/pip-zCFqBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:02 INFO - Running setup.py (path:/tmp/pip-g58Q8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:02 INFO - Running setup.py (path:/tmp/pip-XboOrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47: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)) 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:03 INFO - Running setup.py (path:/tmp/pip-cTgqQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47: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)) 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:03 INFO - Running setup.py (path:/tmp/pip-l0qmc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47: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)) 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:03 INFO - Running setup.py (path:/tmp/pip-UJmnvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47: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)) 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:03 INFO - Running setup.py (path:/tmp/pip-A12GeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47: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)) 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:03 INFO - Running setup.py (path:/tmp/pip-8bG7f8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47: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)) 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:03 INFO - Running setup.py (path:/tmp/pip-s9l27W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47: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)) 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:03 INFO - Running setup.py (path:/tmp/pip-vYCPjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47: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)) 07:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:03 INFO - Running setup.py (path:/tmp/pip-ROPcQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47: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)) 07:47: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)) 07:47: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)) 07:47: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)) 07:47: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)) 07:47: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)) 07:47: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)) 07:47:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:47: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 07:47: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 07:47: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 07:47: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 07:47:04 INFO - Downloading blessings-1.6.tar.gz 07:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:47:04 INFO - Installing collected packages: blessings 07:47:04 INFO - Running setup.py install for blessings 07:47:04 INFO - Successfully installed blessings 07:47:04 INFO - Cleaning up... 07:47:04 INFO - Return code: 0 07:47:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:47:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:05 INFO - Reading from file tmpfile_stdout 07:47:05 INFO - Current package versions: 07:47:05 INFO - argparse == 1.2.1 07:47:05 INFO - blessings == 1.6 07:47:05 INFO - blobuploader == 1.2.4 07:47:05 INFO - docopt == 0.6.1 07:47:05 INFO - functools32 == 3.2.3-2 07:47:05 INFO - jsonschema == 2.5.1 07:47:05 INFO - manifestparser == 1.1 07:47:05 INFO - mozInstall == 1.13 07:47:05 INFO - mozcrash == 1.0 07:47:05 INFO - mozdebug == 0.1 07:47:05 INFO - mozdevice == 0.51 07:47:05 INFO - mozfile == 1.2 07:47:05 INFO - mozhttpd == 0.7 07:47:05 INFO - mozinfo == 0.10 07:47:05 INFO - mozleak == 0.1 07:47:05 INFO - mozlog == 3.5 07:47:05 INFO - moznetwork == 0.27 07:47:05 INFO - mozprocess == 0.25 07:47:05 INFO - mozprofile == 0.28 07:47:05 INFO - mozrunner == 6.13 07:47:05 INFO - mozscreenshot == 0.1 07:47:05 INFO - mozsystemmonitor == 0.3 07:47:05 INFO - moztest == 0.8 07:47:05 INFO - mozversion == 1.4 07:47:05 INFO - psutil == 3.1.1 07:47:05 INFO - requests == 1.2.3 07:47:05 INFO - wsgiref == 0.1.2 07:47:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47: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')]} 07:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47: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 0x229b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2607a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b090>, '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 0x260bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2605f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', '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 07:47: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 07:47: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 07:47:05 INFO - Using env: {'DISPLAY': ':0', 07:47:05 INFO - 'HOME': '/home/cltbld', 07:47:05 INFO - 'LANG': 'en_US.UTF-8', 07:47:05 INFO - 'LANGUAGE': 'en_US:en', 07:47:05 INFO - 'LOGNAME': 'cltbld', 07:47:05 INFO - 'MAIL': '/var/mail/cltbld', 07:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:05 INFO - 'MOZ_NO_REMOTE': '1', 07:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:05 INFO - 'NO_EM_RESTART': '1', 07:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:05 INFO - 'PWD': '/builds/slave/test', 07:47:05 INFO - 'SHELL': '/bin/bash', 07:47:05 INFO - 'SHLVL': '1', 07:47:05 INFO - 'TERM': 'linux', 07:47:05 INFO - 'TMOUT': '86400', 07:47:05 INFO - 'USER': 'cltbld', 07:47:05 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', 07:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:05 INFO - '_': '/tools/buildbot/bin/python'} 07:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47: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)) 07:47: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)) 07:47: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)) 07:47: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)) 07:47: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)) 07:47: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)) 07:47: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)) 07:47: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)) 07:47: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)) 07:47:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:47: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 07:47: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 07:47: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 07:47: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 07:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:47: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)) 07:47: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)) 07:47:06 INFO - Installing collected packages: simplejson 07:47:06 INFO - Running setup.py install for simplejson 07:47:06 INFO - building 'simplejson._speedups' extension 07:47: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 07:47: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 07:47:07 INFO - Successfully installed simplejson 07:47:07 INFO - Cleaning up... 07:47:07 INFO - Return code: 0 07:47:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47: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')]} 07:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47: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 0x229b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2607a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b090>, '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 0x260bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2605f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', '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 07:47: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 07:47: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 07:47:07 INFO - Using env: {'DISPLAY': ':0', 07:47:07 INFO - 'HOME': '/home/cltbld', 07:47:07 INFO - 'LANG': 'en_US.UTF-8', 07:47:07 INFO - 'LANGUAGE': 'en_US:en', 07:47:07 INFO - 'LOGNAME': 'cltbld', 07:47:07 INFO - 'MAIL': '/var/mail/cltbld', 07:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:07 INFO - 'MOZ_NO_REMOTE': '1', 07:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:07 INFO - 'NO_EM_RESTART': '1', 07:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:07 INFO - 'PWD': '/builds/slave/test', 07:47:07 INFO - 'SHELL': '/bin/bash', 07:47:07 INFO - 'SHLVL': '1', 07:47:07 INFO - 'TERM': 'linux', 07:47:07 INFO - 'TMOUT': '86400', 07:47:07 INFO - 'USER': 'cltbld', 07:47:07 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', 07:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:07 INFO - '_': '/tools/buildbot/bin/python'} 07:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:47:07 INFO - Cleaning up... 07:47:07 INFO - Return code: 0 07:47:07 INFO - Running post-action listener: _resource_record_post_action 07:47:07 INFO - Running post-action listener: _start_resource_monitoring 07:47:07 INFO - Starting resource monitoring. 07:47:07 INFO - [mozharness: 2017-09-21 14:47:07.941894Z] Finished create-virtualenv step (success) 07:47:07 INFO - [mozharness: 2017-09-21 14:47:07.942404Z] Running install step. 07:47:07 INFO - Running pre-action listener: _resource_record_pre_action 07:47:07 INFO - Running main action method: install 07:47:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:08 INFO - Reading from file tmpfile_stdout 07:47:08 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:47:08 INFO - Reading from file tmpfile_stdout 07:47:08 INFO - Output received: 07:47:08 INFO - Usage: mozinstall [options] installer 07:47:08 INFO - Options: 07:47:08 INFO - -h, --help show this help message and exit 07:47:08 INFO - -d DEST, --destination=DEST 07:47:08 INFO - Directory to install application into. [default: 07:47:08 INFO - "/builds/slave/test"] 07:47:08 INFO - --app=APP Application being installed. [default: firefox] 07:47:08 INFO - mkdir: /builds/slave/test/build/application 07:47: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'] 07:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:47:25 INFO - Reading from file tmpfile_stdout 07:47:25 INFO - Output received: 07:47:25 INFO - /builds/slave/test/build/application/firefox/firefox 07:47:25 INFO - Running post-action listener: _resource_record_post_action 07:47:25 INFO - [mozharness: 2017-09-21 14:47:25.907889Z] Finished install step (success) 07:47:25 INFO - [mozharness: 2017-09-21 14:47:25.908141Z] Running setup-mitmproxy step. 07:47:25 INFO - Running pre-action listener: _resource_record_pre_action 07:47:25 INFO - Running main action method: setup_mitmproxy 07:47:25 INFO - Skipping: mitmproxy is not required 07:47:25 INFO - Running post-action listener: _resource_record_post_action 07:47:25 INFO - [mozharness: 2017-09-21 14:47:25.909405Z] Finished setup-mitmproxy step (success) 07:47:25 INFO - [mozharness: 2017-09-21 14:47:25.909627Z] Running run-tests step. 07:47:25 INFO - Running pre-action listener: _resource_record_pre_action 07:47:25 INFO - Running pre-action listener: _set_gcov_prefix 07:47:25 INFO - Running main action method: run_tests 07:47:25 WARNING - Try message not found. 07:47:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:47:25 INFO - Python 2.7.3 07:47:25 INFO - Return code: 0 07:47:25 INFO - grabbing minidump binary from tooltool 07:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b090>, '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 0x260bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2605f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:47:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:47:25 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:47:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:47:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:26 INFO - Return code: 0 07:47:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:47:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:47:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:47:26 INFO - ENV: RUST_BACKTRACE is now full 07:47:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:47:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:47: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/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:47: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/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:47:26 INFO - Using env: {'DISPLAY': ':0', 07:47:26 INFO - 'HOME': '/home/cltbld', 07:47:26 INFO - 'LANG': 'en_US.UTF-8', 07:47:26 INFO - 'LANGUAGE': 'en_US:en', 07:47:26 INFO - 'LOGNAME': 'cltbld', 07:47:26 INFO - 'MAIL': '/var/mail/cltbld', 07:47:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:26 INFO - 'MOZ_NO_REMOTE': '1', 07:47:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:26 INFO - 'NO_EM_RESTART': '1', 07:47:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:26 INFO - 'PWD': '/builds/slave/test', 07:47:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:26 INFO - 'RUST_BACKTRACE': 'full', 07:47:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:47:26 INFO - 'SHELL': '/bin/bash', 07:47:26 INFO - 'SHLVL': '1', 07:47:26 INFO - 'TERM': 'linux', 07:47:26 INFO - 'TMOUT': '86400', 07:47:26 INFO - 'USER': 'cltbld', 07:47:26 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', 07:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:26 INFO - '_': '/tools/buildbot/bin/python'} 07:47: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/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:47:26 INFO - mozversion application_buildid: 20170921132403 07:47:26 INFO - mozversion application_changeset: f7e9777221a34f9f23c2e4933307eb38b621b679 07:47:26 INFO - mozversion application_display_name: Nightly 07:47:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:26 INFO - mozversion application_name: Firefox 07:47:26 INFO - mozversion application_remotingname: firefox 07:47:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:47:26 INFO - mozversion application_vendor: Mozilla 07:47:26 INFO - mozversion application_version: 57.0a1 07:47:26 INFO - mozversion platform_buildid: 20170921132403 07:47:26 INFO - mozversion platform_changeset: f7e9777221a34f9f23c2e4933307eb38b621b679 07:47:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:47:26 INFO - mozversion platform_version: 57.0a1 07:47:26 INFO - using testdate: 1506005246 07:47:26 INFO - actual date: 1506005246 07:47:26 INFO - starting webserver on 'localhost:39057' 07:47:26 INFO - SUITE-START | Running 2 tests 07:47:26 INFO - TEST-START | dromaeo_css 07:47:26 INFO - Initialising browser for dromaeo_css test... 07:47:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39057/getInfo.html -profile /tmp/tmp9cRPGt/profile 07:47:26 INFO - TEST-INFO | started process 16142 (/builds/slave/test/build/application/firefox/firefox http://localhost:39057/getInfo.html) 07:47:33 INFO - TEST-INFO | 16142: exit 0 07:47:33 INFO - Browser initialized. 07:47:33 INFO - Running cycle 1/1 for dromaeo_css test... 07:47:33 INFO - Using env: {'DISPLAY': ':0', 07:47:33 INFO - 'HOME': '/home/cltbld', 07:47:33 INFO - 'JSGC_DISABLE_POISONING': '1', 07:47:33 INFO - 'LANG': 'en_US.UTF-8', 07:47:33 INFO - 'LANGUAGE': 'en_US:en', 07:47:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:47:33 INFO - 'LOGNAME': 'cltbld', 07:47:33 INFO - 'MAIL': '/var/mail/cltbld', 07:47:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:47:33 INFO - 'MOZ_CRASHREPORTER': '1', 07:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:47:33 INFO - 'MOZ_NO_REMOTE': '1', 07:47:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:33 INFO - 'NO_EM_RESTART': '1', 07:47:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:33 INFO - 'PWD': '/builds/slave/test', 07:47:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:33 INFO - 'RUST_BACKTRACE': 'full', 07:47:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:47:33 INFO - 'SHELL': '/bin/bash', 07:47:33 INFO - 'SHLVL': '1', 07:47:33 INFO - 'TERM': 'linux', 07:47:33 INFO - 'TMOUT': '86400', 07:47:33 INFO - 'USER': 'cltbld', 07:47:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', 07:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:33 INFO - '_': '/tools/buildbot/bin/python'} 07:47:33 INFO - TEST-INFO | started process 16378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9cRPGt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:34 INFO - PID 16378 | 07:47:34 INFO - PID 16378 | (/builds/slave/test/build/application/firefox/firefox:16429): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:47:34 INFO - PID 16378 | 07:47:44 INFO - PID 16378 | RSS: Main: 144359424 07:47:44 INFO - PID 16378 | 07:50:42 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:39057/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39057/tests/dromaeo/cssquery-ext.html) 07:50:43 INFO - PID 16378 | RSS: Main: 148238336 07:50:43 INFO - PID 16378 | 07:53:45 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:39057/tests/dromaeo/cssquery-ext.html (next: http://localhost:39057/tests/dromaeo/cssquery-jquery.html) 07:53:45 INFO - PID 16378 | RSS: Main: 148307968 07:53:45 INFO - PID 16378 | 07:56:47 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:39057/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39057/tests/dromaeo/cssquery-mootools.html) 07:56:47 INFO - PID 16378 | RSS: Main: 149262336 07:56:47 INFO - PID 16378 | 07:59:49 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:39057/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39057/tests/dromaeo/cssquery-prototype.html) 07:59:49 INFO - PID 16378 | RSS: Main: 149483520 07:59:49 INFO - PID 16378 | 08:02:53 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:39057/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39057/tests/dromaeo/cssquery-yui.html) 08:02:53 INFO - PID 16378 | RSS: Main: 150913024 08:02:53 INFO - PID 16378 | 08:05:55 INFO - PID 16378 | Cycle 1(1): loaded http://localhost:39057/tests/dromaeo/cssquery-yui.html (next: http://localhost:39057/tests/dromaeo/cssquery-dojo.html) 08:05:55 INFO - PID 16378 | RSS: Main: 152805376 08:05:55 INFO - PID 16378 | 08:05:55 INFO - PID 16378 | __start_tp_report 08:05:55 INFO - PID 16378 | _x_x_mozilla_page_load 08:05:55 INFO - PID 16378 | _x_x_mozilla_page_load_details 08:05:55 INFO - PID 16378 | |i|pagename|runs| 08:05:55 INFO - PID 16378 | |0;dojo.html;3881.3789793633014;3916.686665066794;3919.118198405359;3925.9803700981493;3931.997340678127;6187.69061546922;6234;6287.37126287371;6327.272363678178;6342.0803983422375;6316.715747791349;6318.589291696048;6318.715657795398;6319.431251187392;6335.334789847069;5611.775528978836;5616.9157462638095;5659.264295641561;5731.570132240098;5769.105788602773;5676.290463692038;5678.091505359143;5750.223719797837;5768.826935191951;5786.247787787582;5484.561235101182;5626.381098079208;5691.74387152577;5776.480116789488;5792.044312688401;5164.147915593922;5639.125935480007;5700.030994730864;5727.713614319309;5736.196932429463;5620.971895140498;5637.577181711347;5672.205891175238;5680.829575112753;5688.232088668018;6214.906776398358;6227.221597300338;6253.37466253371;6255.24937007562;6268.216472940882;6845.247022827485;6852.383285504278;6864.039034535169;6874.690638921211;6892.207396149457;6841.794746157623;6850;6919.965400173017;6940.13248343957;6949.5830250184645;6231.158793562857;6302.779402720883;6349;6361.236651601837;6444.581102228341;6910.827229319308;6916;6919.4464442844455;6929.514933954676;6977.33715297046;6708.094407254958;6722.630255336004;6787.21946976104;6797.52417330792;6814.1482314710665;6848.794536163923;6859.588424694534;6875.896861547081;6905.1713794345;6952.93047069533;6671.032700258435;6745.325467453314;6776.220734615484;6780.457563394916;6780.660966951633;6763.458923286125;6792.45660347171;6806.829829254309;6835.384815366641;6838.14523184602;4955.90088198234;5021.49785021495;5023.924641130386;5029.673071250357;5041.924371134436;4487.035287413157;4579.198640237945;4581.175388430048;4623.329617205486;4643;6300.684965751694;6343.524235682342;6363.172787537591;6369.617822930639;6378.298387177407;6683.899741503881;6782.796516104525;6784.185897692209;6796.592204467748;6799.796006119825;6311.147995020613;6315.905261421082;6327.778527751507;6383.39357761012;6388.977763557808;5566.860828479239;5568.276124103922;5588.469095435927;5594.300712410949;5594.916076258859;7049.259827718119;7051.259617740166;7060.54106483077;7156.355927966404;7163.925411188364;6710.597364157971;6794.252632210354;6800.557963732342;6805.455563555002;6888.483363747739;6890.379865812101;7002.2297547268745;7013.3337332955325;7022.789316320519;7025.754098606524;6759.493038022267;6786.049953006682;6787.151606049244;6805.625690587065;6809.353111454404;6845.726170953305;6876.415504682158;6902.896456553256;6903.792886213421;6926.826829329307;6591.143151390289;6598.406143447113;6676.699548520425;6691.631960242039;6699.832504187434;6426.967865160645;6531.379518945692;6539.771108011197;6601.9009714853355;6643.56816806906;6565.310642382481;6570.704318305592;6571.047198156336;6575.934240657723;6581.967090164519;6664.400203981665;6716.865662686621;6718.496112791462;6734.528582999143;6758.763443279461;6349.8730025400155;6429.7428102875365;6459.838504037437;6481.319461456667;6544.934550654432 08:05:55 INFO - PID 16378 | |1;ext.html;966.1497881863961;968.2254196642684;989.0406305883293;1002.0981116994708;1017.6692574913151;43952.3407148893;44671.32993005108;44715.77642111793;44727.552724472785;44782.552174478245;41384.37923431151;41984.790076049656;42036.78981605088;42041.369379459335;42048.36927446091;7623;7782.027246594176;7795.14253432122;7812.414068944823;7822.882656760153;7659.578723170223;7753.418493612973;7770.184130666284;7773.7279195228175;7782.182870798541;8328.916710832906;8608.569571521399;8613.61238744258;8617.61220745065;8618.956905215466;8417.831643367099;8443.704470343539;8444.113368096385;8464.788380290542;8475.406721529496;7774.611269436506;7982.042154941386;7998.160193179749;8005.719799806979;8353.37349698775;40846.591534084575;41198.794006030075;41236.38145427821;41252.587474125474;41316;3624.5650521937537;3669.4679271505747;3671.394219953731;3672.2288319452946;3672.6694597486353;33500.162495937795;33624;33646;33659.15852103692;33661.495077573854;5309.123994540896;5332.733363331818;5354.196870469422;5366.356037275513;5431.293931788881;220905;221763;222141;222395;223279.8836005842;51971.22043169355;51982.48017519852;52130.21804672933;54633.1805022925;55760.16359754607;57201.71399142977;57610.423895760505;57701.42298577044;57741;57757.13364299539;16899.15504224784;16981.150942452827;17093.401730939608;17151.313947441962;17177.31290748381;13735.725285494234;13801.309934503435;13885.722285554233;13922.09506382082;13937.09408888419;15789.921050394674;15887.682246355009;15910.204489775464;15926.203689815462;15942.28259728315;6104.481119104926;6205.410486003822;6268.968655156787;6273.560850740496;6316.526260530479;1107.2636696596835;1114.6043154680135;1115.3530952047793;1121.697141771717;1132.6771870017005;25800.74199258021;26164.215073547824;26311.342216444744;26444.206673799818;26473.073442429424;1209.4255228766265;1214.1925619463134;1226.3500344817262;1228.6314105768233;1249.2629348684138;13883.444662213398;13897.79153312701;13941.58175254744;14084.225367604675;14122.858771412155;278690;283269;284401;284914;285878;55513.44486555163;57696;58518.707406462694;58848.70575647095;63034.36965630285;1534.3095606976906;1544;1560.4616407339677;1565.937362505487;1566.3891082477614;30881.845590771904;31035.68964310328;31134.527713349085;31534.842325788224;32198.517022244218;42195.36706949337;42619.57380426156;42653.57346426496;42699.14601707886;42780.358294626225;256656;260440;260936;261225;262476;38539.42190867083;38652.226955461294;38794;38915;38918;47222.84686305457;47402;47456.52543474659;47630.52369476261;47769.28346074742;35745.82127089348;35961.640383595826;35969.64030359663;36021.81989090038;36155.457668135525;35336.82331588326;35385;35449.291014179056;35492.46761298531;35626.28747424985;39442;40665.59334406618;40926;40954.1809163821;41103.794481027406;33607;33972;34160.82919585386;34409.139771505914;34932.301353973286;26139.346516337242;26474.602880957187;26779.099142278254;27111;27131.59302610423 08:05:55 INFO - PID 16378 | |2;jquery.html;610.1427494370411;614.9231346081737;625.3871206217909;636.106270689681;655.6688872119579;22964.196253131144;23669;23850;23869.641955370684;23898.40253993651;26273.73726262737;27406.5889011665;27480.450390992217;27494.45011099777;27500.862495687492;6682.799516014503;6698.531102822804;6710.630915299645;6728.091707619482;6729.629870357128;6552.213734351884;6619.30497297784;6752.291009444011;6784;6808.523403361766;6745.089412929266;6766.289539598345;6770.7968760937;6780.186377634691;6783.355581219801;6580.638064906429;6788.355106264897;6873.690683919235;6888.621125838077;6893.241743408246;6427.453666438359;6430.0676401921455;6436.613803171825;6443.7744678936015;6448.290688024314;30880.845595771876;31578.684213158034;31633.20916977071;31636.367272654417;31662;2240.327901629521;2254.6054440472853;2284.223364056212;2285.6685780561893;2292.9656055159185;20610.587788244153;21403.892980535154;21437;21474;21478.892605536872;2497.9250622481354;2551.349405901502;2597.402597402608;2599.129291687287;2601.115620688975;135980.32009839985;142961;143234;149367;159424.20287898602;16268.593285167966;16520.256588453547;17098.658026839392;17239.482815515556;17556.824431755773;26996.86501567519;27192;27216.183514494598;27251.182464526097;27257.727422725915;10761.946190268998;10963.684357877106;10985.450727463754;11036.448177591088;11100.222984391015;9859.654912078044;9928.702138935843;10010.949945250228;10113.190944724405;10132.949335253425;9905.58521233366;9954.751131221778;10161.18710503158;10184.185265178769;10342.741431464123;2883.235942475246;2933.4306146211675;2934.1784300395925;2934.2370983544433;2990.8654110565076;1037.8080055189814;1044.613493007592;1047.7171163785736;1053.8366553184114;1056.3767377247307;22224.55550888973;22326.21858234954;22354.888225558767;22438.43903902383;22725.545489090127;1090.1170052257696;1096.7916095941746;1105.1490352428584;1105.535675016495;1106.9225154239286;12006.519739210335;12207.267563946192;12258.20321679088;12304.384780760925;12469.314187719763;605593;610799;618518;624343;633122;132767.3361633205;134197.32901335627;136547.31726341305;136583.31708341592;137247;1203.8314635950974;1205.6737588652413;1237.2020047069589;1241.0878004666563;1242.2422322383338;19124.52188695238;19258.518537036685;19374.128164232363;19376.4187074388;19529.70705439448;62783.37216627775;63222.36777632165;63844;64003;64938.67530662316;83631;83918;83961;84597.57701211455;86140.56929715311;16091.919540402692;16569.25438355301;16580.668386632442;16714.749278760584;16740.079295638858;24966.50066998686;25052.248432547054;25115.623265651397;25143.87428062848;25162.993480260586;20531.28140515075;20760.48098797542;20773.480662983548;21060.26289079875;21107.788922110583;17770.20034098443;17982.91008544949;18506.537336566693;18561.628767424845;19037.809621903605;20724;21067;21374.893125534272;21404.250851220757;21575.568488630455;15946.68106637884;16117.677646446771;16134.67730645404;16147.19264036817;16225.18874056316;19167.32914347991;19244.807551924303;19270.32553860608;19301.4209573713;19432.708509372653 08:05:55 INFO - PID 16378 | |3;mootools.html;1431.2485944878938;1468.4640106361169;1481.4518628107594;1496.7754836774482;1502.6619010722582;16997;17629.91185044073;17638.11809409529;17647.29410823567;17651.823481765212;17187.140642967865;17351.73972390412;17352.47942561725;17366.13169341534;17408.129593520338;2702.8513431761244;2728.058819707198;2734.740199681027;2742.492638861807;2742.5886117082396;2552.540542702313;2635.3806855388966;2638.6437830892773;2641.6565846439935;2643.9339016524646;2611.660484137069;2620.1746449868324;2645.9206223813317;2683.7047924728363;2700.4194098268867;2659.8138130330885;2703.04042065068;2704.148193319098;2706.512827691015;2709.810313278081;2642.3129986203726;2683.570628699418;2684.033747850772;2686.2881336445857;2706.7563919247364;16220.918895405566;16376.344946202138;16652.83347166525;16654.916725416417;16672.58318542034;8126.39052071097;8424;8426.662933482654;8434.78913027173;8438.240558349717;5358.169483730028;5571.609987300891;5580.972095139539;5703.31560212773;5734.369219385864;2115.428834214769;2144.1209104267177;2161.329987703801;2220.078667353063;2230.107956817286;30465.390692186254;31046.223844403845;31060.068197954097;31078;31123.688763112306;7077.504574679723;7193.496455248082;7266.854662906712;7390.224026477143;7425.740099096613;19509.804901951084;19936.601267974558;19970.800291996893;23577.29268121959;23639.881800590887;8048;8261.710840120568;8270.421070525126;8283.461574997606;8294.958525207456;7243.74646887367;7345.081864766904;7530.171681115073;7586.696532138763;7712.884306735404;5719.056355701346;5801.216835727208;5815.88368232633;5832.62087964281;6059.636421814617;1565.3582031367084;1630.4130513015305;1640.2045008171267;1645.3418632547077;1658.8589969852699;788.9526628402314;806.9370718432664;812.9430939834155;817.6933649881295;837.5853952293531;7869.921300786918;7890.566018869017;7936.047674279123;7949.880751788728;7964.840703185904;759.783461713409;790.1229635105029;790.7588185603331;795.0459448661513;798.6206551887923;4432.667549933768;5143.5113664201845;5403.945960540423;5683.715814209273;5727.627704199213;24202.63696044561;24431;25353.492930141292;25375.238742837377;25398;25342.873285633454;25488.362790930005;25753.61369579458;25803.612945805828;25835.095771647902;11548.826767598493;12011.699707507381;12172.81740773889;12464.750704985849;12529.561465348668;8835.337349698926;9124.406913550598;9190.724278271662;9217.953910230674;9283;20759;20769.169233231107;20881.26915557948;20998.370048898556;21136.048877800844;21351;21532.784672153077;21604.703717776985;21726.674099888198;21802.781972180073;12368.567100151451;12407.565735199585;12412.193207441487;12525.56160534377;12566.560170393992;14855.182964937032;14915.85084149188;14949.177795220932;14956.775648365501;14958.551243462714;11088.611898583511;11112.666620001413;11124.833127503256;11366.829497557377;11366.829497557708;10551.736206594896;10586.8411973822;10821.296615719953;10857.185711071543;11080.889191107986;10128.84806727885;10187.235957303084;10232;10247.948760256151;10254.538545765608;7747.380209583107;7842.72550460754;7854.1753115922;7885.093214280431;7939.245771651684;7654;7863.292303692695;7915.248051435105;7920.445568810128;7960.363170946426 08:05:55 INFO - PID 16378 | |4;prototype.html;561.3292115921475;571.6512927114461;579.9043157878945;589.631480324797;591.7839988404232;6184.474319682827;6232.48145094806;6233.844153896155;6294.276158241803;6294.622322660638;6075.301340345862;6228.968855155718;6235.376462353763;6243.157173781549;6288.213973253343;4896.338994235786;4969.950300497003;5054.368203974504;5065.772040258197;5079.4412614612365;5000.5999520038495;5026.472220416858;5032.9748351258195;5037.093323201822;5041.495850414965;4902.166631672606;4939.456659767441;4942.739601401638;4945.579625731799;4946.802127914879;4907.82822601209;4978;5010.248462730583;5014.147594908838;5022.522860328263;4556.157110934488;4575.839845605421;4595.564350894031;4596.839110631146;4609.354690343354;6003.369646187175;6050.273967123973;6122.938770612282;6145.941109728246;6261.342559031327;5786.508146807527;5796.333421656479;5801.158831969341;5859.150423188614;5897.262842144732;6538.378854008862;6569.408753212234;6603.504737144734;6620;6631.635260060695;4813.831515896927;5049.722265275408;5057.822976195852;5071.427857364229;5091.694498330112;6668.09937677112;6784.491163162733;6887.449004079662;6929.782469609727;6947.756828511028;5162.993216322781;5179.715115668599;5200.895982080413;5210.97394513025;5215.608829337815;5236.9738151309;5269.262303277545;5276.287701160371;5284.286621306152;5313.1764576490705;5869.5010924071075;5870.471657550841;5883.588148829626;5892.616979896293;5906.8651943639625;6652.933470665232;6661.500387470862;6687.565308254948;6730;6741.224759152662;1791.265581111738;1804.864635152369;1807.9367222147162;1808.095952023988;1816.309802275127;1223.9632811015683;1237.0845574274972;1259.9307038112993;1272.8854403103765;1276.425608476171;6045.455908968214;6052.818415447544;6082.391760823971;6093.2078829751845;6136.570440069152;6504.934950650528;6528.869422611616;6594.153636981653;6662.200535935622;6685.598864068172;5892.587518873637;5998.280206375263;6077.665728384981;6107.297660769068;6112.113743507255;3426.9143271418416;3461.671141241578;3465.5321531593418;3474.739394545419;3509.403401421713;6757.898631520531;6831.316868313129;6901.240863505011;6933.93066069343;6936.237013928464;6706.26231114577;6782.830429239309;6812.649635875615;6843.144606924135;6871.553349032297;6944.5346901851135;6967.54710943787;6997.1253593300835;7005.439564834903;7009.264027277164;6723.562968407038;6730.966345168439;6743.325667433218;6764.053032575345;6765.42493888025;6562.606243625398;6582.539222254396;6603.636799976048;6632.270450250565;6677.532572719863;6736.393724564813;6777.322267773183;6888.552244104118;6908.2400935896;6978.47661425385;5145.4340022598235;5150.587952963679;5159.561437277874;5183.300254465599;5201.971231219752;6442.387973142544;6593;6623.966880165568;6628.635425051669;6638;6206.472449841814;6426.389492998158;6460.709268082854;6484.5460817742305;6530.379613936669;6463.547551671338;6516.967415162894;6520.119783829123;6525.1517302750335;6528.543001990005;6403.367141378919;6450.580712253689;6488.221413430229;6526.608403495806;6579.671016449254;6551.934480655133;6557.344265573404;6578.80263592093;6640.468762499085;6684.43182329488;6310.842228944313;6337.176167098432;6388.6583817397;6414.903776443264;6415.454686351713 08:05:55 INFO - PID 16378 | |5;yui.html;901.3150005995442;943.1558754914356;947.422072535753;961.4519723757459;991.0981007283372;18420.815791842077;19033.333833315835;19144.329948451807;19159.42521724347;19261.518462038457;15511.922440387782;15540.53378398647;15565.92217038916;17215.82784172158;17566.29734810609;1048.8636477257965;1061.2040969273007;1063.4204358624568;1063.5905176507063;1065.8934106589356;1083.3987137138886;1085.2837127495854;1086.4784903246446;1087.2986923434419;1087.7933192693401;1080.7082087836318;1109.8668159820834;1117.8379135025416;1119.0040863631375;1124.791913496006;1110.4114819145866;1113.9387333696643;1114.0363585498567;1114.0864491117286;1115.782422427631;795.9761207163795;813.5566116466481;818.7298191596818;819.3240576524331;822.8560001999685;18612.720809187736;18840.05799710009;18902.52743681419;18906.905465472722;18913.810861891343;22358.329250122522;22559.436014099778;22865.77134228653;23000.42498937523;23037.424064398358;17609.119544022877;17774.644507109915;17814.55463613407;17839.46481605554;17930.103494825336;3913.6477717005605;3939.113699417637;3939.980300098481;3940.8817735467983;3942.8028598570245;154966;156559.21720391326;156902;160894;162812;17135.828641713673;17182;17263.56841078958;17296.827031729772;17381.304747810198;31630.841845790623;31889.362212755615;31904.361912761615;31918.361632767213;31925.52111718326;8671.262942649819;8708.95645521781;8757.56212189388;8801.339899507562;8807.075257097913;4454.309582014793;4469.932951005738;4470.173017991682;4479.731216127043;4491.258942274553;5256.816011439658;5281.973590132102;5330.200469929541;5336.17289320156;5363.383210930715;1102.0522350778324;1118.6028959719345;1127.6053381316474;1131.728385187549;1131.7679875625477;677.678102901118;695.5583204665074;696.5576858694766;701.9052427922165;707.0419581467141;11760.647180584596;11987.580434684744;12274.324912129918;12520.624381268577;13136.211827290394;695.5061906046662;698.7205117952859;703.2756261051023;705.5413980912448;710.3216428310951;5600.915986260209;5600.943990560124;5611.3266408031295;5674.319081710139;5721.885562288814;147609.26195368954;147675;150345.2482737601;153238;154942;126094.3695281536;127727;130023;132128.3393583026;137032;111507;111868.44065779619;111935;112505;117330.41334793271;12486.750264994831;12798.744025119258;12970.870291296966;13089.672758181121;13200.075994680281;50662.49337506578;52534.47465525296;52583.73708131435;53241.4675853252;54159.18761218506;65359.346406535326;78707.60646196733;95269.5236523813;97251.51374243083;101274;18357;18610.534736631693;18866.434006979813;18899.29906308439;18940.3370882024;17869.642607147525;18047.909760451115;18177.727334089734;21154.15383384709;21167;18153.183106759963;18259.726104108184;18477.35329263523;18518;18672.346467873558;19091.140898659873;19127.52181195481;19188.712169317194;19420.902895485433;19472.707909381654;17248.655026899643;17451.47645570635;17901.73147402816;19193.90403047976;19329.4201173965;12708.809367859674;13289.933550332187;13436.798448023092;13566.321683915567;13579.185248885098;13074.346282685638;13625.659358516117;14020.579382618538;14079.436822526985;14094.929525352307 08:05:55 INFO - PID 16378 | __end_tp_report 08:05:55 INFO - PID 16378 | __start_cc_report 08:05:55 INFO - PID 16378 | _x_x_mozilla_cycle_collect,266 08:05:55 INFO - PID 16378 | __end_cc_report 08:05:55 INFO - PID 16378 | __startTimestamp1506006355355__endTimestamp 08:05:55 INFO - PID 16378 | 08:05:55 INFO - PID 16378 | ------- Summary: start ------- 08:05:55 INFO - PID 16378 | Number of tests: 6 08:05:55 INFO - PID 16378 | 08:05:55 INFO - PID 16378 | [#0] dojo.html Cycles:165 Average:6287.85 Median:6544.93 stddev:733.88 (11.2%) stddev-sans-first:711.43 08:05:55 INFO - PID 16378 | Values: 3881.4 3916.7 3919.1 3926.0 3932.0 6187.7 6234.0 6287.4 6327.3 6342.1 6316.7 6318.6 6318.7 6319.4 6335.3 5611.8 5616.9 5659.3 5731.6 5769.1 5676.3 5678.1 5750.2 5768.8 5786.2 5484.6 5626.4 5691.7 5776.5 5792.0 5164.1 5639.1 5700.0 5727.7 5736.2 5621.0 5637.6 5672.2 5680.8 5688.2 6214.9 6227.2 6253.4 6255.2 6268.2 6845.2 6852.4 6864.0 6874.7 6892.2 6841.8 6850.0 6920.0 6940.1 6949.6 6231.2 6302.8 6349.0 6361.2 6444.6 6910.8 6916.0 6919.4 6929.5 6977.3 6708.1 6722.6 6787.2 6797.5 6814.1 6848.8 6859.6 6875.9 6905.2 6952.9 6671.0 6745.3 6776.2 6780.5 6780.7 6763.5 6792.5 6806.8 6835.4 6838.1 4955.9 5021.5 5023.9 5029.7 5041.9 4487.0 4579.2 4581.2 4623.3 4643.0 6300.7 6343.5 6363.2 6369.6 6378.3 6683.9 6782.8 6784.2 6796.6 6799.8 6311.1 6315.9 6327.8 6383.4 6389.0 5566.9 5568.3 5588.5 5594.3 5594.9 7049.3 7051.3 7060.5 7156.4 7163.9 6710.6 6794.3 6800.6 6805.5 6888.5 6890.4 7002.2 7013.3 7022.8 7025.8 6759.5 6786.0 6787.2 6805.6 6809.4 6845.7 6876.4 6902.9 6903.8 6926.8 6591.1 6598.4 6676.7 6691.6 6699.8 6427.0 6531.4 6539.8 6601.9 6643.6 6565.3 6570.7 6571.0 6575.9 6582.0 6664.4 6716.9 6718.5 6734.5 6758.8 6349.9 6429.7 6459.8 6481.3 6544.9 08:05:55 INFO - PID 16378 | 08:05:55 INFO - PID 16378 | [#1] ext.html Cycles:180 Average:43824.08 Median:3672.45 stddev:66679.61 (1815.7%) stddev-sans-first:66789.02 08:05:55 INFO - PID 16378 | Values: 966.1 968.2 989.0 1002.1 1017.7 43952.3 44671.3 44715.8 44727.6 44782.6 41384.4 41984.8 42036.8 42041.4 42048.4 7623.0 7782.0 7795.1 7812.4 7822.9 7659.6 7753.4 7770.2 7773.7 7782.2 8328.9 8608.6 8613.6 8617.6 8619.0 8417.8 8443.7 8444.1 8464.8 8475.4 7774.6 7982.0 7998.2 8005.7 8353.4 40846.6 41198.8 41236.4 41252.6 41316.0 3624.6 3669.5 3671.4 3672.2 3672.7 33500.2 33624.0 33646.0 33659.2 33661.5 5309.1 5332.7 5354.2 5366.4 5431.3 220905.0 221763.0 222141.0 222395.0 223279.9 51971.2 51982.5 52130.2 54633.2 55760.2 57201.7 57610.4 57701.4 57741.0 57757.1 16899.2 16981.2 17093.4 17151.3 17177.3 13735.7 13801.3 13885.7 13922.1 13937.1 15789.9 15887.7 15910.2 15926.2 15942.3 6104.5 6205.4 6269.0 6273.6 6316.5 1107.3 1114.6 1115.4 1121.7 1132.7 25800.7 26164.2 26311.3 26444.2 26473.1 1209.4 1214.2 1226.4 1228.6 1249.3 13883.4 13897.8 13941.6 14084.2 14122.9 278690.0 283269.0 284401.0 284914.0 285878.0 55513.4 57696.0 58518.7 58848.7 63034.4 1534.3 1544.0 1560.5 1565.9 1566.4 30881.8 31035.7 31134.5 31534.8 32198.5 42195.4 42619.6 42653.6 42699.1 42780.4 256656.0 260440.0 260936.0 261225.0 262476.0 38539.4 38652.2 38794.0 38915.0 38918.0 47222.8 47402.0 47456.5 47630.5 47769.3 35745.8 35961.6 35969.6 36021.8 36155.5 35336.8 35385.0 35449.3 35492.5 35626.3 39442.0 40665.6 40926.0 40954.2 41103.8 33607.0 33972.0 34160.8 34409.1 34932.3 26139.3 26474.6 26779.1 27111.0 27131.6 08:05:55 INFO - PID 16378 | 08:05:55 INFO - PID 16378 | [#2] jquery.html Cycles:180 Average:40662.94 Median:12346.52 stddev:103323.82 (836.9%) stddev-sans-first:103569.90 08:05:55 INFO - PID 16378 | Values: 610.1 614.9 625.4 636.1 655.7 22964.2 23669.0 23850.0 23869.6 23898.4 26273.7 27406.6 27480.5 27494.5 27500.9 6682.8 6698.5 6710.6 6728.1 6729.6 6552.2 6619.3 6752.3 6784.0 6808.5 6745.1 6766.3 6770.8 6780.2 6783.4 6580.6 6788.4 6873.7 6888.6 6893.2 6427.5 6430.1 6436.6 6443.8 6448.3 30880.8 31578.7 31633.2 31636.4 31662.0 2240.3 2254.6 2284.2 2285.7 2293.0 20610.6 21403.9 21437.0 21474.0 21478.9 2497.9 2551.3 2597.4 2599.1 2601.1 135980.3 142961.0 143234.0 149367.0 159424.2 16268.6 16520.3 17098.7 17239.5 17556.8 26996.9 27192.0 27216.2 27251.2 27257.7 10761.9 10963.7 10985.5 11036.4 11100.2 9859.7 9928.7 10010.9 10113.2 10132.9 9905.6 9954.8 10161.2 10184.2 10342.7 2883.2 2933.4 2934.2 2934.2 2990.9 1037.8 1044.6 1047.7 1053.8 1056.4 22224.6 22326.2 22354.9 22438.4 22725.5 1090.1 1096.8 1105.1 1105.5 1106.9 12006.5 12207.3 12258.2 12304.4 12469.3 605593.0 610799.0 618518.0 624343.0 633122.0 132767.3 134197.3 136547.3 136583.3 137247.0 1203.8 1205.7 1237.2 1241.1 1242.2 19124.5 19258.5 19374.1 19376.4 19529.7 62783.4 63222.4 63844.0 64003.0 64938.7 83631.0 83918.0 83961.0 84597.6 86140.6 16091.9 16569.3 16580.7 16714.7 16740.1 24966.5 25052.2 25115.6 25143.9 25163.0 20531.3 20760.5 20773.5 21060.3 21107.8 17770.2 17982.9 18506.5 18561.6 19037.8 20724.0 21067.0 21374.9 21404.3 21575.6 15946.7 16117.7 16134.7 16147.2 16225.2 19167.3 19244.8 19270.3 19301.4 19432.7 08:05:55 INFO - PID 16378 | 08:05:55 INFO - PID 16378 | [#3] mootools.html Cycles:180 Average:10266.16 Median:2641.98 stddev:7866.49 (297.7%) stddev-sans-first:7860.56 08:05:55 INFO - PID 16378 | Values: 1431.2 1468.5 1481.5 1496.8 1502.7 16997.0 17629.9 17638.1 17647.3 17651.8 17187.1 17351.7 17352.5 17366.1 17408.1 2702.9 2728.1 2734.7 2742.5 2742.6 2552.5 2635.4 2638.6 2641.7 2643.9 2611.7 2620.2 2645.9 2683.7 2700.4 2659.8 2703.0 2704.1 2706.5 2709.8 2642.3 2683.6 2684.0 2686.3 2706.8 16220.9 16376.3 16652.8 16654.9 16672.6 8126.4 8424.0 8426.7 8434.8 8438.2 5358.2 5571.6 5581.0 5703.3 5734.4 2115.4 2144.1 2161.3 2220.1 2230.1 30465.4 31046.2 31060.1 31078.0 31123.7 7077.5 7193.5 7266.9 7390.2 7425.7 19509.8 19936.6 19970.8 23577.3 23639.9 8048.0 8261.7 8270.4 8283.5 8295.0 7243.7 7345.1 7530.2 7586.7 7712.9 5719.1 5801.2 5815.9 5832.6 6059.6 1565.4 1630.4 1640.2 1645.3 1658.9 789.0 806.9 812.9 817.7 837.6 7869.9 7890.6 7936.0 7949.9 7964.8 759.8 790.1 790.8 795.0 798.6 4432.7 5143.5 5403.9 5683.7 5727.6 24202.6 24431.0 25353.5 25375.2 25398.0 25342.9 25488.4 25753.6 25803.6 25835.1 11548.8 12011.7 12172.8 12464.8 12529.6 8835.3 9124.4 9190.7 9218.0 9283.0 20759.0 20769.2 20881.3 20998.4 21136.0 21351.0 21532.8 21604.7 21726.7 21802.8 12368.6 12407.6 12412.2 12525.6 12566.6 14855.2 14915.9 14949.2 14956.8 14958.6 11088.6 11112.7 11124.8 11366.8 11366.8 10551.7 10586.8 10821.3 10857.2 11080.9 10128.8 10187.2 10232.0 10247.9 10254.5 7747.4 7842.7 7854.2 7885.1 7939.2 7654.0 7863.3 7915.2 7920.4 7960.4 08:05:55 INFO - PID 16378 | 08:05:55 INFO - PID 16378 | [#4] prototype.html Cycles:180 Average:5591.85 Median:6195.47 stddev:1555.09 (25.1%) stddev-sans-first:1512.92 08:05:55 INFO - PID 16378 | Values: 561.3 571.7 579.9 589.6 591.8 6184.5 6232.5 6233.8 6294.3 6294.6 6075.3 6229.0 6235.4 6243.2 6288.2 4896.3 4970.0 5054.4 5065.8 5079.4 5000.6 5026.5 5033.0 5037.1 5041.5 4902.2 4939.5 4942.7 4945.6 4946.8 4907.8 4978.0 5010.2 5014.1 5022.5 4556.2 4575.8 4595.6 4596.8 4609.4 6003.4 6050.3 6122.9 6145.9 6261.3 5786.5 5796.3 5801.2 5859.2 5897.3 6538.4 6569.4 6603.5 6620.0 6631.6 4813.8 5049.7 5057.8 5071.4 5091.7 6668.1 6784.5 6887.4 6929.8 6947.8 5163.0 5179.7 5200.9 5211.0 5215.6 5237.0 5269.3 5276.3 5284.3 5313.2 5869.5 5870.5 5883.6 5892.6 5906.9 6652.9 6661.5 6687.6 6730.0 6741.2 1791.3 1804.9 1807.9 1808.1 1816.3 1224.0 1237.1 1259.9 1272.9 1276.4 6045.5 6052.8 6082.4 6093.2 6136.6 6504.9 6528.9 6594.2 6662.2 6685.6 5892.6 5998.3 6077.7 6107.3 6112.1 3426.9 3461.7 3465.5 3474.7 3509.4 6757.9 6831.3 6901.2 6933.9 6936.2 6706.3 6782.8 6812.6 6843.1 6871.6 6944.5 6967.5 6997.1 7005.4 7009.3 6723.6 6731.0 6743.3 6764.1 6765.4 6562.6 6582.5 6603.6 6632.3 6677.5 6736.4 6777.3 6888.6 6908.2 6978.5 5145.4 5150.6 5159.6 5183.3 5202.0 6442.4 6593.0 6624.0 6628.6 6638.0 6206.5 6426.4 6460.7 6484.5 6530.4 6463.5 6517.0 6520.1 6525.2 6528.5 6403.4 6450.6 6488.2 6526.6 6579.7 6551.9 6557.3 6578.8 6640.5 6684.4 6310.8 6337.2 6388.7 6414.9 6415.5 08:05:55 INFO - PID 16378 | 08:05:55 INFO - PID 16378 | [#5] yui.html Cycles:180 Average:28328.81 Median:18449.08 stddev:42673.93 (231.3%) stddev-sans-first:42743.95 08:05:55 INFO - PID 16378 | Values: 901.3 943.2 947.4 961.5 991.1 18420.8 19033.3 19144.3 19159.4 19261.5 15511.9 15540.5 15565.9 17215.8 17566.3 1048.9 1061.2 1063.4 1063.6 1065.9 1083.4 1085.3 1086.5 1087.3 1087.8 1080.7 1109.9 1117.8 1119.0 1124.8 1110.4 1113.9 1114.0 1114.1 1115.8 796.0 813.6 818.7 819.3 822.9 18612.7 18840.1 18902.5 18906.9 18913.8 22358.3 22559.4 22865.8 23000.4 23037.4 17609.1 17774.6 17814.6 17839.5 17930.1 3913.6 3939.1 3940.0 3940.9 3942.8 154966.0 156559.2 156902.0 160894.0 162812.0 17135.8 17182.0 17263.6 17296.8 17381.3 31630.8 31889.4 31904.4 31918.4 31925.5 8671.3 8709.0 8757.6 8801.3 8807.1 4454.3 4469.9 4470.2 4479.7 4491.3 5256.8 5282.0 5330.2 5336.2 5363.4 1102.1 1118.6 1127.6 1131.7 1131.8 677.7 695.6 696.6 701.9 707.0 11760.6 11987.6 12274.3 12520.6 13136.2 695.5 698.7 703.3 705.5 710.3 5600.9 5600.9 5611.3 5674.3 5721.9 147609.3 147675.0 150345.2 153238.0 154942.0 126094.4 127727.0 130023.0 132128.3 137032.0 111507.0 111868.4 111935.0 112505.0 117330.4 12486.8 12798.7 12970.9 13089.7 13200.1 50662.5 52534.5 52583.7 53241.5 54159.2 65359.3 78707.6 95269.5 97251.5 101274.0 18357.0 18610.5 18866.4 18899.3 18940.3 17869.6 18047.9 18177.7 21154.2 21167.0 18153.2 18259.7 18477.4 18518.0 18672.3 19091.1 19127.5 19188.7 19420.9 19472.7 17248.7 17451.5 17901.7 19193.9 19329.4 12708.8 13289.9 13436.8 13566.3 13579.2 13074.3 13625.7 14020.6 14079.4 14094.9 08:05:55 INFO - PID 16378 | -------- Summary: end -------- 08:05:55 INFO - PID 16378 | 08:05:55 INFO - TEST-INFO | 16378: exit 0 08:05:55 INFO - TEST-OK | dromaeo_css | took 1109716ms 08:05:55 INFO - TEST-START | kraken 08:05:55 INFO - Initialising browser for kraken test... 08:05:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39057/getInfo.html -profile /tmp/tmpJPH5f4/profile 08:05:56 INFO - TEST-INFO | started process 16752 (/builds/slave/test/build/application/firefox/firefox http://localhost:39057/getInfo.html) 08:06:01 INFO - TEST-INFO | 16752: exit 0 08:06:02 INFO - Browser initialized. 08:06:02 INFO - Running cycle 1/1 for kraken test... 08:06:02 INFO - Using env: {'DISPLAY': ':0', 08:06:02 INFO - 'HOME': '/home/cltbld', 08:06:02 INFO - 'JSGC_DISABLE_POISONING': '1', 08:06:02 INFO - 'LANG': 'en_US.UTF-8', 08:06:02 INFO - 'LANGUAGE': 'en_US:en', 08:06:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:06:02 INFO - 'LOGNAME': 'cltbld', 08:06:02 INFO - 'MAIL': '/var/mail/cltbld', 08:06:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:06:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:06:02 INFO - 'MOZ_CRASHREPORTER': '1', 08:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:06:02 INFO - 'MOZ_NO_REMOTE': '1', 08:06:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:02 INFO - 'NO_EM_RESTART': '1', 08:06:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:02 INFO - 'PWD': '/builds/slave/test', 08:06:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:06:02 INFO - 'RUST_BACKTRACE': 'full', 08:06:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:06:02 INFO - 'SHELL': '/bin/bash', 08:06:02 INFO - 'SHLVL': '1', 08:06:02 INFO - 'TERM': 'linux', 08:06:02 INFO - 'TMOUT': '86400', 08:06:02 INFO - 'USER': 'cltbld', 08:06:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337', 08:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:02 INFO - '_': '/tools/buildbot/bin/python'} 08:06:02 INFO - TEST-INFO | started process 16985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJPH5f4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:02 INFO - PID 16985 | 08:06:02 INFO - PID 16985 | (/builds/slave/test/build/application/firefox/firefox:17034): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:06:02 INFO - PID 16985 | 08:06:13 INFO - PID 16985 | RSS: Main: 144056320 08:06:13 INFO - PID 16985 | 08:06:15 INFO - PID 16985 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39057/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:16 INFO - PID 16985 | RSS: Main: 149639168 08:06:16 INFO - PID 16985 | 08:06:19 INFO - PID 16985 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39057/tests/kraken/driver.html?testName=audio-dft) 08:06:19 INFO - PID 16985 | RSS: Main: 149602304 08:06:19 INFO - PID 16985 | 08:06:22 INFO - PID 16985 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39057/tests/kraken/driver.html?testName=audio-fft) 08:06:23 INFO - PID 16985 | RSS: Main: 146366464 08:06:23 INFO - PID 16985 | 08:06:25 INFO - PID 16985 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39057/tests/kraken/driver.html?testName=audio-oscillator) 08:06:25 INFO - PID 16985 | RSS: Main: 147546112 08:06:25 INFO - PID 16985 | 08:06:27 INFO - PID 16985 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39057/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:06:28 INFO - PID 16985 | RSS: Main: 147746816 08:06:28 INFO - PID 16985 | 08:06:31 INFO - PID 16985 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39057/tests/kraken/driver.html?testName=imaging-darkroom) 08:06:32 INFO - PID 16985 | RSS: Main: 147673088 08:06:32 INFO - PID 16985 | 08:06:35 INFO - PID 16985 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39057/tests/kraken/driver.html?testName=imaging-desaturate) 08:06:36 INFO - PID 16985 | RSS: Main: 148697088 08:06:36 INFO - PID 16985 | 08:06:39 INFO - PID 16985 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39057/tests/kraken/driver.html?testName=json-parse-financial) 08:06:39 INFO - PID 16985 | RSS: Main: 150147072 08:06:39 INFO - PID 16985 | 08:06:41 INFO - PID 16985 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39057/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:06:42 INFO - PID 16985 | RSS: Main: 149921792 08:06:42 INFO - PID 16985 | 08:06:43 INFO - PID 16985 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:06:44 INFO - PID 16985 | RSS: Main: 150171648 08:06:44 INFO - PID 16985 | 08:06:46 INFO - PID 16985 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:06:46 INFO - PID 16985 | RSS: Main: 149954560 08:06:46 INFO - PID 16985 | 08:06:49 INFO - PID 16985 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:06:49 INFO - PID 16985 | RSS: Main: 150298624 08:06:49 INFO - PID 16985 | 08:06:52 INFO - PID 16985 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:06:53 INFO - PID 16985 | RSS: Main: 150417408 08:06:53 INFO - PID 16985 | 08:06:54 INFO - PID 16985 | Cycle 1(1): loaded http://localhost:39057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39057/tests/kraken/driver.html?testName=ai-astar) 08:06:55 INFO - PID 16985 | RSS: Main: 152227840 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | __start_tp_report 08:06:55 INFO - PID 16985 | _x_x_mozilla_page_load 08:06:55 INFO - PID 16985 | _x_x_mozilla_page_load_details 08:06:55 INFO - PID 16985 | |i|pagename|runs| 08:06:55 INFO - PID 16985 | |0;ai-astar;106;105;105;104;105;107;106;105;104;107 08:06:55 INFO - PID 16985 | |1;audio-beat-detection;113;113;115;110;110;112;111;137;118;113 08:06:55 INFO - PID 16985 | |2;audio-dft;161;162;162;164;161;162;162;166;163;167 08:06:55 INFO - PID 16985 | |3;audio-fft;75;75;74;74;72;74;73;73;74;75 08:06:55 INFO - PID 16985 | |4;audio-oscillator;79;79;78;78;78;78;79;78;78;78 08:06:55 INFO - PID 16985 | |5;imaging-gaussian-blur;113;113;114;115;113;114;114;114;115;114 08:06:55 INFO - PID 16985 | |6;imaging-darkroom;149;151;151;149;150;151;150;150;151;150 08:06:55 INFO - PID 16985 | |7;imaging-desaturate;95;95;94;94;93;94;94;94;95;94 08:06:55 INFO - PID 16985 | |8;json-parse-financial;43;44;43;45;50;43;46;45;43;44 08:06:55 INFO - PID 16985 | |9;json-stringify-tinderbox;36;36;42;36;37;37;36;41;37;36 08:06:55 INFO - PID 16985 | |10;stanford-crypto-aes;72;76;70;69;69;70;71;70;69;69 08:06:55 INFO - PID 16985 | |11;stanford-crypto-ccm;110;104;110;109;107;106;110;110;104;106 08:06:55 INFO - PID 16985 | |12;stanford-crypto-pbkdf2;154;147;146;151;152;148;152;163;149;155 08:06:55 INFO - PID 16985 | |13;stanford-crypto-sha256-iterative;61;63;68;59;60;66;64;59;59;63 08:06:55 INFO - PID 16985 | __end_tp_report 08:06:55 INFO - PID 16985 | __start_cc_report 08:06:55 INFO - PID 16985 | _x_x_mozilla_cycle_collect,720 08:06:55 INFO - PID 16985 | __end_cc_report 08:06:55 INFO - PID 16985 | __startTimestamp1506006415135__endTimestamp 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | ------- Summary: start ------- 08:06:55 INFO - PID 16985 | Number of tests: 14 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | [#0] ai-astar Cycles:10 Average:105.40 Median:105.50 stddev:1.07 (1.0%) stddev-sans-first:1.12 08:06:55 INFO - PID 16985 | Values: 106.0 105.0 105.0 104.0 105.0 107.0 106.0 105.0 104.0 107.0 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | [#1] audio-beat-detection Cycles:10 Average:115.20 Median:113.00 stddev:8.02 (7.1%) stddev-sans-first:8.47 08:06:55 INFO - PID 16985 | Values: 113.0 113.0 115.0 110.0 110.0 112.0 111.0 137.0 118.0 113.0 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:2.05 (1.3%) stddev-sans-first:2.05 08:06:55 INFO - PID 16985 | Values: 161.0 162.0 162.0 164.0 161.0 162.0 162.0 166.0 163.0 167.0 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | [#3] audio-fft Cycles:10 Average:73.90 Median:74.00 stddev:0.99 (1.3%) stddev-sans-first:0.97 08:06:55 INFO - PID 16985 | Values: 75.0 75.0 74.0 74.0 72.0 74.0 73.0 73.0 74.0 75.0 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | [#4] audio-oscillator Cycles:10 Average:78.30 Median:78.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 08:06:55 INFO - PID 16985 | Values: 79.0 79.0 78.0 78.0 78.0 78.0 79.0 78.0 78.0 78.0 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 08:06:55 INFO - PID 16985 | Values: 113.0 113.0 114.0 115.0 113.0 114.0 114.0 114.0 115.0 114.0 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.50 stddev:0.79 (0.5%) stddev-sans-first:0.71 08:06:55 INFO - PID 16985 | Values: 149.0 151.0 151.0 149.0 150.0 151.0 150.0 150.0 151.0 150.0 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 08:06:55 INFO - PID 16985 | Values: 95.0 95.0 94.0 94.0 93.0 94.0 94.0 94.0 95.0 94.0 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | [#8] json-parse-financial Cycles:10 Average:44.60 Median:44.50 stddev:2.17 (4.9%) stddev-sans-first:2.22 08:06:55 INFO - PID 16985 | Values: 43.0 44.0 43.0 45.0 50.0 43.0 46.0 45.0 43.0 44.0 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | [#9] json-stringify-tinderbox Cycles:10 Average:37.40 Median:37.00 stddev:2.22 (6.0%) stddev-sans-first:2.30 08:06:55 INFO - PID 16985 | Values: 36.0 36.0 42.0 36.0 37.0 37.0 36.0 41.0 37.0 36.0 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | [#10] stanford-crypto-aes Cycles:10 Average:70.50 Median:70.00 stddev:2.17 (3.1%) stddev-sans-first:2.24 08:06:55 INFO - PID 16985 | Values: 72.0 76.0 70.0 69.0 69.0 70.0 71.0 70.0 69.0 69.0 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | [#11] stanford-crypto-ccm Cycles:10 Average:107.60 Median:109.50 stddev:2.50 (2.3%) stddev-sans-first:2.50 08:06:55 INFO - PID 16985 | Values: 110.0 104.0 110.0 109.0 107.0 106.0 110.0 110.0 104.0 106.0 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.70 Median:152.00 stddev:4.95 (3.3%) stddev-sans-first:5.17 08:06:55 INFO - PID 16985 | Values: 154.0 147.0 146.0 151.0 152.0 148.0 152.0 163.0 149.0 155.0 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:63.00 stddev:3.16 (5.0%) stddev-sans-first:3.32 08:06:55 INFO - PID 16985 | Values: 61.0 63.0 68.0 59.0 60.0 66.0 64.0 59.0 59.0 63.0 08:06:55 INFO - PID 16985 | -------- Summary: end -------- 08:06:55 INFO - PID 16985 | 08:06:55 INFO - PID 16985 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:06:56 INFO - TEST-INFO | 16985: exit 0 08:06:56 INFO - TEST-OK | kraken | took 60143ms 08:06:56 INFO - SUITE-END | took 1169s 08:06:56 INFO - Completed test suite (00:19:30) 08:06:56 INFO - javascript benchmark 08:06:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9052.08666245869, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3881.3789793633014, 3916.686665066794, 3919.118198405359, 3925.9803700981493, 3931.997340678127, 6187.69061546922, 6234.0, 6287.37126287371, 6327.272363678178, 6342.0803983422375, 6316.715747791349, 6318.589291696048, 6318.715657795398, 6319.431251187392, 6335.334789847069, 5611.775528978836, 5616.9157462638095, 5659.264295641561, 5731.570132240098, 5769.105788602773, 5676.290463692038, 5678.091505359143, 5750.223719797837, 5768.826935191951, 5786.247787787582, 5484.561235101182, 5626.381098079208, 5691.74387152577, 5776.480116789488, 5792.044312688401, 5164.147915593922, 5639.125935480007, 5700.030994730864, 5727.713614319309, 5736.196932429463, 5620.971895140498, 5637.577181711347, 5672.205891175238, 5680.829575112753, 5688.232088668018, 6214.906776398358, 6227.221597300338, 6253.37466253371, 6255.24937007562, 6268.216472940882, 6845.247022827485, 6852.383285504278, 6864.039034535169, 6874.690638921211, 6892.207396149457, 6841.794746157623, 6850.0, 6919.965400173017, 6940.13248343957, 6949.5830250184645, 6231.158793562857, 6302.779402720883, 6349.0, 6361.236651601837, 6444.581102228341, 6910.827229319308, 6916.0, 6919.4464442844455, 6929.514933954676, 6977.33715297046, 6708.094407254958, 6722.630255336004, 6787.21946976104, 6797.52417330792, 6814.1482314710665, 6848.794536163923, 6859.588424694534, 6875.896861547081, 6905.1713794345, 6952.93047069533, 6671.032700258435, 6745.325467453314, 6776.220734615484, 6780.457563394916, 6780.660966951633, 6763.458923286125, 6792.45660347171, 6806.829829254309, 6835.384815366641, 6838.14523184602, 4955.90088198234, 5021.49785021495, 5023.924641130386, 5029.673071250357, 5041.924371134436, 4487.035287413157, 4579.198640237945, 4581.175388430048, 4623.329617205486, 4643.0, 6300.684965751694, 6343.524235682342, 6363.172787537591, 6369.617822930639, 6378.298387177407, 6683.899741503881, 6782.796516104525, 6784.185897692209, 6796.592204467748, 6799.796006119825, 6311.147995020613, 6315.905261421082, 6327.778527751507, 6383.39357761012, 6388.977763557808, 5566.860828479239, 5568.276124103922, 5588.469095435927, 5594.300712410949, 5594.916076258859, 7049.259827718119, 7051.259617740166, 7060.54106483077, 7156.355927966404, 7163.925411188364, 6710.597364157971, 6794.252632210354, 6800.557963732342, 6805.455563555002, 6888.483363747739, 6890.379865812101, 7002.2297547268745, 7013.3337332955325, 7022.789316320519, 7025.754098606524, 6759.493038022267, 6786.049953006682, 6787.151606049244, 6805.625690587065, 6809.353111454404, 6845.726170953305, 6876.415504682158, 6902.896456553256, 6903.792886213421, 6926.826829329307, 6591.143151390289, 6598.406143447113, 6676.699548520425, 6691.631960242039, 6699.832504187434, 6426.967865160645, 6531.379518945692, 6539.771108011197, 6601.9009714853355, 6643.56816806906, 6565.310642382481, 6570.704318305592, 6571.047198156336, 6575.934240657723, 6581.967090164519, 6664.400203981665, 6716.865662686621, 6718.496112791462, 6734.528582999143, 6758.763443279461, 6349.8730025400155, 6429.7428102875365, 6459.838504037437, 6481.319461456667, 6544.934550654432], "value": 6238.983967597902, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [966.1497881863961, 968.2254196642684, 989.0406305883293, 1002.0981116994708, 1017.6692574913151, 43952.3407148893, 44671.32993005108, 44715.77642111793, 44727.552724472785, 44782.552174478245, 41384.37923431151, 41984.790076049656, 42036.78981605088, 42041.369379459335, 42048.36927446091, 7623.0, 7782.027246594176, 7795.14253432122, 7812.414068944823, 7822.882656760153, 7659.578723170223, 7753.418493612973, 7770.184130666284, 7773.7279195228175, 7782.182870798541, 8328.916710832906, 8608.569571521399, 8613.61238744258, 8617.61220745065, 8618.956905215466, 8417.831643367099, 8443.704470343539, 8444.113368096385, 8464.788380290542, 8475.406721529496, 7774.611269436506, 7982.042154941386, 7998.160193179749, 8005.719799806979, 8353.37349698775, 40846.591534084575, 41198.794006030075, 41236.38145427821, 41252.587474125474, 41316.0, 3624.5650521937537, 3669.4679271505747, 3671.394219953731, 3672.2288319452946, 3672.6694597486353, 33500.162495937795, 33624.0, 33646.0, 33659.15852103692, 33661.495077573854, 5309.123994540896, 5332.733363331818, 5354.196870469422, 5366.356037275513, 5431.293931788881, 220905.0, 221763.0, 222141.0, 222395.0, 223279.8836005842, 51971.22043169355, 51982.48017519852, 52130.21804672933, 54633.1805022925, 55760.16359754607, 57201.71399142977, 57610.423895760505, 57701.42298577044, 57741.0, 57757.13364299539, 16899.15504224784, 16981.150942452827, 17093.401730939608, 17151.313947441962, 17177.31290748381, 13735.725285494234, 13801.309934503435, 13885.722285554233, 13922.09506382082, 13937.09408888419, 15789.921050394674, 15887.682246355009, 15910.204489775464, 15926.203689815462, 15942.28259728315, 6104.481119104926, 6205.410486003822, 6268.968655156787, 6273.560850740496, 6316.526260530479, 1107.2636696596835, 1114.6043154680135, 1115.3530952047793, 1121.697141771717, 1132.6771870017005, 25800.74199258021, 26164.215073547824, 26311.342216444744, 26444.206673799818, 26473.073442429424, 1209.4255228766265, 1214.1925619463134, 1226.3500344817262, 1228.6314105768233, 1249.2629348684138, 13883.444662213398, 13897.79153312701, 13941.58175254744, 14084.225367604675, 14122.858771412155, 278690.0, 283269.0, 284401.0, 284914.0, 285878.0, 55513.44486555163, 57696.0, 58518.707406462694, 58848.70575647095, 63034.36965630285, 1534.3095606976906, 1544.0, 1560.4616407339677, 1565.937362505487, 1566.3891082477614, 30881.845590771904, 31035.68964310328, 31134.527713349085, 31534.842325788224, 32198.517022244218, 42195.36706949337, 42619.57380426156, 42653.57346426496, 42699.14601707886, 42780.358294626225, 256656.0, 260440.0, 260936.0, 261225.0, 262476.0, 38539.42190867083, 38652.226955461294, 38794.0, 38915.0, 38918.0, 47222.84686305457, 47402.0, 47456.52543474659, 47630.52369476261, 47769.28346074742, 35745.82127089348, 35961.640383595826, 35969.64030359663, 36021.81989090038, 36155.457668135525, 35336.82331588326, 35385.0, 35449.291014179056, 35492.46761298531, 35626.28747424985, 39442.0, 40665.59334406618, 40926.0, 40954.1809163821, 41103.794481027406, 33607.0, 33972.0, 34160.82919585386, 34409.139771505914, 34932.301353973286, 26139.346516337242, 26474.602880957187, 26779.099142278254, 27111.0, 27131.59302610423], "value": 19010.8003725209, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.1427494370411, 614.9231346081737, 625.3871206217909, 636.106270689681, 655.6688872119579, 22964.196253131144, 23669.0, 23850.0, 23869.641955370684, 23898.40253993651, 26273.73726262737, 27406.5889011665, 27480.450390992217, 27494.45011099777, 27500.862495687492, 6682.799516014503, 6698.531102822804, 6710.630915299645, 6728.091707619482, 6729.629870357128, 6552.213734351884, 6619.30497297784, 6752.291009444011, 6784.0, 6808.523403361766, 6745.089412929266, 6766.289539598345, 6770.7968760937, 6780.186377634691, 6783.355581219801, 6580.638064906429, 6788.355106264897, 6873.690683919235, 6888.621125838077, 6893.241743408246, 6427.453666438359, 6430.0676401921455, 6436.613803171825, 6443.7744678936015, 6448.290688024314, 30880.845595771876, 31578.684213158034, 31633.20916977071, 31636.367272654417, 31662.0, 2240.327901629521, 2254.6054440472853, 2284.223364056212, 2285.6685780561893, 2292.9656055159185, 20610.587788244153, 21403.892980535154, 21437.0, 21474.0, 21478.892605536872, 2497.9250622481354, 2551.349405901502, 2597.402597402608, 2599.129291687287, 2601.115620688975, 135980.32009839985, 142961.0, 143234.0, 149367.0, 159424.20287898602, 16268.593285167966, 16520.256588453547, 17098.658026839392, 17239.482815515556, 17556.824431755773, 26996.86501567519, 27192.0, 27216.183514494598, 27251.182464526097, 27257.727422725915, 10761.946190268998, 10963.684357877106, 10985.450727463754, 11036.448177591088, 11100.222984391015, 9859.654912078044, 9928.702138935843, 10010.949945250228, 10113.190944724405, 10132.949335253425, 9905.58521233366, 9954.751131221778, 10161.18710503158, 10184.185265178769, 10342.741431464123, 2883.235942475246, 2933.4306146211675, 2934.1784300395925, 2934.2370983544433, 2990.8654110565076, 1037.8080055189814, 1044.613493007592, 1047.7171163785736, 1053.8366553184114, 1056.3767377247307, 22224.55550888973, 22326.21858234954, 22354.888225558767, 22438.43903902383, 22725.545489090127, 1090.1170052257696, 1096.7916095941746, 1105.1490352428584, 1105.535675016495, 1106.9225154239286, 12006.519739210335, 12207.267563946192, 12258.20321679088, 12304.384780760925, 12469.314187719763, 605593.0, 610799.0, 618518.0, 624343.0, 633122.0, 132767.3361633205, 134197.32901335627, 136547.31726341305, 136583.31708341592, 137247.0, 1203.8314635950974, 1205.6737588652413, 1237.2020047069589, 1241.0878004666563, 1242.2422322383338, 19124.52188695238, 19258.518537036685, 19374.128164232363, 19376.4187074388, 19529.70705439448, 62783.37216627775, 63222.36777632165, 63844.0, 64003.0, 64938.67530662316, 83631.0, 83918.0, 83961.0, 84597.57701211455, 86140.56929715311, 16091.919540402692, 16569.25438355301, 16580.668386632442, 16714.749278760584, 16740.079295638858, 24966.50066998686, 25052.248432547054, 25115.623265651397, 25143.87428062848, 25162.993480260586, 20531.28140515075, 20760.48098797542, 20773.480662983548, 21060.26289079875, 21107.788922110583, 17770.20034098443, 17982.91008544949, 18506.537336566693, 18561.628767424845, 19037.809621903605, 20724.0, 21067.0, 21374.893125534272, 21404.250851220757, 21575.568488630455, 15946.68106637884, 16117.677646446771, 16134.67730645404, 16147.19264036817, 16225.18874056316, 19167.32914347991, 19244.807551924303, 19270.32553860608, 19301.4209573713, 19432.708509372653], "value": 13096.610049761659, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.2485944878938, 1468.4640106361169, 1481.4518628107594, 1496.7754836774482, 1502.6619010722582, 16997.0, 17629.91185044073, 17638.11809409529, 17647.29410823567, 17651.823481765212, 17187.140642967865, 17351.73972390412, 17352.47942561725, 17366.13169341534, 17408.129593520338, 2702.8513431761244, 2728.058819707198, 2734.740199681027, 2742.492638861807, 2742.5886117082396, 2552.540542702313, 2635.3806855388966, 2638.6437830892773, 2641.6565846439935, 2643.9339016524646, 2611.660484137069, 2620.1746449868324, 2645.9206223813317, 2683.7047924728363, 2700.4194098268867, 2659.8138130330885, 2703.04042065068, 2704.148193319098, 2706.512827691015, 2709.810313278081, 2642.3129986203726, 2683.570628699418, 2684.033747850772, 2686.2881336445857, 2706.7563919247364, 16220.918895405566, 16376.344946202138, 16652.83347166525, 16654.916725416417, 16672.58318542034, 8126.39052071097, 8424.0, 8426.662933482654, 8434.78913027173, 8438.240558349717, 5358.169483730028, 5571.609987300891, 5580.972095139539, 5703.31560212773, 5734.369219385864, 2115.428834214769, 2144.1209104267177, 2161.329987703801, 2220.078667353063, 2230.107956817286, 30465.390692186254, 31046.223844403845, 31060.068197954097, 31078.0, 31123.688763112306, 7077.504574679723, 7193.496455248082, 7266.854662906712, 7390.224026477143, 7425.740099096613, 19509.804901951084, 19936.601267974558, 19970.800291996893, 23577.29268121959, 23639.881800590887, 8048.0, 8261.710840120568, 8270.421070525126, 8283.461574997606, 8294.958525207456, 7243.74646887367, 7345.081864766904, 7530.171681115073, 7586.696532138763, 7712.884306735404, 5719.056355701346, 5801.216835727208, 5815.88368232633, 5832.62087964281, 6059.636421814617, 1565.3582031367084, 1630.4130513015305, 1640.2045008171267, 1645.3418632547077, 1658.8589969852699, 788.9526628402314, 806.9370718432664, 812.9430939834155, 817.6933649881295, 837.5853952293531, 7869.921300786918, 7890.566018869017, 7936.047674279123, 7949.880751788728, 7964.840703185904, 759.783461713409, 790.1229635105029, 790.7588185603331, 795.0459448661513, 798.6206551887923, 4432.667549933768, 5143.5113664201845, 5403.945960540423, 5683.715814209273, 5727.627704199213, 24202.63696044561, 24431.0, 25353.492930141292, 25375.238742837377, 25398.0, 25342.873285633454, 25488.362790930005, 25753.61369579458, 25803.612945805828, 25835.095771647902, 11548.826767598493, 12011.699707507381, 12172.81740773889, 12464.750704985849, 12529.561465348668, 8835.337349698926, 9124.406913550598, 9190.724278271662, 9217.953910230674, 9283.0, 20759.0, 20769.169233231107, 20881.26915557948, 20998.370048898556, 21136.048877800844, 21351.0, 21532.784672153077, 21604.703717776985, 21726.674099888198, 21802.781972180073, 12368.567100151451, 12407.565735199585, 12412.193207441487, 12525.56160534377, 12566.560170393992, 14855.182964937032, 14915.85084149188, 14949.177795220932, 14956.775648365501, 14958.551243462714, 11088.611898583511, 11112.666620001413, 11124.833127503256, 11366.829497557377, 11366.829497557708, 10551.736206594896, 10586.8411973822, 10821.296615719953, 10857.185711071543, 11080.889191107986, 10128.84806727885, 10187.235957303084, 10232.0, 10247.948760256151, 10254.538545765608, 7747.380209583107, 7842.72550460754, 7854.1753115922, 7885.093214280431, 7939.245771651684, 7654.0, 7863.292303692695, 7915.248051435105, 7920.445568810128, 7960.363170946426], "value": 7056.637117447266, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.3292115921475, 571.6512927114461, 579.9043157878945, 589.631480324797, 591.7839988404232, 6184.474319682827, 6232.48145094806, 6233.844153896155, 6294.276158241803, 6294.622322660638, 6075.301340345862, 6228.968855155718, 6235.376462353763, 6243.157173781549, 6288.213973253343, 4896.338994235786, 4969.950300497003, 5054.368203974504, 5065.772040258197, 5079.4412614612365, 5000.5999520038495, 5026.472220416858, 5032.9748351258195, 5037.093323201822, 5041.495850414965, 4902.166631672606, 4939.456659767441, 4942.739601401638, 4945.579625731799, 4946.802127914879, 4907.82822601209, 4978.0, 5010.248462730583, 5014.147594908838, 5022.522860328263, 4556.157110934488, 4575.839845605421, 4595.564350894031, 4596.839110631146, 4609.354690343354, 6003.369646187175, 6050.273967123973, 6122.938770612282, 6145.941109728246, 6261.342559031327, 5786.508146807527, 5796.333421656479, 5801.158831969341, 5859.150423188614, 5897.262842144732, 6538.378854008862, 6569.408753212234, 6603.504737144734, 6620.0, 6631.635260060695, 4813.831515896927, 5049.722265275408, 5057.822976195852, 5071.427857364229, 5091.694498330112, 6668.09937677112, 6784.491163162733, 6887.449004079662, 6929.782469609727, 6947.756828511028, 5162.993216322781, 5179.715115668599, 5200.895982080413, 5210.97394513025, 5215.608829337815, 5236.9738151309, 5269.262303277545, 5276.287701160371, 5284.286621306152, 5313.1764576490705, 5869.5010924071075, 5870.471657550841, 5883.588148829626, 5892.616979896293, 5906.8651943639625, 6652.933470665232, 6661.500387470862, 6687.565308254948, 6730.0, 6741.224759152662, 1791.265581111738, 1804.864635152369, 1807.9367222147162, 1808.095952023988, 1816.309802275127, 1223.9632811015683, 1237.0845574274972, 1259.9307038112993, 1272.8854403103765, 1276.425608476171, 6045.455908968214, 6052.818415447544, 6082.391760823971, 6093.2078829751845, 6136.570440069152, 6504.934950650528, 6528.869422611616, 6594.153636981653, 6662.200535935622, 6685.598864068172, 5892.587518873637, 5998.280206375263, 6077.665728384981, 6107.297660769068, 6112.113743507255, 3426.9143271418416, 3461.671141241578, 3465.5321531593418, 3474.739394545419, 3509.403401421713, 6757.898631520531, 6831.316868313129, 6901.240863505011, 6933.93066069343, 6936.237013928464, 6706.26231114577, 6782.830429239309, 6812.649635875615, 6843.144606924135, 6871.553349032297, 6944.5346901851135, 6967.54710943787, 6997.1253593300835, 7005.439564834903, 7009.264027277164, 6723.562968407038, 6730.966345168439, 6743.325667433218, 6764.053032575345, 6765.42493888025, 6562.606243625398, 6582.539222254396, 6603.636799976048, 6632.270450250565, 6677.532572719863, 6736.393724564813, 6777.322267773183, 6888.552244104118, 6908.2400935896, 6978.47661425385, 5145.4340022598235, 5150.587952963679, 5159.561437277874, 5183.300254465599, 5201.971231219752, 6442.387973142544, 6593.0, 6623.966880165568, 6628.635425051669, 6638.0, 6206.472449841814, 6426.389492998158, 6460.709268082854, 6484.5460817742305, 6530.379613936669, 6463.547551671338, 6516.967415162894, 6520.119783829123, 6525.1517302750335, 6528.543001990005, 6403.367141378919, 6450.580712253689, 6488.221413430229, 6526.608403495806, 6579.671016449254, 6551.934480655133, 6557.344265573404, 6578.80263592093, 6640.468762499085, 6684.43182329488, 6310.842228944313, 6337.176167098432, 6388.6583817397, 6414.903776443264, 6415.454686351713], "value": 5146.602523955965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.3150005995442, 943.1558754914356, 947.422072535753, 961.4519723757459, 991.0981007283372, 18420.815791842077, 19033.333833315835, 19144.329948451807, 19159.42521724347, 19261.518462038457, 15511.922440387782, 15540.53378398647, 15565.92217038916, 17215.82784172158, 17566.29734810609, 1048.8636477257965, 1061.2040969273007, 1063.4204358624568, 1063.5905176507063, 1065.8934106589356, 1083.3987137138886, 1085.2837127495854, 1086.4784903246446, 1087.2986923434419, 1087.7933192693401, 1080.7082087836318, 1109.8668159820834, 1117.8379135025416, 1119.0040863631375, 1124.791913496006, 1110.4114819145866, 1113.9387333696643, 1114.0363585498567, 1114.0864491117286, 1115.782422427631, 795.9761207163795, 813.5566116466481, 818.7298191596818, 819.3240576524331, 822.8560001999685, 18612.720809187736, 18840.05799710009, 18902.52743681419, 18906.905465472722, 18913.810861891343, 22358.329250122522, 22559.436014099778, 22865.77134228653, 23000.42498937523, 23037.424064398358, 17609.119544022877, 17774.644507109915, 17814.55463613407, 17839.46481605554, 17930.103494825336, 3913.6477717005605, 3939.113699417637, 3939.980300098481, 3940.8817735467983, 3942.8028598570245, 154966.0, 156559.21720391326, 156902.0, 160894.0, 162812.0, 17135.828641713673, 17182.0, 17263.56841078958, 17296.827031729772, 17381.304747810198, 31630.841845790623, 31889.362212755615, 31904.361912761615, 31918.361632767213, 31925.52111718326, 8671.262942649819, 8708.95645521781, 8757.56212189388, 8801.339899507562, 8807.075257097913, 4454.309582014793, 4469.932951005738, 4470.173017991682, 4479.731216127043, 4491.258942274553, 5256.816011439658, 5281.973590132102, 5330.200469929541, 5336.17289320156, 5363.383210930715, 1102.0522350778324, 1118.6028959719345, 1127.6053381316474, 1131.728385187549, 1131.7679875625477, 677.678102901118, 695.5583204665074, 696.5576858694766, 701.9052427922165, 707.0419581467141, 11760.647180584596, 11987.580434684744, 12274.324912129918, 12520.624381268577, 13136.211827290394, 695.5061906046662, 698.7205117952859, 703.2756261051023, 705.5413980912448, 710.3216428310951, 5600.915986260209, 5600.943990560124, 5611.3266408031295, 5674.319081710139, 5721.885562288814, 147609.26195368954, 147675.0, 150345.2482737601, 153238.0, 154942.0, 126094.3695281536, 127727.0, 130023.0, 132128.3393583026, 137032.0, 111507.0, 111868.44065779619, 111935.0, 112505.0, 117330.41334793271, 12486.750264994831, 12798.744025119258, 12970.870291296966, 13089.672758181121, 13200.075994680281, 50662.49337506578, 52534.47465525296, 52583.73708131435, 53241.4675853252, 54159.18761218506, 65359.346406535326, 78707.60646196733, 95269.5236523813, 97251.51374243083, 101274.0, 18357.0, 18610.534736631693, 18866.434006979813, 18899.29906308439, 18940.3370882024, 17869.642607147525, 18047.909760451115, 18177.727334089734, 21154.15383384709, 21167.0, 18153.183106759963, 18259.726104108184, 18477.35329263523, 18518.0, 18672.346467873558, 19091.140898659873, 19127.52181195481, 19188.712169317194, 19420.902895485433, 19472.707909381654, 17248.655026899643, 17451.47645570635, 17901.73147402816, 19193.90403047976, 19329.4201173965, 12708.809367859674, 13289.933550332187, 13436.798448023092, 13566.321683915567, 13579.185248885098, 13074.346282685638, 13625.659358516117, 14020.579382618538, 14079.436822526985, 14094.929525352307], "value": 9751.522510544095, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1368.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 105.0, 104.0, 105.0, 107.0, 106.0, 105.0, 104.0, 107.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 115.0, 110.0, 110.0, 112.0, 111.0, 137.0, 118.0, 113.0], "value": 115.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 164.0, 161.0, 162.0, 162.0, 166.0, 163.0, 167.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 74.0, 72.0, 74.0, 73.0, 73.0, 74.0, 75.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 78.0, 78.0, 79.0, 78.0, 78.0, 78.0], "value": 78.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 115.0, 113.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 151.0, 149.0, 150.0, 151.0, 150.0, 150.0, 151.0, 150.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 43.0, 45.0, 50.0, 43.0, 46.0, 45.0, 43.0, 44.0], "value": 44.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 42.0, 36.0, 37.0, 37.0, 36.0, 41.0, 37.0, 36.0], "value": 37.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 70.0, 69.0, 69.0, 70.0, 71.0, 70.0, 69.0, 69.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 109.0, 107.0, 106.0, 110.0, 110.0, 104.0, 106.0], "value": 107.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 147.0, 146.0, 151.0, 152.0, 148.0, 152.0, 163.0, 149.0, 155.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 68.0, 59.0, 60.0, 66.0, 64.0, 59.0, 59.0, 63.0], "value": 62.2, "unit": "score"}]}]} 08:06:56 INFO - Return code: 0 08:06:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:06:56 INFO - # TBPL SUCCESS # 08:06:56 INFO - Running post-action listener: _package_coverage_data 08:06:56 INFO - Running post-action listener: _resource_record_post_action 08:06:56 INFO - [mozharness: 2017-09-21 15:06:56.435507Z] Finished run-tests step (success) 08:06:56 INFO - Running post-run listener: _resource_record_post_run 08:06:56 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 345391104; Read time: 12; Write time: 612932 08:06:56 INFO - TinderboxPrint: CPU usage
13.1% 08:06:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:06:56 INFO - TinderboxPrint: I/O write bytes / time
345,391,104 / 612,932 08:06:56 INFO - TinderboxPrint: CPU idle
8,231.1 (86.9%) 08:06:56 INFO - TinderboxPrint: CPU user
1,187.9 (12.5%) 08:06:56 INFO - TinderboxPrint: Swap in / out
0 / 0 08:06:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13508608; Read time: 0; Write time: 2884 08:06:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:06:56 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 331882496; Read time: 12; Write time: 610048 08:06:57 INFO - Running post-run listener: _upload_blobber_files 08:06:57 INFO - Blob upload gear active. 08:06:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:06:57 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 08:06:57 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'] 08:06:57 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 08:06:57 INFO - (blobuploader) - INFO - Open directory for files ... 08:06:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:06:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:06:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:07:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:00 INFO - (blobuploader) - INFO - Done attempting. 08:07:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:07:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:07:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:06 INFO - (blobuploader) - INFO - Done attempting. 08:07:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:07:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:07:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:07 INFO - (blobuploader) - INFO - Done attempting. 08:07:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:07:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:07:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:08 INFO - (blobuploader) - INFO - Done attempting. 08:07:08 INFO - (blobuploader) - INFO - Iteration through files over. 08:07:08 INFO - Return code: 0 08:07:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:07:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:07:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/def8b958b7c5ccbb4f808a490197c0b26a1d35201bd969e6a68232d6fdfc16c1b071a3ec4d9099536c7bfcb613ef24b950d3a6902fe3a77eafdc2cc56922b57c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e83628aca40ef41c84fccb46d82cbf827965e57062a8a06cd0ef28b44a62382d68f86854d74ea398c251c3909fa451738badb8ad660a166cffbf8ec492e1f05", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3edab308451f7746437e9425aee22bbfe4763ad7903ccae38ce2d1b8545e6ea4eabcc973114993afeeb71ef95a561b1fffb1803fbdc9ae972768fe1dba524da2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5b7f3e87e324a51ec002ea6751100e664d69d94f304f70715097204bea41c3f24f990dda9d8008a6b4014c9711a363629043d574b55dceaa9b1706b9e9b1be8"} 08:07:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:07:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:07:08 INFO - Contents: 08:07:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/def8b958b7c5ccbb4f808a490197c0b26a1d35201bd969e6a68232d6fdfc16c1b071a3ec4d9099536c7bfcb613ef24b950d3a6902fe3a77eafdc2cc56922b57c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e83628aca40ef41c84fccb46d82cbf827965e57062a8a06cd0ef28b44a62382d68f86854d74ea398c251c3909fa451738badb8ad660a166cffbf8ec492e1f05", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3edab308451f7746437e9425aee22bbfe4763ad7903ccae38ce2d1b8545e6ea4eabcc973114993afeeb71ef95a561b1fffb1803fbdc9ae972768fe1dba524da2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5b7f3e87e324a51ec002ea6751100e664d69d94f304f70715097204bea41c3f24f990dda9d8008a6b4014c9711a363629043d574b55dceaa9b1706b9e9b1be8"} 08:07:08 INFO - Running post-run listener: copy_logs_to_upload_dir 08:07:08 INFO - Copying logs to upload dir... 08:07:08 INFO - mkdir: /builds/slave/test/build/upload/logs 08:07:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.329667 ========= master_lag: 0.81 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-21 08:07:08.776462) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 08:07:08.783943) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/def8b958b7c5ccbb4f808a490197c0b26a1d35201bd969e6a68232d6fdfc16c1b071a3ec4d9099536c7bfcb613ef24b950d3a6902fe3a77eafdc2cc56922b57c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e83628aca40ef41c84fccb46d82cbf827965e57062a8a06cd0ef28b44a62382d68f86854d74ea398c251c3909fa451738badb8ad660a166cffbf8ec492e1f05", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3edab308451f7746437e9425aee22bbfe4763ad7903ccae38ce2d1b8545e6ea4eabcc973114993afeeb71ef95a561b1fffb1803fbdc9ae972768fe1dba524da2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5b7f3e87e324a51ec002ea6751100e664d69d94f304f70715097204bea41c3f24f990dda9d8008a6b4014c9711a363629043d574b55dceaa9b1706b9e9b1be8"} build_url:https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/def8b958b7c5ccbb4f808a490197c0b26a1d35201bd969e6a68232d6fdfc16c1b071a3ec4d9099536c7bfcb613ef24b950d3a6902fe3a77eafdc2cc56922b57c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e83628aca40ef41c84fccb46d82cbf827965e57062a8a06cd0ef28b44a62382d68f86854d74ea398c251c3909fa451738badb8ad660a166cffbf8ec492e1f05", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3edab308451f7746437e9425aee22bbfe4763ad7903ccae38ce2d1b8545e6ea4eabcc973114993afeeb71ef95a561b1fffb1803fbdc9ae972768fe1dba524da2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5b7f3e87e324a51ec002ea6751100e664d69d94f304f70715097204bea41c3f24f990dda9d8008a6b4014c9711a363629043d574b55dceaa9b1706b9e9b1be8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 08:07:08.814963) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:07:08.815293) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1506005019.822253-578191337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004890 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:07:08.898545) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 08:07:08.898908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 08:07:08.899269) ========= ========= Total master_lag: 1.00 =========