builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-086 starttime: 1506435031.07 results: success (0) revision: 2779d2d4bacc75ff18c54830bb8429314f4afe7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 07:10:31.075223) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 07:10:31.075666) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 07:10:31.075949) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 07:10:31.115576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 07:10:31.115909) ========= 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=438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 07:10:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2017-09-26 07:10:31 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074931 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 07:10:31.206936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 07:10:31.210262) ========= 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=438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022785 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 07:10:31.290940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 07:10:31.294287) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2779d2d4bacc75ff18c54830bb8429314f4afe7e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2779d2d4bacc75ff18c54830bb8429314f4afe7e --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=438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 07:10:31,459 truncating revision to first 12 chars 2017-09-26 07:10:31,459 Setting DEBUG logging. 2017-09-26 07:10:31,460 attempt 1/10 2017-09-26 07:10:31,460 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2779d2d4bacc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 07:10:31,851 unpacking tar archive at: mozilla-beta-2779d2d4bacc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.747202 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 07:10:32.057797) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 07:10:32.061137) ========= script_repo_revision: 2779d2d4bacc75ff18c54830bb8429314f4afe7e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 07:10:32.061515) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 07:10:32.061776) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 07:10:32.077706) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-09-26 07:10:32.078065) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:10:32 INFO - MultiFileLogger online at 20170926 07:10:32 in /builds/slave/test 07:10:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 07:10:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:10:32 INFO - {'append_to_log': False, 07:10:32 INFO - 'base_work_dir': '/builds/slave/test', 07:10:32 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 07:10:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:10:32 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 07:10:32 INFO - 'buildbot_json_path': 'buildprops.json', 07:10:32 INFO - 'code_coverage': False, 07:10:32 INFO - 'config_files': ('talos/linux_config.py',), 07:10:32 INFO - 'default_actions': ('clobber', 07:10:32 INFO - 'read-buildbot-config', 07:10:32 INFO - 'download-and-extract', 07:10:32 INFO - 'populate-webroot', 07:10:32 INFO - 'create-virtualenv', 07:10:32 INFO - 'install', 07:10:32 INFO - 'setup-mitmproxy', 07:10:32 INFO - 'run-tests'), 07:10:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:10:32 INFO - 'disable_ccov_upload': False, 07:10:32 INFO - 'disable_stylo': False, 07:10:32 INFO - 'download_minidump_stackwalk': True, 07:10:32 INFO - 'download_symbols': 'ondemand', 07:10:32 INFO - 'enable_stylo': False, 07:10:32 INFO - 'enable_webrender': False, 07:10:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:10:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:10:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:10:32 INFO - 'gecko_profile': False, 07:10:32 INFO - 'gecko_profile_interval': 0, 07:10:32 INFO - 'installer_path': 'installer.exe', 07:10:32 INFO - 'log_level': 'info', 07:10:32 INFO - 'log_name': 'talos', 07:10:32 INFO - 'log_to_console': True, 07:10:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:10:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:10:32 INFO - 'opt_config_files': (), 07:10:32 INFO - 'pip_index': False, 07:10:32 INFO - 'suite': 'dromaeojs-e10s', 07:10:32 INFO - 'system_bits': '32', 07:10:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:10:32 INFO - 'title': 'talos-linux64-ix-086', 07:10:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:10:32 INFO - 'use_talos_json': True, 07:10:32 INFO - 'verify': 'False', 07:10:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:10:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:10:32 INFO - 'work_dir': 'build'} 07:10:32 INFO - [mozharness: 2017-09-26 14:10:32.376033Z] Running clobber step. 07:10:32 INFO - Running pre-action listener: _resource_record_pre_action 07:10:32 INFO - Running main action method: clobber 07:10:32 INFO - rmtree: /builds/slave/test/build 07:10:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:10:33 INFO - Running post-action listener: _resource_record_post_action 07:10:33 INFO - [mozharness: 2017-09-26 14:10:33.379635Z] Finished clobber step (success) 07:10:33 INFO - [mozharness: 2017-09-26 14:10:33.379731Z] Running read-buildbot-config step. 07:10:33 INFO - Running pre-action listener: _resource_record_pre_action 07:10:33 INFO - Running main action method: read_buildbot_config 07:10:33 INFO - Using buildbot properties: 07:10:33 INFO - { 07:10:33 INFO - "project": "", 07:10:33 INFO - "product": "firefox", 07:10:33 INFO - "who": "ffxbld@noreply.mozilla.org", 07:10:33 INFO - "installer_path": "public/build/target.tar.bz2", 07:10:33 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 07:10:33 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 07:10:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 07:10:33 INFO - "stage_platform": "linux64", 07:10:33 INFO - "basedir": "/builds/slave/test", 07:10:33 INFO - "buildnumber": 126, 07:10:33 INFO - "platform": "ubuntu64_hw", 07:10:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:10:33 INFO - "slavebuilddir": "test", 07:10:33 INFO - "taskId": "KVICLAA2Qwi3PqeZD7v6lw", 07:10:33 INFO - "branch": "mozilla-beta", 07:10:33 INFO - "script_repo_revision": "production", 07:10:33 INFO - "revision": "2779d2d4bacc75ff18c54830bb8429314f4afe7e", 07:10:33 INFO - "slavename": "talos-linux64-ix-086", 07:10:33 INFO - "repo_path": "releases/mozilla-beta" 07:10:33 INFO - } 07:10:33 INFO - Finding installer, test and symbols from parent task. 07:10:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KVICLAA2Qwi3PqeZD7v6lw'}, attempt #1 07:10:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KVICLAA2Qwi3PqeZD7v6lw'}, attempt #1 07:10:34 INFO - Task dependencies: crNUz0RzRTib4IXZG5QDnw 07:10:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw'}, attempt #1 07:10:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.tar.bz2 07:10:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.test_packages.json 07:10:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.crashreporter-symbols.zip 07:10:34 INFO - Running post-action listener: _resource_record_post_action 07:10:34 INFO - [mozharness: 2017-09-26 14:10:34.672936Z] Finished read-buildbot-config step (success) 07:10:34 INFO - [mozharness: 2017-09-26 14:10:34.673150Z] Running download-and-extract step. 07:10:34 INFO - Running pre-action listener: _resource_record_pre_action 07:10:34 INFO - Running main action method: download_and_extract 07:10:34 INFO - mkdir: /builds/slave/test/build/tests 07:10:34 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:10:34 INFO - trying https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.test_packages.json 07:10:34 INFO - Downloading https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:10:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:10:35 INFO - Downloaded 989 bytes. 07:10:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:10:35 INFO - Using the following test package requirements: 07:10:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:10:35 INFO - u'common': [u'target.common.tests.zip'], 07:10:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:10:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:10:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:10:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:10:35 INFO - u'mozbase': [u'target.common.tests.zip'], 07:10:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:10:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:10:35 INFO - u'web-platform': [u'target.common.tests.zip', 07:10:35 INFO - u'target.web-platform.tests.tar.gz'], 07:10:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:10:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:10:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.common.tests.zip 07:10:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:10:35 INFO - Fetch https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.common.tests.zip into memory 07:10:36 INFO - Content-Length response header: 55179466 07:10:36 INFO - Bytes received: 55179466 07:10:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.talos.tests.zip 07:10:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:10:47 INFO - Fetch https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.talos.tests.zip into memory 07:10:49 INFO - Content-Length response header: 14509184 07:10:49 INFO - Bytes received: 14509184 07:10: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:10:49 INFO - trying https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.tar.bz2 07:10:49 INFO - Downloading https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:10:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:10:51 INFO - Downloaded 53544334 bytes. 07:10:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.tar.bz2 07:10:51 INFO - mkdir: /builds/slave/test/properties 07:10:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:10:51 INFO - Writing to file /builds/slave/test/properties/build_url 07:10:51 INFO - Contents: 07:10:51 INFO - build_url:https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.tar.bz2 07:10:51 INFO - Running post-action listener: _resource_record_post_action 07:10:51 INFO - Running post-action listener: find_tests_for_verification 07:10:51 INFO - Running post-action listener: set_extra_try_arguments 07:10:51 INFO - [mozharness: 2017-09-26 14:10:51.739637Z] Finished download-and-extract step (success) 07:10:51 INFO - [mozharness: 2017-09-26 14:10:51.739789Z] Running populate-webroot step. 07:10:51 INFO - Running pre-action listener: _resource_record_pre_action 07:10:51 INFO - Running main action method: populate_webroot 07:10:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:10:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:10:51 INFO - 'tests': ['tresize', 07:10:51 INFO - 'tcanvasmark']}, 07:10:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:10:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:10:51 INFO - 'tests': ['dromaeo_css', 07:10:51 INFO - 'kraken']}, 07:10:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:10:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:10:51 INFO - 'talos_options': ['--disable-stylo'], 07:10:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:10:51 INFO - 'tests': ['damp', 'tps']}, 07:10:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:10:51 INFO - 'talos_options': ['--disable-stylo'], 07:10:51 INFO - 'tests': ['damp', 'tps']}, 07:10:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:10:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:10:51 INFO - 'tests': ['dromaeo_dom']}, 07:10:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:10:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:10:51 INFO - 'tests': ['basic_compositor_video', 07:10:51 INFO - 'glvideo']}, 07:10:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:10:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:10:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:10:51 INFO - 'talos_options': ['--disable-stylo'], 07:10:51 INFO - 'tests': ['ts_paint_webext', 07:10:51 INFO - 'tp5o_webext']}, 07:10:51 INFO - 'other-e10s': {'tests': ['a11yr', 07:10:51 INFO - 'ts_paint', 07:10:51 INFO - 'tpaint', 07:10:51 INFO - 'sessionrestore', 07:10:51 INFO - 'sessionrestore_many_windows', 07:10:51 INFO - 'sessionrestore_no_auto_restore', 07:10:51 INFO - 'tabpaint']}, 07:10:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:10:51 INFO - 'tests': ['a11yr', 07:10:51 INFO - 'ts_paint', 07:10:51 INFO - 'tpaint', 07:10:51 INFO - 'sessionrestore', 07:10:51 INFO - 'sessionrestore_many_windows', 07:10:51 INFO - 'sessionrestore_no_auto_restore', 07:10:51 INFO - 'tabpaint']}, 07:10:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:10:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:10:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:10:51 INFO - 'tests': ['perf_reftest_singletons']}, 07:10:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:10:51 INFO - 'tests': ['bloom_basic']}, 07:10:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:10:51 INFO - 'tsvgr_opacity', 07:10:51 INFO - 'tart', 07:10:51 INFO - 'tscrollx', 07:10:51 INFO - 'tsvg_static']}, 07:10:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:10:51 INFO - 'tests': ['tsvgx', 07:10:51 INFO - 'tsvgr_opacity', 07:10:51 INFO - 'tart', 07:10:51 INFO - 'tscrollx', 07:10:51 INFO - 'tsvg_static']}, 07:10:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:10:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:10:51 INFO - 'talos_options': ['--disable-stylo'], 07:10:51 INFO - 'tests': ['tp5o']}, 07:10:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:10:51 INFO - 'talos_options': ['--mitmproxy', 07:10:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:10:51 INFO - '--firstNonBlankPaint'], 07:10:51 INFO - 'tests': ['tp6_google', 07:10:51 INFO - 'tp6_youtube', 07:10:51 INFO - 'tp6_amazon', 07:10:51 INFO - 'tp6_facebook']}, 07:10:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:10:51 INFO - 'talos_options': ['--disable-stylo', 07:10:51 INFO - '--mitmproxy', 07:10:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:10:51 INFO - '--firstNonBlankPaint'], 07:10:51 INFO - 'tests': ['tp6_google', 07:10:51 INFO - 'tp6_youtube', 07:10:51 INFO - 'tp6_amazon', 07:10:51 INFO - 'tp6_facebook']}, 07:10:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:10:51 INFO - 'talos_options': ['--stylo-threads=1', 07:10:51 INFO - '--mitmproxy', 07:10:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:10:51 INFO - '--firstNonBlankPaint'], 07:10:51 INFO - 'tests': ['tp6_google', 07:10:51 INFO - 'tp6_youtube', 07:10:51 INFO - 'tp6_amazon', 07:10:51 INFO - 'tp6_facebook']}, 07:10:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:10:51 INFO - 'talos_options': ['--xperf_path', 07:10:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:51 INFO - 'tests': ['tp5n']}, 07:10:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:10:51 INFO - 'talos_options': ['--disable-stylo', 07:10:51 INFO - '--xperf_path', 07:10:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:51 INFO - 'tests': ['tp5n']}}} 07:10:51 INFO - Running post-action listener: _resource_record_post_action 07:10:51 INFO - [mozharness: 2017-09-26 14:10:51.756929Z] Finished populate-webroot step (success) 07:10:51 INFO - [mozharness: 2017-09-26 14:10:51.757018Z] Running create-virtualenv step. 07:10:51 INFO - Running pre-action listener: _resource_record_pre_action 07:10:51 INFO - Running main action method: create_virtualenv 07:10:51 INFO - Creating virtualenv /builds/slave/test/build/venv 07:10:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:10:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:10:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:10:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:10:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:10:52 INFO - Installing distribute.............................................................................................................................................................................................done. 07:10:52 INFO - Installing pip...............done. 07:10:52 INFO - Return code: 0 07:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:10:52 INFO - Reading from file tmpfile_stdout 07:10:52 INFO - Output received: 07:10:52 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:10:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:10: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:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10: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:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf90a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94090>, '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 0xf94d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ef90>, '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': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', '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:10: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', 'pip>=1.5'] in /builds/slave/test/build 07:10: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 pip>=1.5 07:10:52 INFO - Using env: {'DISPLAY': ':0', 07:10:52 INFO - 'HOME': '/home/cltbld', 07:10:52 INFO - 'LANG': 'en_US.UTF-8', 07:10:52 INFO - 'LANGUAGE': 'en_US:en', 07:10:52 INFO - 'LOGNAME': 'cltbld', 07:10:52 INFO - 'MAIL': '/var/mail/cltbld', 07:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:52 INFO - 'MOZ_NO_REMOTE': '1', 07:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:52 INFO - 'NO_EM_RESTART': '1', 07:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:52 INFO - 'PWD': '/builds/slave/test', 07:10:52 INFO - 'SHELL': '/bin/bash', 07:10:52 INFO - 'SHLVL': '1', 07:10:52 INFO - 'TERM': 'linux', 07:10:52 INFO - 'TMOUT': '86400', 07:10:52 INFO - 'USER': 'cltbld', 07:10:52 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', 07:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:52 INFO - '_': '/tools/buildbot/bin/python'} 07:10:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:10:54 INFO - Downloading/unpacking pip>=1.5 07:10:54 INFO - Running setup.py egg_info for package pip 07:10:54 INFO - warning: no files found matching 'pip/cacert.pem' 07:10:54 INFO - warning: no files found matching '*.html' under directory 'docs' 07:10:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:10:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:10:54 INFO - Installing collected packages: pip 07:10:54 INFO - Found existing installation: pip 1.1 07:10:54 INFO - Uninstalling pip: 07:10:54 INFO - Successfully uninstalled pip 07:10:54 INFO - Running setup.py install for pip 07:10:54 INFO - warning: no files found matching 'pip/cacert.pem' 07:10:54 INFO - warning: no files found matching '*.html' under directory 'docs' 07:10:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:10:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:10:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:10:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:10:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:10:54 INFO - Successfully installed pip 07:10:54 INFO - Cleaning up... 07:10:54 INFO - Return code: 0 07:10:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf90a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94090>, '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 0xf94d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ef90>, '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': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', '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:10:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:10:54 INFO - Using env: {'DISPLAY': ':0', 07:10:54 INFO - 'HOME': '/home/cltbld', 07:10:54 INFO - 'LANG': 'en_US.UTF-8', 07:10:54 INFO - 'LANGUAGE': 'en_US:en', 07:10:54 INFO - 'LOGNAME': 'cltbld', 07:10:54 INFO - 'MAIL': '/var/mail/cltbld', 07:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:54 INFO - 'MOZ_NO_REMOTE': '1', 07:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:54 INFO - 'NO_EM_RESTART': '1', 07:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:54 INFO - 'PWD': '/builds/slave/test', 07:10:54 INFO - 'SHELL': '/bin/bash', 07:10:54 INFO - 'SHLVL': '1', 07:10:54 INFO - 'TERM': 'linux', 07:10:54 INFO - 'TMOUT': '86400', 07:10:54 INFO - 'USER': 'cltbld', 07:10:54 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', 07:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:54 INFO - '_': '/tools/buildbot/bin/python'} 07:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:54 INFO - Downloading/unpacking psutil>=3.1.1 07:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:10:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:55 INFO - Installing collected packages: psutil 07:10:55 INFO - Running setup.py install for psutil 07:10:55 INFO - building 'psutil._psutil_linux' extension 07:10:55 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:10:55 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:10:55 INFO - building 'psutil._psutil_posix' extension 07:10:55 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:10:55 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:10:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:56 INFO - Successfully installed psutil 07:10:56 INFO - Cleaning up... 07:10:56 INFO - Return code: 0 07:10:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf90a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94090>, '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 0xf94d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ef90>, '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': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', '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:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:10:56 INFO - Using env: {'DISPLAY': ':0', 07:10:56 INFO - 'HOME': '/home/cltbld', 07:10:56 INFO - 'LANG': 'en_US.UTF-8', 07:10:56 INFO - 'LANGUAGE': 'en_US:en', 07:10:56 INFO - 'LOGNAME': 'cltbld', 07:10:56 INFO - 'MAIL': '/var/mail/cltbld', 07:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:56 INFO - 'MOZ_NO_REMOTE': '1', 07:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:56 INFO - 'NO_EM_RESTART': '1', 07:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:56 INFO - 'PWD': '/builds/slave/test', 07:10:56 INFO - 'SHELL': '/bin/bash', 07:10:56 INFO - 'SHLVL': '1', 07:10:56 INFO - 'TERM': 'linux', 07:10:56 INFO - 'TMOUT': '86400', 07:10:56 INFO - 'USER': 'cltbld', 07:10:56 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', 07:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:56 INFO - '_': '/tools/buildbot/bin/python'} 07:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:10:57 INFO - Installing collected packages: mozsystemmonitor 07:10:57 INFO - Running setup.py install for mozsystemmonitor 07:10:57 INFO - Successfully installed mozsystemmonitor 07:10:57 INFO - Cleaning up... 07:10:57 INFO - Return code: 0 07:10:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:10:57 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:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:57 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:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:57 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 0xc251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf90a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94090>, '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 0xf94d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ef90>, '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': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', '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:10:57 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:10:57 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:10:57 INFO - Using env: {'DISPLAY': ':0', 07:10:57 INFO - 'HOME': '/home/cltbld', 07:10:57 INFO - 'LANG': 'en_US.UTF-8', 07:10:57 INFO - 'LANGUAGE': 'en_US:en', 07:10:57 INFO - 'LOGNAME': 'cltbld', 07:10:57 INFO - 'MAIL': '/var/mail/cltbld', 07:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:57 INFO - 'MOZ_NO_REMOTE': '1', 07:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:57 INFO - 'NO_EM_RESTART': '1', 07:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:57 INFO - 'PWD': '/builds/slave/test', 07:10:57 INFO - 'SHELL': '/bin/bash', 07:10:57 INFO - 'SHLVL': '1', 07:10:57 INFO - 'TERM': 'linux', 07:10:57 INFO - 'TMOUT': '86400', 07:10:57 INFO - 'USER': 'cltbld', 07:10:57 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', 07:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:57 INFO - '_': '/tools/buildbot/bin/python'} 07:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:57 INFO - Downloading/unpacking jsonschema==2.5.1 07:10: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:10: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:10: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:10: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:10:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:10:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:10: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:10: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:10: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:10: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:10:59 INFO - Downloading functools32-3.2.3-2.tar.gz 07:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:10:59 INFO - warning: no files found matching '*.txt' 07:10:59 INFO - no previously-included directories found matching 'build' 07:10:59 INFO - no previously-included directories found matching 'dist' 07:10:59 INFO - no previously-included directories found matching '.git*' 07:10:59 INFO - Installing collected packages: jsonschema, functools32 07:10:59 INFO - Running setup.py install for functools32 07:10:59 INFO - warning: no files found matching '*.txt' 07:10:59 INFO - no previously-included directories found matching 'build' 07:10:59 INFO - no previously-included directories found matching 'dist' 07:10:59 INFO - no previously-included directories found matching '.git*' 07:10:59 INFO - Successfully installed jsonschema functools32 07:10:59 INFO - Cleaning up... 07:10:59 INFO - Return code: 0 07:10:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:10: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:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10: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:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:59 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 0xc251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf90a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94090>, '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 0xf94d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ef90>, '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': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', '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:10:59 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:10:59 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:10:59 INFO - Using env: {'DISPLAY': ':0', 07:10:59 INFO - 'HOME': '/home/cltbld', 07:10:59 INFO - 'LANG': 'en_US.UTF-8', 07:10:59 INFO - 'LANGUAGE': 'en_US:en', 07:10:59 INFO - 'LOGNAME': 'cltbld', 07:10:59 INFO - 'MAIL': '/var/mail/cltbld', 07:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:59 INFO - 'MOZ_NO_REMOTE': '1', 07:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:59 INFO - 'NO_EM_RESTART': '1', 07:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:59 INFO - 'PWD': '/builds/slave/test', 07:10:59 INFO - 'SHELL': '/bin/bash', 07:10:59 INFO - 'SHLVL': '1', 07:10:59 INFO - 'TERM': 'linux', 07:10:59 INFO - 'TMOUT': '86400', 07:10:59 INFO - 'USER': 'cltbld', 07:10:59 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', 07:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:59 INFO - '_': '/tools/buildbot/bin/python'} 07:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:10:59 INFO - Cleaning up... 07:10:59 INFO - Return code: 0 07:10:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:10: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:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10: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:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:59 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 0xc251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf90a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94090>, '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 0xf94d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ef90>, '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': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', '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:10:59 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:10:59 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:10:59 INFO - Using env: {'DISPLAY': ':0', 07:10:59 INFO - 'HOME': '/home/cltbld', 07:10:59 INFO - 'LANG': 'en_US.UTF-8', 07:10:59 INFO - 'LANGUAGE': 'en_US:en', 07:10:59 INFO - 'LOGNAME': 'cltbld', 07:10:59 INFO - 'MAIL': '/var/mail/cltbld', 07:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:59 INFO - 'MOZ_NO_REMOTE': '1', 07:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:59 INFO - 'NO_EM_RESTART': '1', 07:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:59 INFO - 'PWD': '/builds/slave/test', 07:10:59 INFO - 'SHELL': '/bin/bash', 07:10:59 INFO - 'SHLVL': '1', 07:10:59 INFO - 'TERM': 'linux', 07:10:59 INFO - 'TMOUT': '86400', 07:10:59 INFO - 'USER': 'cltbld', 07:10:59 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', 07:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:59 INFO - '_': '/tools/buildbot/bin/python'} 07:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:59 INFO - Downloading/unpacking blobuploader==1.2.4 07:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:00 INFO - Downloading blobuploader-1.2.4.tar.gz 07:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:11:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:01 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:11:01 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:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:11:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:11:01 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:11:01 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:11:01 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:11:01 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:11:01 INFO - Downloading docopt-0.6.1.tar.gz 07:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:11:02 INFO - Installing collected packages: blobuploader, requests, docopt 07:11:02 INFO - Running setup.py install for blobuploader 07:11:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:11:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:11:02 INFO - Running setup.py install for requests 07:11:02 INFO - Running setup.py install for docopt 07:11:02 INFO - Successfully installed blobuploader requests docopt 07:11:02 INFO - Cleaning up... 07:11:02 INFO - Return code: 0 07:11:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11: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:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11: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:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:02 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 0xc251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf90a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94090>, '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 0xf94d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ef90>, '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': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', '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:11:02 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:11:02 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:11:02 INFO - Using env: {'DISPLAY': ':0', 07:11:02 INFO - 'HOME': '/home/cltbld', 07:11:02 INFO - 'LANG': 'en_US.UTF-8', 07:11:02 INFO - 'LANGUAGE': 'en_US:en', 07:11:02 INFO - 'LOGNAME': 'cltbld', 07:11:02 INFO - 'MAIL': '/var/mail/cltbld', 07:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:02 INFO - 'MOZ_NO_REMOTE': '1', 07:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:02 INFO - 'NO_EM_RESTART': '1', 07:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:02 INFO - 'PWD': '/builds/slave/test', 07:11:02 INFO - 'SHELL': '/bin/bash', 07:11:02 INFO - 'SHLVL': '1', 07:11:02 INFO - 'TERM': 'linux', 07:11:02 INFO - 'TMOUT': '86400', 07:11:02 INFO - 'USER': 'cltbld', 07:11:02 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', 07:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:02 INFO - '_': '/tools/buildbot/bin/python'} 07:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:02 INFO - Running setup.py (path:/tmp/pip-M6vMoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:02 INFO - Running setup.py (path:/tmp/pip-1nu4Fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:03 INFO - Running setup.py (path:/tmp/pip-L7UXgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:03 INFO - Running setup.py (path:/tmp/pip-NPmk0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:03 INFO - Running setup.py (path:/tmp/pip-IgvWxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:03 INFO - Running setup.py (path:/tmp/pip-KnCgSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:03 INFO - Running setup.py (path:/tmp/pip-ECKDre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:03 INFO - Running setup.py (path:/tmp/pip-6KYTHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:03 INFO - Running setup.py (path:/tmp/pip-gaZNVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:03 INFO - Running setup.py (path:/tmp/pip-d0D7n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:03 INFO - Running setup.py (path:/tmp/pip-TvobFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:03 INFO - Running setup.py (path:/tmp/pip-aHme66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:03 INFO - Running setup.py (path:/tmp/pip-3OAqq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:03 INFO - Running setup.py (path:/tmp/pip-1q4A_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:03 INFO - Running setup.py (path:/tmp/pip-BOEgyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:03 INFO - Running setup.py (path:/tmp/pip-vccW0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:04 INFO - Running setup.py (path:/tmp/pip-o2V3WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:11:04 INFO - Running setup.py install for manifestparser 07:11:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:11:04 INFO - Running setup.py install for mozcrash 07:11:04 INFO - Running setup.py install for mozdebug 07:11:04 INFO - Running setup.py install for mozdevice 07:11:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:11:04 INFO - Running setup.py install for mozfile 07:11:04 INFO - Running setup.py install for mozhttpd 07:11:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:11:04 INFO - Running setup.py install for mozinfo 07:11:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:11:04 INFO - Running setup.py install for mozInstall 07:11:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:11:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:11:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:11:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:11:04 INFO - Running setup.py install for mozleak 07:11:04 INFO - Running setup.py install for mozlog 07:11:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:11:05 INFO - Running setup.py install for moznetwork 07:11:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:11:05 INFO - Running setup.py install for mozprocess 07:11:05 INFO - Running setup.py install for mozprofile 07:11:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:11:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:11:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:11:05 INFO - Running setup.py install for mozrunner 07:11:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:11:05 INFO - Running setup.py install for mozscreenshot 07:11:05 INFO - Running setup.py install for moztest 07:11:05 INFO - Running setup.py install for mozversion 07:11:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:11:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:11:05 INFO - Cleaning up... 07:11:05 INFO - Return code: 0 07:11:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11: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:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11: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:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:05 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 0xc251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf90a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94090>, '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 0xf94d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ef90>, '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': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', '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:11:05 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:11:05 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:11:05 INFO - Using env: {'DISPLAY': ':0', 07:11:05 INFO - 'HOME': '/home/cltbld', 07:11:05 INFO - 'LANG': 'en_US.UTF-8', 07:11:05 INFO - 'LANGUAGE': 'en_US:en', 07:11:05 INFO - 'LOGNAME': 'cltbld', 07:11:05 INFO - 'MAIL': '/var/mail/cltbld', 07:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:05 INFO - 'MOZ_NO_REMOTE': '1', 07:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:05 INFO - 'NO_EM_RESTART': '1', 07:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:05 INFO - 'PWD': '/builds/slave/test', 07:11:05 INFO - 'SHELL': '/bin/bash', 07:11:05 INFO - 'SHLVL': '1', 07:11:05 INFO - 'TERM': 'linux', 07:11:05 INFO - 'TMOUT': '86400', 07:11:05 INFO - 'USER': 'cltbld', 07:11:05 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', 07:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:05 INFO - '_': '/tools/buildbot/bin/python'} 07:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:06 INFO - Running setup.py (path:/tmp/pip-wvBvm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:06 INFO - Running setup.py (path:/tmp/pip-Vr2BtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:06 INFO - Running setup.py (path:/tmp/pip-6zUd6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:06 INFO - Running setup.py (path:/tmp/pip-9If6kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:06 INFO - Running setup.py (path:/tmp/pip-3_qzrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:06 INFO - Running setup.py (path:/tmp/pip-giSh_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:06 INFO - Running setup.py (path:/tmp/pip-sfzLp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:06 INFO - Running setup.py (path:/tmp/pip-_W0hB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:06 INFO - Running setup.py (path:/tmp/pip-2QE2fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:06 INFO - Running setup.py (path:/tmp/pip-fnILPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:06 INFO - Running setup.py (path:/tmp/pip-E7RyH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:06 INFO - Running setup.py (path:/tmp/pip-JjlVSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:06 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:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:06 INFO - Running setup.py (path:/tmp/pip-r0NMcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:06 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:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:07 INFO - Running setup.py (path:/tmp/pip-4VuGmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:07 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:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:07 INFO - Running setup.py (path:/tmp/pip-FYtS6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:07 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:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:07 INFO - Running setup.py (path:/tmp/pip-0UY5mQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:07 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:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:07 INFO - Running setup.py (path:/tmp/pip-QFIiNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:07 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:11:07 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:11:07 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:11:07 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:11:07 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:11:07 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:11:07 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:11:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:08 INFO - Downloading blessings-1.6.tar.gz 07:11:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:11:08 INFO - Installing collected packages: blessings 07:11:08 INFO - Running setup.py install for blessings 07:11:08 INFO - Successfully installed blessings 07:11:08 INFO - Cleaning up... 07:11:08 INFO - Return code: 0 07:11:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:11:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:08 INFO - Reading from file tmpfile_stdout 07:11:08 INFO - Current package versions: 07:11:08 INFO - argparse == 1.2.1 07:11:08 INFO - blessings == 1.6 07:11:08 INFO - blobuploader == 1.2.4 07:11:08 INFO - docopt == 0.6.1 07:11:08 INFO - functools32 == 3.2.3-2 07:11:08 INFO - jsonschema == 2.5.1 07:11:08 INFO - manifestparser == 1.1 07:11:08 INFO - mozInstall == 1.13 07:11:08 INFO - mozcrash == 1.0 07:11:08 INFO - mozdebug == 0.1 07:11:08 INFO - mozdevice == 0.51 07:11:08 INFO - mozfile == 1.2 07:11:08 INFO - mozhttpd == 0.7 07:11:08 INFO - mozinfo == 0.10 07:11:08 INFO - mozleak == 0.1 07:11:08 INFO - mozlog == 3.5 07:11:08 INFO - moznetwork == 0.27 07:11:08 INFO - mozprocess == 0.25 07:11:08 INFO - mozprofile == 0.28 07:11:08 INFO - mozrunner == 6.13 07:11:08 INFO - mozscreenshot == 0.1 07:11:08 INFO - mozsystemmonitor == 0.3 07:11:08 INFO - moztest == 0.8 07:11:08 INFO - mozversion == 1.4 07:11:08 INFO - psutil == 3.1.1 07:11:08 INFO - requests == 1.2.3 07:11:08 INFO - wsgiref == 0.1.2 07:11:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:08 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 0xc251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf90a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94090>, '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 0xf94d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ef90>, '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': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', '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:11:08 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:11:08 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:11:08 INFO - Using env: {'DISPLAY': ':0', 07:11:08 INFO - 'HOME': '/home/cltbld', 07:11:08 INFO - 'LANG': 'en_US.UTF-8', 07:11:08 INFO - 'LANGUAGE': 'en_US:en', 07:11:08 INFO - 'LOGNAME': 'cltbld', 07:11:08 INFO - 'MAIL': '/var/mail/cltbld', 07:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:08 INFO - 'MOZ_NO_REMOTE': '1', 07:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:08 INFO - 'NO_EM_RESTART': '1', 07:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:08 INFO - 'PWD': '/builds/slave/test', 07:11:08 INFO - 'SHELL': '/bin/bash', 07:11:08 INFO - 'SHLVL': '1', 07:11:08 INFO - 'TERM': 'linux', 07:11:08 INFO - 'TMOUT': '86400', 07:11:08 INFO - 'USER': 'cltbld', 07:11:08 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', 07:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:08 INFO - '_': '/tools/buildbot/bin/python'} 07:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:09 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:11:09 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:11:09 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:11:09 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:11:09 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:11:09 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:11:09 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:11:09 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:11:09 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:11:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:11:09 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:11:09 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:11:09 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:11:09 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:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:11:10 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:11:10 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:11:10 INFO - Installing collected packages: simplejson 07:11:10 INFO - Running setup.py install for simplejson 07:11:10 INFO - building 'simplejson._speedups' extension 07:11:10 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:11:11 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:11:11 INFO - Successfully installed simplejson 07:11:11 INFO - Cleaning up... 07:11:11 INFO - Return code: 0 07:11:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:11:11 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:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:11 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:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:11 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 0xc251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdeda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf90a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94090>, '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 0xf94d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ef90>, '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': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', '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:11:11 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:11:11 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:11:11 INFO - Using env: {'DISPLAY': ':0', 07:11:11 INFO - 'HOME': '/home/cltbld', 07:11:11 INFO - 'LANG': 'en_US.UTF-8', 07:11:11 INFO - 'LANGUAGE': 'en_US:en', 07:11:11 INFO - 'LOGNAME': 'cltbld', 07:11:11 INFO - 'MAIL': '/var/mail/cltbld', 07:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:11 INFO - 'MOZ_NO_REMOTE': '1', 07:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:11 INFO - 'NO_EM_RESTART': '1', 07:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:11 INFO - 'PWD': '/builds/slave/test', 07:11:11 INFO - 'SHELL': '/bin/bash', 07:11:11 INFO - 'SHLVL': '1', 07:11:11 INFO - 'TERM': 'linux', 07:11:11 INFO - 'TMOUT': '86400', 07:11:11 INFO - 'USER': 'cltbld', 07:11:11 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', 07:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:11 INFO - '_': '/tools/buildbot/bin/python'} 07:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:11:11 INFO - Cleaning up... 07:11:11 INFO - Return code: 0 07:11:11 INFO - Running post-action listener: _resource_record_post_action 07:11:11 INFO - Running post-action listener: _start_resource_monitoring 07:11:11 INFO - Starting resource monitoring. 07:11:11 INFO - [mozharness: 2017-09-26 14:11:11.536620Z] Finished create-virtualenv step (success) 07:11:11 INFO - [mozharness: 2017-09-26 14:11:11.537088Z] Running install step. 07:11:11 INFO - Running pre-action listener: _resource_record_pre_action 07:11:11 INFO - Running main action method: install 07:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:11 INFO - Reading from file tmpfile_stdout 07:11:11 INFO - Detecting whether we're running mozinstall >=1.0... 07:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:11:11 INFO - Reading from file tmpfile_stdout 07:11:11 INFO - Output received: 07:11:11 INFO - Usage: mozinstall [options] installer 07:11:11 INFO - Options: 07:11:11 INFO - -h, --help show this help message and exit 07:11:11 INFO - -d DEST, --destination=DEST 07:11:11 INFO - Directory to install application into. [default: 07:11:11 INFO - "/builds/slave/test"] 07:11:11 INFO - --app=APP Application being installed. [default: firefox] 07:11:11 INFO - mkdir: /builds/slave/test/build/application 07:11:11 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:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:11:26 INFO - Reading from file tmpfile_stdout 07:11:26 INFO - Output received: 07:11:26 INFO - /builds/slave/test/build/application/firefox/firefox 07:11:26 INFO - Running post-action listener: _resource_record_post_action 07:11:26 INFO - [mozharness: 2017-09-26 14:11:26.501072Z] Finished install step (success) 07:11:26 INFO - [mozharness: 2017-09-26 14:11:26.501390Z] Running setup-mitmproxy step. 07:11:26 INFO - Running pre-action listener: _resource_record_pre_action 07:11:26 INFO - Running main action method: setup_mitmproxy 07:11:26 INFO - Skipping: mitmproxy is not required 07:11:26 INFO - Running post-action listener: _resource_record_post_action 07:11:26 INFO - [mozharness: 2017-09-26 14:11:26.502515Z] Finished setup-mitmproxy step (success) 07:11:26 INFO - [mozharness: 2017-09-26 14:11:26.502739Z] Running run-tests step. 07:11:26 INFO - Running pre-action listener: _resource_record_pre_action 07:11:26 INFO - Running pre-action listener: _set_gcov_prefix 07:11:26 INFO - Running main action method: run_tests 07:11:26 WARNING - Try message not found. 07:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:11:26 INFO - Python 2.7.3 07:11:26 INFO - Return code: 0 07:11:26 INFO - grabbing minidump binary from tooltool 07:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf94090>, '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 0xf94d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:11:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:11:26 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:11:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:11:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:11:26 INFO - Return code: 0 07:11:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:11:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:11:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:11:26 INFO - ENV: RUST_BACKTRACE is now full 07:11:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:11:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--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:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-086 --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:11:26 INFO - Using env: {'DISPLAY': ':0', 07:11:26 INFO - 'HOME': '/home/cltbld', 07:11:26 INFO - 'LANG': 'en_US.UTF-8', 07:11:26 INFO - 'LANGUAGE': 'en_US:en', 07:11:26 INFO - 'LOGNAME': 'cltbld', 07:11:26 INFO - 'MAIL': '/var/mail/cltbld', 07:11:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:11:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:26 INFO - 'MOZ_NO_REMOTE': '1', 07:11:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:26 INFO - 'NO_EM_RESTART': '1', 07:11:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:26 INFO - 'PWD': '/builds/slave/test', 07:11:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:11:26 INFO - 'RUST_BACKTRACE': 'full', 07:11:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:11:26 INFO - 'SHELL': '/bin/bash', 07:11:26 INFO - 'SHLVL': '1', 07:11:26 INFO - 'TERM': 'linux', 07:11:26 INFO - 'TMOUT': '86400', 07:11:26 INFO - 'USER': 'cltbld', 07:11:26 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', 07:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:26 INFO - '_': '/tools/buildbot/bin/python'} 07:11:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--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:11:26 INFO - mozversion application_buildid: 20170926125004 07:11:26 INFO - mozversion application_changeset: 2779d2d4bacc75ff18c54830bb8429314f4afe7e 07:11:26 INFO - mozversion application_display_name: Firefox 07:11:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:11:26 INFO - mozversion application_name: Firefox 07:11:26 INFO - mozversion application_remotingname: firefox 07:11:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:11:26 INFO - mozversion application_vendor: Mozilla 07:11:26 INFO - mozversion application_version: 57.0 07:11:26 INFO - mozversion platform_buildid: 20170926125004 07:11:26 INFO - mozversion platform_changeset: 2779d2d4bacc75ff18c54830bb8429314f4afe7e 07:11:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:11:26 INFO - mozversion platform_version: 57.0 07:11:26 INFO - using testdate: 1506435086 07:11:26 INFO - actual date: 1506435086 07:11:26 INFO - starting webserver on 'localhost:54903' 07:11:26 INFO - SUITE-START | Running 2 tests 07:11:26 INFO - TEST-START | dromaeo_css 07:11:26 INFO - Initialising browser for dromaeo_css test... 07:11:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54903/getInfo.html -profile /tmp/tmpYs2EcI/profile 07:11:26 INFO - TEST-INFO | started process 10264 (/builds/slave/test/build/application/firefox/firefox http://localhost:54903/getInfo.html) 07:11:31 INFO - TEST-INFO | 10264: exit 0 07:11:31 INFO - Browser initialized. 07:11:31 INFO - Running cycle 1/1 for dromaeo_css test... 07:11:31 INFO - Using env: {'DISPLAY': ':0', 07:11:31 INFO - 'HOME': '/home/cltbld', 07:11:31 INFO - 'JSGC_DISABLE_POISONING': '1', 07:11:31 INFO - 'LANG': 'en_US.UTF-8', 07:11:31 INFO - 'LANGUAGE': 'en_US:en', 07:11:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:11:31 INFO - 'LOGNAME': 'cltbld', 07:11:31 INFO - 'MAIL': '/var/mail/cltbld', 07:11:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:11:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:11:31 INFO - 'MOZ_CRASHREPORTER': '1', 07:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:11:31 INFO - 'MOZ_NO_REMOTE': '1', 07:11:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:31 INFO - 'NO_EM_RESTART': '1', 07:11:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:31 INFO - 'PWD': '/builds/slave/test', 07:11:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:11:31 INFO - 'RUST_BACKTRACE': 'full', 07:11:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:11:31 INFO - 'SHELL': '/bin/bash', 07:11:31 INFO - 'SHLVL': '1', 07:11:31 INFO - 'TERM': 'linux', 07:11:31 INFO - 'TMOUT': '86400', 07:11:31 INFO - 'USER': 'cltbld', 07:11:31 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', 07:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:31 INFO - '_': '/tools/buildbot/bin/python'} 07:11:31 INFO - TEST-INFO | started process 10458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYs2EcI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:32 INFO - PID 10458 | 07:11:32 INFO - PID 10458 | (/builds/slave/test/build/application/firefox/firefox:10506): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:11:32 INFO - PID 10458 | 07:11:42 INFO - PID 10458 | RSS: Main: 141303808 07:11:42 INFO - PID 10458 | 07:14:40 INFO - PID 10458 | Cycle 1(1): loaded http://localhost:54903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54903/tests/dromaeo/cssquery-ext.html) 07:14:41 INFO - PID 10458 | RSS: Main: 145055744 07:14:41 INFO - PID 10458 | 07:17:43 INFO - PID 10458 | Cycle 1(1): loaded http://localhost:54903/tests/dromaeo/cssquery-ext.html (next: http://localhost:54903/tests/dromaeo/cssquery-jquery.html) 07:17:43 INFO - PID 10458 | RSS: Main: 143876096 07:17:43 INFO - PID 10458 | 07:20:45 INFO - PID 10458 | Cycle 1(1): loaded http://localhost:54903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54903/tests/dromaeo/cssquery-mootools.html) 07:20:45 INFO - PID 10458 | RSS: Main: 144523264 07:20:45 INFO - PID 10458 | 07:23:47 INFO - PID 10458 | Cycle 1(1): loaded http://localhost:54903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54903/tests/dromaeo/cssquery-prototype.html) 07:23:47 INFO - PID 10458 | RSS: Main: 144195584 07:23:47 INFO - PID 10458 | 07:26:50 INFO - PID 10458 | Cycle 1(1): loaded http://localhost:54903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54903/tests/dromaeo/cssquery-yui.html) 07:26:51 INFO - PID 10458 | RSS: Main: 145874944 07:26:51 INFO - PID 10458 | 07:29:52 INFO - PID 10458 | Cycle 1(1): loaded http://localhost:54903/tests/dromaeo/cssquery-yui.html (next: http://localhost:54903/tests/dromaeo/cssquery-dojo.html) 07:29:53 INFO - PID 10458 | RSS: Main: 149221376 07:29:53 INFO - PID 10458 | 07:29:53 INFO - PID 10458 | __start_tp_report 07:29:53 INFO - PID 10458 | _x_x_mozilla_page_load 07:29:53 INFO - PID 10458 | _x_x_mozilla_page_load_details 07:29:53 INFO - PID 10458 | |i|pagename|runs| 07:29:53 INFO - PID 10458 | |0;dojo.html;3986.8238869533484;3993.880183594492;4025.5370632377285;4038.7778672173035;4073.8777836664913;6636.236832764233;6673.766418175364;6708.161479815023;6731.057651928728;6748.561343512668;6682.722753269815;6685.364890335411;6747.898781518281;6755.695993680284;6778.627175505345;5940.168376427304;5981.611195272304;6029.1257767623665;6042.697865106749;6116.908246376308;5990.970045149768;6014.8195554133445;6021.45806877381;6031.60794548353;6067.24159480065;6075.878482430371;6102;6105.725242364104;6132.4480796728285;6139.478144357735;6035.245594300713;6051.334353221142;6066.241719785027;6141.6007959482495;6155.753769849201;5920.792772252994;5931.970340148315;5938.792142275;5973;5997.5501837361935;6617.735290588371;6621.801345959629;6638.369354911276;6656.700448479782;6693.364130407652;7235.384992275663;7242.45681573884;7311.415086793044;7318.194998550155;7332.853342933165;6939.722411103549;7262.346388825031;7305.232950540223;7341.9632901835685;7361.043064401647;6730.83172920676;6738.393544581011;6768.593884366905;6769.52613317068;6781.321867813278;7353.77938661841;7401.111866576045;7407.703691852374;7437.330640242404;7445.181030086686;7091.680874360666;7115.537490063233;7150.892736608955;7185.748498802622;7208;7171.784846454615;7235.059442272576;7249.238829922782;7268.818279542948;7350.816229594303;7174.246704096099;7183.281671832775;7202.92797072033;7218.783436496913;7222.241664625139;7110.3956163725625;7113.060380273576;7128.394086502602;7138.464615153885;7206;5325.733713314319;5337.039332920034;5373.543248823816;5419.403865574784;5461.262729531462;4933.235348520985;4971.353724015855;5006.299118123466;5011.273365362002;5011.724355160428;6694.531382803157;6708.228553716288;6786.253512113763;6786.355296246848;6815;7156.570605763671;7212.3148300911325;7236.891446628305;7237.638118094074;7327.8534429312185;6548.050532672831;6635.900461493082;6642;6644.202695676453;6646.933530664728;6170.691465426711;6181.660008699565;6191.164192834;6208.906866397007;6222.906656400158;7284.6721897514735;7462.70149194037;7495.775126746206;7498.062742157231;7577.128630207597;7131.429485641136;7137.607431591208;7258.237885022208;7298.343149116605;7317.451191160578;7470.887936680845;7498.887516687363;7571.545707257582;7586.924130758622;7593.734219302298;7024.894626580503;7087.893681594884;7127.394171495481;7139.964300178466;7141.9642901785155;7145.249748776304;7183.568985860865;7238.6380680966795;7293.744718935024;7351.742689005859;6936.271691472524;6978.930210698031;6985.790426287016;6988.021676965127;6990.965045174741;6879.071325371211;6887.6556172192195;6887.896681549681;6897.241303456515;6980.720771169096;6823.078884350549;6833.658317084027;6929.341712537301;6934.341237582422;6939.514234003571;7042.577445353295;7064.823379415556;7082.079329687108;7093.680784364819;7139.82150446243;6765.1205343305055;6810.761623343357;6870.141232345957;6927.549709268881;6930.896036559557 07:29:53 INFO - PID 10458 | |1;ext.html;963.8891527474339;967.4678926590374;985.620536093604;1014.0569270578359;1019.261035749082;44598.554014459885;45651.54348456518;45693.54306456934;45710;45712.3143152853;42342.7882860586;42354.364684529755;42375.788121059355;42671.78664106675;42707.359389609104;8019.438639295237;8094.797630059236;8112.43212975092;8154.184581541857;8167.469114507568;8021.318187954031;8167.79580510489;8174.305184059363;8177.79555511111;8187.345012398994;8637.827243455127;8795.384323097385;8795.560221988875;8828.337874659393;8829.470231786081;8681.522516261603;8715.477071375737;8737.038925718165;8743.081976392483;8778.429402088845;8682;8702.173293537104;8718.084601116854;8768;8787.736367908972;40249.798751006354;40376.19247615061;40432;40527.392089118686;40546.59453405487;3700.7594506357;3725.701943844486;3727.310447567209;3754.3617585010343;3756.7370284080125;33257.83371083153;33422;33437.33125337504;33484.49773253403;33819.4927076094;5593.972030139823;5626.718664066781;5643.407442218549;5686.1755045518585;5693.430656934315;219416;219568;220896;220942;221960;52580.94838103216;52863.73568132135;52994.20508692373;53133.203001955;53205.73397133067;56176.15735763967;56374;56462.717686411306;56483.71758141183;56631;18197.636047278982;18704.438866834018;18708.719369209473;18709.719354209697;18715.157817897954;15315.693686126215;15424.768628470581;15496.612584685248;15514.5345639631;15515.379384824706;15342.846571534143;15815.13016784088;15850.128242946517;15903.52289431319;15956.042637441791;6102.572819902564;6144.385561443909;6203.069539569011;6249.500039996789;6263.71813268404;1088.6407485529755;1105.2594761509808;1105.9170562207705;1115.041064684371;1131.9207655464204;26153.73846261551;26174;26270.73729262721;26304.21087367382;26486.337841554116;1212.5210541835925;1227.6908052734964;1233.7964235900977;1241.596481143632;1247.8003519436847;13696.383662735201;13991.230482323366;14079.648008799657;14181.361838717075;14247.643808904653;279007;283450;283725;284095;284172;57902;59504;63904.36095638984;64209.357906421275;64276.357236427975;1551.2786554252327;1557.22138930537;1562.3360071969369;1574.7716581095676;1588.864946479539;30447.212170888724;30967.91612293559;30975.69024309728;31197;31298.68701313049;42395.364069539595;42551.3617295747;42603.7869810649;42775;42817.35773963455;251044;252103;252105;252967;253321;36290.455643164845;36736.448953265186;36880.63119368772;36907.815460922524;37010.259794803416;47352.289715653606;47555.52444475511;47967.52032479631;47996.76001620109;48163.5183648159;34936.825315873255;35288.29423411466;35404.64595354014;35866.82066589651;36382.8180859094;34868;35093;35147.29705405826;35409.29181416409;35502;41021;41218.79390603028;41321.173576528905;41582.58417415787;41617.37573936333;33396.66603333935;33569.16077098092;34007.149821254665;34024.82987585046;34329.65670343365;25031.49937001286;25050.24849254525;25955.74044259609;26222.213333600022;26691.466170676867 07:29:53 INFO - PID 10458 | |2;jquery.html;643.8304481824282;644.6358837496809;644.7724923200542;647.1982610235177;653.1190172303766;24005.279841604737;24656.630150547757;24695.135670251544;24717.876410617966;24749;26235.475290494178;26529.86735066322;26533.336666583346;26655.333616659595;26677.33306667334;6301.180846489973;6641.335866413357;6673.833154171136;6736.528443008991;6768;6647.434968027699;6704.664766761667;6708.12794336738;6710.194776626788;6725.461963042945;6647.966760166192;6679.66601669917;6682.131322928012;6693.129893113888;6827.283135270774;6890.655467226644;6945.2707465716385;6947.40947019504;6948.374646281859;6954.200266969287;6510.153680021567;6524.902126468107;6529.347065293433;6542.4766018718865;6542.901856472156;30043.5493467596;30462.086137415914;30545.23636909095;30562.08313750591;30595.388092238252;2248.460369511322;2313.560423519526;2317;2318.4899322149267;2319.953600927972;21081.367558973256;21603.67594486084;21627.783722162734;21737.456563585878;21789.673154902688;2618.1098426534877;2639.4984952858895;2681.6111663808833;2687.032668239432;2690.932726681829;143994;150135;152179;167846.1607691966;175278.12360938243;15968.600784980468;16332.87672602554;16844.915775421043;16866.662666746597;16975.151242438074;26788.062417815672;26838.731612683623;26939.575438210264;26954.7088497476;27001.729982700315;11388.94305528467;11490.712732181762;11603.245789023686;11624.88375116255;11804.586839460577;10671.466426678635;10755.83866242007;10803.297785643908;10899.400532970763;10936.343819370863;9954.402735835873;9990.450525221182;10014.849777253346;10198.643047493302;10351.327163734333;3004.3841012592366;3096.814191148538;3105.503119500869;3105.844707764603;3138.9215269618444;1056.4823236614004;1060.3054998975529;1070.7376692710336;1075.6504136155625;1081.9945900270448;21125;21280.787192127882;21317.36047918565;21437.892810535846;21830.345089647337;1129.6949823547595;1135.2904434728296;1151.7120719820045;1156.7917774800449;1158.5887010111458;11486.712832179095;11832.290062596272;11874.406279685982;11919.225250358872;12043.698907527207;636294;640752;641080;642115;658779;141052;141782;143384;144143;145662.27168864087;1139.2822521811206;1282.538286216961;1288.8388951381078;1295.352323838081;1295.788437810669;21807.78192218121;21827.45431364165;21853;21950.560988779816;22138.114475420804;66249;66679.66660166669;66779.66610166918;67198;69304.30695692978;77482;80953.59523202346;81871;82683;84541.57729211314;15536.456224032105;15981.360745570511;16005.919970400073;16038.839611603735;16119.435819746253;21713.457163571038;22036.33890983273;22131.77868221297;22847.88576057109;23066.192683256006;18848.811511885255;19052.714209286594;19579.118939647466;19952.3016694415;19962.700559491328;17096.230669620145;17305.221265043354;17329.30682772675;17613.647727045132;17647.558811029827;19276;20353.79646203578;20429;20559.69160462624;20652.896735516228;15811.13038782832;15828.68342633164;15842.68314633724;15852.920735396248;15855.445059422866;19305.710414343514;19330.4200873974;19417.805821941598;19538.31615893437;19623.803761962197 07:29:53 INFO - PID 10458 | |3;mootools.html;1500.7673810559363;1515.7726341048842;1540.8228053773819;1556.1441207335963;1568.5843251538345;17087.487375378743;17749.7337539937;17751.467455976308;17763.91118044408;17776.644467110666;17177.227024783882;17193.312267509315;17287.13564321782;17378.304867805273;17391;3005.1585556044342;3037.0736925237793;3080.6303243610687;3089.0423968569703;3098.504239321709;2993.9550906736417;3055.358374741296;3062.678418766031;3065.923351916209;3067.9846600766964;3005.1285127313054;3006.7143621355935;3142.167325658691;3144.8584813683324;3146.307812281306;3105.301307205872;3109.3004074083265;3137.717605415512;3146.606674165729;3149.165471150124;2980.1506570627266;2981.835999020053;3015.909522714322;3017.306019615479;3061.2193890557764;17583.73624395635;17658.11709414524;17735.556611084827;17794.644107117787;17818.376356827448;8793.912060879373;9081.818363632756;9084.50035248061;9087.818243635156;9087.863682044775;5982.940170598282;6106.572539922207;6164.96917515414;6211.068339749028;6241.937580624226;2138.7754285799924;2173.4892300309416;2197.571473562656;2203.7135172427484;2231.732192136954;33202.50196247034;33361.6663833361;33386.165345866306;33432.49851252209;33530.83234583811;7206.459515536356;7206.675699593531;7230.168530619047;7587.241275872479;7668.654910528928;21159.153633854472;21177.364679059654;21276.468088297606;21329.146834126463;21330.78669213319;8850.247728942983;8966.86549701742;8996.910030899739;9019.098090190928;9029.23251523628;8145.714899978472;8196.385271104691;8301.543415112226;8325.458845175166;8370.12113728062;5550.139728342114;5559.208559985625;5576.498115169654;5596.860078497989;5623.184638227434;1552.813662360524;1562.7499600063936;1647.6045749020388;1650;1652;1005.4872015272264;1013.9594416223416;1023.2581378500677;1024.8770147582188;1041.068243921701;9043.502607356528;9104.453732775923;9171.128742769426;9185.816283674423;9259.30555208362;1090.1442367741286;1097.4512743628186;1098.7857367813199;1102.063246240705;1104.6741211342674;5325.440828712929;5364.722312277083;5457.536109430664;5511.53151982086;5663.716814159276;26028.86985565098;26889.193324200307;27073.323166920985;27315.180544583694;27439.862800685867;25557;26719.599206011924;27160;27207;27294;12723.236605803866;13455.125416847874;13457.461701532025;13462.865371346357;13560.932195339157;9006.684766033419;9146;9183.724488265363;9250.814983700153;9277.350585458953;22158.446038849157;22201.029563758144;22816.885915570318;23051.077956881538;23082.422939426648;23427.88286058559;23523.647145293176;23855.403614909766;23909;24115.879420602785;12643.241405515699;12888.548900788428;12889.806652900026;12896.548620798227;12916.612501624966;15835.920820395824;15985.840141598901;16065.759013614572;16073.839261607234;16106.597335066717;12720.936395317964;12895.355232238164;13098.738025239632;13158.605241842377;13293.468261269441;12430.689232768891;12571;12590.181638193488;13005.609831705064;13065.934670326587;10922.508487118257;10998.230123891251;11055.447227638746;11087.722806929569;11092.778144437227;7883.329916957123;7954.5624990626075;7967.681292748457;7967.9203207967175;8103.31121854649;8803.515806630698;8887.73336799897;8895.243904268209;8905.154010369004;8940.240079593308 07:29:53 INFO - PID 10458 | |4;prototype.html;570.2928368822659;574.5547200919287;576.4575147835059;606.8846919085373;611.4741322462681;6471.223453185618;6532.366908272932;6584.572002819813;6596.142501474802;6608.273089960113;6328.177336946202;6342.619442833433;6473.190851143607;6483.902741458882;6507.9023814642815;5273.8945221095555;5303.761330740107;5307.548858347026;5308.389535203462;5353.223782551528;5035.295058691768;5115.462876397981;5235.528802407783;5235.816746413876;5265.631405801595;5063;5110.667806592578;5123.897522049557;5127.666701664399;5139.100657384962;5084.161113416319;5097.929434818692;5109.463506331837;5128.846009647837;5130.102232109366;4648.325992731069;4677.532246775329;4685.4143232095985;4715.976420117911;4730.834420795256;6345.555811093179;6396.680165991682;6406.359364063603;6410.67946602668;6415.422611964899;6019.488343490765;6072.724727807165;6078.756849726005;6119.265688117454;6172.67287533178;6874.9750109951465;6891.793246202622;6899.137607799025;6900.930990690079;6915.204751453597;5244.632875698702;5256.474352564751;5289.285946397225;5302.310699609065;5318.627696061278;6850.897236541456;6989.266127056637;6994.5803251805055;7087.574745515286;7155;5391.29913111293;5391.433899440581;5397.622166448311;5420.322459692538;5438.15708565173;5471.179323101487;5478.315210598676;5480.862978425571;5506.779728810883;5531.3915469298345;6060.181875446847;6070.817875463743;6101.572889897665;6107;6132.448079672851;6823.28355522663;6844.691988860513;6857.657117144123;6918.654067296615;6924.130484769084;1880.2854915132161;1894.8157401623985;1899.6390685769936;1904.9714254286196;1910.3695780392436;1308.2673702726504;1329.4947919790418;1342.4831439895515;1356.3625096204769;1363.3319673360181;6350.523710721714;6419.903701444482;6420.325865784119;6438.58553042609;6447.323031081763;6839.469396323392;6861.176658800976;6917.619530925847;6985.511014229057;7071.186813516409;6348.460380867678;6395.840103997344;6420.5184611154355;6468.8059358219325;6547.050677651714;3660.3228402745576;3673.4673472346362;3675.1547144156993;3682.3924052531033;3700.9259814803554;7017.298270173044;7021.157461104598;7077.186123595749;7112.6443677815905;7160.641967901584;7031.40233080194;7040.084788977502;7047.612381319077;7136.220590439104;7158.2125966143685;7120.608366539786;7139.178994415501;7216.855662886818;7241.637918104074;7243.7464688735645;6901;6901.1718593769065;6909.585424874524;6987.231404545598;7075.221725610076;6920.757773477904;6942.583444993316;6945.340192681687;6946.79159625212;6990.16118065815;7225.747098851515;7252.891206631799;7268.527545709512;7273.163586187656;7289.198188199188;5421.295231619864;5421.945780542144;5452.454754524516;5459.727013649381;5467.371252306036;6879.724811007503;6949.826254343682;6985.825354366181;7025.332593403618;7059.223485416703;6592.307807680125;6750.763723269858;6810.829729256809;6817.840967035517;6871.553349032297;6623.509710315333;6655;6721.899171512334;6736.663166841737;6774.119364482585;6500.479961603155;6586.604803711793;6615.900761488678;6641.435477984425;6650.20197576294;6717.529772915849;6733.360330768569;6796.796096117125;6831.795046148623;6834;6598.822388611842;6636.336366363325;6701.597904125768;6704.351781046362;6728.764493242713 07:29:53 INFO - PID 10458 | |5;yui.html;976.7069879036287;996.5117092624613;1003.1673710820015;1015.7866847961927;1028.593705486333;20844.37466875994;21547.353579392624;21573.67639485405;21582.244621438214;24302.635460468064;24273.393165170837;24295;24414.389640258956;24504;24575;1016.8830584482805;1081.7403823082443;1083.3012706804107;1088.17298852872;1095.5234473004268;1115.6485707002269;1120.495776900394;1125.386664267976;1125.926814757038;1127.780082883838;1093.2456604942604;1128.7121783945124;1129.1644183304377;1129.322406556064;1134.353418551426;1119.7256672115302;1129.4183495499824;1131.3720884908955;1131.7849608574386;1132.1452303510837;825.7027470110755;826.3265438667527;828.7348048624442;829.5686243153586;829.7552222094497;19454.416367508857;20126.295579654787;20332.186712531628;20352.084156213004;20375.49061273465;22686.432839178986;23021.76978230213;23196.884015579813;23201.7679823203;23236.18673346425;19495;19620.215191392326;19718.70421943672;19860.801391986184;19901.402957911287;4097.97951010243;4184.811683474251;4190.497140343178;4195.223883581547;4197.622214000755;161536;166466;167828.16085919616;170095;172465;16796.916015419843;17210.70919681004;17367.56581085483;17414.912925435292;17448;35113.297734045176;35992.46011309832;36161.8191909044;36269.81865090658;36352.45471317932;10067.798644027225;10082.294239403318;10160.4919754012;10161.085502304828;10277.845832312521;5033.1695270280725;5046.1926091825135;5052.368453943257;5135.743212839343;5145.253938178943;6624.768133115318;6676.330917270682;6681.365270299314;6768.424683901923;6846.554973926778;1202.7113492761848;1202.9939850300693;1222.2849632964815;1231.2673958994385;1233.0690328801877;769.5075151902787;774.7482068327703;796.8366484870587;796.9880451793227;805.8348038652063;12475.5009799607;12889.355532223351;13373.531926382724;13865.029447938547;13899.374528146056;709.1596458197052;714.639107250835;718.8418547919449;722.1334398721555;732.5568031341069;6087.756489740449;6148.415900489446;6157.476614487819;6245.406686364879;6281;155993;157805;158057;161749;164680;132017.33991329983;132441;133285;134449.67487134377;136166.3191684035;111696.44151779189;112758.43620781843;113211;113925;114278;11614.941925290319;11700.414979250832;11866.584669536525;12135.878641213829;12190.085743569445;58776.70611646914;59053.40946590479;59292.40707592869;59374.70312648409;59865;72308.63845680738;72437.63781181061;72808;74820;75560;17265.13674316254;17387.217575209397;17412.303507859542;17555.385561505285;17748.733768993734;18122.72815907736;18750.156242969373;18775.436736897915;18912.43262702121;19125.90437047806;16974.83025169782;17218.139093045047;17296.048717320667;17366.565835854206;17486.82513174852;15782.210889455251;15876;15894.377427724758;15899;15962.521124366287;16579.171041447637;16768.832311677215;16771.91614041922;16816.159192040595;16826.66346673035;11392.886071139183;12090.818637720266;12112.878871211175;12135.75728485443;12257.877421225674;11741.354225517678;11810.881891180978;11841.82237266459;11844.70388240301;11879.406029698308 07:29:53 INFO - PID 10458 | __end_tp_report 07:29:53 INFO - PID 10458 | __start_cc_report 07:29:53 INFO - PID 10458 | _x_x_mozilla_cycle_collect,248 07:29:53 INFO - PID 10458 | __end_cc_report 07:29:53 INFO - PID 10458 | __startTimestamp1506436193035__endTimestamp 07:29:53 INFO - PID 10458 | 07:29:53 INFO - PID 10458 | ------- Summary: start ------- 07:29:53 INFO - PID 10458 | Number of tests: 6 07:29:53 INFO - PID 10458 | 07:29:53 INFO - PID 10458 | [#0] dojo.html Cycles:165 Average:6673.53 Median:6887.90 stddev:763.29 (11.1%) stddev-sans-first:735.95 07:29:53 INFO - PID 10458 | Values: 3986.8 3993.9 4025.5 4038.8 4073.9 6636.2 6673.8 6708.2 6731.1 6748.6 6682.7 6685.4 6747.9 6755.7 6778.6 5940.2 5981.6 6029.1 6042.7 6116.9 5991.0 6014.8 6021.5 6031.6 6067.2 6075.9 6102.0 6105.7 6132.4 6139.5 6035.2 6051.3 6066.2 6141.6 6155.8 5920.8 5932.0 5938.8 5973.0 5997.6 6617.7 6621.8 6638.4 6656.7 6693.4 7235.4 7242.5 7311.4 7318.2 7332.9 6939.7 7262.3 7305.2 7342.0 7361.0 6730.8 6738.4 6768.6 6769.5 6781.3 7353.8 7401.1 7407.7 7437.3 7445.2 7091.7 7115.5 7150.9 7185.7 7208.0 7171.8 7235.1 7249.2 7268.8 7350.8 7174.2 7183.3 7202.9 7218.8 7222.2 7110.4 7113.1 7128.4 7138.5 7206.0 5325.7 5337.0 5373.5 5419.4 5461.3 4933.2 4971.4 5006.3 5011.3 5011.7 6694.5 6708.2 6786.3 6786.4 6815.0 7156.6 7212.3 7236.9 7237.6 7327.9 6548.1 6635.9 6642.0 6644.2 6646.9 6170.7 6181.7 6191.2 6208.9 6222.9 7284.7 7462.7 7495.8 7498.1 7577.1 7131.4 7137.6 7258.2 7298.3 7317.5 7470.9 7498.9 7571.5 7586.9 7593.7 7024.9 7087.9 7127.4 7140.0 7142.0 7145.2 7183.6 7238.6 7293.7 7351.7 6936.3 6978.9 6985.8 6988.0 6991.0 6879.1 6887.7 6887.9 6897.2 6980.7 6823.1 6833.7 6929.3 6934.3 6939.5 7042.6 7064.8 7082.1 7093.7 7139.8 6765.1 6810.8 6870.1 6927.5 6930.9 07:29:53 INFO - PID 10458 | 07:29:53 INFO - PID 10458 | [#1] ext.html Cycles:180 Average:43668.18 Median:20304.29 stddev:65750.28 (323.8%) stddev-sans-first:65856.54 07:29:53 INFO - PID 10458 | Values: 963.9 967.5 985.6 1014.1 1019.3 44598.6 45651.5 45693.5 45710.0 45712.3 42342.8 42354.4 42375.8 42671.8 42707.4 8019.4 8094.8 8112.4 8154.2 8167.5 8021.3 8167.8 8174.3 8177.8 8187.3 8637.8 8795.4 8795.6 8828.3 8829.5 8681.5 8715.5 8737.0 8743.1 8778.4 8682.0 8702.2 8718.1 8768.0 8787.7 40249.8 40376.2 40432.0 40527.4 40546.6 3700.8 3725.7 3727.3 3754.4 3756.7 33257.8 33422.0 33437.3 33484.5 33819.5 5594.0 5626.7 5643.4 5686.2 5693.4 219416.0 219568.0 220896.0 220942.0 221960.0 52580.9 52863.7 52994.2 53133.2 53205.7 56176.2 56374.0 56462.7 56483.7 56631.0 18197.6 18704.4 18708.7 18709.7 18715.2 15315.7 15424.8 15496.6 15514.5 15515.4 15342.8 15815.1 15850.1 15903.5 15956.0 6102.6 6144.4 6203.1 6249.5 6263.7 1088.6 1105.3 1105.9 1115.0 1131.9 26153.7 26174.0 26270.7 26304.2 26486.3 1212.5 1227.7 1233.8 1241.6 1247.8 13696.4 13991.2 14079.6 14181.4 14247.6 279007.0 283450.0 283725.0 284095.0 284172.0 57902.0 59504.0 63904.4 64209.4 64276.4 1551.3 1557.2 1562.3 1574.8 1588.9 30447.2 30967.9 30975.7 31197.0 31298.7 42395.4 42551.4 42603.8 42775.0 42817.4 251044.0 252103.0 252105.0 252967.0 253321.0 36290.5 36736.4 36880.6 36907.8 37010.3 47352.3 47555.5 47967.5 47996.8 48163.5 34936.8 35288.3 35404.6 35866.8 36382.8 34868.0 35093.0 35147.3 35409.3 35502.0 41021.0 41218.8 41321.2 41582.6 41617.4 33396.7 33569.2 34007.1 34024.8 34329.7 25031.5 25050.2 25955.7 26222.2 26691.5 07:29:53 INFO - PID 10458 | 07:29:53 INFO - PID 10458 | [#2] jquery.html Cycles:180 Average:41785.39 Median:21841.67 stddev:107834.35 (493.7%) stddev-sans-first:108092.61 07:29:53 INFO - PID 10458 | Values: 643.8 644.6 644.8 647.2 653.1 24005.3 24656.6 24695.1 24717.9 24749.0 26235.5 26529.9 26533.3 26655.3 26677.3 6301.2 6641.3 6673.8 6736.5 6768.0 6647.4 6704.7 6708.1 6710.2 6725.5 6648.0 6679.7 6682.1 6693.1 6827.3 6890.7 6945.3 6947.4 6948.4 6954.2 6510.2 6524.9 6529.3 6542.5 6542.9 30043.5 30462.1 30545.2 30562.1 30595.4 2248.5 2313.6 2317.0 2318.5 2320.0 21081.4 21603.7 21627.8 21737.5 21789.7 2618.1 2639.5 2681.6 2687.0 2690.9 143994.0 150135.0 152179.0 167846.2 175278.1 15968.6 16332.9 16844.9 16866.7 16975.2 26788.1 26838.7 26939.6 26954.7 27001.7 11388.9 11490.7 11603.2 11624.9 11804.6 10671.5 10755.8 10803.3 10899.4 10936.3 9954.4 9990.5 10014.8 10198.6 10351.3 3004.4 3096.8 3105.5 3105.8 3138.9 1056.5 1060.3 1070.7 1075.7 1082.0 21125.0 21280.8 21317.4 21437.9 21830.3 1129.7 1135.3 1151.7 1156.8 1158.6 11486.7 11832.3 11874.4 11919.2 12043.7 636294.0 640752.0 641080.0 642115.0 658779.0 141052.0 141782.0 143384.0 144143.0 145662.3 1139.3 1282.5 1288.8 1295.4 1295.8 21807.8 21827.5 21853.0 21950.6 22138.1 66249.0 66679.7 66779.7 67198.0 69304.3 77482.0 80953.6 81871.0 82683.0 84541.6 15536.5 15981.4 16005.9 16038.8 16119.4 21713.5 22036.3 22131.8 22847.9 23066.2 18848.8 19052.7 19579.1 19952.3 19962.7 17096.2 17305.2 17329.3 17613.6 17647.6 19276.0 20353.8 20429.0 20559.7 20652.9 15811.1 15828.7 15842.7 15852.9 15855.4 19305.7 19330.4 19417.8 19538.3 19623.8 07:29:53 INFO - PID 10458 | 07:29:53 INFO - PID 10458 | [#3] mootools.html Cycles:180 Average:10979.00 Median:27183.50 stddev:8322.71 (30.6%) stddev-sans-first:8315.59 07:29:53 INFO - PID 10458 | Values: 1500.8 1515.8 1540.8 1556.1 1568.6 17087.5 17749.7 17751.5 17763.9 17776.6 17177.2 17193.3 17287.1 17378.3 17391.0 3005.2 3037.1 3080.6 3089.0 3098.5 2994.0 3055.4 3062.7 3065.9 3068.0 3005.1 3006.7 3142.2 3144.9 3146.3 3105.3 3109.3 3137.7 3146.6 3149.2 2980.2 2981.8 3015.9 3017.3 3061.2 17583.7 17658.1 17735.6 17794.6 17818.4 8793.9 9081.8 9084.5 9087.8 9087.9 5982.9 6106.6 6165.0 6211.1 6241.9 2138.8 2173.5 2197.6 2203.7 2231.7 33202.5 33361.7 33386.2 33432.5 33530.8 7206.5 7206.7 7230.2 7587.2 7668.7 21159.2 21177.4 21276.5 21329.1 21330.8 8850.2 8966.9 8996.9 9019.1 9029.2 8145.7 8196.4 8301.5 8325.5 8370.1 5550.1 5559.2 5576.5 5596.9 5623.2 1552.8 1562.7 1647.6 1650.0 1652.0 1005.5 1014.0 1023.3 1024.9 1041.1 9043.5 9104.5 9171.1 9185.8 9259.3 1090.1 1097.5 1098.8 1102.1 1104.7 5325.4 5364.7 5457.5 5511.5 5663.7 26028.9 26889.2 27073.3 27315.2 27439.9 25557.0 26719.6 27160.0 27207.0 27294.0 12723.2 13455.1 13457.5 13462.9 13560.9 9006.7 9146.0 9183.7 9250.8 9277.4 22158.4 22201.0 22816.9 23051.1 23082.4 23427.9 23523.6 23855.4 23909.0 24115.9 12643.2 12888.5 12889.8 12896.5 12916.6 15835.9 15985.8 16065.8 16073.8 16106.6 12720.9 12895.4 13098.7 13158.6 13293.5 12430.7 12571.0 12590.2 13005.6 13065.9 10922.5 10998.2 11055.4 11087.7 11092.8 7883.3 7954.6 7967.7 7967.9 8103.3 8803.5 8887.7 8895.2 8905.2 8940.2 07:29:53 INFO - PID 10458 | 07:29:53 INFO - PID 10458 | [#4] prototype.html Cycles:180 Average:5824.97 Median:6470.01 stddev:1613.63 (24.9%) stddev-sans-first:1569.22 07:29:53 INFO - PID 10458 | Values: 570.3 574.6 576.5 606.9 611.5 6471.2 6532.4 6584.6 6596.1 6608.3 6328.2 6342.6 6473.2 6483.9 6507.9 5273.9 5303.8 5307.5 5308.4 5353.2 5035.3 5115.5 5235.5 5235.8 5265.6 5063.0 5110.7 5123.9 5127.7 5139.1 5084.2 5097.9 5109.5 5128.8 5130.1 4648.3 4677.5 4685.4 4716.0 4730.8 6345.6 6396.7 6406.4 6410.7 6415.4 6019.5 6072.7 6078.8 6119.3 6172.7 6875.0 6891.8 6899.1 6900.9 6915.2 5244.6 5256.5 5289.3 5302.3 5318.6 6850.9 6989.3 6994.6 7087.6 7155.0 5391.3 5391.4 5397.6 5420.3 5438.2 5471.2 5478.3 5480.9 5506.8 5531.4 6060.2 6070.8 6101.6 6107.0 6132.4 6823.3 6844.7 6857.7 6918.7 6924.1 1880.3 1894.8 1899.6 1905.0 1910.4 1308.3 1329.5 1342.5 1356.4 1363.3 6350.5 6419.9 6420.3 6438.6 6447.3 6839.5 6861.2 6917.6 6985.5 7071.2 6348.5 6395.8 6420.5 6468.8 6547.1 3660.3 3673.5 3675.2 3682.4 3700.9 7017.3 7021.2 7077.2 7112.6 7160.6 7031.4 7040.1 7047.6 7136.2 7158.2 7120.6 7139.2 7216.9 7241.6 7243.7 6901.0 6901.2 6909.6 6987.2 7075.2 6920.8 6942.6 6945.3 6946.8 6990.2 7225.7 7252.9 7268.5 7273.2 7289.2 5421.3 5421.9 5452.5 5459.7 5467.4 6879.7 6949.8 6985.8 7025.3 7059.2 6592.3 6750.8 6810.8 6817.8 6871.6 6623.5 6655.0 6721.9 6736.7 6774.1 6500.5 6586.6 6615.9 6641.4 6650.2 6717.5 6733.4 6796.8 6831.8 6834.0 6598.8 6636.3 6701.6 6704.4 6728.8 07:29:53 INFO - PID 10458 | 07:29:53 INFO - PID 10458 | [#5] yui.html Cycles:180 Average:29056.07 Median:17377.39 stddev:43957.24 (253.0%) stddev-sans-first:44029.99 07:29:53 INFO - PID 10458 | Values: 976.7 996.5 1003.2 1015.8 1028.6 20844.4 21547.4 21573.7 21582.2 24302.6 24273.4 24295.0 24414.4 24504.0 24575.0 1016.9 1081.7 1083.3 1088.2 1095.5 1115.6 1120.5 1125.4 1125.9 1127.8 1093.2 1128.7 1129.2 1129.3 1134.4 1119.7 1129.4 1131.4 1131.8 1132.1 825.7 826.3 828.7 829.6 829.8 19454.4 20126.3 20332.2 20352.1 20375.5 22686.4 23021.8 23196.9 23201.8 23236.2 19495.0 19620.2 19718.7 19860.8 19901.4 4098.0 4184.8 4190.5 4195.2 4197.6 161536.0 166466.0 167828.2 170095.0 172465.0 16796.9 17210.7 17367.6 17414.9 17448.0 35113.3 35992.5 36161.8 36269.8 36352.5 10067.8 10082.3 10160.5 10161.1 10277.8 5033.2 5046.2 5052.4 5135.7 5145.3 6624.8 6676.3 6681.4 6768.4 6846.6 1202.7 1203.0 1222.3 1231.3 1233.1 769.5 774.7 796.8 797.0 805.8 12475.5 12889.4 13373.5 13865.0 13899.4 709.2 714.6 718.8 722.1 732.6 6087.8 6148.4 6157.5 6245.4 6281.0 155993.0 157805.0 158057.0 161749.0 164680.0 132017.3 132441.0 133285.0 134449.7 136166.3 111696.4 112758.4 113211.0 113925.0 114278.0 11614.9 11700.4 11866.6 12135.9 12190.1 58776.7 59053.4 59292.4 59374.7 59865.0 72308.6 72437.6 72808.0 74820.0 75560.0 17265.1 17387.2 17412.3 17555.4 17748.7 18122.7 18750.2 18775.4 18912.4 19125.9 16974.8 17218.1 17296.0 17366.6 17486.8 15782.2 15876.0 15894.4 15899.0 15962.5 16579.2 16768.8 16771.9 16816.2 16826.7 11392.9 12090.8 12112.9 12135.8 12257.9 11741.4 11810.9 11841.8 11844.7 11879.4 07:29:53 INFO - PID 10458 | -------- Summary: end -------- 07:29:53 INFO - PID 10458 | 07:29:53 INFO - TEST-INFO | 10458: exit 0 07:29:53 INFO - TEST-OK | dromaeo_css | took 1106770ms 07:29:53 INFO - TEST-START | kraken 07:29:53 INFO - Initialising browser for kraken test... 07:29:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54903/getInfo.html -profile /tmp/tmplbtzgh/profile 07:29:53 INFO - TEST-INFO | started process 10827 (/builds/slave/test/build/application/firefox/firefox http://localhost:54903/getInfo.html) 07:29:57 INFO - TEST-INFO | 10827: exit 0 07:29:57 INFO - Browser initialized. 07:29:57 INFO - Running cycle 1/1 for kraken test... 07:29:57 INFO - Using env: {'DISPLAY': ':0', 07:29:57 INFO - 'HOME': '/home/cltbld', 07:29:57 INFO - 'JSGC_DISABLE_POISONING': '1', 07:29:57 INFO - 'LANG': 'en_US.UTF-8', 07:29:57 INFO - 'LANGUAGE': 'en_US:en', 07:29:57 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:29:57 INFO - 'LOGNAME': 'cltbld', 07:29:57 INFO - 'MAIL': '/var/mail/cltbld', 07:29:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:29:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:29:57 INFO - 'MOZ_CRASHREPORTER': '1', 07:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:57 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:29:57 INFO - 'MOZ_NO_REMOTE': '1', 07:29:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:57 INFO - 'NO_EM_RESTART': '1', 07:29:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:57 INFO - 'PWD': '/builds/slave/test', 07:29:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:29:57 INFO - 'RUST_BACKTRACE': 'full', 07:29:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:29:57 INFO - 'SHELL': '/bin/bash', 07:29:57 INFO - 'SHLVL': '1', 07:29:57 INFO - 'TERM': 'linux', 07:29:57 INFO - 'TMOUT': '86400', 07:29:57 INFO - 'USER': 'cltbld', 07:29:57 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887', 07:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:57 INFO - '_': '/tools/buildbot/bin/python'} 07:29:57 INFO - TEST-INFO | started process 11018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplbtzgh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:58 INFO - PID 11018 | 07:29:58 INFO - PID 11018 | (/builds/slave/test/build/application/firefox/firefox:11066): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:29:58 INFO - PID 11018 | 07:30:09 INFO - PID 11018 | RSS: Main: 143134720 07:30:09 INFO - PID 11018 | 07:30:11 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:54903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54903/tests/kraken/driver.html?testName=audio-beat-detection) 07:30:12 INFO - PID 11018 | RSS: Main: 148746240 07:30:12 INFO - PID 11018 | 07:30:15 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:54903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54903/tests/kraken/driver.html?testName=audio-dft) 07:30:15 INFO - PID 11018 | RSS: Main: 149762048 07:30:15 INFO - PID 11018 | 07:30:18 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:54903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54903/tests/kraken/driver.html?testName=audio-fft) 07:30:19 INFO - PID 11018 | RSS: Main: 151240704 07:30:19 INFO - PID 11018 | 07:30:21 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:54903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54903/tests/kraken/driver.html?testName=audio-oscillator) 07:30:21 INFO - PID 11018 | RSS: Main: 150835200 07:30:21 INFO - PID 11018 | 07:30:23 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:54903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:30:24 INFO - PID 11018 | RSS: Main: 150880256 07:30:24 INFO - PID 11018 | 07:30:27 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:54903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54903/tests/kraken/driver.html?testName=imaging-darkroom) 07:30:28 INFO - PID 11018 | RSS: Main: 150900736 07:30:28 INFO - PID 11018 | 07:30:31 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:54903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54903/tests/kraken/driver.html?testName=imaging-desaturate) 07:30:32 INFO - PID 11018 | RSS: Main: 151793664 07:30:32 INFO - PID 11018 | 07:30:35 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:54903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54903/tests/kraken/driver.html?testName=json-parse-financial) 07:30:35 INFO - PID 11018 | RSS: Main: 152956928 07:30:35 INFO - PID 11018 | 07:30:37 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:54903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:30:37 INFO - PID 11018 | RSS: Main: 152522752 07:30:37 INFO - PID 11018 | 07:30:39 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:54903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54903/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:30:39 INFO - PID 11018 | RSS: Main: 152809472 07:30:39 INFO - PID 11018 | 07:30:41 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:54903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:30:42 INFO - PID 11018 | RSS: Main: 149716992 07:30:42 INFO - PID 11018 | 07:30:44 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:54903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:30:45 INFO - PID 11018 | RSS: Main: 149987328 07:30:45 INFO - PID 11018 | 07:30:48 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:54903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:30:48 INFO - PID 11018 | RSS: Main: 150589440 07:30:48 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | Cycle 1(1): loaded http://localhost:54903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54903/tests/kraken/driver.html?testName=ai-astar) 07:30:50 INFO - PID 11018 | RSS: Main: 152092672 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | __start_tp_report 07:30:50 INFO - PID 11018 | _x_x_mozilla_page_load 07:30:50 INFO - PID 11018 | _x_x_mozilla_page_load_details 07:30:50 INFO - PID 11018 | |i|pagename|runs| 07:30:50 INFO - PID 11018 | |0;ai-astar;104;106;106;104;107;110;107;108;105;109 07:30:50 INFO - PID 11018 | |1;audio-beat-detection;117;111;111;112;112;144;123;113;111;141 07:30:50 INFO - PID 11018 | |2;audio-dft;163;164;162;160;162;166;162;162;161;161 07:30:50 INFO - PID 11018 | |3;audio-fft;78;73;75;73;74;75;75;74;74;74 07:30:50 INFO - PID 11018 | |4;audio-oscillator;79;77;80;82;76;78;77;80;79;82 07:30:50 INFO - PID 11018 | |5;imaging-gaussian-blur;113;114;114;113;114;113;114;113;113;114 07:30:50 INFO - PID 11018 | |6;imaging-darkroom;148;159;148;148;149;149;148;150;148;153 07:30:50 INFO - PID 11018 | |7;imaging-desaturate;94;95;97;95;94;95;94;95;96;93 07:30:50 INFO - PID 11018 | |8;json-parse-financial;45;45;44;44;44;50;46;44;41;45 07:30:50 INFO - PID 11018 | |9;json-stringify-tinderbox;38;39;38;38;38;38;38;38;39;38 07:30:50 INFO - PID 11018 | |10;stanford-crypto-aes;73;73;71;70;70;69;70;71;71;74 07:30:50 INFO - PID 11018 | |11;stanford-crypto-ccm;106;107;101;102;103;108;102;106;106;102 07:30:50 INFO - PID 11018 | |12;stanford-crypto-pbkdf2;153;169;152;158;148;146;144;152;149;147 07:30:50 INFO - PID 11018 | |13;stanford-crypto-sha256-iterative;60;58;57;59;62;59;58;59;58;64 07:30:50 INFO - PID 11018 | __end_tp_report 07:30:50 INFO - PID 11018 | __start_cc_report 07:30:50 INFO - PID 11018 | _x_x_mozilla_cycle_collect,691 07:30:50 INFO - PID 11018 | __end_cc_report 07:30:50 INFO - PID 11018 | __startTimestamp1506436250777__endTimestamp 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | ------- Summary: start ------- 07:30:50 INFO - PID 11018 | Number of tests: 14 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | [#0] ai-astar Cycles:10 Average:106.60 Median:107.00 stddev:2.01 (1.9%) stddev-sans-first:1.90 07:30:50 INFO - PID 11018 | Values: 104.0 106.0 106.0 104.0 107.0 110.0 107.0 108.0 105.0 109.0 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | [#1] audio-beat-detection Cycles:10 Average:119.50 Median:115.00 stddev:12.70 (11.0%) stddev-sans-first:13.44 07:30:50 INFO - PID 11018 | Values: 117.0 111.0 111.0 112.0 112.0 144.0 123.0 113.0 111.0 141.0 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.70 (1.1%) stddev-sans-first:1.79 07:30:50 INFO - PID 11018 | Values: 163.0 164.0 162.0 160.0 162.0 166.0 162.0 162.0 161.0 161.0 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | [#3] audio-fft Cycles:10 Average:74.50 Median:74.50 stddev:1.43 (1.9%) stddev-sans-first:0.78 07:30:50 INFO - PID 11018 | Values: 78.0 73.0 75.0 73.0 74.0 75.0 75.0 74.0 74.0 74.0 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | [#4] audio-oscillator Cycles:10 Average:79.00 Median:79.50 stddev:2.05 (2.6%) stddev-sans-first:2.18 07:30:50 INFO - PID 11018 | Values: 79.0 77.0 80.0 82.0 76.0 78.0 77.0 80.0 79.0 82.0 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:30:50 INFO - PID 11018 | Values: 113.0 114.0 114.0 113.0 114.0 113.0 114.0 113.0 113.0 114.0 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:149.00 stddev:3.53 (2.4%) stddev-sans-first:3.67 07:30:50 INFO - PID 11018 | Values: 148.0 159.0 148.0 148.0 149.0 149.0 148.0 150.0 148.0 153.0 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:1.14 (1.2%) stddev-sans-first:1.17 07:30:50 INFO - PID 11018 | Values: 94.0 95.0 97.0 95.0 94.0 95.0 94.0 95.0 96.0 93.0 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | [#8] json-parse-financial Cycles:10 Average:44.80 Median:45.00 stddev:2.25 (5.0%) stddev-sans-first:2.39 07:30:50 INFO - PID 11018 | Values: 45.0 45.0 44.0 44.0 44.0 50.0 46.0 44.0 41.0 45.0 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 07:30:50 INFO - PID 11018 | Values: 38.0 39.0 38.0 38.0 38.0 38.0 38.0 38.0 39.0 38.0 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | [#10] stanford-crypto-aes Cycles:10 Average:71.20 Median:71.00 stddev:1.62 (2.3%) stddev-sans-first:1.58 07:30:50 INFO - PID 11018 | Values: 73.0 73.0 71.0 70.0 70.0 69.0 70.0 71.0 71.0 74.0 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | [#11] stanford-crypto-ccm Cycles:10 Average:104.30 Median:106.00 stddev:2.54 (2.4%) stddev-sans-first:2.62 07:30:50 INFO - PID 11018 | Values: 106.0 107.0 101.0 102.0 103.0 108.0 102.0 106.0 106.0 102.0 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:152.00 stddev:7.27 (4.8%) stddev-sans-first:7.70 07:30:50 INFO - PID 11018 | Values: 153.0 169.0 152.0 158.0 148.0 146.0 144.0 152.0 149.0 147.0 07:30:50 INFO - PID 11018 | 07:30:50 INFO - PID 11018 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.40 Median:59.00 stddev:2.12 (3.6%) stddev-sans-first:2.24 07:30:50 INFO - PID 11018 | Values: 60.0 58.0 57.0 59.0 62.0 59.0 58.0 59.0 58.0 64.0 07:30:50 INFO - PID 11018 | -------- Summary: end -------- 07:30:50 INFO - PID 11018 | 07:30:51 INFO - PID 11018 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:30:51 INFO - TEST-INFO | 11018: exit 0 07:30:51 INFO - TEST-OK | kraken | took 57731ms 07:30:51 INFO - SUITE-END | took 1164s 07:30:51 INFO - Completed test suite (00:19:24) 07:30:51 INFO - javascript benchmark 07:30:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9414.571074335314, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3986.8238869533484, 3993.880183594492, 4025.5370632377285, 4038.7778672173035, 4073.8777836664913, 6636.236832764233, 6673.766418175364, 6708.161479815023, 6731.057651928728, 6748.561343512668, 6682.722753269815, 6685.364890335411, 6747.898781518281, 6755.695993680284, 6778.627175505345, 5940.168376427304, 5981.611195272304, 6029.1257767623665, 6042.697865106749, 6116.908246376308, 5990.970045149768, 6014.8195554133445, 6021.45806877381, 6031.60794548353, 6067.24159480065, 6075.878482430371, 6102.0, 6105.725242364104, 6132.4480796728285, 6139.478144357735, 6035.245594300713, 6051.334353221142, 6066.241719785027, 6141.6007959482495, 6155.753769849201, 5920.792772252994, 5931.970340148315, 5938.792142275, 5973.0, 5997.5501837361935, 6617.735290588371, 6621.801345959629, 6638.369354911276, 6656.700448479782, 6693.364130407652, 7235.384992275663, 7242.45681573884, 7311.415086793044, 7318.194998550155, 7332.853342933165, 6939.722411103549, 7262.346388825031, 7305.232950540223, 7341.9632901835685, 7361.043064401647, 6730.83172920676, 6738.393544581011, 6768.593884366905, 6769.52613317068, 6781.321867813278, 7353.77938661841, 7401.111866576045, 7407.703691852374, 7437.330640242404, 7445.181030086686, 7091.680874360666, 7115.537490063233, 7150.892736608955, 7185.748498802622, 7208.0, 7171.784846454615, 7235.059442272576, 7249.238829922782, 7268.818279542948, 7350.816229594303, 7174.246704096099, 7183.281671832775, 7202.92797072033, 7218.783436496913, 7222.241664625139, 7110.3956163725625, 7113.060380273576, 7128.394086502602, 7138.464615153885, 7206.0, 5325.733713314319, 5337.039332920034, 5373.543248823816, 5419.403865574784, 5461.262729531462, 4933.235348520985, 4971.353724015855, 5006.299118123466, 5011.273365362002, 5011.724355160428, 6694.531382803157, 6708.228553716288, 6786.253512113763, 6786.355296246848, 6815.0, 7156.570605763671, 7212.3148300911325, 7236.891446628305, 7237.638118094074, 7327.8534429312185, 6548.050532672831, 6635.900461493082, 6642.0, 6644.202695676453, 6646.933530664728, 6170.691465426711, 6181.660008699565, 6191.164192834, 6208.906866397007, 6222.906656400158, 7284.6721897514735, 7462.70149194037, 7495.775126746206, 7498.062742157231, 7577.128630207597, 7131.429485641136, 7137.607431591208, 7258.237885022208, 7298.343149116605, 7317.451191160578, 7470.887936680845, 7498.887516687363, 7571.545707257582, 7586.924130758622, 7593.734219302298, 7024.894626580503, 7087.893681594884, 7127.394171495481, 7139.964300178466, 7141.9642901785155, 7145.249748776304, 7183.568985860865, 7238.6380680966795, 7293.744718935024, 7351.742689005859, 6936.271691472524, 6978.930210698031, 6985.790426287016, 6988.021676965127, 6990.965045174741, 6879.071325371211, 6887.6556172192195, 6887.896681549681, 6897.241303456515, 6980.720771169096, 6823.078884350549, 6833.658317084027, 6929.341712537301, 6934.341237582422, 6939.514234003571, 7042.577445353295, 7064.823379415556, 7082.079329687108, 7093.680784364819, 7139.82150446243, 6765.1205343305055, 6810.761623343357, 6870.141232345957, 6927.549709268881, 6930.896036559557], "value": 6622.905625783548, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [963.8891527474339, 967.4678926590374, 985.620536093604, 1014.0569270578359, 1019.261035749082, 44598.554014459885, 45651.54348456518, 45693.54306456934, 45710.0, 45712.3143152853, 42342.7882860586, 42354.364684529755, 42375.788121059355, 42671.78664106675, 42707.359389609104, 8019.438639295237, 8094.797630059236, 8112.43212975092, 8154.184581541857, 8167.469114507568, 8021.318187954031, 8167.79580510489, 8174.305184059363, 8177.79555511111, 8187.345012398994, 8637.827243455127, 8795.384323097385, 8795.560221988875, 8828.337874659393, 8829.470231786081, 8681.522516261603, 8715.477071375737, 8737.038925718165, 8743.081976392483, 8778.429402088845, 8682.0, 8702.173293537104, 8718.084601116854, 8768.0, 8787.736367908972, 40249.798751006354, 40376.19247615061, 40432.0, 40527.392089118686, 40546.59453405487, 3700.7594506357, 3725.701943844486, 3727.310447567209, 3754.3617585010343, 3756.7370284080125, 33257.83371083153, 33422.0, 33437.33125337504, 33484.49773253403, 33819.4927076094, 5593.972030139823, 5626.718664066781, 5643.407442218549, 5686.1755045518585, 5693.430656934315, 219416.0, 219568.0, 220896.0, 220942.0, 221960.0, 52580.94838103216, 52863.73568132135, 52994.20508692373, 53133.203001955, 53205.73397133067, 56176.15735763967, 56374.0, 56462.717686411306, 56483.71758141183, 56631.0, 18197.636047278982, 18704.438866834018, 18708.719369209473, 18709.719354209697, 18715.157817897954, 15315.693686126215, 15424.768628470581, 15496.612584685248, 15514.5345639631, 15515.379384824706, 15342.846571534143, 15815.13016784088, 15850.128242946517, 15903.52289431319, 15956.042637441791, 6102.572819902564, 6144.385561443909, 6203.069539569011, 6249.500039996789, 6263.71813268404, 1088.6407485529755, 1105.2594761509808, 1105.9170562207705, 1115.041064684371, 1131.9207655464204, 26153.73846261551, 26174.0, 26270.73729262721, 26304.21087367382, 26486.337841554116, 1212.5210541835925, 1227.6908052734964, 1233.7964235900977, 1241.596481143632, 1247.8003519436847, 13696.383662735201, 13991.230482323366, 14079.648008799657, 14181.361838717075, 14247.643808904653, 279007.0, 283450.0, 283725.0, 284095.0, 284172.0, 57902.0, 59504.0, 63904.36095638984, 64209.357906421275, 64276.357236427975, 1551.2786554252327, 1557.22138930537, 1562.3360071969369, 1574.7716581095676, 1588.864946479539, 30447.212170888724, 30967.91612293559, 30975.69024309728, 31197.0, 31298.68701313049, 42395.364069539595, 42551.3617295747, 42603.7869810649, 42775.0, 42817.35773963455, 251044.0, 252103.0, 252105.0, 252967.0, 253321.0, 36290.455643164845, 36736.448953265186, 36880.63119368772, 36907.815460922524, 37010.259794803416, 47352.289715653606, 47555.52444475511, 47967.52032479631, 47996.76001620109, 48163.5183648159, 34936.825315873255, 35288.29423411466, 35404.64595354014, 35866.82066589651, 36382.8180859094, 34868.0, 35093.0, 35147.29705405826, 35409.29181416409, 35502.0, 41021.0, 41218.79390603028, 41321.173576528905, 41582.58417415787, 41617.37573936333, 33396.66603333935, 33569.16077098092, 34007.149821254665, 34024.82987585046, 34329.65670343365, 25031.49937001286, 25050.24849254525, 25955.74044259609, 26222.213333600022, 26691.466170676867], "value": 19221.37998551301, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.8304481824282, 644.6358837496809, 644.7724923200542, 647.1982610235177, 653.1190172303766, 24005.279841604737, 24656.630150547757, 24695.135670251544, 24717.876410617966, 24749.0, 26235.475290494178, 26529.86735066322, 26533.336666583346, 26655.333616659595, 26677.33306667334, 6301.180846489973, 6641.335866413357, 6673.833154171136, 6736.528443008991, 6768.0, 6647.434968027699, 6704.664766761667, 6708.12794336738, 6710.194776626788, 6725.461963042945, 6647.966760166192, 6679.66601669917, 6682.131322928012, 6693.129893113888, 6827.283135270774, 6890.655467226644, 6945.2707465716385, 6947.40947019504, 6948.374646281859, 6954.200266969287, 6510.153680021567, 6524.902126468107, 6529.347065293433, 6542.4766018718865, 6542.901856472156, 30043.5493467596, 30462.086137415914, 30545.23636909095, 30562.08313750591, 30595.388092238252, 2248.460369511322, 2313.560423519526, 2317.0, 2318.4899322149267, 2319.953600927972, 21081.367558973256, 21603.67594486084, 21627.783722162734, 21737.456563585878, 21789.673154902688, 2618.1098426534877, 2639.4984952858895, 2681.6111663808833, 2687.032668239432, 2690.932726681829, 143994.0, 150135.0, 152179.0, 167846.1607691966, 175278.12360938243, 15968.600784980468, 16332.87672602554, 16844.915775421043, 16866.662666746597, 16975.151242438074, 26788.062417815672, 26838.731612683623, 26939.575438210264, 26954.7088497476, 27001.729982700315, 11388.94305528467, 11490.712732181762, 11603.245789023686, 11624.88375116255, 11804.586839460577, 10671.466426678635, 10755.83866242007, 10803.297785643908, 10899.400532970763, 10936.343819370863, 9954.402735835873, 9990.450525221182, 10014.849777253346, 10198.643047493302, 10351.327163734333, 3004.3841012592366, 3096.814191148538, 3105.503119500869, 3105.844707764603, 3138.9215269618444, 1056.4823236614004, 1060.3054998975529, 1070.7376692710336, 1075.6504136155625, 1081.9945900270448, 21125.0, 21280.787192127882, 21317.36047918565, 21437.892810535846, 21830.345089647337, 1129.6949823547595, 1135.2904434728296, 1151.7120719820045, 1156.7917774800449, 1158.5887010111458, 11486.712832179095, 11832.290062596272, 11874.406279685982, 11919.225250358872, 12043.698907527207, 636294.0, 640752.0, 641080.0, 642115.0, 658779.0, 141052.0, 141782.0, 143384.0, 144143.0, 145662.27168864087, 1139.2822521811206, 1282.538286216961, 1288.8388951381078, 1295.352323838081, 1295.788437810669, 21807.78192218121, 21827.45431364165, 21853.0, 21950.560988779816, 22138.114475420804, 66249.0, 66679.66660166669, 66779.66610166918, 67198.0, 69304.30695692978, 77482.0, 80953.59523202346, 81871.0, 82683.0, 84541.57729211314, 15536.456224032105, 15981.360745570511, 16005.919970400073, 16038.839611603735, 16119.435819746253, 21713.457163571038, 22036.33890983273, 22131.77868221297, 22847.88576057109, 23066.192683256006, 18848.811511885255, 19052.714209286594, 19579.118939647466, 19952.3016694415, 19962.700559491328, 17096.230669620145, 17305.221265043354, 17329.30682772675, 17613.647727045132, 17647.558811029827, 19276.0, 20353.79646203578, 20429.0, 20559.69160462624, 20652.896735516228, 15811.13038782832, 15828.68342633164, 15842.68314633724, 15852.920735396248, 15855.445059422866, 19305.710414343514, 19330.4200873974, 19417.805821941598, 19538.31615893437, 19623.803761962197], "value": 13178.575767592121, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.7673810559363, 1515.7726341048842, 1540.8228053773819, 1556.1441207335963, 1568.5843251538345, 17087.487375378743, 17749.7337539937, 17751.467455976308, 17763.91118044408, 17776.644467110666, 17177.227024783882, 17193.312267509315, 17287.13564321782, 17378.304867805273, 17391.0, 3005.1585556044342, 3037.0736925237793, 3080.6303243610687, 3089.0423968569703, 3098.504239321709, 2993.9550906736417, 3055.358374741296, 3062.678418766031, 3065.923351916209, 3067.9846600766964, 3005.1285127313054, 3006.7143621355935, 3142.167325658691, 3144.8584813683324, 3146.307812281306, 3105.301307205872, 3109.3004074083265, 3137.717605415512, 3146.606674165729, 3149.165471150124, 2980.1506570627266, 2981.835999020053, 3015.909522714322, 3017.306019615479, 3061.2193890557764, 17583.73624395635, 17658.11709414524, 17735.556611084827, 17794.644107117787, 17818.376356827448, 8793.912060879373, 9081.818363632756, 9084.50035248061, 9087.818243635156, 9087.863682044775, 5982.940170598282, 6106.572539922207, 6164.96917515414, 6211.068339749028, 6241.937580624226, 2138.7754285799924, 2173.4892300309416, 2197.571473562656, 2203.7135172427484, 2231.732192136954, 33202.50196247034, 33361.6663833361, 33386.165345866306, 33432.49851252209, 33530.83234583811, 7206.459515536356, 7206.675699593531, 7230.168530619047, 7587.241275872479, 7668.654910528928, 21159.153633854472, 21177.364679059654, 21276.468088297606, 21329.146834126463, 21330.78669213319, 8850.247728942983, 8966.86549701742, 8996.910030899739, 9019.098090190928, 9029.23251523628, 8145.714899978472, 8196.385271104691, 8301.543415112226, 8325.458845175166, 8370.12113728062, 5550.139728342114, 5559.208559985625, 5576.498115169654, 5596.860078497989, 5623.184638227434, 1552.813662360524, 1562.7499600063936, 1647.6045749020388, 1650.0, 1652.0, 1005.4872015272264, 1013.9594416223416, 1023.2581378500677, 1024.8770147582188, 1041.068243921701, 9043.502607356528, 9104.453732775923, 9171.128742769426, 9185.816283674423, 9259.30555208362, 1090.1442367741286, 1097.4512743628186, 1098.7857367813199, 1102.063246240705, 1104.6741211342674, 5325.440828712929, 5364.722312277083, 5457.536109430664, 5511.53151982086, 5663.716814159276, 26028.86985565098, 26889.193324200307, 27073.323166920985, 27315.180544583694, 27439.862800685867, 25557.0, 26719.599206011924, 27160.0, 27207.0, 27294.0, 12723.236605803866, 13455.125416847874, 13457.461701532025, 13462.865371346357, 13560.932195339157, 9006.684766033419, 9146.0, 9183.724488265363, 9250.814983700153, 9277.350585458953, 22158.446038849157, 22201.029563758144, 22816.885915570318, 23051.077956881538, 23082.422939426648, 23427.88286058559, 23523.647145293176, 23855.403614909766, 23909.0, 24115.879420602785, 12643.241405515699, 12888.548900788428, 12889.806652900026, 12896.548620798227, 12916.612501624966, 15835.920820395824, 15985.840141598901, 16065.759013614572, 16073.839261607234, 16106.597335066717, 12720.936395317964, 12895.355232238164, 13098.738025239632, 13158.605241842377, 13293.468261269441, 12430.689232768891, 12571.0, 12590.181638193488, 13005.609831705064, 13065.934670326587, 10922.508487118257, 10998.230123891251, 11055.447227638746, 11087.722806929569, 11092.778144437227, 7883.329916957123, 7954.5624990626075, 7967.681292748457, 7967.9203207967175, 8103.31121854649, 8803.515806630698, 8887.73336799897, 8895.243904268209, 8905.154010369004, 8940.240079593308], "value": 7661.285093217046, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.2928368822659, 574.5547200919287, 576.4575147835059, 606.8846919085373, 611.4741322462681, 6471.223453185618, 6532.366908272932, 6584.572002819813, 6596.142501474802, 6608.273089960113, 6328.177336946202, 6342.619442833433, 6473.190851143607, 6483.902741458882, 6507.9023814642815, 5273.8945221095555, 5303.761330740107, 5307.548858347026, 5308.389535203462, 5353.223782551528, 5035.295058691768, 5115.462876397981, 5235.528802407783, 5235.816746413876, 5265.631405801595, 5063.0, 5110.667806592578, 5123.897522049557, 5127.666701664399, 5139.100657384962, 5084.161113416319, 5097.929434818692, 5109.463506331837, 5128.846009647837, 5130.102232109366, 4648.325992731069, 4677.532246775329, 4685.4143232095985, 4715.976420117911, 4730.834420795256, 6345.555811093179, 6396.680165991682, 6406.359364063603, 6410.67946602668, 6415.422611964899, 6019.488343490765, 6072.724727807165, 6078.756849726005, 6119.265688117454, 6172.67287533178, 6874.9750109951465, 6891.793246202622, 6899.137607799025, 6900.930990690079, 6915.204751453597, 5244.632875698702, 5256.474352564751, 5289.285946397225, 5302.310699609065, 5318.627696061278, 6850.897236541456, 6989.266127056637, 6994.5803251805055, 7087.574745515286, 7155.0, 5391.29913111293, 5391.433899440581, 5397.622166448311, 5420.322459692538, 5438.15708565173, 5471.179323101487, 5478.315210598676, 5480.862978425571, 5506.779728810883, 5531.3915469298345, 6060.181875446847, 6070.817875463743, 6101.572889897665, 6107.0, 6132.448079672851, 6823.28355522663, 6844.691988860513, 6857.657117144123, 6918.654067296615, 6924.130484769084, 1880.2854915132161, 1894.8157401623985, 1899.6390685769936, 1904.9714254286196, 1910.3695780392436, 1308.2673702726504, 1329.4947919790418, 1342.4831439895515, 1356.3625096204769, 1363.3319673360181, 6350.523710721714, 6419.903701444482, 6420.325865784119, 6438.58553042609, 6447.323031081763, 6839.469396323392, 6861.176658800976, 6917.619530925847, 6985.511014229057, 7071.186813516409, 6348.460380867678, 6395.840103997344, 6420.5184611154355, 6468.8059358219325, 6547.050677651714, 3660.3228402745576, 3673.4673472346362, 3675.1547144156993, 3682.3924052531033, 3700.9259814803554, 7017.298270173044, 7021.157461104598, 7077.186123595749, 7112.6443677815905, 7160.641967901584, 7031.40233080194, 7040.084788977502, 7047.612381319077, 7136.220590439104, 7158.2125966143685, 7120.608366539786, 7139.178994415501, 7216.855662886818, 7241.637918104074, 7243.7464688735645, 6901.0, 6901.1718593769065, 6909.585424874524, 6987.231404545598, 7075.221725610076, 6920.757773477904, 6942.583444993316, 6945.340192681687, 6946.79159625212, 6990.16118065815, 7225.747098851515, 7252.891206631799, 7268.527545709512, 7273.163586187656, 7289.198188199188, 5421.295231619864, 5421.945780542144, 5452.454754524516, 5459.727013649381, 5467.371252306036, 6879.724811007503, 6949.826254343682, 6985.825354366181, 7025.332593403618, 7059.223485416703, 6592.307807680125, 6750.763723269858, 6810.829729256809, 6817.840967035517, 6871.553349032297, 6623.509710315333, 6655.0, 6721.899171512334, 6736.663166841737, 6774.119364482585, 6500.479961603155, 6586.604803711793, 6615.900761488678, 6641.435477984425, 6650.20197576294, 6717.529772915849, 6733.360330768569, 6796.796096117125, 6831.795046148623, 6834.0, 6598.822388611842, 6636.336366363325, 6701.597904125768, 6704.351781046362, 6728.764493242713], "value": 5362.628917080398, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [976.7069879036287, 996.5117092624613, 1003.1673710820015, 1015.7866847961927, 1028.593705486333, 20844.37466875994, 21547.353579392624, 21573.67639485405, 21582.244621438214, 24302.635460468064, 24273.393165170837, 24295.0, 24414.389640258956, 24504.0, 24575.0, 1016.8830584482805, 1081.7403823082443, 1083.3012706804107, 1088.17298852872, 1095.5234473004268, 1115.6485707002269, 1120.495776900394, 1125.386664267976, 1125.926814757038, 1127.780082883838, 1093.2456604942604, 1128.7121783945124, 1129.1644183304377, 1129.322406556064, 1134.353418551426, 1119.7256672115302, 1129.4183495499824, 1131.3720884908955, 1131.7849608574386, 1132.1452303510837, 825.7027470110755, 826.3265438667527, 828.7348048624442, 829.5686243153586, 829.7552222094497, 19454.416367508857, 20126.295579654787, 20332.186712531628, 20352.084156213004, 20375.49061273465, 22686.432839178986, 23021.76978230213, 23196.884015579813, 23201.7679823203, 23236.18673346425, 19495.0, 19620.215191392326, 19718.70421943672, 19860.801391986184, 19901.402957911287, 4097.97951010243, 4184.811683474251, 4190.497140343178, 4195.223883581547, 4197.622214000755, 161536.0, 166466.0, 167828.16085919616, 170095.0, 172465.0, 16796.916015419843, 17210.70919681004, 17367.56581085483, 17414.912925435292, 17448.0, 35113.297734045176, 35992.46011309832, 36161.8191909044, 36269.81865090658, 36352.45471317932, 10067.798644027225, 10082.294239403318, 10160.4919754012, 10161.085502304828, 10277.845832312521, 5033.1695270280725, 5046.1926091825135, 5052.368453943257, 5135.743212839343, 5145.253938178943, 6624.768133115318, 6676.330917270682, 6681.365270299314, 6768.424683901923, 6846.554973926778, 1202.7113492761848, 1202.9939850300693, 1222.2849632964815, 1231.2673958994385, 1233.0690328801877, 769.5075151902787, 774.7482068327703, 796.8366484870587, 796.9880451793227, 805.8348038652063, 12475.5009799607, 12889.355532223351, 13373.531926382724, 13865.029447938547, 13899.374528146056, 709.1596458197052, 714.639107250835, 718.8418547919449, 722.1334398721555, 732.5568031341069, 6087.756489740449, 6148.415900489446, 6157.476614487819, 6245.406686364879, 6281.0, 155993.0, 157805.0, 158057.0, 161749.0, 164680.0, 132017.33991329983, 132441.0, 133285.0, 134449.67487134377, 136166.3191684035, 111696.44151779189, 112758.43620781843, 113211.0, 113925.0, 114278.0, 11614.941925290319, 11700.414979250832, 11866.584669536525, 12135.878641213829, 12190.085743569445, 58776.70611646914, 59053.40946590479, 59292.40707592869, 59374.70312648409, 59865.0, 72308.63845680738, 72437.63781181061, 72808.0, 74820.0, 75560.0, 17265.13674316254, 17387.217575209397, 17412.303507859542, 17555.385561505285, 17748.733768993734, 18122.72815907736, 18750.156242969373, 18775.436736897915, 18912.43262702121, 19125.90437047806, 16974.83025169782, 17218.139093045047, 17296.048717320667, 17366.565835854206, 17486.82513174852, 15782.210889455251, 15876.0, 15894.377427724758, 15899.0, 15962.521124366287, 16579.171041447637, 16768.832311677215, 16771.91614041922, 16816.159192040595, 16826.66346673035, 11392.886071139183, 12090.818637720266, 12112.878871211175, 12135.75728485443, 12257.877421225674, 11741.354225517678, 11810.881891180978, 11841.82237266459, 11844.70388240301, 11879.406029698308], "value": 10101.764752209141, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1369.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 106.0, 106.0, 104.0, 107.0, 110.0, 107.0, 108.0, 105.0, 109.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 111.0, 112.0, 112.0, 144.0, 123.0, 113.0, 111.0, 141.0], "value": 119.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 160.0, 162.0, 166.0, 162.0, 162.0, 161.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 75.0, 73.0, 74.0, 75.0, 75.0, 74.0, 74.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 80.0, 82.0, 76.0, 78.0, 77.0, 80.0, 79.0, 82.0], "value": 79.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 159.0, 148.0, 148.0, 149.0, 149.0, 148.0, 150.0, 148.0, 153.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 97.0, 95.0, 94.0, 95.0, 94.0, 95.0, 96.0, 93.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 45.0, 44.0, 44.0, 44.0, 50.0, 46.0, 44.0, 41.0, 45.0], "value": 44.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 71.0, 70.0, 70.0, 69.0, 70.0, 71.0, 71.0, 74.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 107.0, 101.0, 102.0, 103.0, 108.0, 102.0, 106.0, 106.0, 102.0], "value": 104.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 169.0, 152.0, 158.0, 148.0, 146.0, 144.0, 152.0, 149.0, 147.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 57.0, 59.0, 62.0, 59.0, 58.0, 59.0, 58.0, 64.0], "value": 59.4, "unit": "score"}]}]} 07:30:51 INFO - Return code: 0 07:30:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:30:51 INFO - # TBPL SUCCESS # 07:30:51 INFO - Running post-action listener: _package_coverage_data 07:30:51 INFO - Running post-action listener: _resource_record_post_action 07:30:51 INFO - [mozharness: 2017-09-26 14:30:51.597802Z] Finished run-tests step (success) 07:30:51 INFO - Running post-run listener: _resource_record_post_run 07:30:51 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285093888; Read time: 12; Write time: 136224 07:30:51 INFO - TinderboxPrint: CPU usage
13.0% 07:30:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:30:51 INFO - TinderboxPrint: I/O write bytes / time
285,093,888 / 136,224 07:30:51 INFO - TinderboxPrint: CPU idle
8,180.8 (86.9%) 07:30:51 INFO - TinderboxPrint: CPU user
1,181.1 (12.6%) 07:30:51 INFO - TinderboxPrint: Swap in / out
0 / 0 07:30:51 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 503808; Read time: 0; Write time: 44 07:30:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:30:51 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282783744; Read time: 12; Write time: 136096 07:30:52 INFO - Running post-run listener: _upload_blobber_files 07:30:52 INFO - Blob upload gear active. 07:30:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:30:52 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 07:30:52 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:30:52 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:30:52 INFO - (blobuploader) - INFO - Open directory for files ... 07:30:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:30:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:30:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:59 INFO - (blobuploader) - INFO - Done attempting. 07:30:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:30:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:00 INFO - (blobuploader) - INFO - Done attempting. 07:31:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:31:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:31:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:02 INFO - (blobuploader) - INFO - Done attempting. 07:31:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:31:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:31:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:03 INFO - (blobuploader) - INFO - Done attempting. 07:31:03 INFO - (blobuploader) - INFO - Iteration through files over. 07:31:03 INFO - Return code: 0 07:31:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:31:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:31:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d826fb1e418f6743d90a4361b9ab3a11376f3c951b7c057395b8a3fd0747ef1b07636269e098901771a759332accce25f725cbe606262d1c7083f84e679229bb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fa0dd8d9115e67f9ab17cb8d80b8ffbc3b5e000d4fe609f21d0ffc5ef6992163c0391a2279609adaa5eb48c45c97a99d933b926ff7d98803a289391f22dc49c0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e7cde19c0a0e21d064a62f437685450848ca72ff0950b0b647c705e396bba77e8190c53cd9bcfd4128d403159a1bffa5325e3f9d633ed19a2752f411c72f6184", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9fb1f6a312ff8f7acdc11c2b07eba3fd73a481981f1b3a0ebaa8e523a77da52c0a7d3673591fddaee65f9a4475a914dc0ab1a2ccf0b1e12325d73dc9c68d4277"} 07:31:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:31:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:31:03 INFO - Contents: 07:31:03 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d826fb1e418f6743d90a4361b9ab3a11376f3c951b7c057395b8a3fd0747ef1b07636269e098901771a759332accce25f725cbe606262d1c7083f84e679229bb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fa0dd8d9115e67f9ab17cb8d80b8ffbc3b5e000d4fe609f21d0ffc5ef6992163c0391a2279609adaa5eb48c45c97a99d933b926ff7d98803a289391f22dc49c0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e7cde19c0a0e21d064a62f437685450848ca72ff0950b0b647c705e396bba77e8190c53cd9bcfd4128d403159a1bffa5325e3f9d633ed19a2752f411c72f6184", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9fb1f6a312ff8f7acdc11c2b07eba3fd73a481981f1b3a0ebaa8e523a77da52c0a7d3673591fddaee65f9a4475a914dc0ab1a2ccf0b1e12325d73dc9c68d4277"} 07:31:03 INFO - Running post-run listener: copy_logs_to_upload_dir 07:31:03 INFO - Copying logs to upload dir... 07:31:03 INFO - mkdir: /builds/slave/test/build/upload/logs 07:31:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.160098 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-09-26 07:31:03.335860) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 07:31:03.343487) ========= 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=438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d826fb1e418f6743d90a4361b9ab3a11376f3c951b7c057395b8a3fd0747ef1b07636269e098901771a759332accce25f725cbe606262d1c7083f84e679229bb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fa0dd8d9115e67f9ab17cb8d80b8ffbc3b5e000d4fe609f21d0ffc5ef6992163c0391a2279609adaa5eb48c45c97a99d933b926ff7d98803a289391f22dc49c0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e7cde19c0a0e21d064a62f437685450848ca72ff0950b0b647c705e396bba77e8190c53cd9bcfd4128d403159a1bffa5325e3f9d633ed19a2752f411c72f6184", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9fb1f6a312ff8f7acdc11c2b07eba3fd73a481981f1b3a0ebaa8e523a77da52c0a7d3673591fddaee65f9a4475a914dc0ab1a2ccf0b1e12325d73dc9c68d4277"} build_url:https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/crNUz0RzRTib4IXZG5QDnw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d826fb1e418f6743d90a4361b9ab3a11376f3c951b7c057395b8a3fd0747ef1b07636269e098901771a759332accce25f725cbe606262d1c7083f84e679229bb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fa0dd8d9115e67f9ab17cb8d80b8ffbc3b5e000d4fe609f21d0ffc5ef6992163c0391a2279609adaa5eb48c45c97a99d933b926ff7d98803a289391f22dc49c0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e7cde19c0a0e21d064a62f437685450848ca72ff0950b0b647c705e396bba77e8190c53cd9bcfd4128d403159a1bffa5325e3f9d633ed19a2752f411c72f6184", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9fb1f6a312ff8f7acdc11c2b07eba3fd73a481981f1b3a0ebaa8e523a77da52c0a7d3673591fddaee65f9a4475a914dc0ab1a2ccf0b1e12325d73dc9c68d4277"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 07:31:03.374996) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 07:31:03.375335) ========= 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=438111f3d31ce799eff2119d000001bc-1506426160.789145-1395119887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 07:31:03.458046) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 07:31:03.458365) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 07:31:03.458685) ========= ========= Total master_lag: 0.29 =========